Parent Log: http://ci.aztec-labs.com/d807837b95d20001 Command: 97e7ef9a556fd7e6: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/f3a077dd83e56ee0ae0a1175f0dc39fdfa50e6d7 Env: REF_NAME=gh-readonly-queue/master/pr-14734-a229cf871638d3fd774f9272645cc1ac29b8196a CURRENT_VERSION=0.87.9 CI_FULL=1 Date: Tue Jun 24 10:37:37 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14734_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_6b4a73ce992ff502_master 10:37:37 +++ id -u 10:37:37 +++ id -g 10:37:37 ++ docker run -d --name e2e_partial_notes --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_partial_notes.test.ts'\''' 10:37:38 + cid=f36a3da2895e60ea447fe17f517cf4f4e6abe91539b4769aca22a7c6e990feee 10:37:38 + set +x 10:37:38 {"level":25,"time":1750761458840,"pid":12,"hostname":"f36a3da2895e","module":"logger","msg":"Logger initialized with level verbose"} 10:37:44 [10:37:44.632] INFO: e2e:e2e_partial_notes Logging metrics to log/unknown.jsonl 10:37:44 [10:37:44.934] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-f0FeG6/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 10:37:44 [10:37:44.970] INFO: e2e:e2e_partial_notes Calling anvil_setBlockTimestampInterval with params: [12] 10:37:44 [10:37:44.993] WARN: e2e:e2e_partial_notes Set block interval to 12 10:37:44 [10:37:44.994] VERBOSE: e2e:e2e_partial_notes Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 10:37:45 [10:37:45.038] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 10:37:45 [10:37:45.046] VERBOSE: e2e:e2e_partial_notes Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 10:37:45 [10:37:45.066] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 10:37:45 [10:37:45.073] VERBOSE: e2e:e2e_partial_notes Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 10:37:45 [10:37:45.096] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 10:37:45 [10:37:45.101] VERBOSE: e2e:e2e_partial_notes Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 10:37:45 [10:37:45.118] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 10:37:45 [10:37:45.123] VERBOSE: e2e:e2e_partial_notes Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 10:37:45 [10:37:45.141] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 10:37:45 [10:37:45.147] VERBOSE: e2e:e2e_partial_notes Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 10:37:45 [10:37:45.160] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 10:37:45 [10:37:45.165] VERBOSE: e2e:e2e_partial_notes Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 10:37:45 [10:37:45.165] VERBOSE: e2e:e2e_partial_notes Waiting for deployments to complete 10:37:45 [10:37:45.166] INFO: e2e:e2e_partial_notes Waiting for 6 transactions to be mined... 10:37:45 [10:37:45.189] INFO: e2e:e2e_partial_notes All transactions mined successfully 10:37:45 [10:37:45.206] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 10:37:45 [10:37:45.206] VERBOSE: e2e:e2e_partial_notes Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 10:37:45 [10:37:45.227] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 10:37:45 [10:37:45.240] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 10:37:45 [10:37:45.245] VERBOSE: e2e:e2e_partial_notes Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 10:37:45 [10:37:45.258] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 10:37:45 [10:37:45.258] VERBOSE: e2e:e2e_partial_notes Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 10:37:45 [10:37:45.275] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 10:37:45 [10:37:45.280] VERBOSE: e2e:e2e_partial_notes Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 10:37:45 [10:37:45.293] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 10:37:45 [10:37:45.293] VERBOSE: e2e:e2e_partial_notes Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 10:37:45 [10:37:45.293] VERBOSE: e2e:e2e_partial_notes Waiting for deployments to complete 10:37:45 [10:37:45.293] INFO: e2e:e2e_partial_notes Waiting for 8 transactions to be mined... 10:37:45 [10:37:45.311] INFO: e2e:e2e_partial_notes All transactions mined successfully 10:37:45 [10:37:45.321] VERBOSE: e2e:e2e_partial_notes Deployed shared contracts 10:37:45 [10:37:45.345] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 10:37:45 [10:37:45.346] VERBOSE: e2e:e2e_partial_notes Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 10:37:45 [10:37:45.350] 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} 10:37:45 [10:37:45.362] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 10:37:45 [10:37:45.389] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 10:37:45 [10:37:45.397] VERBOSE: e2e:e2e_partial_notes Awaiting for linked libraries to be deployed 10:37:45 [10:37:45.442] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0xcdf47effb77803dcaa1d9d466cec98dab231ef992de8df22ec58ebcbb6ba6083 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 10:37:45 [10:37:45.451] 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} 10:37:45 [10:37:45.452] INFO: e2e:e2e_partial_notes Waiting for 9 transactions to be mined... 10:37:45 [10:37:45.475] INFO: e2e:e2e_partial_notes All transactions mined successfully 10:37:45 [10:37:45.475] VERBOSE: e2e:e2e_partial_notes All core contracts have been deployed 10:37:45 [10:37:45.487] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 10:37:45 [10:37:45.487] VERBOSE: e2e:e2e_partial_notes Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments) 10:37:45 [10:37:45.497] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 10:37:45 [10:37:45.502] VERBOSE: e2e:e2e_partial_notes Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 10:37:45 [10:37:45.528] VERBOSE: e2e:e2e_partial_notes Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 10:37:45 [10:37:45.529] VERBOSE: e2e:e2e_partial_notes Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 10:37:45 [10:37:45.529] INFO: e2e:e2e_partial_notes Waiting for 10 transactions to be mined... 10:37:45 [10:37:45.549] INFO: e2e:e2e_partial_notes All transactions mined successfully 10:37:45 [10:37:45.562] VERBOSE: e2e:e2e_partial_notes Rollup deployed 10:37:45 [10:37:45.562] VERBOSE: e2e:e2e_partial_notes Waiting for rollup and slash factory to be deployed 10:37:45 [10:37:45.562] INFO: e2e:e2e_partial_notes Waiting for 10 transactions to be mined... 10:37:45 [10:37:45.583] INFO: e2e:e2e_partial_notes All transactions mined successfully 10:37:45 [10:37:45.583] VERBOSE: e2e:e2e_partial_notes All transactions for L1 deployment have been mined 10:37:45 [10:37:45.603] 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"} 10:37:45 [10:37:45.609] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 10:37:45 [10:37:45.613] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:45 [10:37:45.614] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 10:37:45 [10:37:45.616] INFO: telemetry:client Using NoopTelemetryClient 10:37:45 [10:37:45.623] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 10:37:45 [10:37:45.623] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 10:37:45 [10:37:45.624] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/178d40d08f6bf0dd/blob-sink with map size 134217728 KB (LMDB v2) 10:37:45 [10:37:45.627] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:45 [10:37:45.630] INFO: aztecjs:utils:watcher New L1 time: 1750761704 10:37:45 [10:37:45.630] WARN: foundation:test-date-provider Time set to 2025-06-24T10:41:44.000Z {"offset":238370,"timeMs":1750761704000} 10:37:45 [10:37:45.633] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 10:37:45 [10:37:45.641] INFO: blob-sink:server Server is running on http://localhost:33789 10:37:45 [10:37:45.641] VERBOSE: e2e:e2e_partial_notes Creating and synching an aztec node... 10:37:45 [10:37:45.642] VERBOSE: e2e:e2e_partial_notes Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/fe02b65d/acvm 10:37:45 [10:37:45.643] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:33789"} 10:37:45 [10:37:45.663] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 10:37:45 [10:37:45.664] INFO: archiver:lmdb Creating archiver data store at directory /tmp/178d40d08f6bf0dd/archiver with map size 134217728 KB (LMDB v2) 10:37:45 [10:37:45.668] INFO: archiver:lmdb Starting data store with maxReaders 16 10:37:45 [10:37:45.892] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:45 [10:37:45.999] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:33789"} 10:37:46 [10:37:46.015] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:33789"} 10:37:46 [10:37:46.016] WARN: node:blob-sink:client No L1 consensus host urls configured 10:37:46 [10:37:46.016] WARN: node:blob-sink:client No archive client configured 10:37:46 [10:37:46.019] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x3b0e5b9693a2dbae33c0dd621dcd0485551d2d9a46e60aa75f23ce20055fdc2f {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x470fc777f595edd062a678306e73c3e600d5460e97640e61c102a448fb4ba45b","l1BlockNumber":16}} 10:37:46 [10:37:46.032] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 10:37:46 [10:37:46.041] INFO: world-state:database Creating world state data store at directory /tmp/178d40d08f6bf0dd/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 10:37:46 [10:37:46.067] INFO: world_state Created world state synchroniser with block history of 64 10:37:46 [10:37:46.067] WARN: node Aztec node is accepting fake proofs 10:37:46 [10:37:46.078] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/178d40d08f6bf0dd/p2p with map size 134217728 KB (LMDB v2) 10:37:46 [10:37:46.080] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 10:37:46 [10:37:46.081] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/178d40d08f6bf0dd/p2p-archive with map size 134217728 KB (LMDB v2) 10:37:46 [10:37:46.082] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 10:37:46 [10:37:46.083] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/178d40d08f6bf0dd/p2p-peers with map size 134217728 KB (LMDB v2) 10:37:46 [10:37:46.084] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 10:37:46 [10:37:46.085] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 10:37:46 [10:37:46.086] VERBOSE: p2p P2P is disabled. Using dummy P2P service 10:37:46 [10:37:46.088] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 10:37:46 [10:37:46.089] INFO: world_state Started world state synchronizer from block 1 10:37:46 [10:37:46.091] VERBOSE: world-state:block_stream Starting sync from block number 0 10:37:46 [10:37:46.092] INFO: p2p Starting p2p client from block 0 with empty mempools 10:37:46 [10:37:46.092] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 10:37:46 [10:37:46.093] INFO: slasher Slasher client initialized 10:37:46 [10:37:46.093] INFO: slasher Starting Slasher client... 10:37:46 [10:37:46.121] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 10:37:46 [10:37:46.122] VERBOSE: node All Aztec Node subsystems synced 10:37:46 [10:37:46.129] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:46 [10:37:46.133] INFO: sequencer-client Deploying forwarder contract 10:37:46 [10:37:46.143] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 10:37:46 [10:37:46.160] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 10:37:46 [10:37:46.160] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 10:37:46 [10:37:46.166] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 10:37:46 [10:37:46.186] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 10:37:46 [10:37:46.186] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 10:37:46 [10:37:46.187] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/fe02b65d/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 10:37:46 [10:37:46.393] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 10:37:46 [10:37:46.395] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 10:37:46 [10:37:46.397] INFO: node Aztec Node version: 0.87.9 10:37:46 [10:37:46.397] 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"} 10:37:46 [10:37:46.398] VERBOSE: e2e:e2e_partial_notes Creating a pxe... 10:37:46 [10:37:46.403] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:46 [10:37:46.412] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/7a5ece429fd8f4f3/pxe_data with map size 134217728 KB (LMDB v2) 10:37:46 [10:37:46.426] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x28e61869f23b63d4f785161ed03279304bd983bed53da7c31dddc5577ebde0fe","blockNumber":1,"slot":2} 10:37:46 [10:37:46.427] INFO: pxe:data:lmdb Starting data store with maxReaders 16 10:37:46 [10:37:46.617] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:46 [10:37:46.736] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 10:37:46 [10:37:46.737] INFO: pxe:service Started PXE connected to chain 31337 version 3291947012 10:37:46 [10:37:46.794] INFO: pxe:service Registered account 0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045 10:37:46 [10:37:46.876] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:46 [10:37:46.879] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 10:37:46 [10:37:46.883] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045 10:37:47 [10:37:47.027] INFO: pxe:service Added contract SchnorrAccount at 0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 10:37:47 [10:37:47.039] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x28e61869f23b63d4f785161ed03279304bd983bed53da7c31dddc5577ebde0fe","blockNumber":1,"slot":2} 10:37:47 [10:37:47.091] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:47 [10:37:47.098] VERBOSE: pxe:block_stream Starting sync from block number 0 10:37:47 [10:37:47.125] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 10:37:47 [10:37:47.253] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 10:37:47 [10:37:47.978] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 10:37:48 [10:37:48.119] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 10:37:48 [10:37:48.203] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:48 [10:37:48.234] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x28e61869f23b63d4f785161ed03279304bd983bed53da7c31dddc5577ebde0fe","blockNumber":1,"slot":2} 10:37:48 [10:37:48.333] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:37:48 [10:37:48.384] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 10:37:48 [10:37:48.385] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:37:48 [10:37:48.413] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:48 [10:37:48.424] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:37:48 [10:37:48.428] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 10:37:48 [10:37:48.611] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:37:48 [10:37:48.650] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 10:37:48 [10:37:48.650] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:37:48 [10:37:48.652] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:48 [10:37:48.685] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:37:48 [10:37:48.688] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 10:37:48 [10:37:48.707] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045 as fee payer 10:37:48 [10:37:48.786] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x28e61869f23b63d4f785161ed03279304bd983bed53da7c31dddc5577ebde0fe","blockNumber":1,"slot":2} 10:37:48 [10:37:48.911] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:49 [10:37:49.149] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:49 [10:37:49.379] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:49 [10:37:49.502] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x28e61869f23b63d4f785161ed03279304bd983bed53da7c31dddc5577ebde0fe","blockNumber":1,"slot":2} 10:37:49 [10:37:49.658] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:50 [10:37:50.149] INFO: pxe:service Proving completed in 3058.585194000001ms {"timings":{"total":3058.585194000001,"sync":8.647488999999041,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":163.71507400000155,"oracles":{"callPrivateFunction":{"times":[1009.1603700000014,348.68555099999867,183.34150299999965]}}},{"functionName":"private_kernel_init","time":116.90384400000039},{"functionName":"ContractClassRegisterer:register","time":985.6845229999999,"oracles":{"loadCapsule":{"times":[18.354150000001027]},"notifyCreatedNullifier":{"times":[18.2403290000002]},"debugLog":{"times":[1.981911000000764]},"notifyCreatedContractClassLog":{"times":[10.791924000001018]}}},{"functionName":"private_kernel_inner","time":180.2421379999996},{"functionName":"SchnorrAccount:constructor","time":317.5061149999983,"oracles":{"getContractInstance":{"times":[2.522531999999046]},"debugLog":{"times":[0.7962159999988216,0.4673189999994065]},"fetchTaggedLogs":{"times":[42.042161999999735]},"loadCapsule":{"times":[0.31927600000017264,0.2470950000006269,0.2042540000002191]},"notifyCreatedNullifier":{"times":[3.5374529999990045,0.3916880000015226]},"notifyCreatedNote":{"times":[0.4988200000007055]},"getRandomField":{"times":[0.5046800000000076,0.2581849999987753,0.11206199999833188,0.09667199999967124,0.17899299999953655,0.09915100000034727,0.08886200000051758,0.0784719999992376,0.06717099999877973,0.06616199999916716,0.0649409999987256]},"getIndexedTaggingSecretAsSender":{"times":[34.40624399999979]},"incrementAppTaggingSecretIndexAsSender":{"times":[32.98509399999966]}}},{"functionName":"private_kernel_inner","time":145.6709609999998},{"functionName":"SchnorrAccount:entrypoint","time":160.13381200000003,"oracles":{"debugLog":{"times":[0.6615439999986847,0.4659200000005512,0.8081469999997353]},"fetchTaggedLogs":{"times":[35.85674300000028]},"loadCapsule":{"times":[0.23359499999969557,0.3991390000010142,0.3209969999988971]},"getNotes":{"times":[2.2825679999987187]},"getAuthWitness":{"times":[0.4774099999995087]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0097109999987879]}}},{"functionName":"private_kernel_inner","time":125.26784800000132},{"functionName":"private_kernel_reset","time":182.69287900000018},{"functionName":"private_kernel_tail","time":100.23222899999928}],"unaccounted":571.8882820000017}} 10:37:50 [10:37:50.170] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:50 [10:37:50.202] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x28e61869f23b63d4f785161ed03279304bd983bed53da7c31dddc5577ebde0fe","blockNumber":1,"slot":2} 10:37:50 [10:37:50.348] VERBOSE: p2p:tx_pool Adding tx 0x14e0de37dab5d2797b9e1b3684e7c444a99f91a4ffb44ed681b843633fe90b39 to pool {"eventName":"tx-added-to-pool","txHash":"0x14e0de37dab5d2797b9e1b3684e7c444a99f91a4ffb44ed681b843633fe90b39","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 10:37:50 [10:37:50.372] INFO: node Received tx 0x14e0de37dab5d2797b9e1b3684e7c444a99f91a4ffb44ed681b843633fe90b39 {"txHash":"0x14e0de37dab5d2797b9e1b3684e7c444a99f91a4ffb44ed681b843633fe90b39"} 10:37:50 [10:37:50.372] INFO: pxe:service Sent transaction 0x14e0de37dab5d2797b9e1b3684e7c444a99f91a4ffb44ed681b843633fe90b39 10:37:50 [10:37:50.380] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:50 [10:37:50.584] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:50 [10:37:50.723] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 10:37:50 [10:37:50.736] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-24T10:42:08.000Z","now":"2025-06-24T10:41:49.106Z"} 10:37:50 [10:37:50.823] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:51 [10:37:51.099] VERBOSE: simulator:public-processor Processed tx 0x14e0de37dab5d2797b9e1b3684e7c444a99f91a4ffb44ed681b843633fe90b39 with no public calls in 259.73992700000053ms {"txHash":"0x14e0de37dab5d2797b9e1b3684e7c444a99f91a4ffb44ed681b843633fe90b39","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":259.73992700000053} 10:37:51 [10:37:51.100] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:51 [10:37:51.105] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3674760009999991s {"duration":0.3674760009999991,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 10:37:51 [10:37:51.267] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x091fc3d117b3d7bf184d268491024c69a49e4385ecec36fc51f158b5676f4c2d","globalVariables":{"chainId":31337,"version":3291947012,"blockNumber":1,"slotNumber":2,"timestamp":1750761728,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x14e0de37dab5d2797b9e1b3684e7c444a99f91a4ffb44ed681b843633fe90b39"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":544.5661540000001,"publicProcessDuration":368.6439960000007,"rollupCircuitsDuration":531.5523240000002,"txCount":1,"blockNumber":1,"blockTimestamp":1750761728,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 10:37:51 [10:37:51.270] VERBOSE: sequencer Attesting committee is empty 10:37:51 [10:37:51.387] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:51 [10:37:51.689] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:51 [10:37:51.694] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x63989a17286b4a1a02b7246303c6a166ec587f33295251b3a5ac816a15fdf1fb 10:37:51 [10:37:51.695] VERBOSE: sequencer-client Sent L1 transaction 0x63989a17286b4a1a02b7246303c6a166ec587f33295251b3a5ac816a15fdf1fb {"gasLimit":514538,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 10:37:51 [10:37:51.710] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:37:51 [10:37:51.711] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x63989a17286b4a1a02b7246303c6a166ec587f33295251b3a5ac816a15fdf1fb","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":1,"blockTimestamp":1750761728,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 10:37:51 [10:37:51.712] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 10:37:51 [10:37:51.732] INFO: blob-sink:server Received blob sidecar for block 0xacd3483b966ec3382395e5079ebd2c16a9c0518a4c30bb9d7d5fdef0761eacae 10:37:51 [10:37:51.740] INFO: blob-sink:server Blob sidecar stored successfully for block 0xacd3483b966ec3382395e5079ebd2c16a9c0518a4c30bb9d7d5fdef0761eacae 10:37:51 [10:37:51.947] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:51 [10:37:51.973] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 10:37:51 [10:37:51.982] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 10:37:51 [10:37:51.986] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 10:37:51 [10:37:51.989] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x091fc3d117b3d7bf184d268491024c69a49e4385ecec36fc51f158b5676f4c2d","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3291947012,"blockNumber":1,"slotNumber":2,"timestamp":1750761728,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x305b4b99d4a4c665e0c15e28f08a84022c81142b706fdd7cb19bdcb01d4cb531","archiveNextLeafIndex":2} 10:37:51 [10:37:51.996] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 10:37:52 [10:37:51.999] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750761764] on http://127.0.0.1:8545 10:37:52 [10:37:52.001] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 10:37:52 [10:37:52.003] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750761764 10:37:52 [10:37:52.003] WARN: foundation:test-date-provider Time set to 2025-06-24T10:42:44.000Z {"offset":291997,"timeMs":1750761764000} 10:37:52 [10:37:52.003] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 10:37:52 [10:37:52.081] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":10.132970000000569,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750761728,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 10:37:52 [10:37:52.150] INFO: pxe:service Registered account 0x128b9483d6f59701c243956c128036beb994f18336613d2306a0484b454668c7 10:37:52 [10:37:52.151] VERBOSE: p2p Synched to latest block 1 10:37:52 [10:37:52.249] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:52 [10:37:52.259] INFO: pxe:service Added contract SchnorrAccount at 0x128b9483d6f59701c243956c128036beb994f18336613d2306a0484b454668c7 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 10:37:52 [10:37:52.295] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x305b4b99d4a4c665e0c15e28f08a84022c81142b706fdd7cb19bdcb01d4cb531","blockNumber":2,"slot":3} 10:37:52 [10:37:52.308] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x305b4b99d4a4c665e0c15e28f08a84022c81142b706fdd7cb19bdcb01d4cb531","header":{"contentCommitment":{"blobsHash":"0x008b0e0a0680520b9d2e474a1293453c34d8ef51a90b9b910fff15f4d18cedf4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750761728,"version":3291947012},"lastArchive":"0x28e61869f23b63d4f785161ed03279304bd983bed53da7c31dddc5577ebde0fe","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0a079800b6ceb05c5bd6519cfecba754a761906d32f92acb63ceb49a2d5912ec","nullifierTree":"0x2b8050c8dc0574db4f1134e26a2a38f5d92a22308843252c7687e85e4b1903ab","publicDataTree":"0x052a848574a4a94b2c20ec2e793d6dd973d873fb267aeb9ccd75998f2071eddb"},"totalFees":6794052480,"totalManaUsed":20448}} 10:37:52 [10:37:52.326] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 10:37:52 [10:37:52.436] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x128b9483d6f59701c243956c128036beb994f18336613d2306a0484b454668c7"} 10:37:52 [10:37:52.474] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:52 [10:37:52.482] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 10:37:52 [10:37:52.482] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x128b9483d6f59701c243956c128036beb994f18336613d2306a0484b454668c7"} 10:37:52 [10:37:52.539] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 10:37:52 [10:37:52.582] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x128b9483d6f59701c243956c128036beb994f18336613d2306a0484b454668c7"} 10:37:52 [10:37:52.590] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 10:37:52 [10:37:52.700] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:52 [10:37:52.822] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x128b9483d6f59701c243956c128036beb994f18336613d2306a0484b454668c7"} 10:37:52 [10:37:52.875] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 10:37:52 [10:37:52.875] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x128b9483d6f59701c243956c128036beb994f18336613d2306a0484b454668c7"} 10:37:52 [10:37:52.919] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:52 [10:37:52.929] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x305b4b99d4a4c665e0c15e28f08a84022c81142b706fdd7cb19bdcb01d4cb531","blockNumber":2,"slot":3} 10:37:52 [10:37:52.959] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x128b9483d6f59701c243956c128036beb994f18336613d2306a0484b454668c7"} 10:37:52 [10:37:52.966] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 10:37:52 [10:37:52.979] VERBOSE: simulator:client_execution_context:debug_log Setting 0x128b9483d6f59701c243956c128036beb994f18336613d2306a0484b454668c7 as fee payer 10:37:53 [10:37:53.128] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:53 [10:37:53.375] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:53 [10:37:53.812] INFO: pxe:service Proving completed in 1520.3470830000006ms {"timings":{"total":1520.3470830000006,"sync":17.9991229999996,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":108.45276600000034,"oracles":{"callPrivateFunction":{"times":[367.3163999999997,276.17426800000067]}}},{"functionName":"private_kernel_init","time":94.13293700000031},{"functionName":"SchnorrAccount:constructor","time":336.4651590000012,"oracles":{"getContractInstance":{"times":[6.829635000000053]},"debugLog":{"times":[0.6241939999999886,0.569311999999627]},"fetchTaggedLogs":{"times":[106.35145399999965]},"loadCapsule":{"times":[0.242565000000468,0.3084070000004431,0.27763600000071165]},"notifyCreatedNullifier":{"times":[0.2618559999991703,0.22717499999998836]},"notifyCreatedNote":{"times":[0.1547229999996489]},"getRandomField":{"times":[0.17983400000048277,0.19841400000041176,0.1004319999992731,0.08444199999939883,0.0752520000005461,0.06532100000003993,0.06139100000109465,0.059660999999323394,0.05848100000002887,0.05840100000023085,0.04444100000000617]},"getIndexedTaggingSecretAsSender":{"times":[55.33965799999896]},"incrementAppTaggingSecretIndexAsSender":{"times":[34.005097999999634]}}},{"functionName":"private_kernel_inner","time":141.3071519999994},{"functionName":"SchnorrAccount:entrypoint","time":237.16848500000015,"oracles":{"debugLog":{"times":[0.5618419999991602,0.8304279999993014,0.5004509999998845]},"fetchTaggedLogs":{"times":[89.00710799999979]},"loadCapsule":{"times":[0.4471499999999651,0.2618849999998929,0.30340699999942444]},"getNotes":{"times":[1.208306000000448]},"getAuthWitness":{"times":[0.2312450000008539]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.43714900000122725]}}},{"functionName":"private_kernel_inner","time":109.1939540000003},{"functionName":"private_kernel_reset","time":146.15398399999867},{"functionName":"private_kernel_tail","time":65.32742800000051}],"unaccounted":264.14609500000006}} 10:37:53 [10:37:53.823] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:53 [10:37:53.841] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x305b4b99d4a4c665e0c15e28f08a84022c81142b706fdd7cb19bdcb01d4cb531","blockNumber":2,"slot":3} 10:37:53 [10:37:53.855] VERBOSE: p2p:tx_pool Adding tx 0x243fe1eac1883fcc2b8ea78794e09fbdb938c4fb15d27fe78f074b3b9fd0fe41 to pool {"eventName":"tx-added-to-pool","txHash":"0x243fe1eac1883fcc2b8ea78794e09fbdb938c4fb15d27fe78f074b3b9fd0fe41","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 10:37:53 [10:37:53.860] INFO: node Received tx 0x243fe1eac1883fcc2b8ea78794e09fbdb938c4fb15d27fe78f074b3b9fd0fe41 {"txHash":"0x243fe1eac1883fcc2b8ea78794e09fbdb938c4fb15d27fe78f074b3b9fd0fe41"} 10:37:53 [10:37:53.861] INFO: pxe:service Sent transaction 0x243fe1eac1883fcc2b8ea78794e09fbdb938c4fb15d27fe78f074b3b9fd0fe41 10:37:54 [10:37:54.033] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:54 [10:37:54.236] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:54 [10:37:54.364] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 10:37:54 [10:37:54.378] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-24T10:42:44.000Z","now":"2025-06-24T10:42:46.375Z"} 10:37:54 [10:37:54.412] VERBOSE: simulator:public-processor Processed tx 0x243fe1eac1883fcc2b8ea78794e09fbdb938c4fb15d27fe78f074b3b9fd0fe41 with no public calls in 25.087328999999954ms {"txHash":"0x243fe1eac1883fcc2b8ea78794e09fbdb938c4fb15d27fe78f074b3b9fd0fe41","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":25.087328999999954} 10:37:54 [10:37:54.424] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.045480859999999665s {"duration":0.045480859999999665,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 10:37:54 [10:37:54.451] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:54 [10:37:54.583] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1d5b66caa65904b43067a7c7a99210ffabe395993ce5627095cf661aa2893f47","globalVariables":{"chainId":31337,"version":3291947012,"blockNumber":2,"slotNumber":3,"timestamp":1750761764,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x243fe1eac1883fcc2b8ea78794e09fbdb938c4fb15d27fe78f074b3b9fd0fe41"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":217.92839000000095,"publicProcessDuration":46.067221999999674,"rollupCircuitsDuration":205.2041509999999,"txCount":1,"blockNumber":2,"blockTimestamp":1750761764,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:37:54 [10:37:54.587] VERBOSE: sequencer Attesting committee is empty 10:37:54 [10:37:54.687] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:54 [10:37:54.913] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:54 [10:37:54.918] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x9bf3ab7e5a098b99f2cd023ea3b3dbfda4ff5efd613ccae816979f0748c92555 10:37:54 [10:37:54.918] VERBOSE: sequencer-client Sent L1 transaction 0x9bf3ab7e5a098b99f2cd023ea3b3dbfda4ff5efd613ccae816979f0748c92555 {"gasLimit":470283,"maxFeePerGas":"1.303611186","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 10:37:54 [10:37:54.931] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:37:54 [10:37:54.932] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x9bf3ab7e5a098b99f2cd023ea3b3dbfda4ff5efd613ccae816979f0748c92555","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":2,"blockTimestamp":1750761764,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:37:54 [10:37:54.932] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 10:37:54 [10:37:54.937] INFO: blob-sink:server Received blob sidecar for block 0x4910f95683fea66b1104eab3df520e1f3c9a40daaacf20cdcbdb654e1b079bc2 10:37:54 [10:37:54.943] INFO: blob-sink:server Blob sidecar stored successfully for block 0x4910f95683fea66b1104eab3df520e1f3c9a40daaacf20cdcbdb654e1b079bc2 10:37:55 [10:37:55.012] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750761800] on http://127.0.0.1:8545 10:37:55 [10:37:55.013] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 10:37:55 [10:37:55.015] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750761800 10:37:55 [10:37:55.015] WARN: foundation:test-date-provider Time set to 2025-06-24T10:43:20.000Z {"offset":324985,"timeMs":1750761800000} 10:37:55 [10:37:55.015] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 10:37:55 [10:37:55.119] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:55 [10:37:55.123] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 10:37:55 [10:37:55.125] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 10:37:55 [10:37:55.128] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 10:37:55 [10:37:55.372] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:55 [10:37:55.385] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x1d5b66caa65904b43067a7c7a99210ffabe395993ce5627095cf661aa2893f47","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3291947012,"blockNumber":2,"slotNumber":3,"timestamp":1750761764,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x148158b6aebc15089bdedb3e095ef02f28fb50298bf1e8b6120c2c7ba951cfc1","archiveNextLeafIndex":3} 10:37:55 [10:37:55.387] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 10:37:55 [10:37:55.486] INFO: e2e:e2e_partial_notes Deploying Token contract... 10:37:55 [10:37:55.822] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:55 [10:37:55.826] WARN: pxe:service No artifact found for contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb when looking for its metadata 10:37:55 [10:37:55.830] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb as part of deployment for 0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c 10:37:56 [10:37:56.025] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":9.015371000001323,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750761764,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:37:56 [10:37:56.030] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:56 [10:37:56.040] VERBOSE: p2p Synched to latest block 2 10:37:56 [10:37:56.358] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:56 [10:37:56.375] INFO: pxe:service Added contract Token at 0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c with class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 10:37:56 [10:37:56.397] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x148158b6aebc15089bdedb3e095ef02f28fb50298bf1e8b6120c2c7ba951cfc1","header":{"contentCommitment":{"blobsHash":"0x001c185043f46b5ae90b4cdf6a07ef6cc859145cbede4aa3f892420451e44550","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750761764,"version":3291947012},"lastArchive":"0x305b4b99d4a4c665e0c15e28f08a84022c81142b706fdd7cb19bdcb01d4cb531","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x287e2b8bf0ab24471b6c9a1f18cf307de2a8f81e1a601e9aeb2f90e1620dd0b6","nullifierTree":"0x1e91e11df50a413aa42d5e738da578efe7e419a2396346b7553c6f36d69d8472","publicDataTree":"0x1edc80168905f5f38732d5198fb63a4e1529f131ef1aa36f39d90a87d1d83fcd"},"totalFees":5018455040,"totalManaUsed":15104}} 10:37:56 [10:37:56.464] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:37:56 [10:37:56.503] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 10:37:56 [10:37:56.504] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:37:56 [10:37:56.545] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x148158b6aebc15089bdedb3e095ef02f28fb50298bf1e8b6120c2c7ba951cfc1","blockNumber":3,"slot":4} 10:37:56 [10:37:56.563] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:56 [10:37:56.633] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:37:56 [10:37:56.645] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x189b2a5c33255a84dfac631008256a572163eb1afd612ae22132a9b5213f6f19 10:37:56 [10:37:56.667] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 10:37:56 [10:37:56.669] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 10:37:56 [10:37:56.682] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 10:37:56 [10:37:56.683] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 10:37:56 [10:37:56.691] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0a4aa4b6bfd3384c595af6021c1a848f1836bfe4cd6a38eab99c0432e43943fc","nullifier":"0x054e383f7e061ba6f1a3da16c3920146b7800a18e4e34b711cde0402a031cf64"} 10:37:56 [10:37:56.694] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 10:37:56 [10:37:56.713] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045 as fee payer 10:37:56 [10:37:56.754] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 10:37:57 [10:37:57.181] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x15aae2e0e2a7081ca06113c682f5373e67df2c3553eda599696574961c502fb4,0x0d6c93288fa1ed94413e630fd9c2f5ded8cd010325d6df84f5b9c8ac12bcac0c,0x146e9c4b5411f0c1e61cf995f05f86929ea24d4cd1b7e2f76bf817490af90f2f 10:37:57 [10:37:57.298] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 10:37:57 [10:37:57.357] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:57 [10:37:57.422] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 10:37:57 [10:37:57.440] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x148158b6aebc15089bdedb3e095ef02f28fb50298bf1e8b6120c2c7ba951cfc1","blockNumber":3,"slot":4} 10:37:57 [10:37:57.461] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 10:37:57 [10:37:57.471] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c,0x0000000000000000000000000000000000000000000000000000000000000001,0x26cef74b14640123bfe7febc255a747743540a5af5bfcc809d07df8bdfeecfef,0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb,0x1cf9f6346c89f5e31903ea0339e2d011f45c4bc0f83dc5acfefdd4cef59b5da1,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045 10:37:57 [10:37:57.619] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:57 [10:37:57.845] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:58 [10:37:58.163] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:58 [10:37:58.167] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x148158b6aebc15089bdedb3e095ef02f28fb50298bf1e8b6120c2c7ba951cfc1","blockNumber":3,"slot":4} 10:37:58 [10:37:58.432] INFO: pxe:service Proving completed in 2039.8058390000006ms {"timings":{"total":2039.8058390000006,"sync":7.055989000000409,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":330.653038000004,"oracles":{"debugLog":{"times":[0.8269079999990936,0.6146730000000389,1.805238000000827,0.697905000000901,0.6910950000019511,0.6011519999992743,0.5259310000001278,0.8244169999998121]},"fetchTaggedLogs":{"times":[133.7909129999971]},"loadCapsule":{"times":[0.44465000000127475,0.5570719999996072,4.937874999999622,0.2827760000000126,0.34117799999876297,0.27288600000247243]},"getSharedSecret":{"times":[5.505427000000054]},"aes128Decrypt":{"times":[1.2040149999993446,2.76372800000172]},"getPublicKeysAndPartialAddress":{"times":[4.124657000000298]},"getKeyValidationRequest":{"times":[4.245049000001018]},"deliverNote":{"times":[7.6314410000013595]},"deleteCapsule":{"times":[0.5556020000003628]},"storeCapsule":{"times":[0.45140900000114925]},"getNotes":{"times":[2.1670759999979055]},"getAuthWitness":{"times":[0.29788600000028964]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08645099999921513]},"callPrivateFunction":{"times":[639.1052979999986,120.53450399999929]},"notifyEnqueuedPublicFunctionCall":{"times":[0.29746700000032433]}}},{"functionName":"private_kernel_init","time":60.667600000000675},{"functionName":"ContractClassRegisterer:register","time":626.5024620000004,"oracles":{"loadCapsule":{"times":[3.090844999998808]},"notifyCreatedNullifier":{"times":[0.3826680000020133]},"debugLog":{"times":[0.5958219999993162]},"notifyCreatedContractClassLog":{"times":[12.094035999998596]}}},{"functionName":"private_kernel_inner","time":106.90350599999874},{"functionName":"ContractInstanceDeployer:deploy","time":80.90137599999798,"oracles":{"storeInExecutionCache":{"times":[0.4046589999998105]},"callPrivateFunction":{"times":[33.787092999999004]},"notifyCreatedNullifier":{"times":[0.23721500000101514]},"debugLog":{"times":[0.5321619999995164]}}},{"functionName":"private_kernel_inner","time":109.3153170000005},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":25.491558999998233,"oracles":{}},{"functionName":"private_kernel_inner","time":115.4734669999998},{"functionName":"private_kernel_reset","time":175.58902599999783},{"functionName":"private_kernel_tail","time":91.99642200000017}],"unaccounted":309.2560770000018}} 10:37:58 [10:37:58.463] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:58 [10:37:58.644] VERBOSE: p2p:tx_pool Adding tx 0x0d752bf8d048cb7b08a83484057d5831b26ee01981446ffa7198e6347caf5237 to pool {"eventName":"tx-added-to-pool","txHash":"0x0d752bf8d048cb7b08a83484057d5831b26ee01981446ffa7198e6347caf5237","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":709,"proofSize":172052,"size":324937,"feePaymentMethod":"fee_juice"} 10:37:58 [10:37:58.664] INFO: node Received tx 0x0d752bf8d048cb7b08a83484057d5831b26ee01981446ffa7198e6347caf5237 {"txHash":"0x0d752bf8d048cb7b08a83484057d5831b26ee01981446ffa7198e6347caf5237"} 10:37:58 [10:37:58.664] INFO: pxe:service Sent transaction 0x0d752bf8d048cb7b08a83484057d5831b26ee01981446ffa7198e6347caf5237 10:37:58 [10:37:58.669] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:58 [10:37:58.689] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 10:37:58 [10:37:58.700] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-24T10:43:20.000Z","now":"2025-06-24T10:43:23.685Z"} 10:37:58 [10:37:58.882] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:59 [10:37:59.132] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:59 [10:37:59.205] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x5e134abf completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x5e134abf","duration":229.33634000000166} 10:37:59 [10:37:59.358] VERBOSE: simulator:public-processor Processed tx 0x0d752bf8d048cb7b08a83484057d5831b26ee01981446ffa7198e6347caf5237 with 1 public calls in 524.9698500000013ms {"txHash":"0x0d752bf8d048cb7b08a83484057d5831b26ee01981446ffa7198e6347caf5237","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":524.9698500000013} 10:37:59 [10:37:59.359] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:59 [10:37:59.363] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.6620286019999985s {"duration":0.6620286019999985,"rate":576759.0687871834,"totalPublicGas":{"daGas":6144,"l2Gas":381831},"totalBlockGas":{"daGas":380416,"l2Gas":418375},"totalSizeInBytes":24384} 10:37:59 [10:37:59.537] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 449728.5904546209 mana/s {"blockHash":"0x14982b71d4983c40d29f6f8bea9bfb423f493ac1a08b38983cf96f5623a79cdc","globalVariables":{"chainId":31337,"version":3291947012,"blockNumber":3,"slotNumber":4,"timestamp":1750761800,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0d752bf8d048cb7b08a83484057d5831b26ee01981446ffa7198e6347caf5237"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":848.5161570000018,"publicProcessDuration":662.415570000001,"rollupCircuitsDuration":838.3816829999996,"txCount":1,"blockNumber":3,"blockTimestamp":1750761800,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 10:37:59 [10:37:59.541] VERBOSE: sequencer Attesting committee is empty 10:37:59 [10:37:59.637] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:59 [10:37:59.816] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xb9108260d87b498aa2b1c8c9f5790de9c001629d15b29a291220a67a6e37ef34 10:37:59 [10:37:59.816] VERBOSE: sequencer-client Sent L1 transaction 0xb9108260d87b498aa2b1c8c9f5790de9c001629d15b29a291220a67a6e37ef34 {"gasLimit":470312,"maxFeePerGas":"1.279583393","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 10:37:59 [10:37:59.828] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:37:59 [10:37:59.828] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xb9108260d87b498aa2b1c8c9f5790de9c001629d15b29a291220a67a6e37ef34","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":3,"blockTimestamp":1750761800,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 10:37:59 [10:37:59.829] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 10:37:59 [10:37:59.835] INFO: blob-sink:server Received blob sidecar for block 0x0baf60cc708f213bc151226b0685897da43029829429421d9569b35d30c8ca31 10:37:59 [10:37:59.841] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:37:59 [10:37:59.842] INFO: blob-sink:server Blob sidecar stored successfully for block 0x0baf60cc708f213bc151226b0685897da43029829429421d9569b35d30c8ca31 10:37:59 [10:37:59.848] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 10:37:59 [10:37:59.849] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 10:37:59 [10:37:59.851] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 10:37:59 [10:37:59.860] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750761836] on http://127.0.0.1:8545 10:37:59 [10:37:59.861] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 10:37:59 [10:37:59.863] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750761836 10:37:59 [10:37:59.863] WARN: foundation:test-date-provider Time set to 2025-06-24T10:43:56.000Z {"offset":356137,"timeMs":1750761836000} 10:37:59 [10:37:59.863] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 10:38:00 [10:38:00.046] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:00 [10:38:00.319] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:00 [10:38:00.334] VERBOSE: archiver:block-helper Store contract instance at 0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c 10:38:00 [10:38:00.357] VERBOSE: archiver:block-helper Store contract class 0x04bc49f0673daeaf90a2800f1977e7a6926baa21f8f7788eeadb74f9e27424fb 10:38:00 [10:38:00.396] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x14982b71d4983c40d29f6f8bea9bfb423f493ac1a08b38983cf96f5623a79cdc","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":3291947012,"blockNumber":3,"slotNumber":4,"timestamp":1750761800,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2f9c12ac257d6876f2561a9b705513bbde935ac2a3a7fc7bf354327146377fb8","archiveNextLeafIndex":4} 10:38:00 [10:38:00.410] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 10:38:00 [10:38:00.440] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":7.1330710000002,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750761800,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":709} 10:38:00 [10:38:00.516] VERBOSE: p2p Synched to latest block 3 10:38:00 [10:38:00.524] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:00 [10:38:00.899] INFO: aztecjs:deploy_sent_tx Contract 0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c successfully deployed. 10:38:00 [10:38:00.900] INFO: e2e:e2e_partial_notes L2 contract deployed 10:38:00 [10:38:00.905] INFO: e2e:e2e_partial_notes Running test: partial notes mint to private 10:38:00 [10:38:00.907] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:01 [10:38:01.174] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:01 [10:38:01.195] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2f9c12ac257d6876f2561a9b705513bbde935ac2a3a7fc7bf354327146377fb8","blockNumber":4,"slot":5} 10:38:01 [10:38:01.226] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x2f9c12ac257d6876f2561a9b705513bbde935ac2a3a7fc7bf354327146377fb8","header":{"contentCommitment":{"blobsHash":"0x00a043c568a6bcb9d56ddb03399bb2638812255e3766fe5bbbe4a03512bb016b","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750761800,"version":3291947012},"lastArchive":"0x148158b6aebc15089bdedb3e095ef02f28fb50298bf1e8b6120c2c7ba951cfc1","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x287e2b8bf0ab24471b6c9a1f18cf307de2a8f81e1a601e9aeb2f90e1620dd0b6","nullifierTree":"0x2a6690d9d9798e9b7c75bbe5ac6d3d359e023f576db97166ab05c4480029f54d","publicDataTree":"0x2fe5745d737e1f014348e59bdc410b2180f73dcfdce69e91e063c6850ca0b827"},"totalFees":139009277500,"totalManaUsed":418375}} 10:38:01 [10:38:01.289] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:38:01 [10:38:01.335] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 10:38:01 [10:38:01.335] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:38:01 [10:38:01.392] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:01 [10:38:01.557] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045"} 10:38:01 [10:38:01.638] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:01 [10:38:01.664] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x189b2a5c33255a84dfac631008256a572163eb1afd612ae22132a9b5213f6f19 10:38:01 [10:38:01.672] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 10:38:01 [10:38:01.673] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 10:38:01 [10:38:01.679] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 10:38:01 [10:38:01.679] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 10:38:01 [10:38:01.682] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0a4aa4b6bfd3384c595af6021c1a848f1836bfe4cd6a38eab99c0432e43943fc","nullifier":"0x054e383f7e061ba6f1a3da16c3920146b7800a18e4e34b711cde0402a031cf64"} 10:38:01 [10:38:01.684] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 10:38:01 [10:38:01.696] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2a8f5854d0648956caa8a1752423d80bacb832507e85a0af26ab558bae24a045 as fee payer 10:38:01 [10:38:01.906] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:01 [10:38:01.994] VERBOSE: simulator:private_execution Executing private function Token:mint_to_private {"contract":"0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c"} 10:38:02 [10:38:02.035] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 10:38:02 [10:38:02.035] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c"} 10:38:02 [10:38:02.036] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2f9c12ac257d6876f2561a9b705513bbde935ac2a3a7fc7bf354327146377fb8","blockNumber":4,"slot":5} 10:38:02 [10:38:02.135] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:02 [10:38:02.190] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c"} 10:38:02 [10:38:02.195] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 10:38:02 [10:38:02.340] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:02 [10:38:02.612] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:03 [10:38:03.407] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:03 [10:38:03.431] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2f9c12ac257d6876f2561a9b705513bbde935ac2a3a7fc7bf354327146377fb8","blockNumber":4,"slot":5} 10:38:03 [10:38:03.891] INFO: pxe:service Proving completed in 2685.569377ms {"timings":{"total":2685.569377,"sync":22.872772999999142,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":556.4956439999987,"oracles":{"debugLog":{"times":[0.6462629999987257,0.37559699999837903,0.4715299999988929,0.46354000000064843,0.363787999998749,0.3292670000009821,0.2707460000019637,0.48992100000032224]},"fetchTaggedLogs":{"times":[326.83027700000093]},"loadCapsule":{"times":[0.20008499999676133,0.15590299999894341,0.29457600000023376,0.1809240000002319,0.15956400000141002,0.19707500000004075]},"getSharedSecret":{"times":[3.1650159999990137]},"aes128Decrypt":{"times":[0.3022259999997914,0.7240160000001197]},"getPublicKeysAndPartialAddress":{"times":[1.5013419999995676]},"getKeyValidationRequest":{"times":[1.691445999997086]},"deliverNote":{"times":[2.934852000002138]},"deleteCapsule":{"times":[0.23757499999919673]},"storeCapsule":{"times":[0.2884359999989101]},"getNotes":{"times":[1.4618609999997716]},"getAuthWitness":{"times":[0.24677499999961583]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05689200000051642]},"callPrivateFunction":{"times":[744.3745490000001]}}},{"functionName":"private_kernel_init","time":85.29703000000154},{"functionName":"Token:mint_to_private","time":649.2706820000021,"oracles":{"debugLog":{"times":[0.5491119999969669,0.47810000000026776]},"fetchTaggedLogs":{"times":[158.3607520000005]},"loadCapsule":{"times":[0.2573049999991781,0.25782600000093225,0.5005309999978635]},"getRandomField":{"times":[0.2476749999987078,0.22168500000043423,0.263225999999122,0.11758299999928568,0.08113199999934295,0.11117200000080629,0.08999199999743723,0.08788099999947008,0.07862200000090525,0.07325200000195764,0.07036199999856763,0.07004100000267499]},"getIndexedTaggingSecretAsSender":{"times":[112.80037000000084]},"incrementAppTaggingSecretIndexAsSender":{"times":[99.42633899999782]},"notifyCreatedNullifier":{"times":[0.31843600000138395]},"storeInExecutionCache":{"times":[0.04376100000081351]},"notifyEnqueuedPublicFunctionCall":{"times":[0.04957099999955972]}}},{"functionName":"private_kernel_inner","time":141.9343860000008},{"functionName":"private_kernel_reset","time":219.73762700000225},{"functionName":"private_kernel_tail","time":93.23728699999992}],"unaccounted":916.7239479999953}} 10:38:03 [10:38:03.925] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:03 [10:38:03.951] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x2f9c12ac257d6876f2561a9b705513bbde935ac2a3a7fc7bf354327146377fb8","blockNumber":4,"slot":5} 10:38:03 [10:38:03.955] VERBOSE: p2p:tx_pool Adding tx 0x2f9ce3be6fbdb7f6b6f8a8b6b65a40c3bb2dabec4a7832d8ef0b87dfeb69a425 to pool {"eventName":"tx-added-to-pool","txHash":"0x2f9ce3be6fbdb7f6b6f8a8b6b65a40c3bb2dabec4a7832d8ef0b87dfeb69a425","noteHashCount":0,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226377,"feePaymentMethod":"fee_juice"} 10:38:03 [10:38:03.961] INFO: node Received tx 0x2f9ce3be6fbdb7f6b6f8a8b6b65a40c3bb2dabec4a7832d8ef0b87dfeb69a425 {"txHash":"0x2f9ce3be6fbdb7f6b6f8a8b6b65a40c3bb2dabec4a7832d8ef0b87dfeb69a425"} 10:38:03 [10:38:03.961] INFO: pxe:service Sent transaction 0x2f9ce3be6fbdb7f6b6f8a8b6b65a40c3bb2dabec4a7832d8ef0b87dfeb69a425 10:38:04 [10:38:04.129] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:04 [10:38:04.332] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:04 [10:38:04.477] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 10:38:04 [10:38:04.495] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-24T10:43:56.000Z","now":"2025-06-24T10:44:00.632Z"} 10:38:04 [10:38:04.536] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:04 [10:38:04.580] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xf1e7e92a completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xf1e7e92a","duration":59.571367000000464} 10:38:04 [10:38:04.602] VERBOSE: simulator:public-processor Processed tx 0x2f9ce3be6fbdb7f6b6f8a8b6b65a40c3bb2dabec4a7832d8ef0b87dfeb69a425 with 1 public calls in 92.42151100000046ms {"txHash":"0x2f9ce3be6fbdb7f6b6f8a8b6b65a40c3bb2dabec4a7832d8ef0b87dfeb69a425","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":92.42151100000046} 10:38:04 [10:38:04.603] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.10709712000000218s {"duration":0.10709712000000218,"rate":396789.3814511458,"totalPublicGas":{"daGas":2048,"l2Gas":42495},"totalBlockGas":{"daGas":13312,"l2Gas":73695},"totalSizeInBytes":1216} 10:38:04 [10:38:04.747] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:04 [10:38:04.763] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 148306.12367623745 mana/s {"blockHash":"0x175c2efdf3856e94760dc2fd154a61fc5172610ca2495f518c0021121d576def","globalVariables":{"chainId":31337,"version":3291947012,"blockNumber":4,"slotNumber":5,"timestamp":1750761836,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x2f9ce3be6fbdb7f6b6f8a8b6b65a40c3bb2dabec4a7832d8ef0b87dfeb69a425"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":286.0044259999995,"publicProcessDuration":107.52034899999853,"rollupCircuitsDuration":269.1016090000012,"txCount":1,"blockNumber":4,"blockTimestamp":1750761836,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 10:38:04 [10:38:04.768] VERBOSE: sequencer Attesting committee is empty 10:38:05 [10:38:05.012] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:05 [10:38:05.020] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x456a48031c5a268ca125e7de163d111cd1863fcc577424eacd20ec4b0469f439 10:38:05 [10:38:05.020] VERBOSE: sequencer-client Sent L1 transaction 0x456a48031c5a268ca125e7de163d111cd1863fcc577424eacd20ec4b0469f439 {"gasLimit":470324,"maxFeePerGas":"1.26112774","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 10:38:05 [10:38:05.030] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:38:05 [10:38:05.031] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x456a48031c5a268ca125e7de163d111cd1863fcc577424eacd20ec4b0469f439","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":4,"blockTimestamp":1750761836,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 10:38:05 [10:38:05.031] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 10:38:05 [10:38:05.037] INFO: blob-sink:server Received blob sidecar for block 0xb7b7ebffebe8a857d63b845235376418845c5c1b58b57456bf718e798380670a 10:38:05 [10:38:05.043] INFO: blob-sink:server Blob sidecar stored successfully for block 0xb7b7ebffebe8a857d63b845235376418845c5c1b58b57456bf718e798380670a 10:38:05 [10:38:05.064] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750761872] on http://127.0.0.1:8545 10:38:05 [10:38:05.065] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 10:38:05 [10:38:05.067] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750761872 10:38:05 [10:38:05.067] WARN: foundation:test-date-provider Time set to 2025-06-24T10:44:32.000Z {"offset":386933,"timeMs":1750761872000} 10:38:05 [10:38:05.067] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 10:38:05 [10:38:05.215] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:05 [10:38:05.228] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 10:38:05 [10:38:05.231] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 10:38:05 [10:38:05.234] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 10:38:05 [10:38:05.484] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:05 [10:38:05.503] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x175c2efdf3856e94760dc2fd154a61fc5172610ca2495f518c0021121d576def","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":3291947012,"blockNumber":4,"slotNumber":5,"timestamp":1750761836,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x1fb472821d7e89c6c1ca256dc4c72fe98936f02f3208369aa3a948b1f532d685","archiveNextLeafIndex":5} 10:38:05 [10:38:05.507] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 10:38:05 [10:38:05.607] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":8.476670000000013,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750761836,"privateLogCount":1,"publicLogCount":1,"contractClassLogCount":0,"contractClassLogSize":0} 10:38:05 [10:38:05.622] VERBOSE: p2p Synched to latest block 4 10:38:05 [10:38:05.689] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:05 [10:38:05.892] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:06 [10:38:06.062] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x1fb472821d7e89c6c1ca256dc4c72fe98936f02f3208369aa3a948b1f532d685","header":{"contentCommitment":{"blobsHash":"0x00b25c977bd20311e1c449df162fd18891b4d8a2e187a58cfc15f3468d7f4d12","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750761836,"version":3291947012},"lastArchive":"0x2f9c12ac257d6876f2561a9b705513bbde935ac2a3a7fc7bf354327146377fb8","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2855e430827428d19d4f9e93d7745ade367381f7935c8f3d881f356bee70a7c0","nullifierTree":"0x1ccf4190a0422a151e63f16b0199200b86dff7dc718a4a17d3648fb3a095b3b4","publicDataTree":"0x14f52072a292e8493f6b5ffc1f88faaca2f47d66529ffee15c75786f5959ab51"},"totalFees":3736336500,"totalManaUsed":73695}} 10:38:06 [10:38:06.065] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x1fb472821d7e89c6c1ca256dc4c72fe98936f02f3208369aa3a948b1f532d685","blockNumber":5,"slot":6} 10:38:06 [10:38:06.191] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:06 [10:38:06.410] VERBOSE: simulator Executing utility function balance_of_private {"contract":"0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c","selector":"0x4375727c"} 10:38:06 [10:38:06.421] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 10:38:06 [10:38:06.425] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 10:38:06 [10:38:06.425] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c"} 10:38:06 [10:38:06.545] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c"} 10:38:06 [10:38:06.552] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x003f8c24e1db3749c4c50578e90a06545fd6aed4c3b73e96082c97f7c0c68d97 10:38:06 [10:38:06.564] VERBOSE: simulator:client_view_context:debug_log Processing partial note private msg 10:38:06 [10:38:06.576] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000001 pending partial notes 10:38:06 [10:38:06.585] VERBOSE: simulator:client_view_context:debug_log Completion log found for partial note with tag 0x245ab49549704b79b9f8ef4899c50dd3e1e1ff08d1f716142775669fe1e9f544 10:38:06 [10:38:06.586] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c for storage slot 0x034630bcc4b14f96753ed3b59332186331bcc3d3bda372ca4e55ac5e34e6ca0d 10:38:06 [10:38:06.588] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x1fb472821d7e89c6c1ca256dc4c72fe98936f02f3208369aa3a948b1f532d685","blockNumber":5,"slot":6} 10:38:06 [10:38:06.592] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 10:38:06 [10:38:06.593] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes for partial note with tag 0x245ab49549704b79b9f8ef4899c50dd3e1e1ff08d1f716142775669fe1e9f544 10:38:06 [10:38:06.595] VERBOSE: pxe:service Added note {"index":192,"contract":"0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c","slot":"0x034630bcc4b14f96753ed3b59332186331bcc3d3bda372ca4e55ac5e34e6ca0d","noteHash":"0x03f9630224ac135a20ef94143a8be397608576b037a5a0c2b5b6620cdc9fa2e7","nullifier":"0x10cccce4fff324aa0c0974ea81ed6b3ae206ba05aa4e879c2e7204f5062cff79"} 10:38:06 [10:38:06.599] VERBOSE: simulator Utility simulation for 0x0174bf8eee4c51864004c0e4cd6e0dc6db843cf45ccbf98ccef6a820956d735c.0x4375727c completed 10:38:06 [10:38:06.604] INFO: node Stopping 10:38:06 [10:38:06.605] INFO: slasher Slasher client stopped. 10:38:06 [10:38:06.605] INFO: sequencer Stopped sequencer 10:38:06 [10:38:06.605] INFO: p2p P2P client stopped. 10:38:06 [10:38:06.607] INFO: world_state Stopped world state synchronizer 10:38:06 [10:38:06.607] INFO: archiver Stopped. 10:38:06 [10:38:06.607] INFO: node Stopped 10:38:06 [10:38:06.608] VERBOSE: e2e:e2e_partial_notes Cleaning up ACVM state 10:38:06 [10:38:06.608] INFO: e2e:e2e_partial_notes Cleaning up ACVM temp directory /tmp/fe02b65d 10:38:06 [10:38:06.609] VERBOSE: e2e:e2e_partial_notes Cleaning up BB state 10:38:06 [10:38:06.617] INFO: blob-sink:server Stopping blob sink 10:38:06 [10:38:06.618] INFO: blob-sink:server Blob sink stopped 10:38:06 [10:38:06.618] VERBOSE: e2e:e2e_partial_notes Cleaning up data directory at /tmp/178d40d08f6bf0dd 10:38:06 PASS src/e2e_partial_notes.test.ts 10:38:06 partial notes 10:38:06 ✓ mint to private (5700 ms) 10:38:06 10:38:06 Test Suites: 1 passed, 1 total 10:38:06 Tests: 1 passed, 1 total 10:38:06 Snapshots: 0 total 10:38:06 Time: 27.942 s 10:38:06 Ran all test suites matching /src\/e2e_partial_notes.test.ts/i. 10:38:06 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?