Parent Log: http://ci.aztec-labs.com/62cb07227cb8778b Command: 3cad4e1fd0756a5c:ISOLATE=1:NAME=e2e_keys yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_keys.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/e9a2301883801edbe36ea8bba05dcca7e714f30a Env: REF_NAME=gh-readonly-queue/master/pr-15131-464e1a9d9b40b5188586643b44bc52bffccbc3e6 CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Wed Jun 18 12:49:41 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15131_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c393731fea71056e_master 12:49:41 +++ id -u 12:49:41 +++ id -g 12:49:41 ++ docker run -d --name e2e_keys --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_keys.test.ts'\''' 12:49:41 + cid=2a09845fd1ee4481c104e9e91423ea0d5f2a214ed449331824e9832520d5705b 12:49:41 + set +x 12:49:42 {"level":25,"time":1750250982152,"pid":12,"hostname":"2a09845fd1ee","module":"logger","msg":"Logger initialized with level verbose"} 12:49:49 [12:49:49.407] INFO: e2e:e2e_keys Logging metrics to log/unknown.jsonl 12:49:49 [12:49:49.729] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-qsCeQF/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 12:49:49 [12:49:49.775] INFO: e2e:e2e_keys Calling anvil_setBlockTimestampInterval with params: [12] 12:49:49 [12:49:49.808] WARN: e2e:e2e_keys Set block interval to 12 12:49:49 [12:49:49.809] VERBOSE: e2e:e2e_keys Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 12:49:49 [12:49:49.941] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 12:49:49 [12:49:49.952] VERBOSE: e2e:e2e_keys Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 12:49:49 [12:49:49.975] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 12:49:49 [12:49:49.982] VERBOSE: e2e:e2e_keys Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 12:49:50 [12:49:50.000] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 12:49:50 [12:49:50.011] VERBOSE: e2e:e2e_keys Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 12:49:50 [12:49:50.036] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 12:49:50 [12:49:50.042] VERBOSE: e2e:e2e_keys Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 12:49:50 [12:49:50.065] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 12:49:50 [12:49:50.072] VERBOSE: e2e:e2e_keys Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 12:49:50 [12:49:50.093] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 12:49:50 [12:49:50.102] VERBOSE: e2e:e2e_keys Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 12:49:50 [12:49:50.104] VERBOSE: e2e:e2e_keys Waiting for deployments to complete 12:49:50 [12:49:50.104] INFO: e2e:e2e_keys Waiting for 6 transactions to be mined... 12:49:50 [12:49:50.131] INFO: e2e:e2e_keys All transactions mined successfully 12:49:50 [12:49:50.164] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 12:49:50 [12:49:50.165] VERBOSE: e2e:e2e_keys Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 12:49:50 [12:49:50.186] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 12:49:50 [12:49:50.216] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 12:49:50 [12:49:50.223] VERBOSE: e2e:e2e_keys Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 12:49:50 [12:49:50.247] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 12:49:50 [12:49:50.248] VERBOSE: e2e:e2e_keys Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 12:49:50 [12:49:50.267] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 12:49:50 [12:49:50.272] VERBOSE: e2e:e2e_keys Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 12:49:50 [12:49:50.295] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 12:49:50 [12:49:50.296] VERBOSE: e2e:e2e_keys Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 12:49:50 [12:49:50.296] VERBOSE: e2e:e2e_keys Waiting for deployments to complete 12:49:50 [12:49:50.296] INFO: e2e:e2e_keys Waiting for 8 transactions to be mined... 12:49:50 [12:49:50.322] INFO: e2e:e2e_keys All transactions mined successfully 12:49:50 [12:49:50.335] VERBOSE: e2e:e2e_keys Deployed shared contracts 12:49:50 [12:49:50.355] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 12:49:50 [12:49:50.355] VERBOSE: e2e:e2e_keys Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 12:49:50 [12:49:50.359] VERBOSE: e2e:e2e_keys Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 12:49:50 [12:49:50.378] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 12:49:50 [12:49:50.407] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 12:49:50 [12:49:50.422] VERBOSE: e2e:e2e_keys Awaiting for linked libraries to be deployed 12:49:50 [12:49:50.526] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x8644647fc3c966f26dc00adc3ea391e4d19105a97873311504966032e858ee0f {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 12:49:50 [12:49:50.538] VERBOSE: e2e:e2e_keys Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 12:49:50 [12:49:50.539] INFO: e2e:e2e_keys Waiting for 9 transactions to be mined... 12:49:50 [12:49:50.604] INFO: e2e:e2e_keys All transactions mined successfully 12:49:50 [12:49:50.605] VERBOSE: e2e:e2e_keys All core contracts have been deployed 12:49:50 [12:49:50.630] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 12:49:50 [12:49:50.631] VERBOSE: e2e:e2e_keys Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 12:49:50 [12:49:50.646] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 12:49:50 [12:49:50.653] VERBOSE: e2e:e2e_keys Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 12:49:50 [12:49:50.699] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 12:49:50 [12:49:50.699] VERBOSE: e2e:e2e_keys Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 12:49:50 [12:49:50.700] INFO: e2e:e2e_keys Waiting for 10 transactions to be mined... 12:49:50 [12:49:50.727] INFO: e2e:e2e_keys All transactions mined successfully 12:49:50 [12:49:50.734] VERBOSE: e2e:e2e_keys Rollup deployed 12:49:50 [12:49:50.735] VERBOSE: e2e:e2e_keys Waiting for rollup and slash factory to be deployed 12:49:50 [12:49:50.735] INFO: e2e:e2e_keys Waiting for 10 transactions to be mined... 12:49:50 [12:49:50.762] INFO: e2e:e2e_keys All transactions mined successfully 12:49:50 [12:49:50.762] VERBOSE: e2e:e2e_keys All transactions for L1 deployment have been mined 12:49:50 [12:49:50.796] INFO: e2e:e2e_keys 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"} 12:49:50 [12:49:50.801] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 12:49:50 [12:49:50.804] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:50 [12:49:50.806] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 12:49:50 [12:49:50.807] INFO: telemetry:client Using NoopTelemetryClient 12:49:50 [12:49:50.814] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 12:49:50 [12:49:50.815] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 12:49:50 [12:49:50.816] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/42da43591ce28582/blob-sink with map size 134217728 KB (LMDB v2) 12:49:50 [12:49:50.819] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:50 [12:49:50.822] INFO: aztecjs:utils:watcher New L1 time: 1750251229 12:49:50 [12:49:50.823] WARN: foundation:test-date-provider Time set to 2025-06-18T12:53:49.000Z {"offset":238177,"timeMs":1750251229000} 12:49:50 [12:49:50.826] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 12:49:50 [12:49:50.839] INFO: blob-sink:server Server is running on http://localhost:44425 12:49:50 [12:49:50.839] VERBOSE: e2e:e2e_keys Creating and synching an aztec node... 12:49:50 [12:49:50.840] VERBOSE: e2e:e2e_keys Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/e9e1a5ed/acvm 12:49:50 [12:49:50.842] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:44425"} 12:49:50 [12:49:50.862] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 12:49:50 [12:49:50.863] INFO: archiver:lmdb Creating archiver data store at directory /tmp/42da43591ce28582/archiver with map size 134217728 KB (LMDB v2) 12:49:50 [12:49:50.864] INFO: archiver:lmdb Starting data store with maxReaders 16 12:49:51 [12:49:51.132] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:51 [12:49:51.332] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:44425"} 12:49:51 [12:49:51.341] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:51 [12:49:51.357] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:44425"} 12:49:51 [12:49:51.358] WARN: node:blob-sink:client No L1 consensus host urls configured 12:49:51 [12:49:51.358] WARN: node:blob-sink:client No archive client configured 12:49:51 [12:49:51.361] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x86fed2369a21c0e529ad1c841d3aedf7a510b7df9a6e84b00e7f18ee9aef8567 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x42f857ca742f4260ddd48a209da4c937b05efffb8ce81327a46d626c527328e2","l1BlockNumber":16}} 12:49:51 [12:49:51.379] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 12:49:51 [12:49:51.388] INFO: world-state:database Creating world state data store at directory /tmp/42da43591ce28582/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 12:49:51 [12:49:51.412] INFO: world_state Created world state synchroniser with block history of 64 12:49:51 [12:49:51.413] WARN: node Aztec node is accepting fake proofs 12:49:51 [12:49:51.430] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/42da43591ce28582/p2p with map size 134217728 KB (LMDB v2) 12:49:51 [12:49:51.437] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 12:49:51 [12:49:51.439] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/42da43591ce28582/p2p-archive with map size 134217728 KB (LMDB v2) 12:49:51 [12:49:51.443] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 12:49:51 [12:49:51.450] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/42da43591ce28582/p2p-peers with map size 134217728 KB (LMDB v2) 12:49:51 [12:49:51.455] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 12:49:51 [12:49:51.461] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 12:49:51 [12:49:51.463] VERBOSE: p2p P2P is disabled. Using dummy P2P service 12:49:51 [12:49:51.467] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 12:49:51 [12:49:51.469] INFO: world_state Started world state synchronizer from block 1 12:49:51 [12:49:51.475] VERBOSE: world-state:block_stream Starting sync from block number 0 12:49:51 [12:49:51.478] INFO: p2p Starting p2p client from block 0 with empty mempools 12:49:51 [12:49:51.478] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 12:49:51 [12:49:51.480] INFO: slasher Slasher client initialized 12:49:51 [12:49:51.480] INFO: slasher Starting Slasher client... 12:49:51 [12:49:51.523] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 12:49:51 [12:49:51.524] VERBOSE: node All Aztec Node subsystems synced 12:49:51 [12:49:51.536] INFO: sequencer-client Deploying forwarder contract 12:49:51 [12:49:51.544] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:51 [12:49:51.545] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 12:49:51 [12:49:51.563] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 12:49:51 [12:49:51.564] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 12:49:51 [12:49:51.571] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 12:49:51 [12:49:51.592] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 12:49:51 [12:49:51.593] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 12:49:51 [12:49:51.594] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/e9e1a5ed/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 12:49:51 [12:49:51.873] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 12:49:51 [12:49:51.877] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 12:49:51 [12:49:51.879] INFO: node Aztec Node version: 0.87.8 12:49:51 [12:49:51.880] 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"} 12:49:51 [12:49:51.882] VERBOSE: e2e:e2e_keys Creating a pxe... 12:49:51 [12:49:51.890] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:51 [12:49:51.912] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/830d80ae0e12aabf/pxe_data with map size 134217728 KB (LMDB v2) 12:49:51 [12:49:51.932] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x06ccfc49e5418e64aa7a8d0bd185c24de1c5011690b401ee107978b64c282c8c","blockNumber":1,"slot":2} 12:49:51 [12:49:51.935] INFO: pxe:data:lmdb Starting data store with maxReaders 16 12:49:52 [12:49:52.173] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:52 [12:49:52.289] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 12:49:52 [12:49:52.290] INFO: pxe:service Started PXE connected to chain 31337 version 3795441481 12:49:52 [12:49:52.345] INFO: pxe:service Registered account 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e 12:49:52 [12:49:52.422] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:52 [12:49:52.425] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 12:49:52 [12:49:52.429] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e 12:49:52 [12:49:52.592] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x06ccfc49e5418e64aa7a8d0bd185c24de1c5011690b401ee107978b64c282c8c","blockNumber":1,"slot":2} 12:49:52 [12:49:52.598] INFO: pxe:service Added contract SchnorrAccount at 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 12:49:52 [12:49:52.640] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:52 [12:49:52.654] VERBOSE: pxe:block_stream Starting sync from block number 0 12:49:52 [12:49:52.689] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 12:49:52 [12:49:52.810] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 12:49:53 [12:49:53.613] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 12:49:53 [12:49:53.725] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 12:49:53 [12:49:53.810] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:53 [12:49:53.843] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x06ccfc49e5418e64aa7a8d0bd185c24de1c5011690b401ee107978b64c282c8c","blockNumber":1,"slot":2} 12:49:53 [12:49:53.948] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:49:54 [12:49:54.000] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:49:54 [12:49:54.001] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:49:54 [12:49:54.032] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:54 [12:49:54.058] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:49:54 [12:49:54.065] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:49:54 [12:49:54.245] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:49:54 [12:49:54.284] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:49:54 [12:49:54.284] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:49:54 [12:49:54.289] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:54 [12:49:54.328] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:49:54 [12:49:54.332] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:49:54 [12:49:54.351] VERBOSE: simulator:client_execution_context:debug_log Setting 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e as fee payer 12:49:54 [12:49:54.425] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x06ccfc49e5418e64aa7a8d0bd185c24de1c5011690b401ee107978b64c282c8c","blockNumber":1,"slot":2} 12:49:54 [12:49:54.549] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:54 [12:49:54.844] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:55 [12:49:55.070] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:55 [12:49:55.312] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:55 [12:49:55.322] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x06ccfc49e5418e64aa7a8d0bd185c24de1c5011690b401ee107978b64c282c8c","blockNumber":1,"slot":2} 12:49:55 [12:49:55.607] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:56 [12:49:56.107] INFO: pxe:service Proving completed in 3468.3431459999993ms {"timings":{"total":3468.3431459999993,"sync":16.34286500000053,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":163.72856699999647,"oracles":{"callPrivateFunction":{"times":[1064.4919960000007,370.2974580000009,191.80555999999888]}}},{"functionName":"private_kernel_init","time":116.09685200000058},{"functionName":"ContractClassRegisterer:register","time":1041.2023610000015,"oracles":{"loadCapsule":{"times":[21.878285000000687]},"notifyCreatedNullifier":{"times":[16.61003300000084]},"debugLog":{"times":[1.2142359999998007]},"notifyCreatedContractClassLog":{"times":[7.675142000000051]}}},{"functionName":"private_kernel_inner","time":197.38101300000017},{"functionName":"SchnorrAccount:constructor","time":334.4035120000008,"oracles":{"getContractInstance":{"times":[1.5522900000014488]},"debugLog":{"times":[0.7426730000006501,0.7801259999996546]},"fetchTaggedLogs":{"times":[62.433139999999185]},"loadCapsule":{"times":[0.6933690000005299,0.39276800000152434,1.8066479999997682]},"notifyCreatedNullifier":{"times":[0.3041819999998552,0.20672399999966729]},"notifyCreatedNote":{"times":[0.4502710000015213]},"getRandomField":{"times":[0.4431109999986802,0.21225500000036845,0.09606700000040291,0.07656599999972968,0.06541499999912048,0.06347500000083528,0.04993300000023737,0.04326299999956973,0.05630399999972724,0.08352600000034727,0.05148399999961839]},"getIndexedTaggingSecretAsSender":{"times":[38.05493799999931]},"incrementAppTaggingSecretIndexAsSender":{"times":[34.95118900000125]}}},{"functionName":"private_kernel_inner","time":254.1863059999996},{"functionName":"SchnorrAccount:entrypoint","time":169.50565300000017,"oracles":{"debugLog":{"times":[0.7534130000003643,0.5523790000006557,0.933575999999448]},"fetchTaggedLogs":{"times":[45.483743000000686]},"loadCapsule":{"times":[0.26262799999858544,0.9340659999998024,0.3418739999997342]},"getNotes":{"times":[2.201935000000958]},"getAuthWitness":{"times":[0.5521690000005037]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0566449999987526]}}},{"functionName":"private_kernel_inner","time":136.42130700000052},{"functionName":"private_kernel_reset","time":180.40141399999993},{"functionName":"private_kernel_tail","time":81.02549399999953}],"unaccounted":777.6478019999995}} 12:49:56 [12:49:56.129] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:56 [12:49:56.201] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x06ccfc49e5418e64aa7a8d0bd185c24de1c5011690b401ee107978b64c282c8c","blockNumber":1,"slot":2} 12:49:56 [12:49:56.347] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:56 [12:49:56.393] VERBOSE: p2p:tx_pool Adding tx 0x064c5cb6e09c0a1869ac63459be89dc1dbc75eec3df341ed46de742b2ce7968f to pool {"eventName":"tx-added-to-pool","txHash":"0x064c5cb6e09c0a1869ac63459be89dc1dbc75eec3df341ed46de742b2ce7968f","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 12:49:56 [12:49:56.443] INFO: node Received tx 0x064c5cb6e09c0a1869ac63459be89dc1dbc75eec3df341ed46de742b2ce7968f {"txHash":"0x064c5cb6e09c0a1869ac63459be89dc1dbc75eec3df341ed46de742b2ce7968f"} 12:49:56 [12:49:56.444] INFO: pxe:service Sent transaction 0x064c5cb6e09c0a1869ac63459be89dc1dbc75eec3df341ed46de742b2ce7968f 12:49:56 [12:49:56.584] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:56 [12:49:56.727] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 12:49:56 [12:49:56.744] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T12:54:13.000Z","now":"2025-06-18T12:53:54.921Z"} 12:49:56 [12:49:56.830] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:57 [12:49:57.017] VERBOSE: simulator:public-processor Processed tx 0x064c5cb6e09c0a1869ac63459be89dc1dbc75eec3df341ed46de742b2ce7968f with no public calls in 180.077491ms {"txHash":"0x064c5cb6e09c0a1869ac63459be89dc1dbc75eec3df341ed46de742b2ce7968f","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":180.077491} 12:49:57 [12:49:57.025] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.279247037000001s {"duration":0.279247037000001,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 12:49:57 [12:49:57.036] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:57 [12:49:57.189] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1ee64bea2674be695c4c69aee7fd69d0e64865439667e7d719be4dab010f4960","globalVariables":{"chainId":31337,"version":3795441481,"blockNumber":1,"slotNumber":2,"timestamp":1750251253,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x064c5cb6e09c0a1869ac63459be89dc1dbc75eec3df341ed46de742b2ce7968f"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":462.88840900000105,"publicProcessDuration":280.6237829999991,"rollupCircuitsDuration":446.9507429999994,"txCount":1,"blockNumber":1,"blockTimestamp":1750251253,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:49:57 [12:49:57.193] VERBOSE: sequencer Attesting committee is empty 12:49:57 [12:49:57.301] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:57 [12:49:57.522] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:57 [12:49:57.681] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x578ce2769a9f55b5870cfc7c7319a597f3ee47676958809fd1a25d6bd0e8da64 12:49:57 [12:49:57.682] VERBOSE: sequencer-client Sent L1 transaction 0x578ce2769a9f55b5870cfc7c7319a597f3ee47676958809fd1a25d6bd0e8da64 {"gasLimit":514552,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 12:49:57 [12:49:57.698] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:49:57 [12:49:57.699] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x578ce2769a9f55b5870cfc7c7319a597f3ee47676958809fd1a25d6bd0e8da64","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1750251253,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:49:57 [12:49:57.700] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 12:49:57 [12:49:57.735] INFO: blob-sink:server Received blob sidecar for block 0x91896c4ef94168bbfd6add3906941bb695d8cc6d5c5f1eba654d69d80a4a56ad 12:49:57 [12:49:57.739] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:57 [12:49:57.758] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 12:49:57 [12:49:57.761] INFO: blob-sink:server Blob sidecar stored successfully for block 0x91896c4ef94168bbfd6add3906941bb695d8cc6d5c5f1eba654d69d80a4a56ad 12:49:57 [12:49:57.763] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 12:49:57 [12:49:57.772] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 12:49:57 [12:49:57.937] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 12:49:57 [12:49:57.951] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:57 [12:49:57.958] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1ee64bea2674be695c4c69aee7fd69d0e64865439667e7d719be4dab010f4960","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3795441481,"blockNumber":1,"slotNumber":2,"timestamp":1750251253,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x29f1b08ae165e01c285792f191560f212c285e7b48fea1b2696812ba17939222","archiveNextLeafIndex":2} 12:49:57 [12:49:57.959] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251289] on http://127.0.0.1:8545 12:49:57 [12:49:57.963] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:49:57 [12:49:57.968] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750251289 12:49:57 [12:49:57.969] WARN: foundation:test-date-provider Time set to 2025-06-18T12:54:49.000Z {"offset":291031,"timeMs":1750251289000} 12:49:57 [12:49:57.969] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 12:49:57 [12:49:57.971] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 12:49:58 [12:49:58.472] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:58 [12:49:58.478] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":445.85276499999964,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750251253,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 12:49:58 [12:49:58.479] WARN: pxe:service No artifact found for contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f when looking for its metadata 12:49:58 [12:49:58.485] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f as part of deployment for 0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72 12:49:58 [12:49:58.715] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:58 [12:49:58.796] VERBOSE: p2p Synched to latest block 1 12:49:59 [12:49:59.108] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:59 [12:49:59.138] INFO: pxe:service Added contract Test at 0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72 with class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 12:49:59 [12:49:59.282] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x29f1b08ae165e01c285792f191560f212c285e7b48fea1b2696812ba17939222","header":{"contentCommitment":{"blobsHash":"0x00c7ea1a88a8696f4eacb91caa079e6251d9e8f6b3c2867cfa3a75c61e276989","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750251253,"version":3795441481},"lastArchive":"0x06ccfc49e5418e64aa7a8d0bd185c24de1c5011690b401ee107978b64c282c8c","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x219878d3a9bf03586400604251517d9551c3abfb3601b0ae204cea3b185f3d65","nullifierTree":"0x295cd5e0388748f0f918c5ea88e24148d2682d64564ba1d11bb62f658b7fe999","publicDataTree":"0x0d15f2db5845162c1fc85721a551c716fc42865607e00889f9d2335734b63402"},"totalFees":6794052480,"totalManaUsed":20448}} 12:49:59 [12:49:59.337] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:59 [12:49:59.362] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x29f1b08ae165e01c285792f191560f212c285e7b48fea1b2696812ba17939222","blockNumber":2,"slot":3} 12:49:59 [12:49:59.565] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:59 [12:49:59.602] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:49:59 [12:49:59.654] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:49:59 [12:49:59.655] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:49:59 [12:49:59.760] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:49:59 [12:49:59.768] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x248f7b7788b24768a52baed80cca6c854eaa0dc614e1565049ee535880208c3b 12:49:59 [12:49:59.771] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:49:59 [12:49:59.782] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:49:59 [12:49:59.783] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:49:59 [12:49:59.790] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:49:59 [12:49:59.790] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:49:59 [12:49:59.795] VERBOSE: pxe:service Added note {"index":0,"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x27cd4f92a8ec73d681dec4251ac00f1c7bf8d191616293d82392ccec85eaae1d","nullifier":"0x053ca2c0d3159c1cc1c6175be8322c885bee7a997d4fa318548f7ed5678eceda"} 12:49:59 [12:49:59.797] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:49:59 [12:49:59.810] VERBOSE: simulator:client_execution_context:debug_log Setting 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e as fee payer 12:49:59 [12:49:59.882] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 12:50:00 [12:50:00.407] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0231f367ddb29264182678ec70e69bd06340efa7dc780f1c7522d13c96eed157,0x08fed0d02dac97b0ce237807685976eba973a7f517fc0723c067c7b7b6e121cc,0x11714ee3dfbdb30a8b2975f186d75eb58f17897f0b8ce770a03c05432642725e 12:50:00 [12:50:00.533] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 12:50:00 [12:50:00.608] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:00 [12:50:00.714] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 12:50:00 [12:50:00.736] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x29f1b08ae165e01c285792f191560f212c285e7b48fea1b2696812ba17939222","blockNumber":2,"slot":3} 12:50:00 [12:50:00.776] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 12:50:00 [12:50:00.796] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72,0x0000000000000000000000000000000000000000000000000000000000000001,0x2af8f83e59cb73d834a765d1569b5e41dbc6daf0896711d56ebed922a7a3bff5,0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0eea76e1163ccfa69030e0733759dce0ccf602f045e7b4a3d9ec9b0864e70308,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e 12:50:00 [12:50:00.818] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:01 [12:50:01.300] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:01 [12:50:01.451] VERBOSE: simulator:private_execution Executing private function Test:initialize {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:01 [12:50:01.479] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:01 [12:50:01.480] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:01 [12:50:01.701] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:01 [12:50:01.720] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x29f1b08ae165e01c285792f191560f212c285e7b48fea1b2696812ba17939222","blockNumber":2,"slot":3} 12:50:01 [12:50:01.736] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:01 [12:50:01.741] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:01 [12:50:01.942] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:02 [12:50:02.173] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:02 [12:50:02.426] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:02 [12:50:02.513] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x29f1b08ae165e01c285792f191560f212c285e7b48fea1b2696812ba17939222","blockNumber":2,"slot":3} 12:50:02 [12:50:02.678] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:03 [12:50:03.485] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:03 [12:50:03.888] INFO: pxe:service Proving completed in 4655.992262000003ms {"timings":{"total":4655.992262000003,"sync":123.63710399999763,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":647.3169979999948,"oracles":{"debugLog":{"times":[1.1182890000018233,0.5157859999999346,0.41947000000072876,0.49711499999830266,0.49989500000083353,0.2828300000001036,0.3909480000002077,0.47355400000014924]},"fetchTaggedLogs":{"times":[108.5632489999989]},"loadCapsule":{"times":[0.6901689999976952,0.7618439999969269,1.8158980000007432,0.26195799999914016,0.2753689999990456,0.2438270000020566]},"getSharedSecret":{"times":[6.51415999999881]},"aes128Decrypt":{"times":[1.1704830000016955,0.9190449999987322]},"getPublicKeysAndPartialAddress":{"times":[1.7486129999997502]},"getKeyValidationRequest":{"times":[1.9826499999981024]},"deliverNote":{"times":[4.620335999999952]},"deleteCapsule":{"times":[0.4049279999999271]},"storeCapsule":{"times":[0.8567210000001069]},"getNotes":{"times":[1.5128260000019509]},"getAuthWitness":{"times":[0.1744620000026771]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.10476699999708217]},"callPrivateFunction":{"times":[787.9293590000016,201.41911900000196,944.4148939999977]}}},{"functionName":"private_kernel_init","time":69.93457000000126},{"functionName":"ContractClassRegisterer:register","time":770.9760119999992,"oracles":{"loadCapsule":{"times":[7.040648000001966]},"notifyCreatedNullifier":{"times":[1.1271390000001702]},"debugLog":{"times":[1.1859839999997348]},"notifyCreatedContractClassLog":{"times":[8.636209999996936]}}},{"functionName":"private_kernel_inner","time":133.54079300000012},{"functionName":"ContractInstanceDeployer:deploy","time":118.99752400000216,"oracles":{"storeInExecutionCache":{"times":[0.40603800000099]},"callPrivateFunction":{"times":[66.58631400000013]},"notifyCreatedNullifier":{"times":[0.3449240000009013]},"debugLog":{"times":[0.6694569999999658]}}},{"functionName":"private_kernel_inner","time":157.58313199999975},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":47.971669999998994,"oracles":{}},{"functionName":"private_kernel_inner","time":131.3833909999994},{"functionName":"Test:initialize","time":781.0267820000008,"oracles":{"getContractInstance":{"times":[8.657271000000037]},"debugLog":{"times":[0.535026999998081,0.7595840000030876]},"fetchTaggedLogs":{"times":[259.2214009999989]},"loadCapsule":{"times":[0.32731300000159536,0.7585039999976289,0.31902199999967706]},"notifyCreatedNullifier":{"times":[0.3352129999984754]}}},{"functionName":"private_kernel_inner","time":117.10556200000065},{"functionName":"private_kernel_reset","time":162.732935},{"functionName":"private_kernel_tail","time":89.78275199999916}],"unaccounted":1304.0030370000095}} 12:50:03 [12:50:03.906] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:03 [12:50:03.910] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x29f1b08ae165e01c285792f191560f212c285e7b48fea1b2696812ba17939222","blockNumber":2,"slot":3} 12:50:04 [12:50:04.084] VERBOSE: p2p:tx_pool Adding tx 0x1d2d8170338ea34b846e8e926e30ac171c26836bffd34296d6fe16b2700a2586 to pool {"eventName":"tx-added-to-pool","txHash":"0x1d2d8170338ea34b846e8e926e30ac171c26836bffd34296d6fe16b2700a2586","noteHashCount":0,"nullifierCount":4,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":583,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 12:50:04 [12:50:04.109] INFO: node Received tx 0x1d2d8170338ea34b846e8e926e30ac171c26836bffd34296d6fe16b2700a2586 {"txHash":"0x1d2d8170338ea34b846e8e926e30ac171c26836bffd34296d6fe16b2700a2586"} 12:50:04 [12:50:04.110] INFO: pxe:service Sent transaction 0x1d2d8170338ea34b846e8e926e30ac171c26836bffd34296d6fe16b2700a2586 12:50:04 [12:50:04.113] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:04 [12:50:04.317] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:04 [12:50:04.437] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 12:50:04 [12:50:04.458] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T12:54:49.000Z","now":"2025-06-18T12:54:55.489Z"} 12:50:04 [12:50:04.556] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:04 [12:50:04.790] VERBOSE: simulator:public-processor Processed tx 0x1d2d8170338ea34b846e8e926e30ac171c26836bffd34296d6fe16b2700a2586 with no public calls in 220.42247100000168ms {"txHash":"0x1d2d8170338ea34b846e8e926e30ac171c26836bffd34296d6fe16b2700a2586","txFee":7272506880,"revertCode":0,"gasUsed":{"totalGas":{"daGas":310272,"l2Gas":21888},"billedGas":{"daGas":310272,"l2Gas":21888},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":4,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":220.42247100000168} 12:50:04 [12:50:04.793] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:04 [12:50:04.794] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.33534799900000145s {"duration":0.33534799900000145,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":310272,"l2Gas":21888},"totalSizeInBytes":19648} 12:50:04 [12:50:04.979] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x14f01d55470ff194d5089a3d13aa819d4609b60bb611df249a3cbf8b9acfcc53","globalVariables":{"chainId":31337,"version":3795441481,"blockNumber":2,"slotNumber":3,"timestamp":1750251289,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1d2d8170338ea34b846e8e926e30ac171c26836bffd34296d6fe16b2700a2586"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":542.3889740000013,"publicProcessDuration":335.66163099999903,"rollupCircuitsDuration":522.0937209999975,"txCount":1,"blockNumber":2,"blockTimestamp":1750251289,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 12:50:04 [12:50:04.982] VERBOSE: sequencer Attesting committee is empty 12:50:05 [12:50:05.089] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:05 [12:50:05.320] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:05 [12:50:05.324] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x9f27e317d91082cc318351409b28c4f2d0c5ada6c7ff1065108da7b03e6c978b 12:50:05 [12:50:05.325] VERBOSE: sequencer-client Sent L1 transaction 0x9f27e317d91082cc318351409b28c4f2d0c5ada6c7ff1065108da7b03e6c978b {"gasLimit":470236,"maxFeePerGas":"1.303611197","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 12:50:05 [12:50:05.336] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251325] on http://127.0.0.1:8545 12:50:05 [12:50:05.338] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:50:05 [12:50:05.339] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x9f27e317d91082cc318351409b28c4f2d0c5ada6c7ff1065108da7b03e6c978b","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":2,"blockTimestamp":1750251289,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 12:50:05 [12:50:05.339] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 12:50:05 [12:50:05.343] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:50:05 [12:50:05.345] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750251325 12:50:05 [12:50:05.345] WARN: foundation:test-date-provider Time set to 2025-06-18T12:55:25.000Z {"offset":319655,"timeMs":1750251325000} 12:50:05 [12:50:05.346] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 12:50:05 [12:50:05.348] INFO: blob-sink:server Received blob sidecar for block 0x6b0a9ec44d9ba100856256fb5ea47543a6a52069ff059ad060957e5010dfddf9 12:50:05 [12:50:05.353] INFO: blob-sink:server Blob sidecar stored successfully for block 0x6b0a9ec44d9ba100856256fb5ea47543a6a52069ff059ad060957e5010dfddf9 12:50:05 [12:50:05.527] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:05 [12:50:05.535] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 12:50:05 [12:50:05.543] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 12:50:05 [12:50:05.553] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 12:50:05 [12:50:05.788] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:05 [12:50:05.807] VERBOSE: archiver:block-helper Store contract instance at 0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72 12:50:05 [12:50:05.827] VERBOSE: archiver:block-helper Store contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 12:50:05 [12:50:05.865] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x14f01d55470ff194d5089a3d13aa819d4609b60bb611df249a3cbf8b9acfcc53","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3795441481,"blockNumber":2,"slotNumber":3,"timestamp":1750251289,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2609a399eb0a8c7a37ce1c7340cd72adf37a6d2ccb3d1736350dad18136d63a8","archiveNextLeafIndex":3} 12:50:05 [12:50:05.884] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 12:50:05 [12:50:05.921] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":9.011701999999786,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750251289,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 12:50:06 [12:50:06.000] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:06 [12:50:06.011] VERBOSE: p2p Synched to latest block 2 12:50:06 [12:50:06.328] INFO: aztecjs:deploy_sent_tx Contract 0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72 successfully deployed. 12:50:06 [12:50:06.332] INFO: e2e:e2e_keys Running test: Keys using nsk_app to detect nullification nsk_app and contract address are enough to detect note nullification 12:50:06 [12:50:06.336] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:06 [12:50:06.385] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x2609a399eb0a8c7a37ce1c7340cd72adf37a6d2ccb3d1736350dad18136d63a8","header":{"contentCommitment":{"blobsHash":"0x0037b0a43fb717b1cce582da538b2dafc7f354fa6ea1e8f4640b049595ecfb18","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750251289,"version":3795441481},"lastArchive":"0x29f1b08ae165e01c285792f191560f212c285e7b48fea1b2696812ba17939222","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x219878d3a9bf03586400604251517d9551c3abfb3601b0ae204cea3b185f3d65","nullifierTree":"0x1e9c69f5c28f79963a010e6dc5463014b8b2a7b4c2ffceb1d2a85b1469e3cd87","publicDataTree":"0x214988c78ed52e0c4150246700cee1e426d2ddb84288a33d3327229fa1fdfa76"},"totalFees":7272506880,"totalManaUsed":21888}} 12:50:06 [12:50:06.454] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2609a399eb0a8c7a37ce1c7340cd72adf37a6d2ccb3d1736350dad18136d63a8","blockNumber":3,"slot":4} 12:50:06 [12:50:06.504] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:50:06 [12:50:06.541] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:06 [12:50:06.542] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:50:06 [12:50:06.546] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:06 [12:50:06.608] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:50:06 [12:50:06.614] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x248f7b7788b24768a52baed80cca6c854eaa0dc614e1565049ee535880208c3b 12:50:06 [12:50:06.627] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:50:06 [12:50:06.628] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:50:06 [12:50:06.634] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:50:06 [12:50:06.634] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:50:06 [12:50:06.638] VERBOSE: pxe:service Added note {"index":0,"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x27cd4f92a8ec73d681dec4251ac00f1c7bf8d191616293d82392ccec85eaae1d","nullifier":"0x053ca2c0d3159c1cc1c6175be8322c885bee7a997d4fa318548f7ed5678eceda"} 12:50:06 [12:50:06.641] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:06 [12:50:06.659] VERBOSE: simulator:client_execution_context:debug_log Setting 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e as fee payer 12:50:06 [12:50:06.831] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:07 [12:50:07.179] VERBOSE: simulator:private_execution Executing private function Test:call_create_note {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:07 [12:50:07.222] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:07 [12:50:07.223] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:07 [12:50:07.231] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:07 [12:50:07.462] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:07 [12:50:07.500] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2609a399eb0a8c7a37ce1c7340cd72adf37a6d2ccb3d1736350dad18136d63a8","blockNumber":3,"slot":4} 12:50:07 [12:50:07.526] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:07 [12:50:07.532] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:07 [12:50:07.755] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:07 [12:50:07.969] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:08 [12:50:08.180] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:08 [12:50:08.547] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2609a399eb0a8c7a37ce1c7340cd72adf37a6d2ccb3d1736350dad18136d63a8","blockNumber":3,"slot":4} 12:50:08 [12:50:08.917] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:09 [12:50:09.391] INFO: pxe:service Proving completed in 3020.207150000002ms {"timings":{"total":3020.207150000002,"sync":24.32711399999971,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":438.0565349999997,"oracles":{"debugLog":{"times":[0.6209039999994275,0.4241699999984121,0.3827469999996538,0.6866570000020147,0.35886499999833177,0.382727000000159,0.49199399999997695,0.725269999999]},"fetchTaggedLogs":{"times":[70.02920499999891]},"loadCapsule":{"times":[0.32751400000051945,0.21820600000137347,0.38265700000192737,0.2884300000005169,0.27235900000232505,0.2737100000013015]},"getSharedSecret":{"times":[6.9916899999989255]},"aes128Decrypt":{"times":[0.2686790000007022,0.6739379999999073]},"getPublicKeysAndPartialAddress":{"times":[1.5901019999982964]},"getKeyValidationRequest":{"times":[1.4841840000008233]},"deliverNote":{"times":[4.310132000002341]},"deleteCapsule":{"times":[0.41147900000214577]},"storeCapsule":{"times":[0.36530599999969127]},"getNotes":{"times":[2.082886000000144]},"getAuthWitness":{"times":[0.28939099999843165]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07546499999807565]},"callPrivateFunction":{"times":[1260.1511610000016]}}},{"functionName":"private_kernel_init","time":100.48487900000327},{"functionName":"Test:call_create_note","time":1071.593232999996,"oracles":{"debugLog":{"times":[0.6745980000014242,0.542808000001969]},"fetchTaggedLogs":{"times":[306.36197099999845]},"loadCapsule":{"times":[0.49623500000234344,0.25191699999777484,0.2656590000005963]},"getRandomField":{"times":[0.3748959999975341,0.15920100000221282,0.24480699999912758,0.1618319999979576,0.10371699999814155,0.09157599999889499,0.0571139999992738,0.06320400000186055,0.06012399999963236,0.06397500000093714,0.05541399999856367,0.06464400000186288]},"notifyCreatedNote":{"times":[0.3770769999973709]},"getIndexedTaggingSecretAsSender":{"times":[218.34184399999867]},"incrementAppTaggingSecretIndexAsSender":{"times":[131.8086430000003]}}},{"functionName":"private_kernel_inner","time":125.62585000000036},{"functionName":"private_kernel_reset","time":225.81175800000346},{"functionName":"private_kernel_tail","time":103.07105000000229}],"unaccounted":931.2367309999972}} 12:50:09 [12:50:09.415] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:09 [12:50:09.444] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2609a399eb0a8c7a37ce1c7340cd72adf37a6d2ccb3d1736350dad18136d63a8","blockNumber":3,"slot":4} 12:50:09 [12:50:09.465] VERBOSE: p2p:tx_pool Adding tx 0x03c257fc3f2bf2c2173a6cd2243de1b1f9884b99e42f9b5061617c3ade7991f8 to pool {"eventName":"tx-added-to-pool","txHash":"0x03c257fc3f2bf2c2173a6cd2243de1b1f9884b99e42f9b5061617c3ade7991f8","noteHashCount":1,"nullifierCount":1,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 12:50:09 [12:50:09.471] INFO: node Received tx 0x03c257fc3f2bf2c2173a6cd2243de1b1f9884b99e42f9b5061617c3ade7991f8 {"txHash":"0x03c257fc3f2bf2c2173a6cd2243de1b1f9884b99e42f9b5061617c3ade7991f8"} 12:50:09 [12:50:09.472] INFO: pxe:service Sent transaction 0x03c257fc3f2bf2c2173a6cd2243de1b1f9884b99e42f9b5061617c3ade7991f8 12:50:09 [12:50:09.625] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:09 [12:50:09.830] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:09 [12:50:09.974] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 12:50:09 [12:50:09.995] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T12:55:25.000Z","now":"2025-06-18T12:55:29.650Z"} 12:50:10 [12:50:10.026] VERBOSE: simulator:public-processor Processed tx 0x03c257fc3f2bf2c2173a6cd2243de1b1f9884b99e42f9b5061617c3ade7991f8 with no public calls in 17.107828000000154ms {"txHash":"0x03c257fc3f2bf2c2173a6cd2243de1b1f9884b99e42f9b5061617c3ade7991f8","txFee":3242857600,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11264,"l2Gas":9760},"billedGas":{"daGas":11264,"l2Gas":9760},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":17.107828000000154} 12:50:10 [12:50:10.031] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.035479576000001546s {"duration":0.035479576000001546,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11264,"l2Gas":9760},"totalSizeInBytes":960} 12:50:10 [12:50:10.034] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:10 [12:50:10.187] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x06341f84c0978ee9fcafb060dff492b81d717c6e20206b78b095ef55d5722d6d","globalVariables":{"chainId":31337,"version":3795441481,"blockNumber":3,"slotNumber":4,"timestamp":1750251325,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x03c257fc3f2bf2c2173a6cd2243de1b1f9884b99e42f9b5061617c3ade7991f8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":213.01112099999955,"publicProcessDuration":36.16104300000006,"rollupCircuitsDuration":193.39189700000134,"txCount":1,"blockNumber":3,"blockTimestamp":1750251325,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:50:10 [12:50:10.192] VERBOSE: sequencer Attesting committee is empty 12:50:10 [12:50:10.282] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:10 [12:50:10.479] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x8227d5cf54c19c5ec9a8d3bda4c4c4a5eda6b4987b07062edb5d81d3708307d3 12:50:10 [12:50:10.479] VERBOSE: sequencer-client Sent L1 transaction 0x8227d5cf54c19c5ec9a8d3bda4c4c4a5eda6b4987b07062edb5d81d3708307d3 {"gasLimit":470280,"maxFeePerGas":"1.279583383","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 12:50:10 [12:50:10.485] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:10 [12:50:10.495] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:50:10 [12:50:10.496] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x8227d5cf54c19c5ec9a8d3bda4c4c4a5eda6b4987b07062edb5d81d3708307d3","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1750251325,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:50:10 [12:50:10.496] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 12:50:10 [12:50:10.501] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 12:50:10 [12:50:10.505] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 12:50:10 [12:50:10.509] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 12:50:10 [12:50:10.512] INFO: blob-sink:server Received blob sidecar for block 0xfa80e0ee93848f03496c66862337732f458c9edce6fb524b67f20b42573fb024 12:50:10 [12:50:10.519] INFO: blob-sink:server Blob sidecar stored successfully for block 0xfa80e0ee93848f03496c66862337732f458c9edce6fb524b67f20b42573fb024 12:50:10 [12:50:10.681] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x06341f84c0978ee9fcafb060dff492b81d717c6e20206b78b095ef55d5722d6d","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":3795441481,"blockNumber":3,"slotNumber":4,"timestamp":1750251325,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0aad14d599f5436a2bd70956459fd29b3e9ab327c42a7bc724c7f30faf37979b","archiveNextLeafIndex":4} 12:50:10 [12:50:10.686] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251361] on http://127.0.0.1:8545 12:50:10 [12:50:10.689] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:50:10 [12:50:10.690] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:10 [12:50:10.696] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750251361 12:50:10 [12:50:10.696] WARN: foundation:test-date-provider Time set to 2025-06-18T12:56:01.000Z {"offset":350304,"timeMs":1750251361000} 12:50:10 [12:50:10.697] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 12:50:10 [12:50:10.697] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 12:50:10 [12:50:10.824] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":17.038634000000457,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750251325,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:50:10 [12:50:10.835] VERBOSE: p2p Synched to latest block 3 12:50:10 [12:50:10.901] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:11 [12:50:11.031] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0aad14d599f5436a2bd70956459fd29b3e9ab327c42a7bc724c7f30faf37979b","blockNumber":4,"slot":5} 12:50:11 [12:50:11.106] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:11 [12:50:11.313] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:11 [12:50:11.516] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:11 [12:50:11.562] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x0aad14d599f5436a2bd70956459fd29b3e9ab327c42a7bc724c7f30faf37979b","header":{"contentCommitment":{"blobsHash":"0x00b2a83b77066ae42e1fc082250c7be16f908af6a63afc0219408d40407e99d7","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750251325,"version":3795441481},"lastArchive":"0x2609a399eb0a8c7a37ce1c7340cd72adf37a6d2ccb3d1736350dad18136d63a8","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0d2208c0102aada2cf029f96309dbaea9b9a91ae96531872435b82caffe7839d","nullifierTree":"0x18268c9dcdccd8f450832d6a783d9e9e971805ce6e51abc161b314938bf7fc8e","publicDataTree":"0x22c262e3d4df73c206ecbd66976528c1026310de2d5974bf89b26ef02e12f439"},"totalFees":3242857600,"totalManaUsed":9760}} 12:50:11 [12:50:11.564] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0aad14d599f5436a2bd70956459fd29b3e9ab327c42a7bc724c7f30faf37979b","blockNumber":4,"slot":5} 12:50:11 [12:50:11.717] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:50:11 [12:50:11.772] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:11 [12:50:11.773] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:50:11 [12:50:11.774] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:11 [12:50:11.841] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:50:11 [12:50:11.849] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x248f7b7788b24768a52baed80cca6c854eaa0dc614e1565049ee535880208c3b 12:50:11 [12:50:11.862] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:50:11 [12:50:11.864] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:50:11 [12:50:11.871] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:50:11 [12:50:11.872] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:50:11 [12:50:11.875] VERBOSE: pxe:service Added note {"index":0,"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x27cd4f92a8ec73d681dec4251ac00f1c7bf8d191616293d82392ccec85eaae1d","nullifier":"0x053ca2c0d3159c1cc1c6175be8322c885bee7a997d4fa318548f7ed5678eceda"} 12:50:11 [12:50:11.877] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:11 [12:50:11.893] VERBOSE: simulator:client_execution_context:debug_log Setting 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e as fee payer 12:50:12 [12:50:12.062] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:12 [12:50:12.475] VERBOSE: simulator:private_execution Executing private function Test:call_destroy_note {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:12 [12:50:12.520] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:12 [12:50:12.521] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:12 [12:50:12.525] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:12 [12:50:12.762] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:12 [12:50:12.803] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0aad14d599f5436a2bd70956459fd29b3e9ab327c42a7bc724c7f30faf37979b","blockNumber":4,"slot":5} 12:50:12 [12:50:12.841] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:12 [12:50:12.859] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2bf9d8424528bb2cff0a12fc8949937e40076cfe23575bfa632759a750d97d93 12:50:12 [12:50:12.876] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:50:12 [12:50:12.878] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72 for storage slot 0x000000000000000000000000000000000000000000000000000000000000000c 12:50:12 [12:50:12.888] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:50:12 [12:50:12.888] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:50:12 [12:50:12.896] VERBOSE: pxe:service Added note {"index":128,"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x066fe5cc4bed607a70492469acae915bd1cca0cd8dedb78ea0e74afc20f32179","nullifier":"0x10bf2d19a0d72ecd4def91fa39562afa80556a3bffdfccecc48395998ece5a22"} 12:50:12 [12:50:12.898] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:13 [12:50:13.030] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:13 [12:50:13.413] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:13 [12:50:13.966] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:14 [12:50:14.107] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0aad14d599f5436a2bd70956459fd29b3e9ab327c42a7bc724c7f30faf37979b","blockNumber":4,"slot":5} 12:50:14 [12:50:14.369] INFO: pxe:service Proving completed in 2839.906222000005ms {"timings":{"total":2839.906222000005,"sync":37.41451000000234,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":526.9612889999953,"oracles":{"debugLog":{"times":[0.9232860000010987,0.4995049999997718,0.6707879999994475,0.7503130000004603,0.524557000000641,0.4680140000018582,0.3413350000009814,0.6532570000017586]},"fetchTaggedLogs":{"times":[73.4619219999986]},"loadCapsule":{"times":[0.260059000000183,0.26761899999837624,0.3585860000021057,0.26874900000257185,0.1721620000025723,0.25928799999746843]},"getSharedSecret":{"times":[5.077344000001176]},"aes128Decrypt":{"times":[0.44962200000009034,1.3260859999973036]},"getPublicKeysAndPartialAddress":{"times":[1.7977280000013707]},"getKeyValidationRequest":{"times":[1.9879719999989902]},"deliverNote":{"times":[3.433076000001165]},"deleteCapsule":{"times":[0.27307999999902677]},"storeCapsule":{"times":[0.3173129999995581]},"getNotes":{"times":[3.7362670000002254]},"getAuthWitness":{"times":[0.17163200000140932]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06333500000255299]},"callPrivateFunction":{"times":[1051.6786350000002]}}},{"functionName":"private_kernel_init","time":88.07981899999868},{"functionName":"Test:call_destroy_note","time":829.2090590000007,"oracles":{"debugLog":{"times":[0.6696179999999003,0.5926519999993616,0.6343449999985751,0.7327420000001439,0.5432989999972051,0.5790110000016284,0.46256300000095507]},"fetchTaggedLogs":{"times":[336.04999300000054]},"loadCapsule":{"times":[0.25579800000195974,0.20684500000061234,0.4882949999991979,0.29335100000025705,0.2560990000019956,0.25501900000017486]},"getSharedSecret":{"times":[4.780862999999954]},"aes128Decrypt":{"times":[0.365577000000485,1.198286000002554]},"getPublicKeysAndPartialAddress":{"times":[3.0575690000005125,4.323980000001029]},"getKeyValidationRequest":{"times":[2.371580000002723,2.6416790000002948]},"deliverNote":{"times":[7.362207000001945]},"deleteCapsule":{"times":[0.30464099999881]},"storeCapsule":{"times":[0.3539749999981723]},"getNotes":{"times":[3.076469999999972]},"notifyNullifiedNote":{"times":[0.8785829999978887]}}},{"functionName":"private_kernel_inner","time":109.10643600000185},{"functionName":"private_kernel_reset","time":188.69840699999986},{"functionName":"private_kernel_tail","time":77.63803100000223}],"unaccounted":982.7986710000041}} 12:50:14 [12:50:14.391] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:14 [12:50:14.420] VERBOSE: p2p:tx_pool Adding tx 0x079d12b8bcfef5ab730994007bfb6f5006caf71ae1e953ad08e7b284101199c0 to pool {"eventName":"tx-added-to-pool","txHash":"0x079d12b8bcfef5ab730994007bfb6f5006caf71ae1e953ad08e7b284101199c0","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 12:50:14 [12:50:14.425] INFO: node Received tx 0x079d12b8bcfef5ab730994007bfb6f5006caf71ae1e953ad08e7b284101199c0 {"txHash":"0x079d12b8bcfef5ab730994007bfb6f5006caf71ae1e953ad08e7b284101199c0"} 12:50:14 [12:50:14.425] INFO: pxe:service Sent transaction 0x079d12b8bcfef5ab730994007bfb6f5006caf71ae1e953ad08e7b284101199c0 12:50:14 [12:50:14.598] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:14 [12:50:14.692] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 12:50:14 [12:50:14.710] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-18T12:56:01.000Z","now":"2025-06-18T12:56:05.014Z"} 12:50:14 [12:50:14.749] VERBOSE: simulator:public-processor Processed tx 0x079d12b8bcfef5ab730994007bfb6f5006caf71ae1e953ad08e7b284101199c0 with no public calls in 16.647092999999586ms {"txHash":"0x079d12b8bcfef5ab730994007bfb6f5006caf71ae1e953ad08e7b284101199c0","txFee":567840000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":11200},"billedGas":{"daGas":1536,"l2Gas":11200},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":16.647092999999586} 12:50:14 [12:50:14.751] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03965738099999726s {"duration":0.03965738099999726,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":11200},"totalSizeInBytes":288} 12:50:14 [12:50:14.866] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:14 [12:50:14.881] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x22447c66dbc3e95e1e3474c933efab88f57f7e3093d7c3a3e06eb0f833f19993","globalVariables":{"chainId":31337,"version":3795441481,"blockNumber":4,"slotNumber":5,"timestamp":1750251361,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x079d12b8bcfef5ab730994007bfb6f5006caf71ae1e953ad08e7b284101199c0"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":192.97782300000108,"publicProcessDuration":40.11648399999831,"rollupCircuitsDuration":171.321222999999,"txCount":1,"blockNumber":4,"blockTimestamp":1750251361,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:50:14 [12:50:14.884] VERBOSE: sequencer Attesting committee is empty 12:50:15 [12:50:15.180] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:15 [12:50:15.187] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x6f72330c7a4f7afe74d08976f215e5af5ef144435918f93df8f43a119d1421e8 12:50:15 [12:50:15.188] VERBOSE: sequencer-client Sent L1 transaction 0x6f72330c7a4f7afe74d08976f215e5af5ef144435918f93df8f43a119d1421e8 {"gasLimit":470295,"maxFeePerGas":"1.261127726","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 12:50:15 [12:50:15.206] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750251397] on http://127.0.0.1:8545 12:50:15 [12:50:15.209] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 12:50:15 [12:50:15.210] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x6f72330c7a4f7afe74d08976f215e5af5ef144435918f93df8f43a119d1421e8","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":4,"blockTimestamp":1750251361,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:50:15 [12:50:15.210] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 12:50:15 [12:50:15.215] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 12:50:15 [12:50:15.219] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750251397 12:50:15 [12:50:15.220] WARN: foundation:test-date-provider Time set to 2025-06-18T12:56:37.000Z {"offset":381781,"timeMs":1750251397000} 12:50:15 [12:50:15.220] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 12:50:15 [12:50:15.225] INFO: blob-sink:server Received blob sidecar for block 0x79ad155dd6038feb6f147bcf52332f2c9899840073644e8815e6b756afeda1dc 12:50:15 [12:50:15.232] INFO: blob-sink:server Blob sidecar stored successfully for block 0x79ad155dd6038feb6f147bcf52332f2c9899840073644e8815e6b756afeda1dc 12:50:15 [12:50:15.362] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x22447c66dbc3e95e1e3474c933efab88f57f7e3093d7c3a3e06eb0f833f19993","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":3795441481,"blockNumber":4,"slotNumber":5,"timestamp":1750251361,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x058c3f1221823394f3fcbbb69980af62a589ad37970f0c43c9378277e9299fc2","archiveNextLeafIndex":5} 12:50:15 [12:50:15.391] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:15 [12:50:15.393] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 12:50:15 [12:50:15.395] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 12:50:15 [12:50:15.397] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 12:50:15 [12:50:15.441] INFO: e2e:e2e_keys Running test: Keys ovsk_app gets ovsk_app 12:50:15 [12:50:15.462] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e {"origin":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000e239d749","authWitnesses":["0x23da711b54451a99ab0cfb75c4bbd3a411b71998f82d52afefd5ed77c77c4af6"]} 12:50:15 [12:50:15.481] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":7.842382000002544,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750251361,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 12:50:15 [12:50:15.483] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x058c3f1221823394f3fcbbb69980af62a589ad37970f0c43c9378277e9299fc2","header":{"contentCommitment":{"blobsHash":"0x004c45935f9f19c4626961e19402aaecf99d32c39984a68262507835e979e5c0","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750251361,"version":3795441481},"lastArchive":"0x0aad14d599f5436a2bd70956459fd29b3e9ab327c42a7bc724c7f30faf37979b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0d2208c0102aada2cf029f96309dbaea9b9a91ae96531872435b82caffe7839d","nullifierTree":"0x0798e2420b9c579e15a42832cd9109a0777d3277bdada2ec2f8bf4adbbcaf78e","publicDataTree":"0x179b60be98d077e19caadabcab15c2fc8046f43a998cd5c67a5057879146a1f2"},"totalFees":567840000,"totalManaUsed":11200}} 12:50:15 [12:50:15.489] VERBOSE: p2p Synched to latest block 4 12:50:15 [12:50:15.569] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:50:15 [12:50:15.616] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:15 [12:50:15.616] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:50:15 [12:50:15.618] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:15 [12:50:15.681] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e"} 12:50:15 [12:50:15.692] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x248f7b7788b24768a52baed80cca6c854eaa0dc614e1565049ee535880208c3b 12:50:15 [12:50:15.710] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:50:15 [12:50:15.711] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 12:50:15 [12:50:15.718] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:50:15 [12:50:15.719] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:50:15 [12:50:15.734] VERBOSE: pxe:service Added note {"index":0,"contract":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x27cd4f92a8ec73d681dec4251ac00f1c7bf8d191616293d82392ccec85eaae1d","nullifier":"0x053ca2c0d3159c1cc1c6175be8322c885bee7a997d4fa318548f7ed5678eceda"} 12:50:15 [12:50:15.741] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:15 [12:50:15.746] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x058c3f1221823394f3fcbbb69980af62a589ad37970f0c43c9378277e9299fc2","blockNumber":5,"slot":6} 12:50:15 [12:50:15.760] VERBOSE: simulator:client_execution_context:debug_log Setting 0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e as fee payer 12:50:15 [12:50:15.919] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:16 [12:50:16.234] VERBOSE: simulator:private_execution Executing private function Test:get_ovsk_app {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:16 [12:50:16.247] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 12:50:16 [12:50:16.248] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:16 [12:50:16.248] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:16 [12:50:16.444] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 12:50:16 [12:50:16.449] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x058c3f1221823394f3fcbbb69980af62a589ad37970f0c43c9378277e9299fc2","blockNumber":5,"slot":6} 12:50:16 [12:50:16.455] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:16 [12:50:16.471] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72"} 12:50:16 [12:50:16.476] VERBOSE: pxe:service Removed note for contract 0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72 at slot 0x000000000000000000000000000000000000000000000000000000000000000c {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","nullifier":"0x10bf2d19a0d72ecd4def91fa39562afa80556a3bffdfccecc48395998ece5a22"} 12:50:16 [12:50:16.478] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2bf9d8424528bb2cff0a12fc8949937e40076cfe23575bfa632759a750d97d93 12:50:16 [12:50:16.491] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 12:50:16 [12:50:16.492] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72 for storage slot 0x000000000000000000000000000000000000000000000000000000000000000c 12:50:16 [12:50:16.499] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 12:50:16 [12:50:16.499] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 12:50:16 [12:50:16.502] VERBOSE: pxe:service Added note {"index":128,"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x066fe5cc4bed607a70492469acae915bd1cca0cd8dedb78ea0e74afc20f32179","nullifier":"0x10bf2d19a0d72ecd4def91fa39562afa80556a3bffdfccecc48395998ece5a22"} 12:50:16 [12:50:16.503] VERBOSE: pxe:service Removed just-added note {"contract":"0x0e620ca9b0f8cc233f7a3495e8dd656009fd222a91de918697ffaf6e3e0f5d72","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x066fe5cc4bed607a70492469acae915bd1cca0cd8dedb78ea0e74afc20f32179","nullifier":"0x10bf2d19a0d72ecd4def91fa39562afa80556a3bffdfccecc48395998ece5a22"} 12:50:16 [12:50:16.505] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 12:50:16 [12:50:16.697] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:17 [12:50:17.460] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:17 [12:50:17.624] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x058c3f1221823394f3fcbbb69980af62a589ad37970f0c43c9378277e9299fc2","blockNumber":5,"slot":6} 12:50:17 [12:50:17.874] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 12:50:17 [12:50:17.903] INFO: pxe:service Simulation completed for 0x09b54d93e70472438af84378f9ad2e00b04b91a2ea7852524aecf4929ece51f1 in 2440.748400000004ms {"txHash":"0x09b54d93e70472438af84378f9ad2e00b04b91a2ea7852524aecf4929ece51f1","origin":"0x11eaba31662c4da99ec5430b8e699567b145fe7a4917247d6fcc4436bc29717e","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000e239d749","authWitnesses":["0x23da711b54451a99ab0cfb75c4bbd3a411b71998f82d52afefd5ed77c77c4af6"]} 12:50:17 [12:50:17.908] INFO: node Stopping 12:50:17 [12:50:17.909] INFO: slasher Slasher client stopped. 12:50:17 [12:50:17.909] INFO: sequencer Stopped sequencer 12:50:17 [12:50:17.909] INFO: p2p P2P client stopped. 12:50:17 [12:50:17.911] INFO: world_state Stopped world state synchronizer 12:50:17 [12:50:17.911] INFO: archiver Stopped. 12:50:17 [12:50:17.912] INFO: node Stopped 12:50:17 [12:50:17.912] VERBOSE: e2e:e2e_keys Cleaning up ACVM state 12:50:17 [12:50:17.912] INFO: e2e:e2e_keys Cleaning up ACVM temp directory /tmp/e9e1a5ed 12:50:17 [12:50:17.913] VERBOSE: e2e:e2e_keys Cleaning up BB state 12:50:17 [12:50:17.925] INFO: blob-sink:server Stopping blob sink 12:50:17 [12:50:17.926] INFO: blob-sink:server Blob sink stopped 12:50:17 [12:50:17.926] VERBOSE: e2e:e2e_keys Cleaning up data directory at /tmp/42da43591ce28582 12:50:17 PASS src/e2e_keys.test.ts 12:50:17 Keys 12:50:17 using nsk_app to detect nullification 12:50:17 ✓ nsk_app and contract address are enough to detect note nullification (9109 ms) 12:50:17 ovsk_app 12:50:17 ✓ gets ovsk_app (2465 ms) 12:50:17 12:50:17 Test Suites: 1 passed, 1 total 12:50:17 Tests: 2 passed, 2 total 12:50:17 Snapshots: 0 total 12:50:17 Time: 35.976 s 12:50:17 Ran all test suites matching /src\/e2e_keys.test.ts/i. 12:50:17 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?