Parent Log: http://ci.aztec-labs.com/b1869ed3b108a335 Command: 3f83527fe89c0976: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/b1b65bcdbd44a49fbebe5d2265256dc9466e92be Env: REF_NAME=gh-readonly-queue/master/pr-15044-267ac35e8ccb487bdc79bbe12d428f4c8b4d4d9f CURRENT_VERSION=0.87.8 CI_FULL=0 Date: Fri Jun 13 16:24:58 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15044_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c393731fea71056e_master 16:24:58 +++ id -u 16:24:58 +++ id -g 16:24:58 ++ docker run -d --name e2e_keys --net=none --cpuset-cpus=0-63 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_keys.test.ts'\''' 16:24:59 + cid=d9dbac6ff7f57d6ac602731efe7c22b98c8afb9cf4de72e3355fdcfc9ce14c84 16:24:59 + set +x 16:24:59 {"level":25,"time":1749831899553,"pid":12,"hostname":"d9dbac6ff7f5","module":"logger","msg":"Logger initialized with level verbose"} 16:25:03 [16:25:03.706] INFO: e2e:e2e_keys Logging metrics to log/unknown.jsonl 16:25:03 [16:25:03.901] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-CWclCK/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 16:25:03 [16:25:03.932] INFO: e2e:e2e_keys Calling anvil_setBlockTimestampInterval with params: [12] 16:25:03 [16:25:03.953] WARN: e2e:e2e_keys Set block interval to 12 16:25:03 [16:25:03.954] VERBOSE: e2e:e2e_keys Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:25:04 [16:25:03.999] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 16:25:04 [16:25:04.006] VERBOSE: e2e:e2e_keys Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 16:25:04 [16:25:04.022] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 16:25:04 [16:25:04.027] VERBOSE: e2e:e2e_keys Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 16:25:04 [16:25:04.042] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 16:25:04 [16:25:04.047] VERBOSE: e2e:e2e_keys Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 16:25:04 [16:25:04.063] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 16:25:04 [16:25:04.067] VERBOSE: e2e:e2e_keys Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 16:25:04 [16:25:04.082] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 16:25:04 [16:25:04.086] VERBOSE: e2e:e2e_keys Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 16:25:04 [16:25:04.098] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 16:25:04 [16:25:04.101] VERBOSE: e2e:e2e_keys Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 16:25:04 [16:25:04.102] VERBOSE: e2e:e2e_keys Waiting for deployments to complete 16:25:04 [16:25:04.102] INFO: e2e:e2e_keys Waiting for 6 transactions to be mined... 16:25:04 [16:25:04.121] INFO: e2e:e2e_keys All transactions mined successfully 16:25:04 [16:25:04.134] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 16:25:04 [16:25:04.135] VERBOSE: e2e:e2e_keys Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 16:25:04 [16:25:04.146] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 16:25:04 [16:25:04.158] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 16:25:04 [16:25:04.162] VERBOSE: e2e:e2e_keys Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 16:25:04 [16:25:04.175] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 16:25:04 [16:25:04.176] VERBOSE: e2e:e2e_keys Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 16:25:04 [16:25:04.191] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 16:25:04 [16:25:04.195] VERBOSE: e2e:e2e_keys Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 16:25:04 [16:25:04.205] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 16:25:04 [16:25:04.205] VERBOSE: e2e:e2e_keys Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 16:25:04 [16:25:04.205] VERBOSE: e2e:e2e_keys Waiting for deployments to complete 16:25:04 [16:25:04.205] INFO: e2e:e2e_keys Waiting for 8 transactions to be mined... 16:25:04 [16:25:04.222] INFO: e2e:e2e_keys All transactions mined successfully 16:25:04 [16:25:04.231] VERBOSE: e2e:e2e_keys Deployed shared contracts 16:25:04 [16:25:04.244] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 16:25:04 [16:25:04.245] VERBOSE: e2e:e2e_keys Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 16:25:04 [16:25:04.247] 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} 16:25:04 [16:25:04.258] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 16:25:04 [16:25:04.282] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 16:25:04 [16:25:04.286] VERBOSE: e2e:e2e_keys Awaiting for linked libraries to be deployed 16:25:04 [16:25:04.320] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x523ec5c20f80c37e20052921cd63eee00937f6097e04240503ff36d6c56dc42a {"gasLimit":10407394,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 16:25:04 [16:25:04.325] 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} 16:25:04 [16:25:04.326] INFO: e2e:e2e_keys Waiting for 9 transactions to be mined... 16:25:04 [16:25:04.346] INFO: e2e:e2e_keys All transactions mined successfully 16:25:04 [16:25:04.346] VERBOSE: e2e:e2e_keys All core contracts have been deployed 16:25:04 [16:25:04.359] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 16:25:04 [16:25:04.359] VERBOSE: e2e:e2e_keys Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 16:25:04 [16:25:04.370] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x3076e8ed3c707fd6d82a919b677cf7a63a9c4828413a41044e3272f6f71e410a {"gasLimit":716194,"maxFeePerGas":"26.850966158","maxPriorityFeePerGas":"26.623333274"} 16:25:04 [16:25:04.374] VERBOSE: e2e:e2e_keys Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 16:25:04 [16:25:04.393] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 {"gasLimit":116953,"maxFeePerGas":"32.147280374","maxPriorityFeePerGas":"31.947999928"} 16:25:04 [16:25:04.393] VERBOSE: e2e:e2e_keys Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 16:25:04 [16:25:04.393] INFO: e2e:e2e_keys Waiting for 10 transactions to be mined... 16:25:04 [16:25:04.411] INFO: e2e:e2e_keys All transactions mined successfully 16:25:04 [16:25:04.416] VERBOSE: e2e:e2e_keys Rollup deployed 16:25:04 [16:25:04.417] VERBOSE: e2e:e2e_keys Waiting for rollup and slash factory to be deployed 16:25:04 [16:25:04.417] INFO: e2e:e2e_keys Waiting for 10 transactions to be mined... 16:25:04 [16:25:04.435] INFO: e2e:e2e_keys All transactions mined successfully 16:25:04 [16:25:04.435] VERBOSE: e2e:e2e_keys All transactions for L1 deployment have been mined 16:25:04 [16:25:04.451] 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"} 16:25:04 [16:25:04.453] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 16:25:04 [16:25:04.455] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:04 [16:25:04.456] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 16:25:04 [16:25:04.456] INFO: telemetry:client Using NoopTelemetryClient 16:25:04 [16:25:04.461] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 16:25:04 [16:25:04.461] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 16:25:04 [16:25:04.462] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/836cd180f247888f/blob-sink with map size 134217728 KB (LMDB v2) 16:25:04 [16:25:04.464] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:04 [16:25:04.466] INFO: aztecjs:utils:watcher New L1 time: 1749832143 16:25:04 [16:25:04.466] WARN: foundation:test-date-provider Time set to 2025-06-13T16:29:03.000Z {"offset":238534,"timeMs":1749832143000} 16:25:04 [16:25:04.468] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 16:25:04 [16:25:04.473] INFO: blob-sink:server Server is running on http://localhost:36977 16:25:04 [16:25:04.473] VERBOSE: e2e:e2e_keys Creating and synching an aztec node... 16:25:04 [16:25:04.474] VERBOSE: e2e:e2e_keys Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/75f4fd66/acvm 16:25:04 [16:25:04.474] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:36977"} 16:25:04 [16:25:04.488] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 16:25:04 [16:25:04.489] INFO: archiver:lmdb Creating archiver data store at directory /tmp/836cd180f247888f/archiver with map size 134217728 KB (LMDB v2) 16:25:04 [16:25:04.490] INFO: archiver:lmdb Starting data store with maxReaders 16 16:25:04 [16:25:04.672] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:04 [16:25:04.746] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:36977"} 16:25:04 [16:25:04.760] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:36977"} 16:25:04 [16:25:04.761] WARN: node:blob-sink:client No L1 consensus host urls configured 16:25:04 [16:25:04.761] WARN: node:blob-sink:client No archive client configured 16:25:04 [16:25:04.763] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x3364f565e1779eea3e567492ce1ad608ee2336216b60f52059a970f2426dd37d {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xa01d7751449d9de5ff9f193ea98e40702d5cd31554afbd0f29553fca79689640","l1BlockNumber":16}} 16:25:04 [16:25:04.776] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x3364f565e1779eea3e567492ce1ad608ee2336216b60f52059a970f2426dd37d","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 16:25:04 [16:25:04.780] INFO: world-state:database Creating world state data store at directory /tmp/836cd180f247888f/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 16:25:04 [16:25:04.802] INFO: world_state Created world state synchroniser with block history of 64 16:25:04 [16:25:04.802] WARN: node Aztec node is accepting fake proofs 16:25:04 [16:25:04.812] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/836cd180f247888f/p2p with map size 134217728 KB (LMDB v2) 16:25:04 [16:25:04.812] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 16:25:04 [16:25:04.813] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/836cd180f247888f/p2p-archive with map size 134217728 KB (LMDB v2) 16:25:04 [16:25:04.814] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 16:25:04 [16:25:04.815] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/836cd180f247888f/p2p-peers with map size 134217728 KB (LMDB v2) 16:25:04 [16:25:04.816] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 16:25:04 [16:25:04.817] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 16:25:04 [16:25:04.818] VERBOSE: p2p P2P is disabled. Using dummy P2P service 16:25:04 [16:25:04.820] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 16:25:04 [16:25:04.821] INFO: world_state Started world state synchronizer from block 1 16:25:04 [16:25:04.823] VERBOSE: world-state:block_stream Starting sync from block number 0 16:25:04 [16:25:04.824] INFO: p2p Starting p2p client from block 0 with empty mempools 16:25:04 [16:25:04.825] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 16:25:04 [16:25:04.826] INFO: slasher Slasher client initialized 16:25:04 [16:25:04.826] INFO: slasher Starting Slasher client... 16:25:04 [16:25:04.854] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:25:04 [16:25:04.855] VERBOSE: node All Aztec Node subsystems synced 16:25:04 [16:25:04.861] INFO: sequencer-client Deploying forwarder contract 16:25:04 [16:25:04.866] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 16:25:04 [16:25:04.879] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:04 [16:25:04.881] VERBOSE: sequencer-client Sent L1 transaction 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968 {"gasLimit":436981,"maxFeePerGas":"1.353583762","maxPriorityFeePerGas":"1.2"} 16:25:04 [16:25:04.881] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968. 16:25:04 [16:25:04.886] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:25:04 [16:25:04.899] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:25:04 [16:25:04.900] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 16:25:04 [16:25:04.900] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/75f4fd66/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 16:25:05 [16:25:05.084] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 16:25:05 [16:25:05.085] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:25:05 [16:25:05.086] INFO: node Aztec Node version: 0.87.8 16:25:05 [16:25:05.087] 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"} 16:25:05 [16:25:05.088] VERBOSE: e2e:e2e_keys Creating a pxe... 16:25:05 [16:25:05.091] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:05 [16:25:05.100] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/c148b490527416f5/pxe_data with map size 134217728 KB (LMDB v2) 16:25:05 [16:25:05.110] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x00e5969d4af7c0ac5d2a1fc178d223f9230c9866a7e4f9672f222f5159f3df67","blockNumber":1,"slot":2} 16:25:05 [16:25:05.111] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:25:05 [16:25:05.307] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:05 [16:25:05.338] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 16:25:05 [16:25:05.338] INFO: pxe:service Started PXE connected to chain 31337 version 3760013501 16:25:05 [16:25:05.385] INFO: pxe:service Registered account 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f 16:25:05 [16:25:05.439] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 16:25:05 [16:25:05.440] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f 16:25:05 [16:25:05.512] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:05 [16:25:05.557] INFO: pxe:service Added contract SchnorrAccount at 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 16:25:05 [16:25:05.595] VERBOSE: pxe:block_stream Starting sync from block number 0 16:25:05 [16:25:05.611] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 16:25:05 [16:25:05.673] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x00e5969d4af7c0ac5d2a1fc178d223f9230c9866a7e4f9672f222f5159f3df67","blockNumber":1,"slot":2} 16:25:05 [16:25:05.698] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:25:06 [16:25:06.086] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 16:25:06 [16:25:06.160] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:25:06 [16:25:06.219] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:06 [16:25:06.314] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:06 [16:25:06.343] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x00e5969d4af7c0ac5d2a1fc178d223f9230c9866a7e4f9672f222f5159f3df67","blockNumber":1,"slot":2} 16:25:06 [16:25:06.350] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:25:06 [16:25:06.350] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:06 [16:25:06.389] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:06 [16:25:06.393] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:25:06 [16:25:06.442] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:06 [16:25:06.551] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:06 [16:25:06.585] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:25:06 [16:25:06.585] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:06 [16:25:06.616] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:06 [16:25:06.619] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:25:06 [16:25:06.633] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f as fee payer 16:25:06 [16:25:06.654] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:06 [16:25:06.870] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:06 [16:25:06.883] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x00e5969d4af7c0ac5d2a1fc178d223f9230c9866a7e4f9672f222f5159f3df67","blockNumber":1,"slot":2} 16:25:07 [16:25:07.142] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:07 [16:25:07.724] INFO: pxe:service Proving completed in 2136.440032999999ms {"timings":{"total":2136.440032999999,"sync":8.278892000000269,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":120.45607299999938,"oracles":{"callPrivateFunction":{"times":[561.4426350000003,269.88958100000036,159.06163099999958]}}},{"functionName":"private_kernel_init","time":95.37972400000035},{"functionName":"ContractClassRegisterer:register","time":548.2507620000006,"oracles":{"loadCapsule":{"times":[4.430916999999681]},"notifyCreatedNullifier":{"times":[0.5633019999995668]},"debugLog":{"times":[0.7698500000005879]},"notifyCreatedContractClassLog":{"times":[7.8577699999996184]}}},{"functionName":"private_kernel_inner","time":118.14054400000077},{"functionName":"SchnorrAccount:constructor","time":244.22287899999992,"oracles":{"getContractInstance":{"times":[1.8257059999996272]},"debugLog":{"times":[0.4968059999991965,0.4339939999999842]},"fetchTaggedLogs":{"times":[41.34429799999998]},"loadCapsule":{"times":[0.36256000000048516,0.2470210000001316,0.24513200000001234]},"notifyCreatedNullifier":{"times":[0.20359999999982392,0.25714199999947596]},"notifyCreatedNote":{"times":[0.3728549999996176]},"getRandomField":{"times":[0.38025999999990745,0.1877119999999195,0.11673500000051718,0.10752599999977974,0.07947899999999208,0.09383600000001024,0.07802799999990384,0.07970100000056846,0.07696200000009412,0.10973099999955593,0.07100699999955395]},"getIndexedTaggingSecretAsSender":{"times":[33.76973300000009]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.067291999999725]}}},{"functionName":"private_kernel_inner","time":109.0525520000001},{"functionName":"SchnorrAccount:entrypoint","time":136.01932599999964,"oracles":{"debugLog":{"times":[0.4865399999998772,0.4019220000000132,0.5817349999997532]},"fetchTaggedLogs":{"times":[32.5956929999993]},"loadCapsule":{"times":[0.20697399999971822,0.20662300000003597,0.24492900000041118]},"getNotes":{"times":[1.5512849999995524]},"getAuthWitness":{"times":[0.3430159999998068]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7959950000004028]}}},{"functionName":"private_kernel_inner","time":106.73901000000114},{"functionName":"private_kernel_reset","time":165.0040570000001},{"functionName":"private_kernel_tail","time":70.87374799999998}],"unaccounted":414.0224659999967}} 16:25:07 [16:25:07.740] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:07 [16:25:07.804] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x00e5969d4af7c0ac5d2a1fc178d223f9230c9866a7e4f9672f222f5159f3df67","blockNumber":1,"slot":2} 16:25:07 [16:25:07.867] VERBOSE: p2p:tx_pool Adding tx 0x07552d614ea8a9ddd56c51ce3b10dc29f9e853023dd3ff44b7d37f2b98b095d8 to pool {"eventName":"tx-added-to-pool","txHash":"0x07552d614ea8a9ddd56c51ce3b10dc29f9e853023dd3ff44b7d37f2b98b095d8","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 16:25:07 [16:25:07.885] INFO: node Received tx 0x07552d614ea8a9ddd56c51ce3b10dc29f9e853023dd3ff44b7d37f2b98b095d8 {"txHash":"0x07552d614ea8a9ddd56c51ce3b10dc29f9e853023dd3ff44b7d37f2b98b095d8"} 16:25:07 [16:25:07.885] INFO: pxe:service Sent transaction 0x07552d614ea8a9ddd56c51ce3b10dc29f9e853023dd3ff44b7d37f2b98b095d8 16:25:07 [16:25:07.946] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:08 [16:25:08.149] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:08 [16:25:08.317] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 16:25:08 [16:25:08.329] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T16:29:27.000Z","now":"2025-06-13T16:29:06.863Z"} 16:25:08 [16:25:08.393] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:08 [16:25:08.562] VERBOSE: simulator:public-processor Processed tx 0x07552d614ea8a9ddd56c51ce3b10dc29f9e853023dd3ff44b7d37f2b98b095d8 with no public calls in 157.9193180000002ms {"txHash":"0x07552d614ea8a9ddd56c51ce3b10dc29f9e853023dd3ff44b7d37f2b98b095d8","txFee":6794052480,"revertCode":0,"gasUsed":{"totalGas":{"daGas":16896,"l2Gas":20448},"billedGas":{"daGas":16896,"l2Gas":20448},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":1,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":157.9193180000002} 16:25:08 [16:25:08.566] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.23528527600000052s {"duration":0.23528527600000052,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 16:25:08 [16:25:08.678] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:08 [16:25:08.692] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2d2ac5fa966c825ccc91a5c6f46759e1c373ebce52a6f5b6c3c63e75fb237b6f","globalVariables":{"chainId":31337,"version":3760013501,"blockNumber":1,"slotNumber":2,"timestamp":1749832167,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x07552d614ea8a9ddd56c51ce3b10dc29f9e853023dd3ff44b7d37f2b98b095d8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":374.6007359999985,"publicProcessDuration":236.08315799999946,"rollupCircuitsDuration":363.1766110000008,"txCount":1,"blockNumber":1,"blockTimestamp":1749832167,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:25:08 [16:25:08.695] VERBOSE: sequencer Attesting committee is empty 16:25:08 [16:25:08.884] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:09 [16:25:09.048] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xc9f0a56f311bd3d0c283aed06cec409fc4414dfe90ff514739bd290eab4e7fdb 16:25:09 [16:25:09.049] VERBOSE: sequencer-client Sent L1 transaction 0xc9f0a56f311bd3d0c283aed06cec409fc4414dfe90ff514739bd290eab4e7fdb {"gasLimit":514507,"maxFeePerGas":"1.574385791","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 16:25:09 [16:25:09.059] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:25:09 [16:25:09.060] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xc9f0a56f311bd3d0c283aed06cec409fc4414dfe90ff514739bd290eab4e7fdb","calldataSize":1444,"calldataGas":12256,"txCount":1,"blockNumber":1,"blockTimestamp":1749832167,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:25:09 [16:25:09.060] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:25:09 [16:25:09.075] INFO: blob-sink:server Received blob sidecar for block 0xc5f852de2e5d2cac6f9ec9cbf9f6043c8c781a1765c70ee0f8f915bac973519d 16:25:09 [16:25:09.080] INFO: blob-sink:server Blob sidecar stored successfully for block 0xc5f852de2e5d2cac6f9ec9cbf9f6043c8c781a1765c70ee0f8f915bac973519d 16:25:09 [16:25:09.086] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:09 [16:25:09.091] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 16:25:09 [16:25:09.092] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 16:25:09 [16:25:09.094] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 16:25:09 [16:25:09.107] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749832203] on http://127.0.0.1:8545 16:25:09 [16:25:09.109] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:25:09 [16:25:09.110] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749832203 16:25:09 [16:25:09.110] WARN: foundation:test-date-provider Time set to 2025-06-13T16:30:03.000Z {"offset":293890,"timeMs":1749832203000} 16:25:09 [16:25:09.111] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 16:25:09 [16:25:09.290] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:09 [16:25:09.535] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:09 [16:25:09.553] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 16:25:09 [16:25:09.563] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2d2ac5fa966c825ccc91a5c6f46759e1c373ebce52a6f5b6c3c63e75fb237b6f","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3760013501,"blockNumber":1,"slotNumber":2,"timestamp":1749832167,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2c3fae987693b66d319f08e9ed6f5431ab34e539e10ca871bae9c5fdb3422a45","archiveNextLeafIndex":2} 16:25:09 [16:25:09.571] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 16:25:09 [16:25:09.964] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:09 [16:25:09.968] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":321.26209500000004,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749832167,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:25:09 [16:25:09.969] WARN: pxe:service No artifact found for contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f when looking for its metadata 16:25:09 [16:25:09.971] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f as part of deployment for 0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876 16:25:10 [16:25:10.184] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:10 [16:25:10.205] VERBOSE: p2p Synched to latest block 1 16:25:10 [16:25:10.434] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:10 [16:25:10.444] INFO: pxe:service Added contract Test at 0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876 with class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 16:25:10 [16:25:10.465] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x2c3fae987693b66d319f08e9ed6f5431ab34e539e10ca871bae9c5fdb3422a45","header":{"contentCommitment":{"blobsHash":"0x005af7a91b006003bbb5afe8864015f75b5da68365f27ff66909be70176a3af5","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749832167,"version":3760013501},"lastArchive":"0x00e5969d4af7c0ac5d2a1fc178d223f9230c9866a7e4f9672f222f5159f3df67","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x09baadbf8da7f8a9adffe522ddd8b2f6b84866d47c826d863dd2acc4f1eb99bf","nullifierTree":"0x27beed28bc39d9aded5f1855fe7b1ddc33387aac57dc79112381767051aa6760","publicDataTree":"0x2b4976d8c9e4d9171fb327e4500952ef45ac98cf5f51297e2f17e46f78ac5ed3"},"totalFees":6794052480,"totalManaUsed":20448}} 16:25:10 [16:25:10.535] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:10 [16:25:10.568] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:25:10 [16:25:10.568] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:10 [16:25:10.619] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:10 [16:25:10.623] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1092ea61619c960fcf7585022ae88677978c4963a948db6c8378e55f645724b2 16:25:10 [16:25:10.634] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:25:10 [16:25:10.635] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:25:10 [16:25:10.642] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:10 [16:25:10.726] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:25:10 [16:25:10.726] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:25:10 [16:25:10.743] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2c3fae987693b66d319f08e9ed6f5431ab34e539e10ca871bae9c5fdb3422a45","blockNumber":2,"slot":3} 16:25:10 [16:25:10.743] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0be26bc1324ebdfa2863f09060807aca5fd1ed98f25c0e4e8f45ffd0a23ca034","nullifier":"0x05919c092f083da593fe032fb29357245b35355393c6a92aea11b50bd8d2c24e"} 16:25:10 [16:25:10.751] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:25:10 [16:25:10.762] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f as fee payer 16:25:10 [16:25:10.788] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:25:11 [16:25:11.101] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0231f367ddb29264182678ec70e69bd06340efa7dc780f1c7522d13c96eed157,0x08fed0d02dac97b0ce237807685976eba973a7f517fc0723c067c7b7b6e121cc,0x11714ee3dfbdb30a8b2975f186d75eb58f17897f0b8ce770a03c05432642725e 16:25:11 [16:25:11.171] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:25:11 [16:25:11.224] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:11 [16:25:11.264] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 16:25:11 [16:25:11.314] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:25:11 [16:25:11.325] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876,0x0000000000000000000000000000000000000000000000000000000000000001,0x0cd95edfe5e5b22aab59888e546db94e0d80987349eecfe32363b881d51edd2b,0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0eea76e1163ccfa69030e0733759dce0ccf602f045e7b4a3d9ec9b0864e70308,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f 16:25:11 [16:25:11.342] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2c3fae987693b66d319f08e9ed6f5431ab34e539e10ca871bae9c5fdb3422a45","blockNumber":2,"slot":3} 16:25:11 [16:25:11.454] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:11 [16:25:11.757] VERBOSE: simulator:private_execution Executing private function Test:initialize {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:11 [16:25:11.770] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:11 [16:25:11.774] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:25:11 [16:25:11.775] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:11 [16:25:11.927] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:11 [16:25:11.935] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2c3fae987693b66d319f08e9ed6f5431ab34e539e10ca871bae9c5fdb3422a45","blockNumber":2,"slot":3} 16:25:11 [16:25:11.938] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:25:12 [16:25:12.021] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:12 [16:25:12.257] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:12 [16:25:12.496] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:12 [16:25:12.632] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2c3fae987693b66d319f08e9ed6f5431ab34e539e10ca871bae9c5fdb3422a45","blockNumber":2,"slot":3} 16:25:12 [16:25:12.737] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:13 [16:25:13.180] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:13 [16:25:13.548] INFO: pxe:service Proving completed in 3089.7485449999986ms {"timings":{"total":3089.7485449999986,"sync":8.861398000000918,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":509.2941039999987,"oracles":{"debugLog":{"times":[0.4895329999999376,0.4266939999997703,0.46608199999900535,0.5940120000013849,0.44522300000062387,0.3556929999995191,0.37186900000051537,0.4413280000007944]},"fetchTaggedLogs":{"times":[52.82769699999881]},"loadCapsule":{"times":[0.2550340000016149,0.40842499999962456,0.5042319999993197,0.891433999999208,0.41518700000051467,0.34072999999989406]},"getSharedSecret":{"times":[3.474702999999863]},"aes128Decrypt":{"times":[1.0086630000005243,1.0625569999992877]},"getPublicKeysAndPartialAddress":{"times":[7.645554999999149]},"getKeyValidationRequest":{"times":[80.1924710000003]},"deliverNote":{"times":[16.947559999998703]},"deleteCapsule":{"times":[3.8703439999990223]},"storeCapsule":{"times":[1.215437999999267]},"getNotes":{"times":[1.3617159999994328]},"getAuthWitness":{"times":[0.21608199999900535]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05322599999999511]},"callPrivateFunction":{"times":[459.2274019999986,106.03880899999967,612.3535630000006]}}},{"functionName":"private_kernel_init","time":55.12987599999906},{"functionName":"ContractClassRegisterer:register","time":446.1480850000007,"oracles":{"loadCapsule":{"times":[3.702741999999489]},"notifyCreatedNullifier":{"times":[0.290168999999878]},"debugLog":{"times":[0.4331789999996545]},"notifyCreatedContractClassLog":{"times":[6.6549379999996745]}}},{"functionName":"private_kernel_inner","time":105.78601100000014},{"functionName":"ContractInstanceDeployer:deploy","time":56.320866000000024,"oracles":{"storeInExecutionCache":{"times":[0.21493399999963003]},"callPrivateFunction":{"times":[47.182756000000154]},"notifyCreatedNullifier":{"times":[0.28377999999975145]},"debugLog":{"times":[0.5108970000001136]}}},{"functionName":"private_kernel_inner","time":108.5589089999994},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":37.88684700000158,"oracles":{}},{"functionName":"private_kernel_inner","time":105.18425100000059},{"functionName":"Test:initialize","time":411.7816810000004,"oracles":{"getContractInstance":{"times":[4.680777999999918]},"debugLog":{"times":[0.45121500000095693,0.36227599999983795]},"fetchTaggedLogs":{"times":[161.88790999999947]},"loadCapsule":{"times":[0.19013300000005984,0.20099300000038056,0.2045189999989816]},"notifyCreatedNullifier":{"times":[0.21686099999897124]}}},{"functionName":"private_kernel_inner","time":107.88860700000077},{"functionName":"private_kernel_reset","time":162.85132800000065},{"functionName":"private_kernel_tail","time":66.5360440000004}],"unaccounted":907.5205379999952}} 16:25:13 [16:25:13.564] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2c3fae987693b66d319f08e9ed6f5431ab34e539e10ca871bae9c5fdb3422a45","blockNumber":2,"slot":3} 16:25:13 [16:25:13.566] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:13 [16:25:13.708] VERBOSE: p2p:tx_pool Adding tx 0x0e535cb2d3d12847022ddaf14615f0dd4a5aadae90f27f9a02ac3d8ae87c6643 to pool {"eventName":"tx-added-to-pool","txHash":"0x0e535cb2d3d12847022ddaf14615f0dd4a5aadae90f27f9a02ac3d8ae87c6643","noteHashCount":0,"nullifierCount":4,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":583,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 16:25:13 [16:25:13.725] INFO: node Received tx 0x0e535cb2d3d12847022ddaf14615f0dd4a5aadae90f27f9a02ac3d8ae87c6643 {"txHash":"0x0e535cb2d3d12847022ddaf14615f0dd4a5aadae90f27f9a02ac3d8ae87c6643"} 16:25:13 [16:25:13.725] INFO: pxe:service Sent transaction 0x0e535cb2d3d12847022ddaf14615f0dd4a5aadae90f27f9a02ac3d8ae87c6643 16:25:13 [16:25:13.772] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:13 [16:25:13.975] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:14 [16:25:14.088] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 16:25:14 [16:25:14.102] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T16:30:03.000Z","now":"2025-06-13T16:30:07.992Z"} 16:25:14 [16:25:14.185] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:14 [16:25:14.377] VERBOSE: simulator:public-processor Processed tx 0x0e535cb2d3d12847022ddaf14615f0dd4a5aadae90f27f9a02ac3d8ae87c6643 with no public calls in 182.30837599999904ms {"txHash":"0x0e535cb2d3d12847022ddaf14615f0dd4a5aadae90f27f9a02ac3d8ae87c6643","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":182.30837599999904} 16:25:14 [16:25:14.379] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2767897069999999s {"duration":0.2767897069999999,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":310272,"l2Gas":21888},"totalSizeInBytes":19648} 16:25:14 [16:25:14.388] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:14 [16:25:14.538] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0ab83a5c77816ae7dffda96a58f1bba8615463e64b76bfcecbdcdcad823799f8","globalVariables":{"chainId":31337,"version":3760013501,"blockNumber":2,"slotNumber":3,"timestamp":1749832203,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0e535cb2d3d12847022ddaf14615f0dd4a5aadae90f27f9a02ac3d8ae87c6643"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":449.772379,"publicProcessDuration":277.2221410000002,"rollupCircuitsDuration":436.5912499999995,"txCount":1,"blockNumber":2,"blockTimestamp":1749832203,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 16:25:14 [16:25:14.543] VERBOSE: sequencer Attesting committee is empty 16:25:14 [16:25:14.650] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:14 [16:25:14.854] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:14 [16:25:14.859] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x662989425e314c545d46d47d8aa2ed44cf86677b3923e498c68f8a5d52003216 16:25:14 [16:25:14.859] VERBOSE: sequencer-client Sent L1 transaction 0x662989425e314c545d46d47d8aa2ed44cf86677b3923e498c68f8a5d52003216 {"gasLimit":470265,"maxFeePerGas":"1.303611163","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:25:14 [16:25:14.866] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 16:25:14 [16:25:14.869] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 16:25:14 [16:25:14.871] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:25:14 [16:25:14.872] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x662989425e314c545d46d47d8aa2ed44cf86677b3923e498c68f8a5d52003216","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":2,"blockTimestamp":1749832203,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 16:25:14 [16:25:14.872] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:25:14 [16:25:14.875] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 16:25:14 [16:25:14.878] INFO: blob-sink:server Received blob sidecar for block 0x17da6f713fbca99db08be23b4f20560209f25a692103e72acb7a0af36cd0a9d2 16:25:14 [16:25:14.882] INFO: blob-sink:server Blob sidecar stored successfully for block 0x17da6f713fbca99db08be23b4f20560209f25a692103e72acb7a0af36cd0a9d2 16:25:15 [16:25:15.059] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:15 [16:25:15.060] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749832239] on http://127.0.0.1:8545 16:25:15 [16:25:15.065] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:25:15 [16:25:15.067] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749832239 16:25:15 [16:25:15.067] WARN: foundation:test-date-provider Time set to 2025-06-13T16:30:39.000Z {"offset":323933,"timeMs":1749832239000} 16:25:15 [16:25:15.067] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 16:25:15 [16:25:15.344] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:15 [16:25:15.363] VERBOSE: archiver:block-helper Store contract instance at 0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876 16:25:15 [16:25:15.384] VERBOSE: archiver:block-helper Store contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 16:25:15 [16:25:15.418] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0ab83a5c77816ae7dffda96a58f1bba8615463e64b76bfcecbdcdcad823799f8","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3760013501,"blockNumber":2,"slotNumber":3,"timestamp":1749832203,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x08d910094f0b176029187ba65b5df3e6e1c89e92c217940f9e6f366fb4be2f3c","archiveNextLeafIndex":3} 16:25:15 [16:25:15.433] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 16:25:15 [16:25:15.465] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.556443000001309,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749832203,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 16:25:15 [16:25:15.540] VERBOSE: p2p Synched to latest block 2 16:25:15 [16:25:15.549] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:15 [16:25:15.877] INFO: aztecjs:deploy_sent_tx Contract 0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876 successfully deployed. 16:25:15 [16:25:15.879] INFO: e2e:e2e_keys Running test: Keys using nsk_app to detect nullification nsk_app and contract address are enough to detect note nullification 16:25:15 [16:25:15.887] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:15 [16:25:15.915] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x08d910094f0b176029187ba65b5df3e6e1c89e92c217940f9e6f366fb4be2f3c","header":{"contentCommitment":{"blobsHash":"0x0003abf5e0ada45d18950230f6027e9f693f218d694923bbf4fafc922e764767","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749832203,"version":3760013501},"lastArchive":"0x2c3fae987693b66d319f08e9ed6f5431ab34e539e10ca871bae9c5fdb3422a45","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x09baadbf8da7f8a9adffe522ddd8b2f6b84866d47c826d863dd2acc4f1eb99bf","nullifierTree":"0x102bfe6d996409bae4d19b79db44978afcfafabdf8b2b2cad41ac28154db10dc","publicDataTree":"0x0b34c631c2b7daf9202e10e8ca6383977589d663d8eaef2ce2dc5fe1b1a71bdc"},"totalFees":7272506880,"totalManaUsed":21888}} 16:25:15 [16:25:15.979] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:16 [16:25:16.012] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:25:16 [16:25:16.012] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:16 [16:25:16.069] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x08d910094f0b176029187ba65b5df3e6e1c89e92c217940f9e6f366fb4be2f3c","blockNumber":3,"slot":4} 16:25:16 [16:25:16.078] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:16 [16:25:16.082] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1092ea61619c960fcf7585022ae88677978c4963a948db6c8378e55f645724b2 16:25:16 [16:25:16.092] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:25:16 [16:25:16.092] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:25:16 [16:25:16.093] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:16 [16:25:16.100] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:25:16 [16:25:16.101] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:25:16 [16:25:16.107] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0be26bc1324ebdfa2863f09060807aca5fd1ed98f25c0e4e8f45ffd0a23ca034","nullifier":"0x05919c092f083da593fe032fb29357245b35355393c6a92aea11b50bd8d2c24e"} 16:25:16 [16:25:16.110] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:25:16 [16:25:16.122] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f as fee payer 16:25:16 [16:25:16.335] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:16 [16:25:16.529] VERBOSE: simulator:private_execution Executing private function Test:call_create_note {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:16 [16:25:16.559] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:25:16 [16:25:16.559] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:16 [16:25:16.711] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:16 [16:25:16.713] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x08d910094f0b176029187ba65b5df3e6e1c89e92c217940f9e6f366fb4be2f3c","blockNumber":3,"slot":4} 16:25:16 [16:25:16.718] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:25:16 [16:25:16.841] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:17 [16:25:17.047] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:17 [16:25:17.505] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:17 [16:25:17.646] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x08d910094f0b176029187ba65b5df3e6e1c89e92c217940f9e6f366fb4be2f3c","blockNumber":3,"slot":4} 16:25:17 [16:25:17.882] INFO: pxe:service Proving completed in 1974.379961999999ms {"timings":{"total":1974.379961999999,"sync":9.49533099999826,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":391.1922760000016,"oracles":{"debugLog":{"times":[0.44769299999825307,0.40447800000038114,0.40878800000064075,0.5086279999995895,0.4191750000027241,0.35516700000152923,0.35701999999946565,0.46081300000150804]},"fetchTaggedLogs":{"times":[68.52685900000142]},"loadCapsule":{"times":[0.1928040000020701,0.15186699999685516,0.3531089999996766,0.26996199999848614,0.6593670000002021,0.18505799999911687]},"getSharedSecret":{"times":[2.793540999999095]},"aes128Decrypt":{"times":[0.2304889999977604,0.8390780000008817]},"getPublicKeysAndPartialAddress":{"times":[4.327543999999762]},"getKeyValidationRequest":{"times":[1.4617859999998473]},"deliverNote":{"times":[6.009320999997726]},"deleteCapsule":{"times":[1.4712299999991956]},"storeCapsule":{"times":[0.24624899999980698]},"getNotes":{"times":[1.3414739999971061]},"getAuthWitness":{"times":[0.19070899999860558]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.061330000000452856]},"callPrivateFunction":{"times":[845.0638770000005]}}},{"functionName":"private_kernel_init","time":58.836136999998416},{"functionName":"Test:call_create_note","time":647.469720000001,"oracles":{"debugLog":{"times":[0.4727969999985362,0.3700270000008459]},"fetchTaggedLogs":{"times":[157.5731420000011]},"loadCapsule":{"times":[0.19073300000309246,0.163684999999532,0.21530799999891315]},"getRandomField":{"times":[0.1035539999975299,0.11466500000096858,0.13108400000055553,0.0894189999999071,0.06596799999897485,0.07243000000016764,0.05732300000090618,0.06552299999748357,0.055816000000049826,0.06849100000181352,0.06508000000030734,0.06790199999886681]},"notifyCreatedNote":{"times":[0.134211000000505]},"getIndexedTaggingSecretAsSender":{"times":[119.79396500000075]},"incrementAppTaggingSecretIndexAsSender":{"times":[102.78190199999881]}}},{"functionName":"private_kernel_inner","time":105.08922000000166},{"functionName":"private_kernel_reset","time":172.5814680000003},{"functionName":"private_kernel_tail","time":69.03191099999822}],"unaccounted":520.6838989999997}} 16:25:17 [16:25:17.894] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:17 [16:25:17.915] VERBOSE: p2p:tx_pool Adding tx 0x28e4e05c6e4164024a3e7c869aa3a66096870f302741cc5cc12ecc3657934f29 to pool {"eventName":"tx-added-to-pool","txHash":"0x28e4e05c6e4164024a3e7c869aa3a66096870f302741cc5cc12ecc3657934f29","noteHashCount":1,"nullifierCount":1,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 16:25:17 [16:25:17.919] INFO: node Received tx 0x28e4e05c6e4164024a3e7c869aa3a66096870f302741cc5cc12ecc3657934f29 {"txHash":"0x28e4e05c6e4164024a3e7c869aa3a66096870f302741cc5cc12ecc3657934f29"} 16:25:17 [16:25:17.920] INFO: pxe:service Sent transaction 0x28e4e05c6e4164024a3e7c869aa3a66096870f302741cc5cc12ecc3657934f29 16:25:18 [16:25:18.099] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:18 [16:25:18.177] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 16:25:18 [16:25:18.191] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T16:30:39.000Z","now":"2025-06-13T16:30:42.124Z"} 16:25:18 [16:25:18.210] VERBOSE: simulator:public-processor Processed tx 0x28e4e05c6e4164024a3e7c869aa3a66096870f302741cc5cc12ecc3657934f29 with no public calls in 12.483942000002571ms {"txHash":"0x28e4e05c6e4164024a3e7c869aa3a66096870f302741cc5cc12ecc3657934f29","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":12.483942000002571} 16:25:18 [16:25:18.211] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.019325823999999558s {"duration":0.019325823999999558,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11264,"l2Gas":9760},"totalSizeInBytes":960} 16:25:18 [16:25:18.318] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:18 [16:25:18.334] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x16c167056de94c236c9af04b3a8b3ec76d622f77b6959c20593ab1ec2f4e7ec5","globalVariables":{"chainId":31337,"version":3760013501,"blockNumber":3,"slotNumber":4,"timestamp":1749832239,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x28e4e05c6e4164024a3e7c869aa3a66096870f302741cc5cc12ecc3657934f29"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":157.4659240000001,"publicProcessDuration":19.713638000001083,"rollupCircuitsDuration":143.74190699999963,"txCount":1,"blockNumber":3,"blockTimestamp":1749832239,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:25:18 [16:25:18.336] VERBOSE: sequencer Attesting committee is empty 16:25:18 [16:25:18.592] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:18 [16:25:18.600] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xf08b39ee55dcc88dfabfaf82c5a38fb0a68ae448b9d4911bfbfc851d6e3006e0 16:25:18 [16:25:18.601] VERBOSE: sequencer-client Sent L1 transaction 0xf08b39ee55dcc88dfabfaf82c5a38fb0a68ae448b9d4911bfbfc851d6e3006e0 {"gasLimit":470265,"maxFeePerGas":"1.279583374","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:25:18 [16:25:18.609] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749832275] on http://127.0.0.1:8545 16:25:18 [16:25:18.611] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:25:18 [16:25:18.613] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:25:18 [16:25:18.614] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf08b39ee55dcc88dfabfaf82c5a38fb0a68ae448b9d4911bfbfc851d6e3006e0","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":3,"blockTimestamp":1749832239,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:25:18 [16:25:18.614] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:25:18 [16:25:18.616] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749832275 16:25:18 [16:25:18.617] WARN: foundation:test-date-provider Time set to 2025-06-13T16:31:15.000Z {"offset":356383,"timeMs":1749832275000} 16:25:18 [16:25:18.617] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 16:25:18 [16:25:18.622] INFO: blob-sink:server Received blob sidecar for block 0xc22b7915bc7f54e3e73a09ddbf80b53c4ae5fa3097d28b84d3cb1a6375909d9f 16:25:18 [16:25:18.625] INFO: blob-sink:server Blob sidecar stored successfully for block 0xc22b7915bc7f54e3e73a09ddbf80b53c4ae5fa3097d28b84d3cb1a6375909d9f 16:25:18 [16:25:18.803] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:18 [16:25:18.814] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 16:25:18 [16:25:18.817] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 16:25:18 [16:25:18.820] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x16c167056de94c236c9af04b3a8b3ec76d622f77b6959c20593ab1ec2f4e7ec5","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":3760013501,"blockNumber":3,"slotNumber":4,"timestamp":1749832239,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x28223569736b7c45b350453b72cf738897485d1730b0d6dc21b345141e34cabb","archiveNextLeafIndex":4} 16:25:18 [16:25:18.821] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 16:25:18 [16:25:18.928] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":7.816150999999081,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749832239,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:25:18 [16:25:18.958] VERBOSE: p2p Synched to latest block 3 16:25:18 [16:25:18.960] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x28223569736b7c45b350453b72cf738897485d1730b0d6dc21b345141e34cabb","header":{"contentCommitment":{"blobsHash":"0x004d1038fed8a307f5f215bd0d095547ab5544e2fa5309a34131b4c3a8fb6a6e","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749832239,"version":3760013501},"lastArchive":"0x08d910094f0b176029187ba65b5df3e6e1c89e92c217940f9e6f366fb4be2f3c","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x003d8dc23ea645d16a6e61a1462d71052de1f74db3aaa9499e1c6bab9a9a16b7","nullifierTree":"0x217a7464c69812b0e3cb0c6be6e63d8e931f9e19e1c14963d67b2debdc367cf5","publicDataTree":"0x202855cb5a7da36d68e15aec7624b887775b3041709160aadff4f3f65e86ea6a"},"totalFees":3242857600,"totalManaUsed":9760}} 16:25:19 [16:25:19.022] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:19 [16:25:19.054] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:25:19 [16:25:19.055] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:19 [16:25:19.055] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:19 [16:25:19.098] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:19 [16:25:19.102] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1092ea61619c960fcf7585022ae88677978c4963a948db6c8378e55f645724b2 16:25:19 [16:25:19.111] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:25:19 [16:25:19.112] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:25:19 [16:25:19.116] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:25:19 [16:25:19.117] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:25:19 [16:25:19.124] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0be26bc1324ebdfa2863f09060807aca5fd1ed98f25c0e4e8f45ffd0a23ca034","nullifier":"0x05919c092f083da593fe032fb29357245b35355393c6a92aea11b50bd8d2c24e"} 16:25:19 [16:25:19.130] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:25:19 [16:25:19.134] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x28223569736b7c45b350453b72cf738897485d1730b0d6dc21b345141e34cabb","blockNumber":4,"slot":5} 16:25:19 [16:25:19.143] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f as fee payer 16:25:19 [16:25:19.322] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:19 [16:25:19.538] VERBOSE: simulator:private_execution Executing private function Test:call_destroy_note {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:19 [16:25:19.569] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:25:19 [16:25:19.569] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:19 [16:25:19.683] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:19 [16:25:19.696] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 16:25:19 [16:25:19.714] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x28223569736b7c45b350453b72cf738897485d1730b0d6dc21b345141e34cabb","blockNumber":4,"slot":5} 16:25:19 [16:25:19.718] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:19 [16:25:19.722] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x08b1c622c4123f875f7fe30f35203900fb2b70b9e61adda7f3d34295015ee2fc 16:25:19 [16:25:19.731] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:25:19 [16:25:19.732] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876 for storage slot 0x000000000000000000000000000000000000000000000000000000000000000c 16:25:19 [16:25:19.736] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:25:19 [16:25:19.737] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:25:19 [16:25:19.739] VERBOSE: pxe:service Added note {"index":128,"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x28b823cc658484e1144d1d9e6be2a8e1c8e9b66b29d834b0667dc578aec39fdd","nullifier":"0x2ec9980fe792fc96707611d2495ccc98e980ec02e664bf7c0bc1a17c503a09b8"} 16:25:19 [16:25:19.741] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:25:19 [16:25:19.906] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:20 [16:25:20.291] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:20 [16:25:20.433] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x28223569736b7c45b350453b72cf738897485d1730b0d6dc21b345141e34cabb","blockNumber":4,"slot":5} 16:25:20 [16:25:20.668] INFO: pxe:service Proving completed in 1718.753045999998ms {"timings":{"total":1718.753045999998,"sync":11.996523999998317,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":279.36714400000346,"oracles":{"debugLog":{"times":[0.45423699999810196,0.37187899999844376,0.380074999997305,0.48522999999840977,0.36297900000135996,0.35408800000004703,0.376458000002458,0.4324530000012601]},"fetchTaggedLogs":{"times":[45.647790999999415]},"loadCapsule":{"times":[0.19349499999952968,0.15766399999847636,0.3095900000007532,1.6699580000022252,1.571245999999519,0.2605100000000675]},"getSharedSecret":{"times":[2.5285450000010314]},"aes128Decrypt":{"times":[0.2225990000006277,0.8534099999997125]},"getPublicKeysAndPartialAddress":{"times":[1.1454860000012559]},"getKeyValidationRequest":{"times":[1.2148010000018985]},"deliverNote":{"times":[7.737160000000586]},"deleteCapsule":{"times":[0.2882580000004964]},"storeCapsule":{"times":[1.7644790000013018]},"getNotes":{"times":[2.345002999998542]},"getAuthWitness":{"times":[0.21653100000185077]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07578500000090571]},"callPrivateFunction":{"times":[620.6880300000012]}}},{"functionName":"private_kernel_init","time":54.32578099999955},{"functionName":"Test:call_destroy_note","time":512.3668179999986,"oracles":{"debugLog":{"times":[0.4534160000002885,0.38412999999854947,0.41135100000246894,0.4992209999982151,0.3840959999979532,0.33880800000042655,0.31917499999690335]},"fetchTaggedLogs":{"times":[150.81070400000317]},"loadCapsule":{"times":[0.16555399999924703,0.1503000000011525,0.360434999998688,0.1942720000006375,0.17033599999922444,0.19549999999799184]},"getSharedSecret":{"times":[2.5521310000003723]},"aes128Decrypt":{"times":[0.22407899999961955,0.8262219999996887]},"getPublicKeysAndPartialAddress":{"times":[1.2613060000003316,1.2466520000016317]},"getKeyValidationRequest":{"times":[1.2090989999996964,1.3795380000010482]},"deliverNote":{"times":[2.4843809999983932]},"deleteCapsule":{"times":[0.22412400000030175]},"storeCapsule":{"times":[0.2107030000006489]},"getNotes":{"times":[1.3690189999979339]},"notifyNullifiedNote":{"times":[0.37984099999812315]}}},{"functionName":"private_kernel_inner","time":104.92263399999865},{"functionName":"private_kernel_reset","time":174.7355830000015},{"functionName":"private_kernel_tail","time":69.60565299999871}],"unaccounted":511.4329089999992}} 16:25:20 [16:25:20.680] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:20 [16:25:20.701] VERBOSE: p2p:tx_pool Adding tx 0x293d4ab6242fff89e9cfd1b71362ea36f622883d84875171cdec409be5f1a187 to pool {"eventName":"tx-added-to-pool","txHash":"0x293d4ab6242fff89e9cfd1b71362ea36f622883d84875171cdec409be5f1a187","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 16:25:20 [16:25:20.705] INFO: node Received tx 0x293d4ab6242fff89e9cfd1b71362ea36f622883d84875171cdec409be5f1a187 {"txHash":"0x293d4ab6242fff89e9cfd1b71362ea36f622883d84875171cdec409be5f1a187"} 16:25:20 [16:25:20.705] INFO: pxe:service Sent transaction 0x293d4ab6242fff89e9cfd1b71362ea36f622883d84875171cdec409be5f1a187 16:25:20 [16:25:20.884] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:20 [16:25:20.953] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 16:25:20 [16:25:20.965] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-13T16:31:15.000Z","now":"2025-06-13T16:31:17.348Z"} 16:25:20 [16:25:20.985] VERBOSE: simulator:public-processor Processed tx 0x293d4ab6242fff89e9cfd1b71362ea36f622883d84875171cdec409be5f1a187 with no public calls in 13.73233799999798ms {"txHash":"0x293d4ab6242fff89e9cfd1b71362ea36f622883d84875171cdec409be5f1a187","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":13.73233799999798} 16:25:20 [16:25:20.986] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.020492781999997534s {"duration":0.020492781999997534,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":11200},"totalSizeInBytes":288} 16:25:21 [16:25:21.090] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:21 [16:25:21.099] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x27f83330d3927b217befb3ac49c1c104c055c849c0fe4831ca5e506d8e29fa2f","globalVariables":{"chainId":31337,"version":3760013501,"blockNumber":4,"slotNumber":5,"timestamp":1749832275,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x293d4ab6242fff89e9cfd1b71362ea36f622883d84875171cdec409be5f1a187"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":144.96542799999952,"publicProcessDuration":20.845305999999255,"rollupCircuitsDuration":134.46627299999818,"txCount":1,"blockNumber":4,"blockTimestamp":1749832275,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:25:21 [16:25:21.100] VERBOSE: sequencer Attesting committee is empty 16:25:21 [16:25:21.353] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:21 [16:25:21.359] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xf6ee3a05938076e0bfe5ea9380c2528a2f5d8b39e3268c22e1950e3a7ea17226 16:25:21 [16:25:21.360] VERBOSE: sequencer-client Sent L1 transaction 0xf6ee3a05938076e0bfe5ea9380c2528a2f5d8b39e3268c22e1950e3a7ea17226 {"gasLimit":470203,"maxFeePerGas":"1.261127715","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:25:21 [16:25:21.368] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:25:21 [16:25:21.369] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf6ee3a05938076e0bfe5ea9380c2528a2f5d8b39e3268c22e1950e3a7ea17226","calldataSize":1444,"calldataGas":12244,"txCount":1,"blockNumber":4,"blockTimestamp":1749832275,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:25:21 [16:25:21.369] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:25:21 [16:25:21.372] INFO: blob-sink:server Received blob sidecar for block 0x36708e6e3cc88e2be87a3cbfb673fcfaaeb78ded7a2cfa8c79b9ae1b7f7dd20c 16:25:21 [16:25:21.375] INFO: blob-sink:server Blob sidecar stored successfully for block 0x36708e6e3cc88e2be87a3cbfb673fcfaaeb78ded7a2cfa8c79b9ae1b7f7dd20c 16:25:21 [16:25:21.403] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749832311] on http://127.0.0.1:8545 16:25:21 [16:25:21.404] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:25:21 [16:25:21.405] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749832311 16:25:21 [16:25:21.406] WARN: foundation:test-date-provider Time set to 2025-06-13T16:31:51.000Z {"offset":389595,"timeMs":1749832311000} 16:25:21 [16:25:21.406] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 16:25:21 [16:25:21.573] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:21 [16:25:21.587] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 16:25:21 [16:25:21.589] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x27f83330d3927b217befb3ac49c1c104c055c849c0fe4831ca5e506d8e29fa2f","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":3760013501,"blockNumber":4,"slotNumber":5,"timestamp":1749832275,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x00c1774f99985a8090d67cffb78a26f6fb269efbb3a09b5c72c3b14eefce1170","archiveNextLeafIndex":5} 16:25:21 [16:25:21.590] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 16:25:21 [16:25:21.592] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 16:25:21 [16:25:21.692] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":6.230325999997149,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749832275,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:25:21 [16:25:21.700] VERBOSE: p2p Synched to latest block 4 16:25:21 [16:25:21.719] INFO: e2e:e2e_keys Running test: Keys ovsk_app gets ovsk_app 16:25:21 [16:25:21.730] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f {"origin":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000e01d40bd","authWitnesses":["0x0cf2ff6a91f277f1ea670e600720ab46bee8fc245c1075543e576946073be84e"]} 16:25:21 [16:25:21.735] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x00c1774f99985a8090d67cffb78a26f6fb269efbb3a09b5c72c3b14eefce1170","header":{"contentCommitment":{"blobsHash":"0x00ba38251faa826aa77b5050fc4e637670653e91996c935b6b381be5e6afa9a0","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749832275,"version":3760013501},"lastArchive":"0x28223569736b7c45b350453b72cf738897485d1730b0d6dc21b345141e34cabb","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x003d8dc23ea645d16a6e61a1462d71052de1f74db3aaa9499e1c6bab9a9a16b7","nullifierTree":"0x005628de5756e9aca8ed07084388823855103b0f3178d10ecc351f53ab16ce90","publicDataTree":"0x2f700448a3f5fb6de5dc1a60d5d3836ce65aaadfcab3fad8ec0b83d32d28a385"},"totalFees":567840000,"totalManaUsed":11200}} 16:25:21 [16:25:21.798] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:21 [16:25:21.830] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:25:21 [16:25:21.830] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:21 [16:25:21.831] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:21 [16:25:21.876] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f"} 16:25:21 [16:25:21.888] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x00c1774f99985a8090d67cffb78a26f6fb269efbb3a09b5c72c3b14eefce1170","blockNumber":5,"slot":6} 16:25:21 [16:25:21.890] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1092ea61619c960fcf7585022ae88677978c4963a948db6c8378e55f645724b2 16:25:21 [16:25:21.899] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:25:21 [16:25:21.900] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:25:21 [16:25:21.904] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:25:21 [16:25:21.905] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:25:21 [16:25:21.907] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0be26bc1324ebdfa2863f09060807aca5fd1ed98f25c0e4e8f45ffd0a23ca034","nullifier":"0x05919c092f083da593fe032fb29357245b35355393c6a92aea11b50bd8d2c24e"} 16:25:21 [16:25:21.909] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:25:21 [16:25:21.920] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f as fee payer 16:25:22 [16:25:22.089] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:22 [16:25:22.319] VERBOSE: simulator:private_execution Executing private function Test:get_ovsk_app {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:22 [16:25:22.331] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:25:22 [16:25:22.331] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:22 [16:25:22.440] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:22 [16:25:22.457] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 16:25:22 [16:25:22.469] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x00c1774f99985a8090d67cffb78a26f6fb269efbb3a09b5c72c3b14eefce1170","blockNumber":5,"slot":6} 16:25:22 [16:25:22.470] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876"} 16:25:22 [16:25:22.474] VERBOSE: pxe:service Removed note for contract 0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876 at slot 0x000000000000000000000000000000000000000000000000000000000000000c {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","nullifier":"0x2ec9980fe792fc96707611d2495ccc98e980ec02e664bf7c0bc1a17c503a09b8"} 16:25:22 [16:25:22.476] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x08b1c622c4123f875f7fe30f35203900fb2b70b9e61adda7f3d34295015ee2fc 16:25:22 [16:25:22.485] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:25:22 [16:25:22.486] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876 for storage slot 0x000000000000000000000000000000000000000000000000000000000000000c 16:25:22 [16:25:22.491] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:25:22 [16:25:22.491] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:25:22 [16:25:22.494] VERBOSE: pxe:service Added note {"index":128,"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x28b823cc658484e1144d1d9e6be2a8e1c8e9b66b29d834b0667dc578aec39fdd","nullifier":"0x2ec9980fe792fc96707611d2495ccc98e980ec02e664bf7c0bc1a17c503a09b8"} 16:25:22 [16:25:22.495] VERBOSE: pxe:service Removed just-added note {"contract":"0x1e1fed10cad798ffae952698065a8c6a6ad1b269ff348e7fb63b277045514876","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x28b823cc658484e1144d1d9e6be2a8e1c8e9b66b29d834b0667dc578aec39fdd","nullifier":"0x2ec9980fe792fc96707611d2495ccc98e980ec02e664bf7c0bc1a17c503a09b8"} 16:25:22 [16:25:22.497] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:25:22 [16:25:22.751] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:23 [16:25:23.038] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:23 [16:25:23.176] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x00c1774f99985a8090d67cffb78a26f6fb269efbb3a09b5c72c3b14eefce1170","blockNumber":5,"slot":6} 16:25:23 [16:25:23.409] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:25:23 [16:25:23.437] INFO: pxe:service Simulation completed for 0x02a81893bfa817efde8cf12d82ecb07ccd56e58bf29a91abbb7cf81f5e106f6c in 1707.1829749999997ms {"txHash":"0x02a81893bfa817efde8cf12d82ecb07ccd56e58bf29a91abbb7cf81f5e106f6c","origin":"0x2a30d36ab211b55bfdcaaf01965d903830a358c7e510af6dc81bece36e150e1f","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000e01d40bd","authWitnesses":["0x0cf2ff6a91f277f1ea670e600720ab46bee8fc245c1075543e576946073be84e"]} 16:25:23 [16:25:23.440] INFO: node Stopping 16:25:23 [16:25:23.441] INFO: slasher Slasher client stopped. 16:25:23 [16:25:23.441] INFO: sequencer Stopped sequencer 16:25:23 [16:25:23.441] INFO: p2p P2P client stopped. 16:25:23 [16:25:23.443] INFO: world_state Stopped world state synchronizer 16:25:23 [16:25:23.443] INFO: archiver Stopped. 16:25:23 [16:25:23.443] INFO: node Stopped 16:25:23 [16:25:23.443] VERBOSE: e2e:e2e_keys Cleaning up ACVM state 16:25:23 [16:25:23.443] INFO: e2e:e2e_keys Cleaning up ACVM temp directory /tmp/75f4fd66 16:25:23 [16:25:23.444] VERBOSE: e2e:e2e_keys Cleaning up BB state 16:25:23 [16:25:23.452] INFO: blob-sink:server Stopping blob sink 16:25:23 [16:25:23.453] INFO: blob-sink:server Blob sink stopped 16:25:23 [16:25:23.453] VERBOSE: e2e:e2e_keys Cleaning up data directory at /tmp/836cd180f247888f 16:25:23 PASS src/e2e_keys.test.ts 16:25:23 Keys 16:25:23 using nsk_app to detect nullification 16:25:23 ✓ nsk_app and contract address are enough to detect note nullification (5839 ms) 16:25:23 ovsk_app 16:25:23 ✓ gets ovsk_app (1721 ms) 16:25:23 16:25:23 Test Suites: 1 passed, 1 total 16:25:23 Tests: 2 passed, 2 total 16:25:23 Snapshots: 0 total 16:25:23 Time: 24.053 s 16:25:23 Ran all test suites matching /src\/e2e_keys.test.ts/i. 16:25:23 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?