ACI ·

Parent Log: http://ci.aztec-labs.com/211a9fb93ab8be76 Command: 26102936e69ab88b: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=1 Date: Fri Jun 13 16:21:43 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15044_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c393731fea71056e_master 16:21:43 +++ id -u 16:21:43 +++ id -g 16:21:43 ++ docker run -d --name e2e_keys --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_keys.test.ts'\''' 16:21:43 + cid=c8fc2995ecfd8656dbf514cabe967a4edaec81c57ede8c162d32de85b409dff3 16:21:43 + set +x 16:21:44 {"level":25,"time":1749831704387,"pid":12,"hostname":"c8fc2995ecfd","module":"logger","msg":"Logger initialized with level verbose"} 16:21:51 [16:21:51.477] INFO: e2e:e2e_keys Logging metrics to log/unknown.jsonl 16:21:51 [16:21:51.941] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-eLo46l/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 16:21:52 [16:21:52.005] INFO: e2e:e2e_keys Calling anvil_setBlockTimestampInterval with params: [12] 16:21:52 [16:21:52.037] WARN: e2e:e2e_keys Set block interval to 12 16:21:52 [16:21:52.038] VERBOSE: e2e:e2e_keys Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:21:52 [16:21:52.088] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 16:21:52 [16:21:52.098] VERBOSE: e2e:e2e_keys Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 16:21:52 [16:21:52.124] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 16:21:52 [16:21:52.130] VERBOSE: e2e:e2e_keys Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 16:21:52 [16:21:52.152] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 16:21:52 [16:21:52.158] VERBOSE: e2e:e2e_keys Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 16:21:52 [16:21:52.179] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 16:21:52 [16:21:52.184] VERBOSE: e2e:e2e_keys Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 16:21:52 [16:21:52.203] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 16:21:52 [16:21:52.210] VERBOSE: e2e:e2e_keys Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 16:21:52 [16:21:52.227] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 16:21:52 [16:21:52.231] VERBOSE: e2e:e2e_keys Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 16:21:52 [16:21:52.232] VERBOSE: e2e:e2e_keys Waiting for deployments to complete 16:21:52 [16:21:52.233] INFO: e2e:e2e_keys Waiting for 6 transactions to be mined... 16:21:52 [16:21:52.257] INFO: e2e:e2e_keys All transactions mined successfully 16:21:52 [16:21:52.278] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 16:21:52 [16:21:52.279] VERBOSE: e2e:e2e_keys Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 16:21:52 [16:21:52.294] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 16:21:52 [16:21:52.309] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 16:21:52 [16:21:52.315] VERBOSE: e2e:e2e_keys Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 16:21:52 [16:21:52.330] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 16:21:52 [16:21:52.330] VERBOSE: e2e:e2e_keys Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 16:21:52 [16:21:52.343] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 16:21:52 [16:21:52.347] VERBOSE: e2e:e2e_keys Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 16:21:52 [16:21:52.361] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 16:21:52 [16:21:52.361] VERBOSE: e2e:e2e_keys Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 16:21:52 [16:21:52.362] VERBOSE: e2e:e2e_keys Waiting for deployments to complete 16:21:52 [16:21:52.362] INFO: e2e:e2e_keys Waiting for 8 transactions to be mined... 16:21:52 [16:21:52.379] INFO: e2e:e2e_keys All transactions mined successfully 16:21:52 [16:21:52.389] VERBOSE: e2e:e2e_keys Deployed shared contracts 16:21:52 [16:21:52.408] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 16:21:52 [16:21:52.409] VERBOSE: e2e:e2e_keys Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 16:21:52 [16:21:52.414] 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:21:52 [16:21:52.434] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 16:21:52 [16:21:52.530] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 16:21:52 [16:21:52.542] VERBOSE: e2e:e2e_keys Awaiting for linked libraries to be deployed 16:21:52 [16:21:52.586] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xdf0ab0a1e08b93a3e314c97bf9d40ff4984f8718a4b0420015ebaefa1e987204 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 16:21:52 [16:21:52.592] 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:21:52 [16:21:52.592] INFO: e2e:e2e_keys Waiting for 9 transactions to be mined... 16:21:52 [16:21:52.622] INFO: e2e:e2e_keys All transactions mined successfully 16:21:52 [16:21:52.623] VERBOSE: e2e:e2e_keys All core contracts have been deployed 16:21:52 [16:21:52.640] VERBOSE: e2e:e2e_keys Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 16:21:52 [16:21:52.640] VERBOSE: e2e:e2e_keys Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 16:21:52 [16:21:52.651] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 16:21:52 [16:21:52.656] VERBOSE: e2e:e2e_keys Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 16:21:52 [16:21:52.682] VERBOSE: e2e:e2e_keys Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 16:21:52 [16:21:52.682] VERBOSE: e2e:e2e_keys Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 16:21:52 [16:21:52.682] INFO: e2e:e2e_keys Waiting for 10 transactions to be mined... 16:21:52 [16:21:52.701] INFO: e2e:e2e_keys All transactions mined successfully 16:21:52 [16:21:52.709] VERBOSE: e2e:e2e_keys Rollup deployed 16:21:52 [16:21:52.709] VERBOSE: e2e:e2e_keys Waiting for rollup and slash factory to be deployed 16:21:52 [16:21:52.710] INFO: e2e:e2e_keys Waiting for 10 transactions to be mined... 16:21:52 [16:21:52.763] INFO: e2e:e2e_keys All transactions mined successfully 16:21:52 [16:21:52.763] VERBOSE: e2e:e2e_keys All transactions for L1 deployment have been mined 16:21:52 [16:21:52.797] 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:21:52 [16:21:52.811] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 16:21:52 [16:21:52.819] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:52 [16:21:52.823] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 16:21:52 [16:21:52.826] INFO: telemetry:client Using NoopTelemetryClient 16:21:52 [16:21:52.835] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 16:21:52 [16:21:52.836] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 16:21:52 [16:21:52.838] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/b1ab0492de8b91d2/blob-sink with map size 134217728 KB (LMDB v2) 16:21:52 [16:21:52.840] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:52 [16:21:52.842] INFO: aztecjs:utils:watcher New L1 time: 1749831951 16:21:52 [16:21:52.843] WARN: foundation:test-date-provider Time set to 2025-06-13T16:25:51.000Z {"offset":238158,"timeMs":1749831951000} 16:21:52 [16:21:52.844] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 16:21:52 [16:21:52.858] INFO: blob-sink:server Server is running on http://localhost:38881 16:21:52 [16:21:52.859] VERBOSE: e2e:e2e_keys Creating and synching an aztec node... 16:21:52 [16:21:52.861] VERBOSE: e2e:e2e_keys Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/8d148899/acvm 16:21:52 [16:21:52.863] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:38881"} 16:21:52 [16:21:52.888] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 16:21:52 [16:21:52.889] INFO: archiver:lmdb Creating archiver data store at directory /tmp/b1ab0492de8b91d2/archiver with map size 134217728 KB (LMDB v2) 16:21:52 [16:21:52.891] INFO: archiver:lmdb Starting data store with maxReaders 16 16:21:53 [16:21:53.077] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:53 [16:21:53.306] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:53 [16:21:53.369] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:38881"} 16:21:53 [16:21:53.389] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:38881"} 16:21:53 [16:21:53.389] WARN: node:blob-sink:client No L1 consensus host urls configured 16:21:53 [16:21:53.390] WARN: node:blob-sink:client No archive client configured 16:21:53 [16:21:53.397] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x8ad2e182b37f4415cb1e55638a39a3cab2f0c7179148c14c6bdb4c4365d72876 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x3cd910d00bb51340ded88ca75bc6ea3800440773db9e062ce93f3bba974431a8","l1BlockNumber":16}} 16:21:53 [16:21:53.513] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:53 [16:21:53.526] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x8ad2e182b37f4415cb1e55638a39a3cab2f0c7179148c14c6bdb4c4365d72876","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 16:21:53 [16:21:53.547] INFO: world-state:database Creating world state data store at directory /tmp/b1ab0492de8b91d2/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 16:21:53 [16:21:53.612] INFO: world_state Created world state synchroniser with block history of 64 16:21:53 [16:21:53.612] WARN: node Aztec node is accepting fake proofs 16:21:53 [16:21:53.637] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/b1ab0492de8b91d2/p2p with map size 134217728 KB (LMDB v2) 16:21:53 [16:21:53.639] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 16:21:53 [16:21:53.644] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/b1ab0492de8b91d2/p2p-archive with map size 134217728 KB (LMDB v2) 16:21:53 [16:21:53.646] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 16:21:53 [16:21:53.647] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/b1ab0492de8b91d2/p2p-peers with map size 134217728 KB (LMDB v2) 16:21:53 [16:21:53.652] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 16:21:53 [16:21:53.654] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 16:21:53 [16:21:53.655] VERBOSE: p2p P2P is disabled. Using dummy P2P service 16:21:53 [16:21:53.659] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 16:21:53 [16:21:53.661] INFO: world_state Started world state synchronizer from block 1 16:21:53 [16:21:53.664] VERBOSE: world-state:block_stream Starting sync from block number 0 16:21:53 [16:21:53.668] INFO: p2p Starting p2p client from block 0 with empty mempools 16:21:53 [16:21:53.668] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 16:21:53 [16:21:53.673] INFO: slasher Slasher client initialized 16:21:53 [16:21:53.674] INFO: slasher Starting Slasher client... 16:21:53 [16:21:53.723] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:21:53 [16:21:53.724] VERBOSE: node All Aztec Node subsystems synced 16:21:53 [16:21:53.733] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:53 [16:21:53.736] INFO: sequencer-client Deploying forwarder contract 16:21:53 [16:21:53.748] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 16:21:53 [16:21:53.771] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 16:21:53 [16:21:53.772] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 16:21:53 [16:21:53.782] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 16:21:53 [16:21:53.805] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:21:53 [16:21:53.805] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 16:21:53 [16:21:53.806] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/8d148899/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 16:21:54 [16:21:54.034] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 16:21:54 [16:21:54.036] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 16:21:54 [16:21:54.037] INFO: node Aztec Node version: 0.87.8 16:21:54 [16:21:54.037] 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:21:54 [16:21:54.038] VERBOSE: e2e:e2e_keys Creating a pxe... 16:21:54 [16:21:54.041] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:54 [16:21:54.055] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/0609ee181193775c/pxe_data with map size 134217728 KB (LMDB v2) 16:21:54 [16:21:54.098] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x09a62457a52f8741c76515b6cbeb72f01c6c0113f1d7b7fec6f3c7ea7c7f3408","blockNumber":1,"slot":2} 16:21:54 [16:21:54.114] INFO: pxe:data:lmdb Starting data store with maxReaders 16 16:21:54 [16:21:54.257] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:54 [16:21:54.528] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 16:21:54 [16:21:54.530] INFO: pxe:service Started PXE connected to chain 31337 version 1563066119 16:21:54 [16:21:54.601] INFO: pxe:service Registered account 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 16:21:54 [16:21:54.609] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:54 [16:21:54.683] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 16:21:54 [16:21:54.690] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 16:21:54 [16:21:54.747] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x09a62457a52f8741c76515b6cbeb72f01c6c0113f1d7b7fec6f3c7ea7c7f3408","blockNumber":1,"slot":2} 16:21:54 [16:21:54.884] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:54 [16:21:54.891] INFO: pxe:service Added contract SchnorrAccount at 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 16:21:54 [16:21:54.992] VERBOSE: pxe:block_stream Starting sync from block number 0 16:21:55 [16:21:55.054] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 16:21:55 [16:21:55.149] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:55 [16:21:55.226] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:21:56 [16:21:56.035] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 16:21:56 [16:21:56.189] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:21:56 [16:21:56.281] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:56 [16:21:56.487] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x09a62457a52f8741c76515b6cbeb72f01c6c0113f1d7b7fec6f3c7ea7c7f3408","blockNumber":1,"slot":2} 16:21:56 [16:21:56.542] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:21:56 [16:21:56.588] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:56 [16:21:56.601] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:21:56 [16:21:56.602] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:21:56 [16:21:56.691] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:21:56 [16:21:56.700] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:21:56 [16:21:56.824] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:57 [16:21:57.034] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:21:57 [16:21:57.107] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:21:57 [16:21:57.108] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:21:57 [16:21:57.111] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:57 [16:21:57.167] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x09a62457a52f8741c76515b6cbeb72f01c6c0113f1d7b7fec6f3c7ea7c7f3408","blockNumber":1,"slot":2} 16:21:57 [16:21:57.200] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:21:57 [16:21:57.210] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:21:57 [16:21:57.229] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 as fee payer 16:21:57 [16:21:57.324] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:57 [16:21:57.557] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:57 [16:21:57.835] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:57 [16:21:57.927] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x09a62457a52f8741c76515b6cbeb72f01c6c0113f1d7b7fec6f3c7ea7c7f3408","blockNumber":1,"slot":2} 16:21:58 [16:21:58.098] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:58 [16:21:58.625] INFO: pxe:service Proving completed in 3669.8022299999993ms {"timings":{"total":3669.8022299999993,"sync":37.58015700000033,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":305.6881060000014,"oracles":{"callPrivateFunction":{"times":[1121.3593729999993,641.5387960000007,333.3125310000014]}}},{"functionName":"private_kernel_init","time":123.29045000000042},{"functionName":"ContractClassRegisterer:register","time":1083.7025749999993,"oracles":{"loadCapsule":{"times":[87.31922699999996]},"notifyCreatedNullifier":{"times":[0.901293999999325]},"debugLog":{"times":[0.9746660000000702]},"notifyCreatedContractClassLog":{"times":[13.823986000001241]}}},{"functionName":"private_kernel_inner","time":188.12768999999935},{"functionName":"SchnorrAccount:constructor","time":579.1003010000004,"oracles":{"getContractInstance":{"times":[5.253539000001183]},"debugLog":{"times":[0.7036790000001929,0.6869590000005701]},"fetchTaggedLogs":{"times":[93.0485179999996]},"loadCapsule":{"times":[3.8975640000007843,0.5923749999983556,0.5229039999994711]},"notifyCreatedNullifier":{"times":[0.5209039999990637,0.41321099999913713]},"notifyCreatedNote":{"times":[0.8624629999994795]},"getRandomField":{"times":[0.6345469999996567,0.2787980000011885,0.09577200000057928,0.061191999999209656,0.07367299999896204,0.07019199999922421,0.05585199999950419,0.07436200000120152,0.1479940000008355,0.10631300000022748,0.0679020000006858]},"getIndexedTaggingSecretAsSender":{"times":[121.73604899999918]},"incrementAppTaggingSecretIndexAsSender":{"times":[37.48299399999996]}}},{"functionName":"private_kernel_inner","time":148.7015049999991},{"functionName":"SchnorrAccount:entrypoint","time":281.1728489999987,"oracles":{"debugLog":{"times":[0.9437850000012986,0.6753379999991012,0.9911169999995764]},"fetchTaggedLogs":{"times":[98.58031500000106]},"loadCapsule":{"times":[1.2894749999995838,1.177201000000423,0.31193899999925634]},"getNotes":{"times":[3.4135999999998603]},"getAuthWitness":{"times":[0.5513240000000224]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0544579999987036]}}},{"functionName":"private_kernel_inner","time":173.45569100000102},{"functionName":"private_kernel_reset","time":171.93559099999948},{"functionName":"private_kernel_tail","time":81.63487499999974}],"unaccounted":495.41244000000006}} 16:21:58 [16:21:58.642] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:58 [16:21:58.666] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x09a62457a52f8741c76515b6cbeb72f01c6c0113f1d7b7fec6f3c7ea7c7f3408","blockNumber":1,"slot":2} 16:21:58 [16:21:58.786] VERBOSE: p2p:tx_pool Adding tx 0x28ee64be7665f3f00903e19f9e872f6f4341964b7a2c16c05eaff67cee3e7315 to pool {"eventName":"tx-added-to-pool","txHash":"0x28ee64be7665f3f00903e19f9e872f6f4341964b7a2c16c05eaff67cee3e7315","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 16:21:58 [16:21:58.812] INFO: node Received tx 0x28ee64be7665f3f00903e19f9e872f6f4341964b7a2c16c05eaff67cee3e7315 {"txHash":"0x28ee64be7665f3f00903e19f9e872f6f4341964b7a2c16c05eaff67cee3e7315"} 16:21:58 [16:21:58.813] INFO: pxe:service Sent transaction 0x28ee64be7665f3f00903e19f9e872f6f4341964b7a2c16c05eaff67cee3e7315 16:21:58 [16:21:58.849] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:59 [16:21:59.053] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:59 [16:21:59.190] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 16:21:59 [16:21:59.205] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T16:26:15.000Z","now":"2025-06-13T16:25:57.363Z"} 16:21:59 [16:21:59.284] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:59 [16:21:59.525] VERBOSE: simulator:public-processor Processed tx 0x28ee64be7665f3f00903e19f9e872f6f4341964b7a2c16c05eaff67cee3e7315 with no public calls in 234.1761920000008ms {"txHash":"0x28ee64be7665f3f00903e19f9e872f6f4341964b7a2c16c05eaff67cee3e7315","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":234.1761920000008} 16:21:59 [16:21:59.528] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:21:59 [16:21:59.531] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.32332268600000136s {"duration":0.32332268600000136,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 16:21:59 [16:21:59.700] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x228b0c2b2247b5aef9feadd36d3de717d43bf87582354ceea9a088f6114b1691","globalVariables":{"chainId":31337,"version":1563066119,"blockNumber":1,"slotNumber":2,"timestamp":1749831975,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x28ee64be7665f3f00903e19f9e872f6f4341964b7a2c16c05eaff67cee3e7315"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":509.9337749999995,"publicProcessDuration":324.38788399999976,"rollupCircuitsDuration":495.9579250000006,"txCount":1,"blockNumber":1,"blockTimestamp":1749831975,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:21:59 [16:21:59.703] VERBOSE: sequencer Attesting committee is empty 16:21:59 [16:21:59.791] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:00 [16:22:00.060] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:00 [16:22:00.065] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x9a766ac3f4344d706da82eef5729ae36151a4558f91a9ecfa18bc39b92a11084 16:22:00 [16:22:00.065] VERBOSE: sequencer-client Sent L1 transaction 0x9a766ac3f4344d706da82eef5729ae36151a4558f91a9ecfa18bc39b92a11084 {"gasLimit":514585,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 16:22:00 [16:22:00.078] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:22:00 [16:22:00.079] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x9a766ac3f4344d706da82eef5729ae36151a4558f91a9ecfa18bc39b92a11084","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1749831975,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:22:00 [16:22:00.080] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:22:00 [16:22:00.098] INFO: blob-sink:server Received blob sidecar for block 0x96e248f638b87d60893d67d14a30f603ec26bc958e47f3ccb4075d21e5248220 16:22:00 [16:22:00.103] INFO: blob-sink:server Blob sidecar stored successfully for block 0x96e248f638b87d60893d67d14a30f603ec26bc958e47f3ccb4075d21e5248220 16:22:00 [16:22:00.118] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749832011] on http://127.0.0.1:8545 16:22:00 [16:22:00.119] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:22:00 [16:22:00.121] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749832011 16:22:00 [16:22:00.121] WARN: foundation:test-date-provider Time set to 2025-06-13T16:26:51.000Z {"offset":290879,"timeMs":1749832011000} 16:22:00 [16:22:00.121] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 16:22:00 [16:22:00.309] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:00 [16:22:00.325] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 16:22:00 [16:22:00.334] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 16:22:00 [16:22:00.339] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 16:22:00 [16:22:00.342] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x228b0c2b2247b5aef9feadd36d3de717d43bf87582354ceea9a088f6114b1691","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":1563066119,"blockNumber":1,"slotNumber":2,"timestamp":1749831975,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1fc09fd2f54945bd256fca14ec4c97d1c868f00babafd5cc2dc1c0d6d1791c28","archiveNextLeafIndex":2} 16:22:00 [16:22:00.343] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 16:22:00 [16:22:00.454] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":24.04327700000067,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749831975,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 16:22:00 [16:22:00.873] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:00 [16:22:00.880] WARN: pxe:service No artifact found for contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f when looking for its metadata 16:22:00 [16:22:00.890] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f as part of deployment for 0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4 16:22:01 [16:22:01.095] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:01 [16:22:01.130] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 16:22:01 [16:22:01.203] VERBOSE: p2p Synched to latest block 1 16:22:01 [16:22:01.463] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:01 [16:22:01.480] INFO: pxe:service Added contract Test at 0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4 with class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 16:22:01 [16:22:01.515] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x1fc09fd2f54945bd256fca14ec4c97d1c868f00babafd5cc2dc1c0d6d1791c28","header":{"contentCommitment":{"blobsHash":"0x00cc4bd2a1990729ce1c22779a0be75b8ff35489ecb430d8a4822627d994d222","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749831975,"version":1563066119},"lastArchive":"0x09a62457a52f8741c76515b6cbeb72f01c6c0113f1d7b7fec6f3c7ea7c7f3408","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0bf76ae164f6c10f0346002b3da221edcc2b435c0962941e08afac0ef2ddee88","nullifierTree":"0x12680333cf89c422643cbae902477f068a5e7ae9c095b71b85ffd4f6cb68d058","publicDataTree":"0x0216f4a07daaffac5bf5e4aa1843368ebbba563fd0e3d899c5a397eac7754559"},"totalFees":6794052480,"totalManaUsed":20448}} 16:22:01 [16:22:01.638] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:01 [16:22:01.702] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:22:01 [16:22:01.702] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:01 [16:22:01.708] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:01 [16:22:01.791] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1fc09fd2f54945bd256fca14ec4c97d1c868f00babafd5cc2dc1c0d6d1791c28","blockNumber":2,"slot":3} 16:22:01 [16:22:01.825] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:01 [16:22:01.831] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x218b77c90ff2c579676aac1218307810d873c7a240f2de962d18c44d4764958f 16:22:01 [16:22:01.846] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:22:01 [16:22:01.848] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:22:01 [16:22:01.873] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:22:01 [16:22:01.874] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:22:01 [16:22:01.883] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x266cc7703fa9cbc7a8f2ce07f1a2663bc3bf3ad550be4587e8cc904ffb709ce0","nullifier":"0x21768d15f593b45a066aef99905a03fe958b004e70b9ff4deb4b23866e9d3f6f"} 16:22:01 [16:22:01.890] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:22:01 [16:22:01.908] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 as fee payer 16:22:01 [16:22:01.917] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:01 [16:22:01.946] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:22:02 [16:22:02.450] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0231f367ddb29264182678ec70e69bd06340efa7dc780f1c7522d13c96eed157,0x08fed0d02dac97b0ce237807685976eba973a7f517fc0723c067c7b7b6e121cc,0x11714ee3dfbdb30a8b2975f186d75eb58f17897f0b8ce770a03c05432642725e 16:22:02 [16:22:02.578] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 16:22:02 [16:22:02.647] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:02 [16:22:02.712] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 16:22:02 [16:22:02.726] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1fc09fd2f54945bd256fca14ec4c97d1c868f00babafd5cc2dc1c0d6d1791c28","blockNumber":2,"slot":3} 16:22:02 [16:22:02.757] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 16:22:02 [16:22:02.772] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4,0x0000000000000000000000000000000000000000000000000000000000000001,0x1c59f174d19cf6cf2050ba3177e2a555f3cc5970e37e01e588bcbd1a485c7965,0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0eea76e1163ccfa69030e0733759dce0ccf602f045e7b4a3d9ec9b0864e70308,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 16:22:02 [16:22:02.984] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:03 [16:22:03.203] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:03 [16:22:03.470] VERBOSE: simulator:private_execution Executing private function Test:initialize {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:03 [16:22:03.514] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:22:03 [16:22:03.515] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:03 [16:22:03.873] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:03 [16:22:03.897] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1fc09fd2f54945bd256fca14ec4c97d1c868f00babafd5cc2dc1c0d6d1791c28","blockNumber":2,"slot":3} 16:22:03 [16:22:03.934] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:03 [16:22:03.939] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:22:04 [16:22:04.101] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:04 [16:22:04.445] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:04 [16:22:04.561] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1fc09fd2f54945bd256fca14ec4c97d1c868f00babafd5cc2dc1c0d6d1791c28","blockNumber":2,"slot":3} 16:22:04 [16:22:04.684] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:05 [16:22:05.024] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:05 [16:22:05.259] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:06 [16:22:06.022] INFO: pxe:service Proving completed in 4518.84735ms {"timings":{"total":4518.84735,"sync":14.269689000000653,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":673.784682000005,"oracles":{"debugLog":{"times":[0.7705910000004224,0.48859299999821815,0.7101089999996475,0.8311719999983325,0.5489839999972901,0.41399100000126055,0.6237870000004477,0.6700179999970715]},"fetchTaggedLogs":{"times":[125.6437420000002]},"loadCapsule":{"times":[0.27217799999925774,0.4513919999990321,0.548134000000573,4.5927020000017365,0.40800099999978556,0.21336500000325032]},"getSharedSecret":{"times":[4.492538999998942]},"aes128Decrypt":{"times":[1.5061700000005658,1.6282129999999597]},"getPublicKeysAndPartialAddress":{"times":[12.288915999997698]},"getKeyValidationRequest":{"times":[8.829623999998148]},"deliverNote":{"times":[9.327807000001485]},"deleteCapsule":{"times":[0.8254019999985758]},"storeCapsule":{"times":[0.4358620000020892]},"getNotes":{"times":[3.5641340000001946]},"getAuthWitness":{"times":[0.2887080000000424]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.061300999997911276]},"callPrivateFunction":{"times":[731.8305409999994,135.57655599999998,1166.609672999999]}}},{"functionName":"private_kernel_init","time":72.19733499999711},{"functionName":"ContractClassRegisterer:register","time":720.0146779999995,"oracles":{"loadCapsule":{"times":[9.726918000000296]},"notifyCreatedNullifier":{"times":[0.3599099999992177]},"debugLog":{"times":[0.6277870000012626]},"notifyCreatedContractClassLog":{"times":[7.03629699999874]}}},{"functionName":"private_kernel_inner","time":160.53276800000094},{"functionName":"ContractInstanceDeployer:deploy","time":82.20445000000109,"oracles":{"storeInExecutionCache":{"times":[0.2640179999980319]},"callPrivateFunction":{"times":[50.26385300000038]},"notifyCreatedNullifier":{"times":[0.3648700000012468]},"debugLog":{"times":[0.7185490000010759]}}},{"functionName":"private_kernel_inner","time":116.04009800000131},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":36.59435099999973,"oracles":{}},{"functionName":"private_kernel_inner","time":140.69569200000115},{"functionName":"Test:initialize","time":884.8550399999986,"oracles":{"getContractInstance":{"times":[22.167868000000453]},"debugLog":{"times":[0.8839939999998023,0.5496650000022782]},"fetchTaggedLogs":{"times":[422.1425569999992]},"loadCapsule":{"times":[0.2668770000018412,0.24020600000221748,0.22128599999996368]},"notifyCreatedNullifier":{"times":[0.24999700000262237]}}},{"functionName":"private_kernel_inner","time":115.5742250000003},{"functionName":"private_kernel_reset","time":201.56486600000062},{"functionName":"private_kernel_tail","time":65.90824900000007}],"unaccounted":1234.611226999994}} 16:22:06 [16:22:06.032] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1fc09fd2f54945bd256fca14ec4c97d1c868f00babafd5cc2dc1c0d6d1791c28","blockNumber":2,"slot":3} 16:22:06 [16:22:06.035] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:06 [16:22:06.166] VERBOSE: p2p:tx_pool Adding tx 0x1323c76cf0469cf32b8b2937455df03158334b3939c22c7bceeeefff52e83460 to pool {"eventName":"tx-added-to-pool","txHash":"0x1323c76cf0469cf32b8b2937455df03158334b3939c22c7bceeeefff52e83460","noteHashCount":0,"nullifierCount":4,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":583,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 16:22:06 [16:22:06.180] INFO: node Received tx 0x1323c76cf0469cf32b8b2937455df03158334b3939c22c7bceeeefff52e83460 {"txHash":"0x1323c76cf0469cf32b8b2937455df03158334b3939c22c7bceeeefff52e83460"} 16:22:06 [16:22:06.180] INFO: pxe:service Sent transaction 0x1323c76cf0469cf32b8b2937455df03158334b3939c22c7bceeeefff52e83460 16:22:06 [16:22:06.241] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:06 [16:22:06.444] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:06 [16:22:06.583] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 16:22:06 [16:22:06.603] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T16:26:51.000Z","now":"2025-06-13T16:26:57.482Z"} 16:22:06 [16:22:06.680] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:06 [16:22:06.916] VERBOSE: simulator:public-processor Processed tx 0x1323c76cf0469cf32b8b2937455df03158334b3939c22c7bceeeefff52e83460 with no public calls in 226.91184799999974ms {"txHash":"0x1323c76cf0469cf32b8b2937455df03158334b3939c22c7bceeeefff52e83460","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":226.91184799999974} 16:22:06 [16:22:06.918] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:06 [16:22:06.920] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.316953755999999s {"duration":0.316953755999999,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":310272,"l2Gas":21888},"totalSizeInBytes":19648} 16:22:07 [16:22:07.089] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x068a2989e22fcd3ed0597fa376eb8f4e7dce1ec664669803b28987041f687c22","globalVariables":{"chainId":31337,"version":1563066119,"blockNumber":2,"slotNumber":3,"timestamp":1749832011,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1323c76cf0469cf32b8b2937455df03158334b3939c22c7bceeeefff52e83460"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":506.6657480000031,"publicProcessDuration":317.42923900000096,"rollupCircuitsDuration":489.6688269999977,"txCount":1,"blockNumber":2,"blockTimestamp":1749832011,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 16:22:07 [16:22:07.094] VERBOSE: sequencer Attesting committee is empty 16:22:07 [16:22:07.232] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:07 [16:22:07.460] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:07 [16:22:07.467] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x4a5f3cc9478ffa42130b238cb8c358869bc7885896ba748e6dd20dea5e676157 16:22:07 [16:22:07.468] VERBOSE: sequencer-client Sent L1 transaction 0x4a5f3cc9478ffa42130b238cb8c358869bc7885896ba748e6dd20dea5e676157 {"gasLimit":470283,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:22:07 [16:22:07.485] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:22:07 [16:22:07.486] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4a5f3cc9478ffa42130b238cb8c358869bc7885896ba748e6dd20dea5e676157","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":2,"blockTimestamp":1749832011,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 16:22:07 [16:22:07.486] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:22:07 [16:22:07.491] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749832047] on http://127.0.0.1:8545 16:22:07 [16:22:07.494] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:22:07 [16:22:07.497] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749832047 16:22:07 [16:22:07.497] WARN: foundation:test-date-provider Time set to 2025-06-13T16:27:27.000Z {"offset":319503,"timeMs":1749832047000} 16:22:07 [16:22:07.498] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 16:22:07 [16:22:07.501] INFO: blob-sink:server Received blob sidecar for block 0x4440c6c84563824763e44d1f7832faabaa31e56e3cd409a0563bf1a4c22e6c27 16:22:07 [16:22:07.507] INFO: blob-sink:server Blob sidecar stored successfully for block 0x4440c6c84563824763e44d1f7832faabaa31e56e3cd409a0563bf1a4c22e6c27 16:22:07 [16:22:07.666] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 16:22:07 [16:22:07.667] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:07 [16:22:07.668] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 16:22:07 [16:22:07.671] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 16:22:07 [16:22:07.990] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:08 [16:22:08.029] VERBOSE: archiver:block-helper Store contract instance at 0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4 16:22:08 [16:22:08.058] VERBOSE: archiver:block-helper Store contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 16:22:08 [16:22:08.107] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x068a2989e22fcd3ed0597fa376eb8f4e7dce1ec664669803b28987041f687c22","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":1563066119,"blockNumber":2,"slotNumber":3,"timestamp":1749832011,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2f199078e87f262f5f58d5fe5f3006e613c91d6e2628884f8bad9ccab447fac9","archiveNextLeafIndex":3} 16:22:08 [16:22:08.129] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 16:22:08 [16:22:08.140] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.586808000000019,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749832011,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 16:22:08 [16:22:08.196] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:08 [16:22:08.231] VERBOSE: p2p Synched to latest block 2 16:22:08 [16:22:08.451] INFO: aztecjs:deploy_sent_tx Contract 0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4 successfully deployed. 16:22:08 [16:22:08.454] 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:22:08 [16:22:08.463] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:08 [16:22:08.501] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x2f199078e87f262f5f58d5fe5f3006e613c91d6e2628884f8bad9ccab447fac9","header":{"contentCommitment":{"blobsHash":"0x001429408f75d2a5566e9c822b8a6c312b21a1222069e259b06e9a4aff38e5a4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749832011,"version":1563066119},"lastArchive":"0x1fc09fd2f54945bd256fca14ec4c97d1c868f00babafd5cc2dc1c0d6d1791c28","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0bf76ae164f6c10f0346002b3da221edcc2b435c0962941e08afac0ef2ddee88","nullifierTree":"0x0819b35adec047be0b5c26114cc066ce59168b121bc1b76ce67b4f38b9618a05","publicDataTree":"0x1d750b27d6b1439b0b73056418ca16c5c7db8660c6f0f1aaa64bdac93f4f8d7c"},"totalFees":7272506880,"totalManaUsed":21888}} 16:22:08 [16:22:08.615] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:08 [16:22:08.667] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:22:08 [16:22:08.667] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:08 [16:22:08.671] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:08 [16:22:08.754] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2f199078e87f262f5f58d5fe5f3006e613c91d6e2628884f8bad9ccab447fac9","blockNumber":3,"slot":4} 16:22:08 [16:22:08.774] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:08 [16:22:08.781] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x218b77c90ff2c579676aac1218307810d873c7a240f2de962d18c44d4764958f 16:22:08 [16:22:08.790] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:22:08 [16:22:08.791] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:22:08 [16:22:08.797] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:22:08 [16:22:08.797] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:22:08 [16:22:08.800] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x266cc7703fa9cbc7a8f2ce07f1a2663bc3bf3ad550be4587e8cc904ffb709ce0","nullifier":"0x21768d15f593b45a066aef99905a03fe958b004e70b9ff4deb4b23866e9d3f6f"} 16:22:08 [16:22:08.802] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:22:08 [16:22:08.814] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 as fee payer 16:22:08 [16:22:08.962] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:09 [16:22:09.489] VERBOSE: simulator:private_execution Executing private function Test:call_create_note {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:09 [16:22:09.528] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:22:09 [16:22:09.529] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:09 [16:22:09.535] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:09 [16:22:09.756] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:09 [16:22:09.785] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2f199078e87f262f5f58d5fe5f3006e613c91d6e2628884f8bad9ccab447fac9","blockNumber":3,"slot":4} 16:22:09 [16:22:09.802] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:09 [16:22:09.806] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:22:09 [16:22:09.963] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:10 [16:22:10.220] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:10 [16:22:10.519] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:10 [16:22:10.912] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:10 [16:22:10.935] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2f199078e87f262f5f58d5fe5f3006e613c91d6e2628884f8bad9ccab447fac9","blockNumber":3,"slot":4} 16:22:11 [16:22:11.368] INFO: pxe:service Proving completed in 2879.4441609999994ms {"timings":{"total":2879.4441609999994,"sync":14.955045999999129,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":644.6214160000018,"oracles":{"debugLog":{"times":[0.6157060000005004,0.47238199999992503,0.4414820000019972,0.4185010000001057,0.3892200000009325,0.29225700000097277,0.30624799999714014,0.5475950000000012]},"fetchTaggedLogs":{"times":[110.43381900000168]},"loadCapsule":{"times":[0.39547099999981583,0.3898399999998219,1.4064969999999448,0.2338159999999334,0.15527400000064517,0.19472500000119908]},"getSharedSecret":{"times":[2.984989000000496]},"aes128Decrypt":{"times":[0.32657900000049267,0.819921999998769]},"getPublicKeysAndPartialAddress":{"times":[1.2816639999982726]},"getKeyValidationRequest":{"times":[1.6685539999998582]},"deliverNote":{"times":[2.851974999997765]},"deleteCapsule":{"times":[0.34163900000203284]},"storeCapsule":{"times":[0.2737170000000333]},"getNotes":{"times":[1.5454419999987294]},"getAuthWitness":{"times":[0.18095499999981257]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.043361000000004424]},"callPrivateFunction":{"times":[1300.466725000002]}}},{"functionName":"private_kernel_init","time":92.85906299999988},{"functionName":"Test:call_create_note","time":933.0681900000018,"oracles":{"debugLog":{"times":[0.6351570000006177,0.4579520000006596]},"fetchTaggedLogs":{"times":[275.629740999997]},"loadCapsule":{"times":[0.2539069999984349,0.16895500000100583,0.2744970000021567]},"getRandomField":{"times":[0.13256300000284682,0.14555400000244845,0.14577399999689078,0.07367299999896204,0.06790199999886681,0.0770620000002964,0.05214199999682023,0.05190199999924516,0.04480100000000675,0.07935100000031525,0.043130999998538755,0.050532000001112465]},"notifyCreatedNote":{"times":[0.1525340000007418]},"getIndexedTaggingSecretAsSender":{"times":[145.39604599999802]},"incrementAppTaggingSecretIndexAsSender":{"times":[137.29332200000135]}}},{"functionName":"private_kernel_inner","time":127.90959199999998},{"functionName":"private_kernel_reset","time":207.02737999999954},{"functionName":"private_kernel_tail","time":91.36962299999868}],"unaccounted":767.6338509999987}} 16:22:11 [16:22:11.383] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:11 [16:22:11.410] VERBOSE: p2p:tx_pool Adding tx 0x1d05e7cfef8eebb5a1c3d5983a54e21b07c3f655f9616188c1d7cdf0344bb8cd to pool {"eventName":"tx-added-to-pool","txHash":"0x1d05e7cfef8eebb5a1c3d5983a54e21b07c3f655f9616188c1d7cdf0344bb8cd","noteHashCount":1,"nullifierCount":1,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 16:22:11 [16:22:11.416] INFO: node Received tx 0x1d05e7cfef8eebb5a1c3d5983a54e21b07c3f655f9616188c1d7cdf0344bb8cd {"txHash":"0x1d05e7cfef8eebb5a1c3d5983a54e21b07c3f655f9616188c1d7cdf0344bb8cd"} 16:22:11 [16:22:11.416] INFO: pxe:service Sent transaction 0x1d05e7cfef8eebb5a1c3d5983a54e21b07c3f655f9616188c1d7cdf0344bb8cd 16:22:11 [16:22:11.473] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 16:22:11 [16:22:11.493] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T16:27:27.000Z","now":"2025-06-13T16:27:30.996Z"} 16:22:11 [16:22:11.522] VERBOSE: simulator:public-processor Processed tx 0x1d05e7cfef8eebb5a1c3d5983a54e21b07c3f655f9616188c1d7cdf0344bb8cd with no public calls in 13.630632000000332ms {"txHash":"0x1d05e7cfef8eebb5a1c3d5983a54e21b07c3f655f9616188c1d7cdf0344bb8cd","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":13.630632000000332} 16:22:11 [16:22:11.523] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.028967917999998462s {"duration":0.028967917999998462,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11264,"l2Gas":9760},"totalSizeInBytes":960} 16:22:11 [16:22:11.622] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:11 [16:22:11.635] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x26d3420419d9533b8d6045ec4523dadbe3d76df4ed72a3dcb09a02e14604039d","globalVariables":{"chainId":31337,"version":1563066119,"blockNumber":3,"slotNumber":4,"timestamp":1749832047,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1d05e7cfef8eebb5a1c3d5983a54e21b07c3f655f9616188c1d7cdf0344bb8cd"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":161.25085599999875,"publicProcessDuration":29.245774999999412,"rollupCircuitsDuration":145.25099200000113,"txCount":1,"blockNumber":3,"blockTimestamp":1749832047,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:22:11 [16:22:11.637] VERBOSE: sequencer Attesting committee is empty 16:22:11 [16:22:11.829] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:11 [16:22:11.960] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x52e507a582b639f75e16d11ef1400e340b6013157dbd3346040275b74f4ce791 16:22:11 [16:22:11.960] VERBOSE: sequencer-client Sent L1 transaction 0x52e507a582b639f75e16d11ef1400e340b6013157dbd3346040275b74f4ce791 {"gasLimit":470312,"maxFeePerGas":"1.279583409","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:22:11 [16:22:11.978] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:22:11 [16:22:11.978] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x52e507a582b639f75e16d11ef1400e340b6013157dbd3346040275b74f4ce791","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":3,"blockTimestamp":1749832047,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:22:11 [16:22:11.979] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:22:11 [16:22:11.989] INFO: blob-sink:server Received blob sidecar for block 0xc9422e32bca231ec8ba3ee51f02dedb4f270aeb957aa8019f16e5751e2fcb36a 16:22:11 [16:22:12.000] INFO: blob-sink:server Blob sidecar stored successfully for block 0xc9422e32bca231ec8ba3ee51f02dedb4f270aeb957aa8019f16e5751e2fcb36a 16:22:12 [16:22:12.037] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:12 [16:22:12.143] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 16:22:12 [16:22:12.148] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 16:22:12 [16:22:12.162] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x26d3420419d9533b8d6045ec4523dadbe3d76df4ed72a3dcb09a02e14604039d","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":1563066119,"blockNumber":3,"slotNumber":4,"timestamp":1749832047,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x050cea0b6227776b13bc51694f8f68e90d1e2fa43d6a6767ffbd4ff5843044d8","archiveNextLeafIndex":4} 16:22:12 [16:22:12.164] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 16:22:12 [16:22:12.183] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749832083] on http://127.0.0.1:8545 16:22:12 [16:22:12.185] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:22:12 [16:22:12.187] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749832083 16:22:12 [16:22:12.188] WARN: foundation:test-date-provider Time set to 2025-06-13T16:28:03.000Z {"offset":350812,"timeMs":1749832083000} 16:22:12 [16:22:12.188] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 16:22:12 [16:22:12.244] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:12 [16:22:12.256] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":8.959977999998955,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749832047,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:22:12 [16:22:12.282] VERBOSE: p2p Synched to latest block 3 16:22:12 [16:22:12.448] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:12 [16:22:12.457] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x050cea0b6227776b13bc51694f8f68e90d1e2fa43d6a6767ffbd4ff5843044d8","header":{"contentCommitment":{"blobsHash":"0x009339ccf06e03f7a1cf51287f9a1547e2c99df9df2853c5aed807027edacc20","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749832047,"version":1563066119},"lastArchive":"0x2f199078e87f262f5f58d5fe5f3006e613c91d6e2628884f8bad9ccab447fac9","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x07581d2023af91ebc72f527bfb89b360931241d54d2336779f08ebbce603ae68","nullifierTree":"0x2989ae129f192a338b3444fe5b0a584174aa05e7614c7987a49219cab501e554","publicDataTree":"0x0f49d4aef8bba4f3a6ec3839aef8354d4d4ab2fc3997fa25d16ea5927d21e94d"},"totalFees":3242857600,"totalManaUsed":9760}} 16:22:12 [16:22:12.551] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:12 [16:22:12.589] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:22:12 [16:22:12.590] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:12 [16:22:12.628] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x050cea0b6227776b13bc51694f8f68e90d1e2fa43d6a6767ffbd4ff5843044d8","blockNumber":4,"slot":5} 16:22:12 [16:22:12.651] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:12 [16:22:12.668] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:12 [16:22:12.673] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x218b77c90ff2c579676aac1218307810d873c7a240f2de962d18c44d4764958f 16:22:12 [16:22:12.684] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:22:12 [16:22:12.685] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:22:12 [16:22:12.699] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:22:12 [16:22:12.700] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:22:12 [16:22:12.709] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 16:22:12 [16:22:12.709] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x266cc7703fa9cbc7a8f2ce07f1a2663bc3bf3ad550be4587e8cc904ffb709ce0","nullifier":"0x21768d15f593b45a066aef99905a03fe958b004e70b9ff4deb4b23866e9d3f6f"} 16:22:12 [16:22:12.715] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:22:12 [16:22:12.732] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 as fee payer 16:22:12 [16:22:12.875] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:13 [16:22:13.269] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:13 [16:22:13.496] VERBOSE: simulator:private_execution Executing private function Test:call_destroy_note {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:13 [16:22:13.529] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:22:13 [16:22:13.530] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:13 [16:22:13.688] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x050cea0b6227776b13bc51694f8f68e90d1e2fa43d6a6767ffbd4ff5843044d8","blockNumber":4,"slot":5} 16:22:13 [16:22:13.742] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:13 [16:22:13.767] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:13 [16:22:13.778] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8fb5cb017ca32615f7d8bcfe428321b60cb50d81d3fa15167de7b8315eb2bb 16:22:13 [16:22:13.792] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:22:13 [16:22:13.793] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4 for storage slot 0x000000000000000000000000000000000000000000000000000000000000000c 16:22:13 [16:22:13.802] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:22:13 [16:22:13.802] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:22:13 [16:22:13.807] VERBOSE: pxe:service Added note {"index":128,"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x2ca26552da9cfc8b6c0a12c73dca3cd912f690ddb57a160b4a172a29ddf642f2","nullifier":"0x03b316a91c450a470533682c226d019d7d82c08723791ef59a1f06a6f472dadf"} 16:22:13 [16:22:13.810] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:22:13 [16:22:13.979] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:14 [16:22:14.261] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:14 [16:22:14.752] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:14 [16:22:14.980] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:14 [16:22:14.982] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x050cea0b6227776b13bc51694f8f68e90d1e2fa43d6a6767ffbd4ff5843044d8","blockNumber":4,"slot":5} 16:22:15 [16:22:15.296] INFO: pxe:service Proving completed in 2848.288359000002ms {"timings":{"total":2848.288359000002,"sync":11.44824399999925,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":518.2661120000048,"oracles":{"debugLog":{"times":[0.5704050000022107,0.39127000000007683,0.44218199999886565,0.49938399999882677,0.5947660000019823,0.4138509999975213,0.5287239999997837,0.662187999998423]},"fetchTaggedLogs":{"times":[81.7435570000016]},"loadCapsule":{"times":[0.16135399999984656,0.15587500000037835,0.322228000000905,1.0006170000015118,0.5594349999992119,0.37665999999808264]},"getSharedSecret":{"times":[4.716374999999971]},"aes128Decrypt":{"times":[0.2936680000020715,0.660148000002664]},"getPublicKeysAndPartialAddress":{"times":[4.5765109999993]},"getKeyValidationRequest":{"times":[6.591055000000779]},"deliverNote":{"times":[9.254395999996632]},"deleteCapsule":{"times":[2.1123460000017076]},"storeCapsule":{"times":[1.4192280000024766]},"getNotes":{"times":[4.123148999999103]},"getAuthWitness":{"times":[0.20597599999746308]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0879529999983788]},"callPrivateFunction":{"times":[1113.3915740000011]}}},{"functionName":"private_kernel_init","time":72.48437299999932},{"functionName":"Test:call_destroy_note","time":858.6657699999996,"oracles":{"debugLog":{"times":[0.5541049999992538,0.6549279999999271,0.5541950000006182,0.6200059999973746,0.5989059999992605,0.44032099999822094,0.6617880000012519]},"fetchTaggedLogs":{"times":[245.20944299999974]},"loadCapsule":{"times":[0.4031100000029255,0.30218800000147894,0.4356520000001183,0.3212390000007872,0.30768800000078045,0.3509389999999257]},"getSharedSecret":{"times":[6.524003000002267]},"aes128Decrypt":{"times":[0.5289740000007441,1.0006760000032955]},"getPublicKeysAndPartialAddress":{"times":[2.459286000001157,2.1894180000017514]},"getKeyValidationRequest":{"times":[2.999260000000504,2.1984379999994417]},"deliverNote":{"times":[4.969701999998506]},"deleteCapsule":{"times":[0.6513679999989108]},"storeCapsule":{"times":[0.41047100000287173]},"getNotes":{"times":[3.3263479999986885]},"notifyNullifiedNote":{"times":[0.6588580000025104]}}},{"functionName":"private_kernel_inner","time":168.5075880000004},{"functionName":"private_kernel_reset","time":225.49547900000107},{"functionName":"private_kernel_tail","time":99.13179799999853}],"unaccounted":894.288994999999}} 16:22:15 [16:22:15.315] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:15 [16:22:15.345] VERBOSE: p2p:tx_pool Adding tx 0x1a28aaa66dfbe1d02af026b1f76227264a1ca17320031fd677c1a0f9ce253a12 to pool {"eventName":"tx-added-to-pool","txHash":"0x1a28aaa66dfbe1d02af026b1f76227264a1ca17320031fd677c1a0f9ce253a12","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 16:22:15 [16:22:15.352] INFO: node Received tx 0x1a28aaa66dfbe1d02af026b1f76227264a1ca17320031fd677c1a0f9ce253a12 {"txHash":"0x1a28aaa66dfbe1d02af026b1f76227264a1ca17320031fd677c1a0f9ce253a12"} 16:22:15 [16:22:15.353] INFO: pxe:service Sent transaction 0x1a28aaa66dfbe1d02af026b1f76227264a1ca17320031fd677c1a0f9ce253a12 16:22:15 [16:22:15.515] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 16:22:15 [16:22:15.523] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:15 [16:22:15.533] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-13T16:28:03.000Z","now":"2025-06-13T16:28:06.345Z"} 16:22:15 [16:22:15.575] VERBOSE: simulator:public-processor Processed tx 0x1a28aaa66dfbe1d02af026b1f76227264a1ca17320031fd677c1a0f9ce253a12 with no public calls in 19.189008999997895ms {"txHash":"0x1a28aaa66dfbe1d02af026b1f76227264a1ca17320031fd677c1a0f9ce253a12","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":19.189008999997895} 16:22:15 [16:22:15.577] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04351021399999808s {"duration":0.04351021399999808,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":11200},"totalSizeInBytes":288} 16:22:15 [16:22:15.730] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:15 [16:22:15.749] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0193d7448b02c9a3760855190b1791e0228f11811fa604ce9115ed05723da835","globalVariables":{"chainId":31337,"version":1563066119,"blockNumber":4,"slotNumber":5,"timestamp":1749832083,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x1a28aaa66dfbe1d02af026b1f76227264a1ca17320031fd677c1a0f9ce253a12"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":235.6451589999997,"publicProcessDuration":44.12308100000155,"rollupCircuitsDuration":218.41858199999842,"txCount":1,"blockNumber":4,"blockTimestamp":1749832083,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:22:15 [16:22:15.752] VERBOSE: sequencer Attesting committee is empty 16:22:15 [16:22:15.945] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:16 [16:22:16.043] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x0ded11bc64a72fda8f233e633888240d5b572722948c485f1c4abeaaf626b7a6 16:22:16 [16:22:16.043] VERBOSE: sequencer-client Sent L1 transaction 0x0ded11bc64a72fda8f233e633888240d5b572722948c485f1c4abeaaf626b7a6 {"gasLimit":470266,"maxFeePerGas":"1.261127755","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 16:22:16 [16:22:16.056] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 16:22:16 [16:22:16.057] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x0ded11bc64a72fda8f233e633888240d5b572722948c485f1c4abeaaf626b7a6","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":4,"blockTimestamp":1749832083,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:22:16 [16:22:16.057] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 16:22:16 [16:22:16.082] INFO: blob-sink:server Received blob sidecar for block 0x39c47bb27d1f5a2f61aa48409603b24a7d8d7b3c0f48a080a0eef7954c001018 16:22:16 [16:22:16.090] INFO: blob-sink:server Blob sidecar stored successfully for block 0x39c47bb27d1f5a2f61aa48409603b24a7d8d7b3c0f48a080a0eef7954c001018 16:22:16 [16:22:16.091] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749832119] on http://127.0.0.1:8545 16:22:16 [16:22:16.093] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 16:22:16 [16:22:16.096] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749832119 16:22:16 [16:22:16.097] WARN: foundation:test-date-provider Time set to 2025-06-13T16:28:39.000Z {"offset":382903,"timeMs":1749832119000} 16:22:16 [16:22:16.097] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 16:22:16 [16:22:16.147] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:16 [16:22:16.159] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 16:22:16 [16:22:16.162] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 16:22:16 [16:22:16.165] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 16:22:16 [16:22:16.352] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:16 [16:22:16.566] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:16 [16:22:16.776] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:16 [16:22:16.797] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x0193d7448b02c9a3760855190b1791e0228f11811fa604ce9115ed05723da835","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":1563066119,"blockNumber":4,"slotNumber":5,"timestamp":1749832083,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x2cb8be0c82df6d5ba7080cda17361883cc9d0aa0c54de783c1f21bb78f8bae52","archiveNextLeafIndex":5} 16:22:16 [16:22:16.803] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 16:22:16 [16:22:16.899] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":7.784336000004259,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749832083,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 16:22:16 [16:22:16.916] VERBOSE: p2p Synched to latest block 4 16:22:16 [16:22:16.985] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:17 [16:22:17.107] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2cb8be0c82df6d5ba7080cda17361883cc9d0aa0c54de783c1f21bb78f8bae52","blockNumber":5,"slot":6} 16:22:17 [16:22:17.188] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:17 [16:22:17.388] INFO: e2e:e2e_keys Running test: Keys ovsk_app gets ovsk_app 16:22:17 [16:22:17.399] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:17 [16:22:17.419] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 {"origin":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000005d2a7f07","authWitnesses":["0x1c3dd9514a569478ec2f7f07d096839f6ff262935438e408ac76d8faed4e1402"]} 16:22:17 [16:22:17.441] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x2cb8be0c82df6d5ba7080cda17361883cc9d0aa0c54de783c1f21bb78f8bae52","header":{"contentCommitment":{"blobsHash":"0x0048792264d867581d665f7067066a5c5825ae89ceb7eaea384249ced65f59a4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749832083,"version":1563066119},"lastArchive":"0x050cea0b6227776b13bc51694f8f68e90d1e2fa43d6a6767ffbd4ff5843044d8","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x07581d2023af91ebc72f527bfb89b360931241d54d2336779f08ebbce603ae68","nullifierTree":"0x00d008093c4f00e98a0b49e6a3f227c304a7f844d28c5cb435be8c506569d3a5","publicDataTree":"0x01de8a7f9cc7f38c2900d38d5909f7b96a2b6bf2527b499a168f98d29e74985b"},"totalFees":567840000,"totalManaUsed":11200}} 16:22:17 [16:22:17.532] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:17 [16:22:17.570] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:22:17 [16:22:17.571] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:17 [16:22:17.611] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:17 [16:22:17.637] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2cb8be0c82df6d5ba7080cda17361883cc9d0aa0c54de783c1f21bb78f8bae52","blockNumber":5,"slot":6} 16:22:17 [16:22:17.658] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1"} 16:22:17 [16:22:17.664] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x218b77c90ff2c579676aac1218307810d873c7a240f2de962d18c44d4764958f 16:22:17 [16:22:17.679] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:22:17 [16:22:17.680] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 16:22:17 [16:22:17.695] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:22:17 [16:22:17.696] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:22:17 [16:22:17.699] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x266cc7703fa9cbc7a8f2ce07f1a2663bc3bf3ad550be4587e8cc904ffb709ce0","nullifier":"0x21768d15f593b45a066aef99905a03fe958b004e70b9ff4deb4b23866e9d3f6f"} 16:22:17 [16:22:17.700] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:22:17 [16:22:17.716] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1 as fee payer 16:22:17 [16:22:17.890] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:18 [16:22:18.283] VERBOSE: simulator:private_execution Executing private function Test:get_ovsk_app {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:18 [16:22:18.307] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 16:22:18 [16:22:18.311] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:18 [16:22:18.325] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:18 [16:22:18.572] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:18 [16:22:18.574] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2cb8be0c82df6d5ba7080cda17361883cc9d0aa0c54de783c1f21bb78f8bae52","blockNumber":5,"slot":6} 16:22:18 [16:22:18.603] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4"} 16:22:18 [16:22:18.613] VERBOSE: pxe:service Removed note for contract 0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4 at slot 0x000000000000000000000000000000000000000000000000000000000000000c {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","nullifier":"0x03b316a91c450a470533682c226d019d7d82c08723791ef59a1f06a6f472dadf"} 16:22:18 [16:22:18.616] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8fb5cb017ca32615f7d8bcfe428321b60cb50d81d3fa15167de7b8315eb2bb 16:22:18 [16:22:18.625] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 16:22:18 [16:22:18.626] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4 for storage slot 0x000000000000000000000000000000000000000000000000000000000000000c 16:22:18 [16:22:18.632] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 16:22:18 [16:22:18.633] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 16:22:18 [16:22:18.635] VERBOSE: pxe:service Added note {"index":128,"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x2ca26552da9cfc8b6c0a12c73dca3cd912f690ddb57a160b4a172a29ddf642f2","nullifier":"0x03b316a91c450a470533682c226d019d7d82c08723791ef59a1f06a6f472dadf"} 16:22:18 [16:22:18.637] VERBOSE: pxe:service Removed just-added note {"contract":"0x0f6fb28d43d7fe26c9cc2b1a0940349c0ef4ee15e565ad356a7f57f395e47ba4","slot":"0x000000000000000000000000000000000000000000000000000000000000000c","noteHash":"0x2ca26552da9cfc8b6c0a12c73dca3cd912f690ddb57a160b4a172a29ddf642f2","nullifier":"0x03b316a91c450a470533682c226d019d7d82c08723791ef59a1f06a6f472dadf"} 16:22:18 [16:22:18.639] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 16:22:18 [16:22:18.799] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:19 [16:22:19.316] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:19 [16:22:19.518] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2cb8be0c82df6d5ba7080cda17361883cc9d0aa0c54de783c1f21bb78f8bae52","blockNumber":5,"slot":6} 16:22:19 [16:22:19.531] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:19 [16:22:19.844] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 16:22:19 [16:22:19.874] INFO: pxe:service Simulation completed for 0x06d848bb3bcaeddcc96d58b8207a76612383a216e765bca3e0db4c9379d2b9bd in 2455.090262000005ms {"txHash":"0x06d848bb3bcaeddcc96d58b8207a76612383a216e765bca3e0db4c9379d2b9bd","origin":"0x1eb7d106d1e131292de9f342ae00b0b8803f4efb78e01bd202f8e6e55f0fe2d1","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000005d2a7f07","authWitnesses":["0x1c3dd9514a569478ec2f7f07d096839f6ff262935438e408ac76d8faed4e1402"]} 16:22:19 [16:22:19.882] INFO: node Stopping 16:22:19 [16:22:19.883] INFO: slasher Slasher client stopped. 16:22:19 [16:22:19.883] INFO: sequencer Stopped sequencer 16:22:19 [16:22:19.884] INFO: p2p P2P client stopped. 16:22:19 [16:22:19.885] INFO: world_state Stopped world state synchronizer 16:22:19 [16:22:19.886] INFO: archiver Stopped. 16:22:19 [16:22:19.886] INFO: node Stopped 16:22:19 [16:22:19.886] VERBOSE: e2e:e2e_keys Cleaning up ACVM state 16:22:19 [16:22:19.886] INFO: e2e:e2e_keys Cleaning up ACVM temp directory /tmp/8d148899 16:22:19 [16:22:19.887] VERBOSE: e2e:e2e_keys Cleaning up BB state 16:22:19 [16:22:19.909] INFO: blob-sink:server Stopping blob sink 16:22:19 [16:22:19.910] INFO: blob-sink:server Blob sink stopped 16:22:19 [16:22:19.911] VERBOSE: e2e:e2e_keys Cleaning up data directory at /tmp/b1ab0492de8b91d2 16:22:19 PASS src/e2e_keys.test.ts 16:22:19 Keys 16:22:19 using nsk_app to detect nullification 16:22:19 ✓ nsk_app and contract address are enough to detect note nullification (8934 ms) 16:22:19 ovsk_app 16:22:19 ✓ gets ovsk_app (2488 ms) 16:22:19 16:22:19 Test Suites: 1 passed, 1 total 16:22:19 Tests: 2 passed, 2 total 16:22:19 Snapshots: 0 total 16:22:19 Time: 35.705 s 16:22:19 Ran all test suites matching /src\/e2e_keys.test.ts/i. 16:22:19 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?