Parent Log: http://ci.aztec-labs.com/bac80ed53a95468a Command: 53e9b8d3e8ba3411:ISOLATE=1:NAME=e2e_authwit yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_authwit.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/f4ac84d7ac4041d505399edd8819840bb14d6c9d Env: REF_NAME=gh-readonly-queue/master/pr-15005-b1b65bcdbd44a49fbebe5d2265256dc9466e92be CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Fri Jun 13 17:07:51 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15005_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_06a902b1832ee6d0_master 17:07:51 +++ id -u 17:07:51 +++ id -g 17:07:51 ++ docker run -d --name e2e_authwit --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_authwit.test.ts'\''' 17:07:51 + cid=be81879be8dc5114bcc9b12bdac2d748d0ac0c6667257a8c73d0296951a73279 17:07:51 + set +x 17:07:52 {"level":25,"time":1749834472480,"pid":12,"hostname":"be81879be8dc","module":"logger","msg":"Logger initialized with level verbose"} 17:07:58 [17:07:58.360] INFO: e2e:e2e_authwit Logging metrics to log/unknown.jsonl 17:07:58 [17:07:58.631] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-uCUBOy/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:07:58 [17:07:58.682] INFO: e2e:e2e_authwit Calling anvil_setBlockTimestampInterval with params: [12] 17:07:58 [17:07:58.705] WARN: e2e:e2e_authwit Set block interval to 12 17:07:58 [17:07:58.705] VERBOSE: e2e:e2e_authwit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:07:58 [17:07:58.766] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:07:58 [17:07:58.777] VERBOSE: e2e:e2e_authwit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:07:58 [17:07:58.800] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:07:58 [17:07:58.807] VERBOSE: e2e:e2e_authwit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:07:58 [17:07:58.831] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:07:58 [17:07:58.836] VERBOSE: e2e:e2e_authwit Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:07:58 [17:07:58.854] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:07:58 [17:07:58.861] VERBOSE: e2e:e2e_authwit Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:07:58 [17:07:58.883] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:07:58 [17:07:58.888] VERBOSE: e2e:e2e_authwit Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:07:58 [17:07:58.901] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:07:58 [17:07:58.908] VERBOSE: e2e:e2e_authwit Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:07:58 [17:07:58.909] VERBOSE: e2e:e2e_authwit Waiting for deployments to complete 17:07:58 [17:07:58.909] INFO: e2e:e2e_authwit Waiting for 6 transactions to be mined... 17:07:58 [17:07:58.928] INFO: e2e:e2e_authwit All transactions mined successfully 17:07:58 [17:07:58.946] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:07:58 [17:07:58.946] VERBOSE: e2e:e2e_authwit Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:07:58 [17:07:58.963] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:07:58 [17:07:58.986] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:07:58 [17:07:58.994] VERBOSE: e2e:e2e_authwit Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:07:59 [17:07:59.007] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:07:59 [17:07:59.008] VERBOSE: e2e:e2e_authwit Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:07:59 [17:07:59.026] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:07:59 [17:07:59.032] VERBOSE: e2e:e2e_authwit Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:07:59 [17:07:59.043] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:07:59 [17:07:59.044] VERBOSE: e2e:e2e_authwit Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:07:59 [17:07:59.044] VERBOSE: e2e:e2e_authwit Waiting for deployments to complete 17:07:59 [17:07:59.044] INFO: e2e:e2e_authwit Waiting for 8 transactions to be mined... 17:07:59 [17:07:59.065] INFO: e2e:e2e_authwit All transactions mined successfully 17:07:59 [17:07:59.075] VERBOSE: e2e:e2e_authwit Deployed shared contracts 17:07:59 [17:07:59.105] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:07:59 [17:07:59.106] VERBOSE: e2e:e2e_authwit Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:07:59 [17:07:59.110] VERBOSE: e2e:e2e_authwit Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:07:59 [17:07:59.125] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:07:59 [17:07:59.153] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:07:59 [17:07:59.161] VERBOSE: e2e:e2e_authwit Awaiting for linked libraries to be deployed 17:07:59 [17:07:59.214] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x7ef8d5290b217464b89aee61764b3399d0b064d779c2eaa2772bb9f75c56f4d2 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:07:59 [17:07:59.224] VERBOSE: e2e:e2e_authwit Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:07:59 [17:07:59.224] INFO: e2e:e2e_authwit Waiting for 9 transactions to be mined... 17:07:59 [17:07:59.252] INFO: e2e:e2e_authwit All transactions mined successfully 17:07:59 [17:07:59.253] VERBOSE: e2e:e2e_authwit All core contracts have been deployed 17:07:59 [17:07:59.269] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:07:59 [17:07:59.270] VERBOSE: e2e:e2e_authwit Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments) 17:07:59 [17:07:59.285] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 17:07:59 [17:07:59.296] VERBOSE: e2e:e2e_authwit Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:07:59 [17:07:59.323] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 17:07:59 [17:07:59.323] VERBOSE: e2e:e2e_authwit Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 17:07:59 [17:07:59.323] INFO: e2e:e2e_authwit Waiting for 10 transactions to be mined... 17:07:59 [17:07:59.343] INFO: e2e:e2e_authwit All transactions mined successfully 17:07:59 [17:07:59.349] VERBOSE: e2e:e2e_authwit Rollup deployed 17:07:59 [17:07:59.349] VERBOSE: e2e:e2e_authwit Waiting for rollup and slash factory to be deployed 17:07:59 [17:07:59.349] INFO: e2e:e2e_authwit Waiting for 10 transactions to be mined... 17:07:59 [17:07:59.376] INFO: e2e:e2e_authwit All transactions mined successfully 17:07:59 [17:07:59.376] VERBOSE: e2e:e2e_authwit All transactions for L1 deployment have been mined 17:07:59 [17:07:59.403] INFO: e2e:e2e_authwit 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"} 17:07:59 [17:07:59.408] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:07:59 [17:07:59.410] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:07:59 [17:07:59.411] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:07:59 [17:07:59.412] INFO: telemetry:client Using NoopTelemetryClient 17:07:59 [17:07:59.419] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:07:59 [17:07:59.419] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:07:59 [17:07:59.420] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/1e5740e9190b6e3a/blob-sink with map size 134217728 KB (LMDB v2) 17:07:59 [17:07:59.422] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:07:59 [17:07:59.424] INFO: aztecjs:utils:watcher New L1 time: 1749834718 17:07:59 [17:07:59.424] WARN: foundation:test-date-provider Time set to 2025-06-13T17:11:58.000Z {"offset":238576,"timeMs":1749834718000} 17:07:59 [17:07:59.427] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:07:59 [17:07:59.435] INFO: blob-sink:server Server is running on http://localhost:37033 17:07:59 [17:07:59.435] VERBOSE: e2e:e2e_authwit Creating and synching an aztec node... 17:07:59 [17:07:59.436] VERBOSE: e2e:e2e_authwit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/25c9ef95/acvm 17:07:59 [17:07:59.438] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:37033"} 17:07:59 [17:07:59.468] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:07:59 [17:07:59.469] INFO: archiver:lmdb Creating archiver data store at directory /tmp/1e5740e9190b6e3a/archiver with map size 134217728 KB (LMDB v2) 17:07:59 [17:07:59.472] INFO: archiver:lmdb Starting data store with maxReaders 16 17:07:59 [17:07:59.662] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:07:59 [17:07:59.766] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:37033"} 17:07:59 [17:07:59.790] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:37033"} 17:07:59 [17:07:59.791] WARN: node:blob-sink:client No L1 consensus host urls configured 17:07:59 [17:07:59.791] WARN: node:blob-sink:client No archive client configured 17:07:59 [17:07:59.795] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x22cc3915bd170d370a93ad30d807b998665ee670209128eca7680481de367876 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xca151bc99959b3372a7ae9a6e35b1ea3969f2986422be01379fb398a6a1b8f16","l1BlockNumber":16}} 17:07:59 [17:07:59.811] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x22cc3915bd170d370a93ad30d807b998665ee670209128eca7680481de367876","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:07:59 [17:07:59.820] INFO: world-state:database Creating world state data store at directory /tmp/1e5740e9190b6e3a/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:07:59 [17:07:59.848] INFO: world_state Created world state synchroniser with block history of 64 17:07:59 [17:07:59.848] WARN: node Aztec node is accepting fake proofs 17:07:59 [17:07:59.868] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:07:59 [17:07:59.870] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/1e5740e9190b6e3a/p2p with map size 134217728 KB (LMDB v2) 17:07:59 [17:07:59.873] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:07:59 [17:07:59.874] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/1e5740e9190b6e3a/p2p-archive with map size 134217728 KB (LMDB v2) 17:07:59 [17:07:59.875] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:07:59 [17:07:59.876] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/1e5740e9190b6e3a/p2p-peers with map size 134217728 KB (LMDB v2) 17:07:59 [17:07:59.877] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:07:59 [17:07:59.878] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:07:59 [17:07:59.879] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:07:59 [17:07:59.882] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:07:59 [17:07:59.882] INFO: world_state Started world state synchronizer from block 1 17:07:59 [17:07:59.884] VERBOSE: world-state:block_stream Starting sync from block number 0 17:07:59 [17:07:59.888] INFO: p2p Starting p2p client from block 0 with empty mempools 17:07:59 [17:07:59.888] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:07:59 [17:07:59.889] INFO: slasher Slasher client initialized 17:07:59 [17:07:59.889] INFO: slasher Starting Slasher client... 17:07:59 [17:07:59.925] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:07:59 [17:07:59.926] VERBOSE: node All Aztec Node subsystems synced 17:07:59 [17:07:59.937] INFO: sequencer-client Deploying forwarder contract 17:07:59 [17:07:59.943] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:07:59 [17:07:59.963] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 17:07:59 [17:07:59.965] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 17:07:59 [17:07:59.975] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:07:59 [17:07:59.994] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:07:59 [17:07:59.995] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:07:59 [17:07:59.995] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/25c9ef95/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:08:00 [17:08:00.243] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:08:00 [17:08:00.245] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:00 [17:08:00.247] INFO: node Aztec Node version: 0.87.8 17:08:00 [17:08:00.247] 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"} 17:08:00 [17:08:00.248] VERBOSE: e2e:e2e_authwit Creating a pxe... 17:08:00 [17:08:00.256] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:00 [17:08:00.269] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/6f5dc4f6c550bab6/pxe_data with map size 134217728 KB (LMDB v2) 17:08:00 [17:08:00.288] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:08:00 [17:08:00.291] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x228cb80d9ff6ac2122c473987aec5d71b75a5dd2d223ae2c8158898016d271d5","blockNumber":1,"slot":2} 17:08:00 [17:08:00.522] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:00 [17:08:00.629] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:08:00 [17:08:00.630] INFO: pxe:service Started PXE connected to chain 31337 version 498363169 17:08:00 [17:08:00.686] INFO: pxe:service Registered account 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 17:08:00 [17:08:00.772] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:00 [17:08:00.773] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:08:00 [17:08:00.776] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 17:08:00 [17:08:00.920] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x228cb80d9ff6ac2122c473987aec5d71b75a5dd2d223ae2c8158898016d271d5","blockNumber":1,"slot":2} 17:08:00 [17:08:00.922] INFO: pxe:service Added contract SchnorrAccount at 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:00 [17:08:00.955] VERBOSE: pxe:block_stream Starting sync from block number 0 17:08:00 [17:08:00.982] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:08:01 [17:08:01.020] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:01 [17:08:01.063] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:01 [17:08:01.733] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:08:01 [17:08:01.840] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:01 [17:08:01.930] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:02 [17:08:02.000] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x228cb80d9ff6ac2122c473987aec5d71b75a5dd2d223ae2c8158898016d271d5","blockNumber":1,"slot":2} 17:08:02 [17:08:02.074] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:02 [17:08:02.127] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:02 [17:08:02.128] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:02 [17:08:02.155] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:02 [17:08:02.180] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:02 [17:08:02.184] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:02 [17:08:02.387] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:02 [17:08:02.476] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:02 [17:08:02.529] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:02 [17:08:02.530] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:02 [17:08:02.603] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x228cb80d9ff6ac2122c473987aec5d71b75a5dd2d223ae2c8158898016d271d5","blockNumber":1,"slot":2} 17:08:02 [17:08:02.617] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:02 [17:08:02.621] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:02 [17:08:02.640] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 as fee payer 17:08:02 [17:08:02.670] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:02 [17:08:02.884] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:03 [17:08:03.339] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:03 [17:08:03.497] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x228cb80d9ff6ac2122c473987aec5d71b75a5dd2d223ae2c8158898016d271d5","blockNumber":1,"slot":2} 17:08:03 [17:08:03.632] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:04 [17:08:04.262] INFO: pxe:service Proving completed in 3309.0622729999995ms {"timings":{"total":3309.0622729999995,"sync":3.0954259999998612,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":176.81145200000174,"oracles":{"callPrivateFunction":{"times":[901.0416029999997,391.0043420000002,344.10373600000094]}}},{"functionName":"private_kernel_init","time":128.49893599999996},{"functionName":"ContractClassRegisterer:register","time":882.0416330000007,"oracles":{"loadCapsule":{"times":[29.67143700000088]},"notifyCreatedNullifier":{"times":[0.8341079999991052]},"debugLog":{"times":[0.9424930000004679]},"notifyCreatedContractClassLog":{"times":[9.337542000001122]}}},{"functionName":"private_kernel_inner","time":334.4208749999998},{"functionName":"SchnorrAccount:constructor","time":349.0078049999993,"oracles":{"getContractInstance":{"times":[1.0713209999994433]},"debugLog":{"times":[0.5308199999999488,0.46514599999864004]},"fetchTaggedLogs":{"times":[55.370638000000326]},"loadCapsule":{"times":[0.36615100000017264,0.2279530000014347,1.7055170000003272]},"notifyCreatedNullifier":{"times":[0.2595450000007986,0.3123070000001462]},"notifyCreatedNote":{"times":[0.6281250000010914]},"getRandomField":{"times":[0.4341949999998178,0.25661399999989953,0.06232399999862537,0.07161400000040885,0.10150600000088161,0.05310300000019197,0.0548030000009021,0.05131299999993644,0.06157300000086252,0.08553500000016356,0.0584130000006553]},"getIndexedTaggingSecretAsSender":{"times":[53.76921699999912]},"incrementAppTaggingSecretIndexAsSender":{"times":[30.521904999999606]}}},{"functionName":"private_kernel_inner","time":127.23432400000092},{"functionName":"SchnorrAccount:entrypoint","time":293.70888099999866,"oracles":{"debugLog":{"times":[0.8080659999995987,0.3613699999987148,0.6708879999987403]},"fetchTaggedLogs":{"times":[89.98244700000032]},"loadCapsule":{"times":[0.22388300000056915,0.3616999999994732,1.6936960000002728]},"getNotes":{"times":[1.8986390000009123]},"getAuthWitness":{"times":[0.41879399999925226]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.033438999998907]}}},{"functionName":"private_kernel_inner","time":162.43031599999995},{"functionName":"private_kernel_reset","time":243.48619400000098},{"functionName":"private_kernel_tail","time":105.15458899999976}],"unaccounted":503.1718419999979}} 17:08:04 [17:08:04.283] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:04 [17:08:04.406] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x228cb80d9ff6ac2122c473987aec5d71b75a5dd2d223ae2c8158898016d271d5","blockNumber":1,"slot":2} 17:08:04 [17:08:04.417] VERBOSE: p2p:tx_pool Adding tx 0x29abe6469eb310f193575c90b04efd0938ab6179eb3f4318efa5ffd426f7dc08 to pool {"eventName":"tx-added-to-pool","txHash":"0x29abe6469eb310f193575c90b04efd0938ab6179eb3f4318efa5ffd426f7dc08","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:08:04 [17:08:04.436] INFO: node Received tx 0x29abe6469eb310f193575c90b04efd0938ab6179eb3f4318efa5ffd426f7dc08 {"txHash":"0x29abe6469eb310f193575c90b04efd0938ab6179eb3f4318efa5ffd426f7dc08"} 17:08:04 [17:08:04.437] INFO: pxe:service Sent transaction 0x29abe6469eb310f193575c90b04efd0938ab6179eb3f4318efa5ffd426f7dc08 17:08:04 [17:08:04.494] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:04 [17:08:04.698] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:04 [17:08:04.901] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:04 [17:08:04.925] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:08:04 [17:08:04.938] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T17:12:22.000Z","now":"2025-06-13T17:12:03.514Z"} 17:08:05 [17:08:05.123] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:05 [17:08:05.190] VERBOSE: simulator:public-processor Processed tx 0x29abe6469eb310f193575c90b04efd0938ab6179eb3f4318efa5ffd426f7dc08 with no public calls in 170.1277829999999ms {"txHash":"0x29abe6469eb310f193575c90b04efd0938ab6179eb3f4318efa5ffd426f7dc08","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":170.1277829999999} 17:08:05 [17:08:05.197] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2569304690000008s {"duration":0.2569304690000008,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:08:05 [17:08:05.320] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x27be6c6deca165eda66a67925f7fa2e4d71921dc6c027784d3e828b15dfd7ed6","globalVariables":{"chainId":31337,"version":498363169,"blockNumber":1,"slotNumber":2,"timestamp":1749834742,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x29abe6469eb310f193575c90b04efd0938ab6179eb3f4318efa5ffd426f7dc08"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":394.4746100000011,"publicProcessDuration":257.8639320000002,"rollupCircuitsDuration":382.35979099999895,"txCount":1,"blockNumber":1,"blockTimestamp":1749834742,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:05 [17:08:05.322] VERBOSE: sequencer Attesting committee is empty 17:08:05 [17:08:05.420] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:05 [17:08:05.625] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:05 [17:08:05.753] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xee7f17be585c28a79770f2a00d71ccd968cad31d8a42215767051c264ebded8e 17:08:05 [17:08:05.753] VERBOSE: sequencer-client Sent L1 transaction 0xee7f17be585c28a79770f2a00d71ccd968cad31d8a42215767051c264ebded8e {"gasLimit":514570,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:08:05 [17:08:05.765] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:05 [17:08:05.766] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xee7f17be585c28a79770f2a00d71ccd968cad31d8a42215767051c264ebded8e","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1749834742,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:05 [17:08:05.766] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:05 [17:08:05.783] INFO: blob-sink:server Received blob sidecar for block 0x39bc3ed7c4db268fd0460a876e259401924167db96cbcb743ceaf47d9922805f 17:08:05 [17:08:05.790] INFO: blob-sink:server Blob sidecar stored successfully for block 0x39bc3ed7c4db268fd0460a876e259401924167db96cbcb743ceaf47d9922805f 17:08:05 [17:08:05.834] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:05 [17:08:05.839] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:08:05 [17:08:05.842] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:08:05 [17:08:05.852] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:08:05 [17:08:05.986] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:06 [17:08:05.998] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x27be6c6deca165eda66a67925f7fa2e4d71921dc6c027784d3e828b15dfd7ed6","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":498363169,"blockNumber":1,"slotNumber":2,"timestamp":1749834742,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x294e00b592ab69d86eace3eef3848beeae3fc53a2f40edfe117e42ea10c33fd7","archiveNextLeafIndex":2} 17:08:06 [17:08:06.006] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834778] on http://127.0.0.1:8545 17:08:06 [17:08:06.010] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:06 [17:08:06.013] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834778 17:08:06 [17:08:06.014] WARN: foundation:test-date-provider Time set to 2025-06-13T17:12:58.000Z {"offset":291986,"timeMs":1749834778000} 17:08:06 [17:08:06.014] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:08:06 [17:08:06.042] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:06 [17:08:06.149] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":57.2308950000006,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749834742,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:06 [17:08:06.178] VERBOSE: p2p Synched to latest block 1 17:08:06 [17:08:06.180] INFO: pxe:service Registered account 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 17:08:06 [17:08:06.273] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:06 [17:08:06.282] INFO: pxe:service Added contract SchnorrAccount at 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:06 [17:08:06.322] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x294e00b592ab69d86eace3eef3848beeae3fc53a2f40edfe117e42ea10c33fd7","blockNumber":2,"slot":3} 17:08:06 [17:08:06.328] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x294e00b592ab69d86eace3eef3848beeae3fc53a2f40edfe117e42ea10c33fd7","header":{"contentCommitment":{"blobsHash":"0x00c74fd42390538fb78f63683915b755058fe26310b25d49bf77e25500f7cbc5","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749834742,"version":498363169},"lastArchive":"0x228cb80d9ff6ac2122c473987aec5d71b75a5dd2d223ae2c8158898016d271d5","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x019f7e4a7d0bd52f50f78c5f9db8ecda2c4584f8fefbb496f60d934ee2bccdba","nullifierTree":"0x09ad6b815656614fb3f88ccd84ededc70ab0900b4abe43923efd6a9f9f05fd39","publicDataTree":"0x01a3806e25f89b9157d0b8b05f953be24f665bdf0f3bd2fbc6171c0e5c167d76"},"totalFees":6794052480,"totalManaUsed":20448}} 17:08:06 [17:08:06.343] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:08:06 [17:08:06.434] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:06 [17:08:06.469] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:06 [17:08:06.470] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:06 [17:08:06.512] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:06 [17:08:06.562] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:08:06 [17:08:06.585] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:06 [17:08:06.591] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:06 [17:08:06.729] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:06 [17:08:06.789] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:06 [17:08:06.825] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:06 [17:08:06.825] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:06 [17:08:06.878] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x294e00b592ab69d86eace3eef3848beeae3fc53a2f40edfe117e42ea10c33fd7","blockNumber":2,"slot":3} 17:08:06 [17:08:06.901] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:06 [17:08:06.905] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:06 [17:08:06.916] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 as fee payer 17:08:07 [17:08:07.042] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:07 [17:08:07.312] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:07 [17:08:07.882] INFO: pxe:service Proving completed in 1565.5020949999998ms {"timings":{"total":1565.5020949999998,"sync":12.690260999999737,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":74.0343780000021,"oracles":{"callPrivateFunction":{"times":[341.4878379999991,229.93656399999963]}}},{"functionName":"private_kernel_init","time":86.27059499999996},{"functionName":"SchnorrAccount:constructor","time":318.7828069999996,"oracles":{"getContractInstance":{"times":[1.476314999999886]},"debugLog":{"times":[0.6292360000006738,0.43008499999996275]},"fetchTaggedLogs":{"times":[119.96572100000049]},"loadCapsule":{"times":[0.32014800000069954,0.371091000000888,0.2930560000004334]},"notifyCreatedNullifier":{"times":[0.2606550000000425,0.33037899999908404]},"notifyCreatedNote":{"times":[0.13261799999963841]},"getRandomField":{"times":[0.13553800000045158,0.20841199999995297,0.046513000001141336,0.05129300000044168,0.06430400000135705,0.05018200000085926,0.0514629999997851,0.055424000000130036,0.03936199999952805,0.03965200000129698,0.040842000000338885]},"getIndexedTaggingSecretAsSender":{"times":[41.89843199999996]},"incrementAppTaggingSecretIndexAsSender":{"times":[31.603636999998344]}}},{"functionName":"private_kernel_inner","time":161.64954099999886},{"functionName":"SchnorrAccount:entrypoint","time":203.70210299999962,"oracles":{"debugLog":{"times":[0.45660599999973783,0.3725220000014815,0.45893599999908474]},"fetchTaggedLogs":{"times":[79.12798999999904]},"loadCapsule":{"times":[0.24885399999948277,0.1947309999995923,0.22070200000052864]},"getNotes":{"times":[1.038949000001594]},"getAuthWitness":{"times":[0.16873999999916123]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5053379999990284]}}},{"functionName":"private_kernel_inner","time":135.95153000000028},{"functionName":"private_kernel_reset","time":223.22169200000098},{"functionName":"private_kernel_tail","time":80.04989199999909}],"unaccounted":269.1492959999996}} 17:08:07 [17:08:07.895] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:07 [17:08:07.899] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x294e00b592ab69d86eace3eef3848beeae3fc53a2f40edfe117e42ea10c33fd7","blockNumber":2,"slot":3} 17:08:07 [17:08:07.922] VERBOSE: p2p:tx_pool Adding tx 0x0ac39e282b75731ecf50c601a2d0b1628895381a1d9d0f0e6d4fe8cd6c58a883 to pool {"eventName":"tx-added-to-pool","txHash":"0x0ac39e282b75731ecf50c601a2d0b1628895381a1d9d0f0e6d4fe8cd6c58a883","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 17:08:07 [17:08:07.929] INFO: node Received tx 0x0ac39e282b75731ecf50c601a2d0b1628895381a1d9d0f0e6d4fe8cd6c58a883 {"txHash":"0x0ac39e282b75731ecf50c601a2d0b1628895381a1d9d0f0e6d4fe8cd6c58a883"} 17:08:07 [17:08:07.929] INFO: pxe:service Sent transaction 0x0ac39e282b75731ecf50c601a2d0b1628895381a1d9d0f0e6d4fe8cd6c58a883 17:08:08 [17:08:08.101] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:08 [17:08:08.305] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:08 [17:08:08.419] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:08:08 [17:08:08.432] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T17:12:58.000Z","now":"2025-06-13T17:13:00.418Z"} 17:08:08 [17:08:08.493] VERBOSE: simulator:public-processor Processed tx 0x0ac39e282b75731ecf50c601a2d0b1628895381a1d9d0f0e6d4fe8cd6c58a883 with no public calls in 45.54449999999997ms {"txHash":"0x0ac39e282b75731ecf50c601a2d0b1628895381a1d9d0f0e6d4fe8cd6c58a883","txFee":5018455040,"revertCode":0,"gasUsed":{"totalGas":{"daGas":11776,"l2Gas":15104},"billedGas":{"daGas":11776,"l2Gas":15104},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":45.54449999999997} 17:08:08 [17:08:08.497] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.06468822799999907s {"duration":0.06468822799999907,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 17:08:08 [17:08:08.519] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:08 [17:08:08.649] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2e135916e50f904cfc33ddfb2689f367a3a74bc55033f7c3ec657ab892cedbd9","globalVariables":{"chainId":31337,"version":498363169,"blockNumber":2,"slotNumber":3,"timestamp":1749834778,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0ac39e282b75731ecf50c601a2d0b1628895381a1d9d0f0e6d4fe8cd6c58a883"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":230.4790150000008,"publicProcessDuration":65.19090700000015,"rollupCircuitsDuration":217.7532910000009,"txCount":1,"blockNumber":2,"blockTimestamp":1749834778,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:08 [17:08:08.652] VERBOSE: sequencer Attesting committee is empty 17:08:08 [17:08:08.747] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:08 [17:08:08.932] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x9f949de964f95bfd3ae44c0323d0b813291fcf0a36e7687f800f2ff0db9e6a90 17:08:08 [17:08:08.933] VERBOSE: sequencer-client Sent L1 transaction 0x9f949de964f95bfd3ae44c0323d0b813291fcf0a36e7687f800f2ff0db9e6a90 {"gasLimit":470269,"maxFeePerGas":"1.303611197","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:08 [17:08:08.949] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:08 [17:08:08.950] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x9f949de964f95bfd3ae44c0323d0b813291fcf0a36e7687f800f2ff0db9e6a90","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":2,"blockTimestamp":1749834778,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:08 [17:08:08.950] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:08 [17:08:08.953] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:08 [17:08:08.958] INFO: blob-sink:server Received blob sidecar for block 0x29d686dd2aef3f0d385fcfb9a421f1a9871b08b191c5bffcdb6ba091b26740fd 17:08:08 [17:08:08.970] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 17:08:08 [17:08:08.971] INFO: blob-sink:server Blob sidecar stored successfully for block 0x29d686dd2aef3f0d385fcfb9a421f1a9871b08b191c5bffcdb6ba091b26740fd 17:08:08 [17:08:08.974] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 17:08:08 [17:08:08.978] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 17:08:08 [17:08:08.980] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834814] on http://127.0.0.1:8545 17:08:08 [17:08:08.982] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:08 [17:08:08.984] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834814 17:08:08 [17:08:08.984] WARN: foundation:test-date-provider Time set to 2025-06-13T17:13:34.000Z {"offset":325016,"timeMs":1749834814000} 17:08:08 [17:08:08.985] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:08:09 [17:08:09.154] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x2e135916e50f904cfc33ddfb2689f367a3a74bc55033f7c3ec657ab892cedbd9","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":498363169,"blockNumber":2,"slotNumber":3,"timestamp":1749834778,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2e2a4abf969539fbca466c7715fd6d4a2d91216e16c80aa9f13515a759010e73","archiveNextLeafIndex":3} 17:08:09 [17:08:09.156] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 17:08:09 [17:08:09.164] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:09 [17:08:09.278] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":10.481555999998818,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749834778,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:09 [17:08:09.286] VERBOSE: p2p Synched to latest block 2 17:08:09 [17:08:09.366] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:09 [17:08:09.449] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x2e2a4abf969539fbca466c7715fd6d4a2d91216e16c80aa9f13515a759010e73","header":{"contentCommitment":{"blobsHash":"0x00a71a336ff05ebb7c01b53e8419d8ea36fee0a4b272eef9eca809f9606656cd","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749834778,"version":498363169},"lastArchive":"0x294e00b592ab69d86eace3eef3848beeae3fc53a2f40edfe117e42ea10c33fd7","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2c0a156865bd1dda2f9722d5d3096239725926e7b53d7b175ca66a15e2de089a","nullifierTree":"0x07c33bb83659c0ed3b25baeee48727d4bcdf06b9c7c6502ac727b847568efe99","publicDataTree":"0x012f2869dfcbddfbb83e974a98b06b6ffc174971727970ed13111dabad0735a5"},"totalFees":5018455040,"totalManaUsed":15104}} 17:08:09 [17:08:09.519] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:09 [17:08:09.557] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:09 [17:08:09.557] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:09 [17:08:09.573] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:09 [17:08:09.598] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2e2a4abf969539fbca466c7715fd6d4a2d91216e16c80aa9f13515a759010e73","blockNumber":3,"slot":4} 17:08:09 [17:08:09.649] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:09 [17:08:09.655] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:09 [17:08:09.668] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:09 [17:08:09.669] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:09 [17:08:09.684] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:09 [17:08:09.684] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:09 [17:08:09.692] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:09 [17:08:09.695] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:09 [17:08:09.712] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 as fee payer 17:08:09 [17:08:09.752] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:08:09 [17:08:09.789] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:09 [17:08:09.804] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71,0x0000000000000000000000000000000000000000000000000000000000000001,0x1c190d79e95cbb667154f605a8d270400de1bf9dabfe94a35229c37702532cab,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x0337e523ddf531b12584c3ac2c04fdd536fdbdda6d22cd9fb4fcdfbff05f01c7,0x2df72da6fe7d08a0487b4e67399432de94d7dbdfc02abef69c59602d9474e31b,0x22f08e2820ab26f00c2d238291b965b020f44a44ff30900125437de0832def43,0x1edd79d3e6deffa5e37e43e0b2cc0c73c592200615535ea012d5895961ff85c4,0x10a828c92feae4e1b0a3c22a957680c0c19fb2cf5f5a80ed62fcc88f231ac309,0x19fb6c909a5a8279831b811d669801a95a34ba8015006af105b89b704552be36,0x1fe0269571e20ca16aeb2cb8d7e3c613d290824313da829f4eb2e3158507b0f9,0x1dff5daf6f75e412e793e85c2e0ebbe1ac94f77b810197da5d9753df5b011dd1,0x031c54b05029dac3f6307ac3f03e9e4d0fd26fbeaf520468b522c6777cb85930,0x0000000000000000000000000000000000000000000000000000000000000000 17:08:09 [17:08:09.816] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:09 [17:08:09.864] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:08:09 [17:08:09.920] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:09 [17:08:09.935] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54,0x0000000000000000000000000000000000000000000000000000000000000001,0x150d850e992c6d95a6224263867a630ae625b40b927a2fbb1667b7314f4ac6ca,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x180a1ca430a01ac31ac28c3c037c879ee8cce70f2e2e0ad554d8566c2d153021,0x0fb63a3cee4df91347da80098b1184ea795393e4705814655c5aff68302590f2,0x0079c9dedb3aeefc9dbbdfc9cb7a7fd2441f24e76870a98d9952cefc1bb39423,0x2e78e7af6f6d04144fabe16b7bc31f704ee7baa7c47d3d14e59817ee8798a28b,0x24406e4189607c6acb947a4b213d9d5ead2f9e0244969fad12b6dc136837b1c2,0x119fe25a083554d13b45bc95617ff411a7bc73897dd07f1662d2717a188360a7,0x299a8319a3a682b317e486505b93125d09aae1a1bcba5f7fef084a8a3a063770,0x0406d6030f56bbf92d3f764ef842bfe0393fa20ef6f8b31893193074ce9ed6a4,0x0e73be418b5c1f9fbab0a18d5bbc168f43b2f8d99a3f018ce9783a3a7a45fb67,0x0000000000000000000000000000000000000000000000000000000000000000 17:08:10 [17:08:10.056] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:10 [17:08:10.276] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:10 [17:08:10.535] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:10 [17:08:10.539] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2e2a4abf969539fbca466c7715fd6d4a2d91216e16c80aa9f13515a759010e73","blockNumber":3,"slot":4} 17:08:10 [17:08:10.797] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:11 [17:08:11.047] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:11 [17:08:11.248] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2e2a4abf969539fbca466c7715fd6d4a2d91216e16c80aa9f13515a759010e73","blockNumber":3,"slot":4} 17:08:11 [17:08:11.320] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:11 [17:08:11.804] INFO: pxe:service Proving completed in 2362.659059999998ms {"timings":{"total":2362.659059999998,"sync":9.562433000002784,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":289.9205340000044,"oracles":{"debugLog":{"times":[0.8419079999985115,0.4469649999991816,0.45472499999959837,0.5501819999990403,0.4863869999971939,0.42912499999874854,0.3641909999969357,0.6974799999989045]},"fetchTaggedLogs":{"times":[95.80575699999827]},"loadCapsule":{"times":[0.27980599999864353,0.2419640000007348,0.4085640000012063,0.23842400000285124,0.20095099999889499,0.2030510000004142]},"getSharedSecret":{"times":[5.500802000002295]},"aes128Decrypt":{"times":[1.1223940000018047,0.7777050000004238]},"getPublicKeysAndPartialAddress":{"times":[5.744856000001164]},"getKeyValidationRequest":{"times":[5.613689000001614]},"deliverNote":{"times":[7.992153999999573]},"deleteCapsule":{"times":[0.5314910000015516]},"storeCapsule":{"times":[0.4210339999990538]},"getNotes":{"times":[5.497292000000016]},"getAuthWitness":{"times":[0.19525100000100792]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0748440000024857]},"callPrivateFunction":{"times":[97.52950600000258,129.0770790000024]}}},{"functionName":"private_kernel_init","time":96.56461000000127},{"functionName":"ContractInstanceDeployer:deploy","time":53.89483499999915,"oracles":{"storeInExecutionCache":{"times":[0.23582300000271061]},"callPrivateFunction":{"times":[40.73580600000059]},"notifyCreatedNullifier":{"times":[0.4483559999971476]},"debugLog":{"times":[0.5908539999982168]}}},{"functionName":"private_kernel_inner","time":175.21715299999778},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":25.804067999997642,"oracles":{}},{"functionName":"private_kernel_inner","time":117.2523770000007},{"functionName":"ContractInstanceDeployer:deploy","time":64.50047700000141,"oracles":{"storeInExecutionCache":{"times":[0.09595500000068569]},"callPrivateFunction":{"times":[58.499306000001525]},"notifyCreatedNullifier":{"times":[0.37911199999871315]},"debugLog":{"times":[0.5709129999995639]}}},{"functionName":"private_kernel_inner","time":143.0323129999997},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":43.4897830000009,"oracles":{}},{"functionName":"private_kernel_inner","time":128.93367099999887},{"functionName":"private_kernel_reset","time":244.58796699999948},{"functionName":"private_kernel_tail","time":87.19351800000004}],"unaccounted":882.705320999994}} 17:08:11 [17:08:11.820] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:11 [17:08:11.859] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2e2a4abf969539fbca466c7715fd6d4a2d91216e16c80aa9f13515a759010e73","blockNumber":3,"slot":4} 17:08:11 [17:08:11.864] VERBOSE: p2p:tx_pool Adding tx 0x1111b532c148fc17b3f899105a1d90c79553de527bdb625b001a81043d014a9c to pool {"eventName":"tx-added-to-pool","txHash":"0x1111b532c148fc17b3f899105a1d90c79553de527bdb625b001a81043d014a9c","noteHashCount":0,"nullifierCount":3,"privateLogCount":2,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 17:08:11 [17:08:11.873] INFO: node Received tx 0x1111b532c148fc17b3f899105a1d90c79553de527bdb625b001a81043d014a9c {"txHash":"0x1111b532c148fc17b3f899105a1d90c79553de527bdb625b001a81043d014a9c"} 17:08:11 [17:08:11.873] INFO: pxe:service Sent transaction 0x1111b532c148fc17b3f899105a1d90c79553de527bdb625b001a81043d014a9c 17:08:12 [17:08:12.031] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:12 [17:08:12.238] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:12 [17:08:12.394] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:08:12 [17:08:12.418] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T17:13:34.000Z","now":"2025-06-13T17:13:37.434Z"} 17:08:12 [17:08:12.443] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:12 [17:08:12.473] VERBOSE: simulator:public-processor Processed tx 0x1111b532c148fc17b3f899105a1d90c79553de527bdb625b001a81043d014a9c with no public calls in 40.9355080000023ms {"txHash":"0x1111b532c148fc17b3f899105a1d90c79553de527bdb625b001a81043d014a9c","txFee":5496909440,"revertCode":0,"gasUsed":{"totalGas":{"daGas":18432,"l2Gas":16544},"billedGas":{"daGas":18432,"l2Gas":16544},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":2,"l2ToL1MessageCount":0,"durationMs":40.9355080000023} 17:08:12 [17:08:12.481] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.062427370000001245s {"duration":0.062427370000001245,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":18432,"l2Gas":16544},"totalSizeInBytes":1376} 17:08:12 [17:08:12.664] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:12 [17:08:12.679] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x268e93ba82ccf474cb3b299ee1242f7133051bfc1cdc2a7e40cde089e8c8d57d","globalVariables":{"chainId":31337,"version":498363169,"blockNumber":3,"slotNumber":4,"timestamp":1749834814,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1111b532c148fc17b3f899105a1d90c79553de527bdb625b001a81043d014a9c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":285.6561920000022,"publicProcessDuration":64.1165860000001,"rollupCircuitsDuration":261.8539490000003,"txCount":1,"blockNumber":3,"blockTimestamp":1749834814,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:12 [17:08:12.682] VERBOSE: sequencer Attesting committee is empty 17:08:12 [17:08:12.878] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:13 [17:08:13.053] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xed33d762489e8bbf6fea0fab8832beb021eee6103e608c8a9a65a1b0138c43f0 17:08:13 [17:08:13.053] VERBOSE: sequencer-client Sent L1 transaction 0xed33d762489e8bbf6fea0fab8832beb021eee6103e608c8a9a65a1b0138c43f0 {"gasLimit":470251,"maxFeePerGas":"1.279583393","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:13 [17:08:13.068] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834850] on http://127.0.0.1:8545 17:08:13 [17:08:13.071] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:13 [17:08:13.075] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:13 [17:08:13.075] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xed33d762489e8bbf6fea0fab8832beb021eee6103e608c8a9a65a1b0138c43f0","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":3,"blockTimestamp":1749834814,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:13 [17:08:13.076] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:13 [17:08:13.079] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834850 17:08:13 [17:08:13.079] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:10.000Z {"offset":356921,"timeMs":1749834850000} 17:08:13 [17:08:13.080] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:08:13 [17:08:13.081] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:13 [17:08:13.085] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:08:13 [17:08:13.087] INFO: blob-sink:server Received blob sidecar for block 0x57a11d7de09f2156848acadbb2a648b33883738664506b96a30765ee2d70ed06 17:08:13 [17:08:13.090] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:08:13 [17:08:13.094] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 17:08:13 [17:08:13.096] INFO: blob-sink:server Blob sidecar stored successfully for block 0x57a11d7de09f2156848acadbb2a648b33883738664506b96a30765ee2d70ed06 17:08:13 [17:08:13.284] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:13 [17:08:13.497] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:13 [17:08:13.668] VERBOSE: archiver:block-helper Store contract instance at 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 17:08:13 [17:08:13.668] VERBOSE: archiver:block-helper Store contract instance at 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 17:08:13 [17:08:13.681] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x268e93ba82ccf474cb3b299ee1242f7133051bfc1cdc2a7e40cde089e8c8d57d","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":498363169,"blockNumber":3,"slotNumber":4,"timestamp":1749834814,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x252440e96b27eb17ed240fee93ed60d72268c99725050c9ee4cd282664b5ee4a","archiveNextLeafIndex":4} 17:08:13 [17:08:13.701] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 17:08:13 [17:08:13.703] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:13 [17:08:13.775] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":12.644888999999239,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749834814,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:13 [17:08:13.794] VERBOSE: p2p Synched to latest block 3 17:08:13 [17:08:13.912] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:13 [17:08:13.917] WARN: pxe:service No artifact found for contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c when looking for its metadata 17:08:13 [17:08:13.919] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c as part of deployment for 0x02118161de92282b79dd3dc3d6fa5c5a12c34f9024e2c4dc421bcf2bfc6a7ce6 17:08:14 [17:08:14.050] INFO: pxe:service Added contract AuthWitTest at 0x02118161de92282b79dd3dc3d6fa5c5a12c34f9024e2c4dc421bcf2bfc6a7ce6 with class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c 17:08:14 [17:08:14.083] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x252440e96b27eb17ed240fee93ed60d72268c99725050c9ee4cd282664b5ee4a","header":{"contentCommitment":{"blobsHash":"0x002796c12e7d006a19919b13c34cd73d36e99e70940c1106e5636281226776e2","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749834814,"version":498363169},"lastArchive":"0x2e2a4abf969539fbca466c7715fd6d4a2d91216e16c80aa9f13515a759010e73","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2c0a156865bd1dda2f9722d5d3096239725926e7b53d7b175ca66a15e2de089a","nullifierTree":"0x2c9285f060b1cf940975f957777ce67034612925785a25edd80ab985dc2d5311","publicDataTree":"0x287ff7d9d2b2d16e8124766cbe3274683cb2ae606ba02bc3fc89b89cd9fc16a0"},"totalFees":5496909440,"totalManaUsed":16544}} 17:08:14 [17:08:14.163] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:14 [17:08:14.251] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:14 [17:08:14.302] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:14 [17:08:14.302] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:14 [17:08:14.396] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x252440e96b27eb17ed240fee93ed60d72268c99725050c9ee4cd282664b5ee4a","blockNumber":4,"slot":5} 17:08:14 [17:08:14.417] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:14 [17:08:14.494] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:14 [17:08:14.512] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:14 [17:08:14.530] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:14 [17:08:14.532] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:14 [17:08:14.542] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:14 [17:08:14.542] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:14 [17:08:14.558] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:14 [17:08:14.561] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:14 [17:08:14.581] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 as fee payer 17:08:14 [17:08:14.635] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:15 [17:08:15.255] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0b531072c192262f69310be602c8bfeb8f4e36acff72ed861afd4f76ee50de56,0x2054c0397fca7702b6f9252401dd1f653f4e20cff98e2eb5395de9bbdc250278,0x2b6ecadb0b2de2c700fc27a25c15b4c8eb590b62f353cdd047a57ce195071418 17:08:15 [17:08:15.419] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:15 [17:08:15.492] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:15 [17:08:15.566] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:08:15 [17:08:15.578] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x252440e96b27eb17ed240fee93ed60d72268c99725050c9ee4cd282664b5ee4a","blockNumber":4,"slot":5} 17:08:15 [17:08:15.609] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:15 [17:08:15.622] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x02118161de92282b79dd3dc3d6fa5c5a12c34f9024e2c4dc421bcf2bfc6a7ce6,0x0000000000000000000000000000000000000000000000000000000000000001,0x277e6cf91ed5b953a23254005d6b51ade2c1fe6b3f2db6b97690e14a03c811b9,0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 17:08:15 [17:08:15.711] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:15 [17:08:15.945] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:16 [17:08:16.196] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:16 [17:08:16.218] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x252440e96b27eb17ed240fee93ed60d72268c99725050c9ee4cd282664b5ee4a","blockNumber":4,"slot":5} 17:08:16 [17:08:16.574] INFO: pxe:service Proving completed in 2505.324385ms {"timings":{"total":2505.324385,"sync":16.091674999999668,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":502.90810799999963,"oracles":{"debugLog":{"times":[0.8640190000005532,0.6047539999999572,0.7179209999994782,0.8786000000000058,0.7122509999971953,0.42904400000043097,0.4315840000017488,0.6651480000000447]},"fetchTaggedLogs":{"times":[207.45274599999902]},"loadCapsule":{"times":[0.29582700000173645,0.39838199999940116,0.4883780000018305,0.3321689999975206,0.5718329999981506,1.7875219999987166]},"getSharedSecret":{"times":[6.115318000000116]},"aes128Decrypt":{"times":[1.489504000001034,1.7199580000014976]},"getPublicKeysAndPartialAddress":{"times":[2.338492999999289]},"getKeyValidationRequest":{"times":[3.3897019999967597]},"deliverNote":{"times":[15.869432000003144]},"deleteCapsule":{"times":[0.32469900000069174]},"storeCapsule":{"times":[0.5030790000018897]},"getNotes":{"times":[2.7189240000006976]},"getAuthWitness":{"times":[0.3417090000002645]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08359500000005937]},"callPrivateFunction":{"times":[907.3100110000014,135.63617199999862]}}},{"functionName":"private_kernel_init","time":53.50407600000108},{"functionName":"ContractClassRegisterer:register","time":888.4257460000008,"oracles":{"loadCapsule":{"times":[5.844313000001421]},"notifyCreatedNullifier":{"times":[1.1526759999978822]},"debugLog":{"times":[2.296400999999605]},"notifyCreatedContractClassLog":{"times":[11.26745099999971]}}},{"functionName":"private_kernel_inner","time":108.58218199999828},{"functionName":"ContractInstanceDeployer:deploy","time":84.54794499999844,"oracles":{"storeInExecutionCache":{"times":[0.11270700000022771]},"callPrivateFunction":{"times":[42.77004500000112]},"notifyCreatedNullifier":{"times":[0.45532599999933154]},"debugLog":{"times":[0.590143999997963]}}},{"functionName":"private_kernel_inner","time":122.58928000000014},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":30.276193000001513,"oracles":{}},{"functionName":"private_kernel_inner","time":114.74437300000136},{"functionName":"private_kernel_reset","time":162.40057700000034},{"functionName":"private_kernel_tail","time":74.52988299999924}],"unaccounted":346.7243469999994}} 17:08:16 [17:08:16.594] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:16 [17:08:16.720] VERBOSE: p2p:tx_pool Adding tx 0x2c74d7c294d4975031b3078a1d72e50c23ddd652ede0fae5256db3e4e1b8a793 to pool {"eventName":"tx-added-to-pool","txHash":"0x2c74d7c294d4975031b3078a1d72e50c23ddd652ede0fae5256db3e4e1b8a793","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":55,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:08:16 [17:08:16.743] INFO: node Received tx 0x2c74d7c294d4975031b3078a1d72e50c23ddd652ede0fae5256db3e4e1b8a793 {"txHash":"0x2c74d7c294d4975031b3078a1d72e50c23ddd652ede0fae5256db3e4e1b8a793"} 17:08:16 [17:08:16.744] INFO: pxe:service Sent transaction 0x2c74d7c294d4975031b3078a1d72e50c23ddd652ede0fae5256db3e4e1b8a793 17:08:16 [17:08:16.765] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 17:08:16 [17:08:16.788] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-13T17:14:10.000Z","now":"2025-06-13T17:14:13.709Z"} 17:08:16 [17:08:16.807] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.127] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.208] VERBOSE: simulator:public-processor Processed tx 0x2c74d7c294d4975031b3078a1d72e50c23ddd652ede0fae5256db3e4e1b8a793 with no public calls in 273.6115280000013ms {"txHash":"0x2c74d7c294d4975031b3078a1d72e50c23ddd652ede0fae5256db3e4e1b8a793","txFee":838780800,"revertCode":0,"gasUsed":{"totalGas":{"daGas":39424,"l2Gas":16544},"billedGas":{"daGas":39424,"l2Gas":16544},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":3,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":273.6115280000013} 17:08:17 [17:08:17.212] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.42273038799999996s {"duration":0.42273038799999996,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":39424,"l2Gas":16544},"totalSizeInBytes":2720} 17:08:17 [17:08:17.405] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.421] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1ea20a179af80db2f9b6a23f7f603e496a364784ad1d90066e98587e1e5646c3","globalVariables":{"chainId":31337,"version":498363169,"blockNumber":4,"slotNumber":5,"timestamp":1749834850,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x2c74d7c294d4975031b3078a1d72e50c23ddd652ede0fae5256db3e4e1b8a793"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":655.9531470000002,"publicProcessDuration":423.14058099999966,"rollupCircuitsDuration":638.1318719999981,"txCount":1,"blockNumber":4,"blockTimestamp":1749834850,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 17:08:17 [17:08:17.424] VERBOSE: sequencer Attesting committee is empty 17:08:17 [17:08:17.609] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.730] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x9b26f616ec17e9c3fc4317594354cf517b81e7a0711409f833acf8c731b354c5 17:08:17 [17:08:17.730] VERBOSE: sequencer-client Sent L1 transaction 0x9b26f616ec17e9c3fc4317594354cf517b81e7a0711409f833acf8c731b354c5 {"gasLimit":470263,"maxFeePerGas":"1.261127721","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:17 [17:08:17.753] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:17 [17:08:17.754] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x9b26f616ec17e9c3fc4317594354cf517b81e7a0711409f833acf8c731b354c5","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":4,"blockTimestamp":1749834850,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 17:08:17 [17:08:17.754] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:17 [17:08:17.759] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834886] on http://127.0.0.1:8545 17:08:17 [17:08:17.763] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:17 [17:08:17.767] INFO: blob-sink:server Received blob sidecar for block 0x41739e847b2fe85970992fc547d8b4f7c56f8a0a1ff1733f32b3960579965327 17:08:17 [17:08:17.770] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834886 17:08:17 [17:08:17.771] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:46.000Z {"offset":388230,"timeMs":1749834886000} 17:08:17 [17:08:17.772] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 17:08:17 [17:08:17.776] INFO: blob-sink:server Blob sidecar stored successfully for block 0x41739e847b2fe85970992fc547d8b4f7c56f8a0a1ff1733f32b3960579965327 17:08:17 [17:08:17.814] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.829] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 17:08:17 [17:08:17.831] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 17:08:17 [17:08:17.832] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 17:08:18 [17:08:18.029] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:18 [17:08:18.310] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:18 [17:08:18.348] VERBOSE: archiver:block-helper Store contract instance at 0x02118161de92282b79dd3dc3d6fa5c5a12c34f9024e2c4dc421bcf2bfc6a7ce6 17:08:18 [17:08:18.351] VERBOSE: archiver:block-helper Store contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c 17:08:18 [17:08:18.369] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x1ea20a179af80db2f9b6a23f7f603e496a364784ad1d90066e98587e1e5646c3","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":498363169,"blockNumber":4,"slotNumber":5,"timestamp":1749834850,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x249ccaf5c0af36736d99a22232f10b0943e1626a362bc77ee94dfb9c2b812dec","archiveNextLeafIndex":5} 17:08:18 [17:08:18.382] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 17:08:18 [17:08:18.449] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":12.073527000000468,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749834850,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 17:08:18 [17:08:18.515] VERBOSE: p2p Synched to latest block 4 17:08:18 [17:08:18.524] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:18 [17:08:18.730] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:18 [17:08:18.784] INFO: aztecjs:deploy_sent_tx Contract 0x02118161de92282b79dd3dc3d6fa5c5a12c34f9024e2c4dc421bcf2bfc6a7ce6 successfully deployed. 17:08:18 [17:08:18.789] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data happy path 17:08:18 [17:08:18.828] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x249ccaf5c0af36736d99a22232f10b0943e1626a362bc77ee94dfb9c2b812dec","header":{"contentCommitment":{"blobsHash":"0x00b3ae01986f41c5bdd4ab54782ce0a7d9111fe8e4f70cbee09bd235c75c1d2c","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749834850,"version":498363169},"lastArchive":"0x252440e96b27eb17ed240fee93ed60d72268c99725050c9ee4cd282664b5ee4a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2c0a156865bd1dda2f9722d5d3096239725926e7b53d7b175ca66a15e2de089a","nullifierTree":"0x2a9a4c088ded43323eeb3c9f2d7c208aa645673b3ef810e40573d00bf3a242c3","publicDataTree":"0x00cc96aeb2d6cac88b8d3cc9183b4381a824162257a0e51618ec31c1f08fa9ef"},"totalFees":838780800,"totalManaUsed":16544}} 17:08:18 [17:08:18.956] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:18 [17:08:18.969] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:18 [17:08:18.970] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:18 [17:08:18.971] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:18 [17:08:18.981] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x249ccaf5c0af36736d99a22232f10b0943e1626a362bc77ee94dfb9c2b812dec","blockNumber":5,"slot":6} 17:08:19 [17:08:19.102] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:19 [17:08:19.113] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:19 [17:08:19.128] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:19 [17:08:19.130] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:19 [17:08:19.146] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:19 [17:08:19.147] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:19 [17:08:19.151] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:19 [17:08:19.153] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:19 [17:08:19.164] VERBOSE: simulator Utility simulation for 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71.0xd191fb1a completed 17:08:19 [17:08:19.175] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.219] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:19 [17:08:19.228] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:19 [17:08:19.399] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","selector":"0xd191fb1a"} 17:08:19 [17:08:19.416] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.419] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:19 [17:08:19.419] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:19 [17:08:19.533] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x249ccaf5c0af36736d99a22232f10b0943e1626a362bc77ee94dfb9c2b812dec","blockNumber":5,"slot":6} 17:08:19 [17:08:19.575] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:19 [17:08:19.612] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1e315342f56803e785f2cea047299dd45741a26a1f27f8ba7145dbe41ea4b8cb 17:08:19 [17:08:19.625] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.636] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:19 [17:08:19.637] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:19 [17:08:19.650] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:19 [17:08:19.651] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:19 [17:08:19.655] VERBOSE: pxe:service Added note {"index":64,"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1eb045d99f2df76090ca098c7da3efc3f61f70f43b39f2e485ac88cafa49007f","nullifier":"0x1e94e03dddbebbb69abc3064b3e4fe1308552e82d72b975c30e4585c529460f0"} 17:08:19 [17:08:19.658] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:19 [17:08:19.669] VERBOSE: simulator Utility simulation for 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54.0xd191fb1a completed 17:08:19 [17:08:19.737] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:19 [17:08:19.748] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:19 [17:08:19.865] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.883] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:19 [17:08:19.920] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:19 [17:08:19.921] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:20 [17:08:20.027] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:20 [17:08:20.052] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1e315342f56803e785f2cea047299dd45741a26a1f27f8ba7145dbe41ea4b8cb 17:08:20 [17:08:20.061] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x249ccaf5c0af36736d99a22232f10b0943e1626a362bc77ee94dfb9c2b812dec","blockNumber":5,"slot":6} 17:08:20 [17:08:20.069] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:20 [17:08:20.070] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:20 [17:08:20.080] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:20 [17:08:20.081] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:20 [17:08:20.084] VERBOSE: pxe:service Added note {"index":64,"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1eb045d99f2df76090ca098c7da3efc3f61f70f43b39f2e485ac88cafa49007f","nullifier":"0x1e94e03dddbebbb69abc3064b3e4fe1308552e82d72b975c30e4585c529460f0"} 17:08:20 [17:08:20.087] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:20 [17:08:20.111] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 as fee payer 17:08:20 [17:08:20.123] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.152] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x02118161de92282b79dd3dc3d6fa5c5a12c34f9024e2c4dc421bcf2bfc6a7ce6"} 17:08:20 [17:08:20.270] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:20 [17:08:20.298] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:20 [17:08:20.299] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:20 [17:08:20.343] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.389] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:20 [17:08:20.431] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:20 [17:08:20.450] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:20 [17:08:20.451] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:20 [17:08:20.463] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:20 [17:08:20.464] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:20 [17:08:20.468] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:20 [17:08:20.470] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:20 [17:08:20.548] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.700] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x249ccaf5c0af36736d99a22232f10b0943e1626a362bc77ee94dfb9c2b812dec","blockNumber":5,"slot":6} 17:08:20 [17:08:20.887] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.184] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.501] INFO: pxe:service Proving completed in 1723.8012149999995ms {"timings":{"total":1723.8012149999995,"sync":5.6565820000032545,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":328.4739609999997,"oracles":{"debugLog":{"times":[0.6700280000004568,0.3606709999985469,0.7759540000006382,1.0218180000010761,0.5517409999993106,0.3664710000011837,0.5331599999990431,1.440773000002082]},"fetchTaggedLogs":{"times":[118.33490800000072]},"loadCapsule":{"times":[1.029168999997637,8.26090000000113,2.275470000000496,0.28419599999688216,0.4254739999996673,0.2865559999991092]},"getSharedSecret":{"times":[7.350417999998172]},"aes128Decrypt":{"times":[0.41404399999737507,1.568639000000985]},"getPublicKeysAndPartialAddress":{"times":[2.2194759999983944]},"getKeyValidationRequest":{"times":[3.734872999997606]},"deliverNote":{"times":[3.608334999997169]},"deleteCapsule":{"times":[0.31683799999882467]},"storeCapsule":{"times":[0.6446670000004815]},"getNotes":{"times":[2.720464999998512]},"getAuthWitness":{"times":[0.35671000000002095]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1386480000001029]},"callPrivateFunction":{"times":[387.0283449999988]}}},{"functionName":"private_kernel_init","time":68.84802000000127},{"functionName":"AuthWitTest:consume","time":77.64018000000215,"oracles":{"storeInExecutionCache":{"times":[0.09330499999850872]},"callPrivateFunction":{"times":[334.94527000000016]},"loadFromExecutionCache":{"times":[0.18253100000220002]},"notifyCreatedNullifier":{"times":[0.3654210000022431]}}},{"functionName":"private_kernel_inner","time":136.93736699999863},{"functionName":"SchnorrAccount:verify_private_authwit","time":299.05575699999827,"oracles":{"debugLog":{"times":[0.6630179999992833,0.6843389999994542,0.6142550000004121,0.7649730000011914,0.6028650000007474,0.3201680000020133,0.331279000001814]},"fetchTaggedLogs":{"times":[100.86157299999832]},"loadCapsule":{"times":[0.336208999997325,19.825138000000152,8.7443880000028,0.21298200000092038,0.26965500000005704,0.19860100000005332]},"getSharedSecret":{"times":[9.360312999997404]},"aes128Decrypt":{"times":[0.2914259999997739,1.2108689999986382]},"getPublicKeysAndPartialAddress":{"times":[5.532964999998512]},"getKeyValidationRequest":{"times":[1.7755819999983942]},"deliverNote":{"times":[3.8096970000005967]},"deleteCapsule":{"times":[0.3445900000006077]},"storeCapsule":{"times":[0.25508500000069034]},"getNotes":{"times":[1.9284700000025623]},"getAuthWitness":{"times":[0.2279229999985546]},"storeInExecutionCache":{"times":[0.11963699999978417]}}},{"functionName":"private_kernel_inner","time":162.2618079999993},{"functionName":"private_kernel_reset","time":222.22119199999725},{"functionName":"private_kernel_tail","time":96.25496999999814}],"unaccounted":326.45137800000157}} 17:08:21 [17:08:21.522] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.584] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x249ccaf5c0af36736d99a22232f10b0943e1626a362bc77ee94dfb9c2b812dec","blockNumber":5,"slot":6} 17:08:21 [17:08:21.585] VERBOSE: p2p:tx_pool Adding tx 0x190f39bf9d0d10dace5dbcb28033d0078931b4fa573c2b38047ba9c016049c33 to pool {"eventName":"tx-added-to-pool","txHash":"0x190f39bf9d0d10dace5dbcb28033d0078931b4fa573c2b38047ba9c016049c33","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 17:08:21 [17:08:21.593] INFO: node Received tx 0x190f39bf9d0d10dace5dbcb28033d0078931b4fa573c2b38047ba9c016049c33 {"txHash":"0x190f39bf9d0d10dace5dbcb28033d0078931b4fa573c2b38047ba9c016049c33"} 17:08:21 [17:08:21.594] INFO: pxe:service Sent transaction 0x190f39bf9d0d10dace5dbcb28033d0078931b4fa573c2b38047ba9c016049c33 17:08:21 [17:08:21.728] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.932] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.130] VERBOSE: sequencer Building block 5 for slot 6 {"slot":6,"blockNumber":5,"msgCount":0} 17:08:22 [17:08:22.137] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.149] VERBOSE: sequencer Processing pending txs {"slot":6,"slotStart":"2025-06-13T17:14:46.000Z","now":"2025-06-13T17:14:50.379Z"} 17:08:22 [17:08:22.191] VERBOSE: simulator:public-processor Processed tx 0x190f39bf9d0d10dace5dbcb28033d0078931b4fa573c2b38047ba9c016049c33 with no public calls in 23.521378999997978ms {"txHash":"0x190f39bf9d0d10dace5dbcb28033d0078931b4fa573c2b38047ba9c016049c33","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":23.521378999997978} 17:08:22 [17:08:22.194] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04387646900000254s {"duration":0.04387646900000254,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":11200},"totalSizeInBytes":288} 17:08:22 [17:08:22.354] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.374] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2623a7691b2890137e90ee81da45300011a7ae85c1c48f4773d0e8c8ff686230","globalVariables":{"chainId":31337,"version":498363169,"blockNumber":5,"slotNumber":6,"timestamp":1749834886,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x190f39bf9d0d10dace5dbcb28033d0078931b4fa573c2b38047ba9c016049c33"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":244.7144019999978,"publicProcessDuration":44.523904999998194,"rollupCircuitsDuration":227.46427100000074,"txCount":1,"blockNumber":5,"blockTimestamp":1749834886,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:22 [17:08:22.376] VERBOSE: sequencer Attesting committee is empty 17:08:22 [17:08:22.564] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.771] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x23d9640d927205f0908e24db8929a0edcd838aaa709ed5d86c2ac3cb893c566f 17:08:22 [17:08:22.771] VERBOSE: sequencer-client Sent L1 transaction 0x23d9640d927205f0908e24db8929a0edcd838aaa709ed5d86c2ac3cb893c566f {"gasLimit":470324,"maxFeePerGas":"1.246951989","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:22 [17:08:22.773] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.790] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834922] on http://127.0.0.1:8545 17:08:22 [17:08:22.795] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:22 [17:08:22.796] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x23d9640d927205f0908e24db8929a0edcd838aaa709ed5d86c2ac3cb893c566f","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":5,"blockTimestamp":1749834886,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:22 [17:08:22.796] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:22 [17:08:22.802] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:22 [17:08:22.808] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834922 17:08:22 [17:08:22.809] WARN: foundation:test-date-provider Time set to 2025-06-13T17:15:22.000Z {"offset":419191,"timeMs":1749834922000} 17:08:22 [17:08:22.809] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 17:08:22 [17:08:22.814] INFO: blob-sink:server Received blob sidecar for block 0xe45975f0dd6e146d9cb4e25e82f7cbd093302f084a220ebb9228aad049039153 17:08:22 [17:08:22.818] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 17:08:22 [17:08:22.823] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 17:08:22 [17:08:22.824] INFO: blob-sink:server Blob sidecar stored successfully for block 0xe45975f0dd6e146d9cb4e25e82f7cbd093302f084a220ebb9228aad049039153 17:08:22 [17:08:22.826] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 17:08:22 [17:08:22.980] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.184] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.509] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.534] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x2623a7691b2890137e90ee81da45300011a7ae85c1c48f4773d0e8c8ff686230","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":498363169,"blockNumber":5,"slotNumber":6,"timestamp":1749834886,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","archiveNextLeafIndex":6} 17:08:23 [17:08:23.543] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 17:08:23 [17:08:23.628] VERBOSE: pxe:service Updated pxe last block to 5 {"blockHash":{},"archive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","header":{"contentCommitment":{"blobsHash":"0x00ed2289919fdae23f662f2d3840b37707c5d8fe1b867be6fb9221fe28c70fa4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749834886,"version":498363169},"lastArchive":"0x249ccaf5c0af36736d99a22232f10b0943e1626a362bc77ee94dfb9c2b812dec","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2c0a156865bd1dda2f9722d5d3096239725926e7b53d7b175ca66a15e2de089a","nullifierTree":"0x02da5a506f3810035275f0dae58973de1f672ef322468cb852e60c7b4c8f2735","publicDataTree":"0x2cec52f4fbdccb29888ddfa28bd6ecb7398c2d1d02922f8f7949f1f993b3b461"},"totalFees":567840000,"totalManaUsed":11200}} 17:08:23 [17:08:23.668] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":37.31365400000141,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749834886,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:23 [17:08:23.700] VERBOSE: p2p Synched to latest block 5 17:08:23 [17:08:23.733] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:23 [17:08:23.746] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.749] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:23 [17:08:23.750] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:23 [17:08:23.824] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:23 [17:08:23.832] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:23 [17:08:23.845] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:23 [17:08:23.846] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:23 [17:08:23.883] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:23 [17:08:23.884] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:23 [17:08:23.902] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:23 [17:08:23.912] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:23 [17:08:23.913] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","blockNumber":6,"slot":7} 17:08:23 [17:08:23.933] WARN: node Nullifier 5967113473564771647502966628100847793919081284769007314165855472458495028019 already exists in the tree 17:08:23 [17:08:23.935] VERBOSE: simulator Utility simulation for 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71.0xd191fb1a completed 17:08:23 [17:08:23.951] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:24 [17:08:24.032] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:24 [17:08:24.044] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:24 [17:08:24.177] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:24 [17:08:24.222] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:24 [17:08:24.223] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:24 [17:08:24.223] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:24 [17:08:24.290] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:24 [17:08:24.299] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1e315342f56803e785f2cea047299dd45741a26a1f27f8ba7145dbe41ea4b8cb 17:08:24 [17:08:24.315] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:24 [17:08:24.316] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:24 [17:08:24.324] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:24 [17:08:24.325] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:24 [17:08:24.328] VERBOSE: pxe:service Added note {"index":64,"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1eb045d99f2df76090ca098c7da3efc3f61f70f43b39f2e485ac88cafa49007f","nullifier":"0x1e94e03dddbebbb69abc3064b3e4fe1308552e82d72b975c30e4585c529460f0"} 17:08:24 [17:08:24.332] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:24 [17:08:24.350] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 as fee payer 17:08:24 [17:08:24.367] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x02118161de92282b79dd3dc3d6fa5c5a12c34f9024e2c4dc421bcf2bfc6a7ce6"} 17:08:24 [17:08:24.444] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:24 [17:08:24.463] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:24 [17:08:24.463] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:24 [17:08:24.465] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:24 [17:08:24.518] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","blockNumber":6,"slot":7} 17:08:24 [17:08:24.627] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:24 [17:08:24.657] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:24 [17:08:24.668] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:24 [17:08:24.701] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:24 [17:08:24.702] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:24 [17:08:24.739] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:24 [17:08:24.740] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:24 [17:08:24.759] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:24 [17:08:24.765] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:24 [17:08:24.924] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.242] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.393] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","blockNumber":6,"slot":7} 17:08:25 [17:08:25.592] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.950] INFO: pxe:service Proving completed in 1877.0252779999973ms {"timings":{"total":1877.0252779999973,"sync":6.650997999997344,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":261.09974500000317,"oracles":{"debugLog":{"times":[0.6408069999997679,0.5032690000007278,0.5246900000020105,0.5473319999982778,0.5206299999990733,0.30512799999996787,0.39680199999929755,0.6610970000001544]},"fetchTaggedLogs":{"times":[73.54506799999945]},"loadCapsule":{"times":[0.19963100000313716,0.5091689999972004,0.4573159999999916,0.40522300000156974,0.23811399999976857,0.19405099999858066]},"getSharedSecret":{"times":[7.907030000002123]},"aes128Decrypt":{"times":[0.28058600000076694,1.1627370000023802]},"getPublicKeysAndPartialAddress":{"times":[1.808643000000302]},"getKeyValidationRequest":{"times":[2.152743000002374]},"deliverNote":{"times":[3.6668180000015127]},"deleteCapsule":{"times":[0.4527860000016517]},"storeCapsule":{"times":[1.7214579999999842]},"getNotes":{"times":[1.9346499999992375]},"getAuthWitness":{"times":[0.25206400000024587]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06476299999849289]},"callPrivateFunction":{"times":[452.6035489999995]}}},{"functionName":"private_kernel_init","time":77.32017300000007},{"functionName":"AuthWitTest:consume","time":46.12035599999945,"oracles":{"storeInExecutionCache":{"times":[0.09036500000001979]},"callPrivateFunction":{"times":[422.9648909999996]},"loadFromExecutionCache":{"times":[0.07310400000278605]},"notifyCreatedNullifier":{"times":[0.4771970000001602]}}},{"functionName":"private_kernel_inner","time":159.36627399999998},{"functionName":"SchnorrAccount:verify_private_authwit","time":398.5200399999994,"oracles":{"debugLog":{"times":[0.44506600000022445,0.5717529999965336,0.540991000001668,0.6021540000001551,0.6256950000024517,0.4822569999960251,0.6632580000004964]},"fetchTaggedLogs":{"times":[187.16557699999976]},"loadCapsule":{"times":[1.9600519999985409,2.4994929999993474,0.6182349999980943,0.5074400000012247,2.434599000000162,0.29611700000532437]},"getSharedSecret":{"times":[21.47558299999946]},"aes128Decrypt":{"times":[0.26716599999781465,1.975081999997201]},"getPublicKeysAndPartialAddress":{"times":[18.546696000004886]},"getKeyValidationRequest":{"times":[15.125561000000744]},"deliverNote":{"times":[19.363913000001048]},"deleteCapsule":{"times":[0.7546829999992042]},"storeCapsule":{"times":[0.4489359999934095]},"getNotes":{"times":[3.945244000002276]},"getAuthWitness":{"times":[0.16469900000083726]},"storeInExecutionCache":{"times":[0.19915100000071106]}}},{"functionName":"private_kernel_inner","time":162.16927299999952},{"functionName":"private_kernel_reset","time":262.85245599999325},{"functionName":"private_kernel_tail","time":100.63319000000047}],"unaccounted":402.2927730000047}} 17:08:25 [17:08:25.964] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.995] VERBOSE: p2p:tx_validator:tx_double_spend Rejecting tx 0x2a22af96c74408bdc427661bc905c1d9f7c5bade5d5c6c8d69382162f62e2fc8 for repeating a nullifier 17:08:25 [17:08:25.998] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","blockNumber":6,"slot":7} 17:08:26 [17:08:26.001] WARN: node Received invalid tx 0x2a22af96c74408bdc427661bc905c1d9f7c5bade5d5c6c8d69382162f62e2fc8: Existing nullifier {"txHash":"0x2a22af96c74408bdc427661bc905c1d9f7c5bade5d5c6c8d69382162f62e2fc8"} 17:08:26 [17:08:26.008] ERROR: pxe:service Error: Error: Invalid tx: Existing nullifier 17:08:26 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19) 17:08:26 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 17:08:26 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 17:08:26 [17:08:26.011] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid chain id 17:08:26 [17:08:26.085] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:26 [17:08:26.095] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:26 [17:08:26.095] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:26 [17:08:26.170] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:26 [17:08:26.172] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.182] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:26 [17:08:26.203] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:26 [17:08:26.204] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:26 [17:08:26.221] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:26 [17:08:26.222] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:26 [17:08:26.238] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:26 [17:08:26.242] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:26 [17:08:26.280] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:26 [17:08:26.283] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:26 [17:08:26.295] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 {"origin":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000001db46b21","authWitnesses":["0x02cb9df3aaee6f90fba82b5a990f1e9282da3ed2172c213108271968762a5aba"]} 17:08:26 [17:08:26.367] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:26 [17:08:26.417] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:26 [17:08:26.418] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:26 [17:08:26.419] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.551] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","blockNumber":6,"slot":7} 17:08:26 [17:08:26.575] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:26 [17:08:26.585] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1e315342f56803e785f2cea047299dd45741a26a1f27f8ba7145dbe41ea4b8cb 17:08:26 [17:08:26.595] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:26 [17:08:26.595] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:26 [17:08:26.601] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:26 [17:08:26.602] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:26 [17:08:26.604] VERBOSE: pxe:service Added note {"index":64,"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1eb045d99f2df76090ca098c7da3efc3f61f70f43b39f2e485ac88cafa49007f","nullifier":"0x1e94e03dddbebbb69abc3064b3e4fe1308552e82d72b975c30e4585c529460f0"} 17:08:26 [17:08:26.606] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:26 [17:08:26.621] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 as fee payer 17:08:26 [17:08:26.626] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.642] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x02118161de92282b79dd3dc3d6fa5c5a12c34f9024e2c4dc421bcf2bfc6a7ce6"} 17:08:26 [17:08:26.778] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:26 [17:08:26.812] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:26 [17:08:26.813] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:26 [17:08:26.852] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.905] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:26 [17:08:26.931] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:26 [17:08:26.941] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:26 [17:08:26.942] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:26 [17:08:26.948] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:26 [17:08:26.949] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:26 [17:08:26.956] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:26 [17:08:26.959] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:27 [17:08:27.049] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid version 17:08:27 [17:08:27.057] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:27 [17:08:27.138] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","blockNumber":6,"slot":7} 17:08:27 [17:08:27.231] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:27 [17:08:27.246] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:27 [17:08:27.246] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:27 [17:08:27.275] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:27 [17:08:27.335] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:27 [17:08:27.359] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:27 [17:08:27.372] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:27 [17:08:27.374] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:27 [17:08:27.382] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:27 [17:08:27.383] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:27 [17:08:27.388] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:27 [17:08:27.390] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:27 [17:08:27.441] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:27 [17:08:27.445] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:27 [17:08:27.461] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 {"origin":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000001db46b21","authWitnesses":["0x2f59bb6059ebb2d989e3bc8c1afeb9a21a19d71508f6619e15a9bde03633884c"]} 17:08:27 [17:08:27.500] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:27 [17:08:27.550] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:27 [17:08:27.591] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:27 [17:08:27.591] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:27 [17:08:27.682] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","blockNumber":6,"slot":7} 17:08:27 [17:08:27.707] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:27 [17:08:27.721] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1e315342f56803e785f2cea047299dd45741a26a1f27f8ba7145dbe41ea4b8cb 17:08:27 [17:08:27.735] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:27 [17:08:27.736] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:27 [17:08:27.738] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:27 [17:08:27.751] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:27 [17:08:27.752] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:27 [17:08:27.760] VERBOSE: pxe:service Added note {"index":64,"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1eb045d99f2df76090ca098c7da3efc3f61f70f43b39f2e485ac88cafa49007f","nullifier":"0x1e94e03dddbebbb69abc3064b3e4fe1308552e82d72b975c30e4585c529460f0"} 17:08:27 [17:08:27.762] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:27 [17:08:27.776] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 as fee payer 17:08:27 [17:08:27.791] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x02118161de92282b79dd3dc3d6fa5c5a12c34f9024e2c4dc421bcf2bfc6a7ce6"} 17:08:27 [17:08:27.897] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:27 [17:08:27.920] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:27 [17:08:27.920] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:27 [17:08:27.966] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.001] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:28 [17:08:28.008] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:28 [17:08:28.019] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:28 [17:08:28.020] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:28 [17:08:28.026] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:28 [17:08:28.027] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:28 [17:08:28.031] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:28 [17:08:28.033] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:28 [17:08:28.251] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.343] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","blockNumber":6,"slot":7} 17:08:28 [17:08:28.442] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:28 [17:08:28.453] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:28 [17:08:28.454] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:28 [17:08:28.481] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.525] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:28 [17:08:28.534] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:28 [17:08:28.553] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:28 [17:08:28.554] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:28 [17:08:28.566] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:28 [17:08:28.567] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:28 [17:08:28.570] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:28 [17:08:28.572] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:28 [17:08:28.620] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:28 [17:08:28.626] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:28 [17:08:28.628] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data happy path 17:08:28 [17:08:28.688] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.722] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:28 [17:08:28.734] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:28 [17:08:28.734] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:28 [17:08:28.808] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:28 [17:08:28.814] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:28 [17:08:28.826] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:28 [17:08:28.827] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:28 [17:08:28.850] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:28 [17:08:28.850] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:28 [17:08:28.868] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:28 [17:08:28.880] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:28 [17:08:28.891] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","blockNumber":6,"slot":7} 17:08:28 [17:08:28.911] VERBOSE: simulator Utility simulation for 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71.0xd191fb1a completed 17:08:28 [17:08:28.949] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.992] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:29 [17:08:29.001] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:29 [17:08:29.135] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:29 [17:08:29.177] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:29 [17:08:29.178] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:29 [17:08:29.178] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:29 [17:08:29.252] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:29 [17:08:29.260] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:29 [17:08:29.273] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:29 [17:08:29.274] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:29 [17:08:29.282] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:29 [17:08:29.283] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:29 [17:08:29.288] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:29 [17:08:29.290] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:29 [17:08:29.311] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 as fee payer 17:08:29 [17:08:29.423] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:29 [17:08:29.814] INFO: pxe:service Proving completed in 786.6508180000019ms {"timings":{"total":786.6508180000019,"sync":5.754028000003018,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":252.6597249999977,"oracles":{"debugLog":{"times":[0.5640720000010333,0.4616969999988214,0.4849279999980354,0.6598080000039772,0.5046089999959804,0.46951699999772245,0.3569699999934528,0.6182350000017323]},"fetchTaggedLogs":{"times":[80.1054409999997]},"loadCapsule":{"times":[0.22512300000380492,0.2542350000003353,0.46505599999363767,0.23998299999948358,0.19944199999736156,0.25709400000050664]},"getSharedSecret":{"times":[4.0952330000000075]},"aes128Decrypt":{"times":[0.2516140000006999,1.091521999995166]},"getPublicKeysAndPartialAddress":{"times":[2.2514179999998305]},"getKeyValidationRequest":{"times":[1.9018680000008317]},"deliverNote":{"times":[5.264439999999013]},"deleteCapsule":{"times":[0.269415000002482]},"storeCapsule":{"times":[0.2888669999956619]},"getNotes":{"times":[3.0229229999968084]},"getAuthWitness":{"times":[0.3031269999992219]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.15026899999793386]},"notifyEnqueuedPublicFunctionCall":{"times":[0.25802500000281725]}}},{"functionName":"private_kernel_init","time":66.81369400000403},{"functionName":"private_kernel_reset","time":185.13196099999914},{"functionName":"private_kernel_tail","time":103.62309000000096}],"unaccounted":172.66831999999704}} 17:08:29 [17:08:29.846] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:29 [17:08:29.857] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","blockNumber":6,"slot":7} 17:08:29 [17:08:29.897] VERBOSE: p2p:tx_pool Adding tx 0x2c7e66ac727c725c41f3568a905e985e1e689d86fb6ff4bc7b66817190f0def4 to pool {"eventName":"tx-added-to-pool","txHash":"0x2c7e66ac727c725c41f3568a905e985e1e689d86fb6ff4bc7b66817190f0def4","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 17:08:29 [17:08:29.961] INFO: node Received tx 0x2c7e66ac727c725c41f3568a905e985e1e689d86fb6ff4bc7b66817190f0def4 {"txHash":"0x2c7e66ac727c725c41f3568a905e985e1e689d86fb6ff4bc7b66817190f0def4"} 17:08:29 [17:08:29.962] INFO: pxe:service Sent transaction 0x2c7e66ac727c725c41f3568a905e985e1e689d86fb6ff4bc7b66817190f0def4 17:08:30 [17:08:30.054] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.261] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.380] VERBOSE: sequencer Building block 6 for slot 7 {"slot":7,"blockNumber":6,"msgCount":0} 17:08:30 [17:08:30.395] VERBOSE: sequencer Processing pending txs {"slot":7,"slotStart":"2025-06-13T17:15:22.000Z","now":"2025-06-13T17:15:29.586Z"} 17:08:30 [17:08:30.459] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":29.82575799999904} 17:08:30 [17:08:30.464] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.488] VERBOSE: simulator:public-processor Processed tx 0x2c7e66ac727c725c41f3568a905e985e1e689d86fb6ff4bc7b66817190f0def4 with 1 public calls in 72.61880399999791ms {"txHash":"0x2c7e66ac727c725c41f3568a905e985e1e689d86fb6ff4bc7b66817190f0def4","txFee":2327130000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":45900},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":512,"l2Gas":20044},"billedGas":{"daGas":1536,"l2Gas":45900}},"publicDataWriteCount":2,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":72.61880399999791} 17:08:30 [17:08:30.491] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.09478996699999698s {"duration":0.09478996699999698,"rate":211456.97835300057,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 17:08:30 [17:08:30.638] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 77224.67732363567 mana/s {"blockHash":"0x0b0c9f2bf72fe317e2472c3bfbdbc59e36465953a8f6a8ebb45acf8017053f44","globalVariables":{"chainId":31337,"version":498363169,"blockNumber":6,"slotNumber":7,"timestamp":1749834922,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x2c7e66ac727c725c41f3568a905e985e1e689d86fb6ff4bc7b66817190f0def4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":259.1123730000036,"publicProcessDuration":95.23995199999626,"rollupCircuitsDuration":244.8227590000024,"txCount":1,"blockNumber":6,"blockTimestamp":1749834922,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:30 [17:08:30.640] VERBOSE: sequencer Attesting committee is empty 17:08:30 [17:08:30.730] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.961] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:30.998] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x320ff24f4e56d5f68fa6c0be0e5144d5ed54b292f1338becef93b916581e524d 17:08:31 [17:08:30.999] VERBOSE: sequencer-client Sent L1 transaction 0x320ff24f4e56d5f68fa6c0be0e5144d5ed54b292f1338becef93b916581e524d {"gasLimit":470295,"maxFeePerGas":"1.236063671","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:31 [17:08:31.026] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834958] on http://127.0.0.1:8545 17:08:31 [17:08:31.031] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:31 [17:08:31.034] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834958 17:08:31 [17:08:31.035] WARN: foundation:test-date-provider Time set to 2025-06-13T17:15:58.000Z {"offset":446965,"timeMs":1749834958000} 17:08:31 [17:08:31.035] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 17:08:31 [17:08:31.038] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:31 [17:08:31.038] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x320ff24f4e56d5f68fa6c0be0e5144d5ed54b292f1338becef93b916581e524d","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":6,"blockTimestamp":1749834922,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:31 [17:08:31.039] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:31 [17:08:31.051] INFO: blob-sink:server Received blob sidecar for block 0xeed18ab84fe75ca832f9e066b47b12494df78dac8da1e5162c9e5993bea76873 17:08:31 [17:08:31.058] INFO: blob-sink:server Blob sidecar stored successfully for block 0xeed18ab84fe75ca832f9e066b47b12494df78dac8da1e5162c9e5993bea76873 17:08:31 [17:08:31.168] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.209] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000006"] on http://127.0.0.1:8545 17:08:31 [17:08:31.211] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 17:08:31 [17:08:31.214] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 17:08:31 [17:08:31.373] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.576] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.751] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x0b0c9f2bf72fe317e2472c3bfbdbc59e36465953a8f6a8ebb45acf8017053f44","blockNumber":6,"txCount":1,"globalVariables":{"chainId":31337,"version":498363169,"blockNumber":6,"slotNumber":7,"timestamp":1749834922,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x1839aa1c24212482c89aab59729e00bd250751efe4e36da3760e0e2ff4d1c8df","archiveNextLeafIndex":7} 17:08:31 [17:08:31.756] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 17:08:31 [17:08:31.780] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.860] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":13.902271999999357,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749834922,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:31 [17:08:31.878] VERBOSE: p2p Synched to latest block 6 17:08:31 [17:08:31.982] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.034] VERBOSE: pxe:service Updated pxe last block to 6 {"blockHash":{},"archive":"0x1839aa1c24212482c89aab59729e00bd250751efe4e36da3760e0e2ff4d1c8df","header":{"contentCommitment":{"blobsHash":"0x003c12fa6a8a5b4879ff2171bd1e65653cc34920f148ff4b236f9ca5e5dc4706","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749834922,"version":498363169},"lastArchive":"0x2372a8fdc1df14bb3b909b36a84c88453440120ada61c6af5fc8b2d412aad3c5","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2c0a156865bd1dda2f9722d5d3096239725926e7b53d7b175ca66a15e2de089a","nullifierTree":"0x2707f8c5be9fc820f91cdc030accca6de747915e115805bb258baadb9beaf901","publicDataTree":"0x0f1169da8945120efb1c4fbf2cfb4a9fa66c3d91396aed27ea771b1ee8ffcaf1"},"totalFees":2327130000,"totalManaUsed":45900}} 17:08:32 [17:08:32.208] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:32 [17:08:32.228] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.231] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:32 [17:08:32.231] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:32 [17:08:32.236] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x1839aa1c24212482c89aab59729e00bd250751efe4e36da3760e0e2ff4d1c8df","blockNumber":7,"slot":8} 17:08:32 [17:08:32.317] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:32 [17:08:32.331] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:32 [17:08:32.349] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:32 [17:08:32.350] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:32 [17:08:32.357] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:32 [17:08:32.357] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:32 [17:08:32.360] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:32 [17:08:32.363] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:32 [17:08:32.373] VERBOSE: simulator Utility simulation for 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71.0xd191fb1a completed 17:08:32 [17:08:32.420] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:32 [17:08:32.432] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:32 [17:08:32.433] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.608] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:32 [17:08:32.654] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:32 [17:08:32.655] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:32 [17:08:32.657] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.754] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:32 [17:08:32.785] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x1839aa1c24212482c89aab59729e00bd250751efe4e36da3760e0e2ff4d1c8df","blockNumber":7,"slot":8} 17:08:32 [17:08:32.808] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1e315342f56803e785f2cea047299dd45741a26a1f27f8ba7145dbe41ea4b8cb 17:08:32 [17:08:32.823] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:32 [17:08:32.827] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:32 [17:08:32.837] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:32 [17:08:32.838] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:32 [17:08:32.850] VERBOSE: pxe:service Added note {"index":64,"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1eb045d99f2df76090ca098c7da3efc3f61f70f43b39f2e485ac88cafa49007f","nullifier":"0x1e94e03dddbebbb69abc3064b3e4fe1308552e82d72b975c30e4585c529460f0"} 17:08:32 [17:08:32.854] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:32 [17:08:32.873] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 as fee payer 17:08:32 [17:08:32.889] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.133] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.476] INFO: pxe:service Proving completed in 997.799708999999ms {"timings":{"total":997.799708999999,"sync":4.464864999994461,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":347.74595399999816,"oracles":{"debugLog":{"times":[0.6121149999962654,0.5148599999956787,0.6565170000030776,0.8228069999968284,0.9539839999997639,0.8838899999973364,0.5878830000001471,0.8416480000014417]},"fetchTaggedLogs":{"times":[150.07981999999902]},"loadCapsule":{"times":[1.384289000001445,0.20666200000414392,1.0555109999986598,0.33413900000596186,0.36050999999861233,0.3693009999988135]},"getSharedSecret":{"times":[3.6905709999991814]},"aes128Decrypt":{"times":[0.18751000000338536,1.1987280000030296]},"getPublicKeysAndPartialAddress":{"times":[1.9287899999981164]},"getKeyValidationRequest":{"times":[4.149785999994492]},"deliverNote":{"times":[12.21542600000248]},"deleteCapsule":{"times":[0.43050500000390457]},"storeCapsule":{"times":[0.4421650000003865]},"getNotes":{"times":[4.715088999997533]},"getAuthWitness":{"times":[0.19661199999973178]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.17012999999860767]},"notifyEnqueuedPublicFunctionCall":{"times":[0.09624500000063563]}}},{"functionName":"private_kernel_init","time":86.28549599999678},{"functionName":"private_kernel_reset","time":237.6502199999959},{"functionName":"private_kernel_tail","time":107.65096300000005}],"unaccounted":214.00221100001363}} 17:08:33 [17:08:33.556] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x1839aa1c24212482c89aab59729e00bd250751efe4e36da3760e0e2ff4d1c8df","blockNumber":7,"slot":8} 17:08:33 [17:08:33.571] VERBOSE: p2p:tx_pool Adding tx 0x082c5103ef39b443286aeb7658cc6e6eb4a745a205370dbfcf67095155759bac to pool {"eventName":"tx-added-to-pool","txHash":"0x082c5103ef39b443286aeb7658cc6e6eb4a745a205370dbfcf67095155759bac","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 17:08:33 [17:08:33.585] INFO: node Received tx 0x082c5103ef39b443286aeb7658cc6e6eb4a745a205370dbfcf67095155759bac {"txHash":"0x082c5103ef39b443286aeb7658cc6e6eb4a745a205370dbfcf67095155759bac"} 17:08:33 [17:08:33.585] INFO: pxe:service Sent transaction 0x082c5103ef39b443286aeb7658cc6e6eb4a745a205370dbfcf67095155759bac 17:08:33 [17:08:33.711] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.914] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.077] VERBOSE: sequencer Building block 7 for slot 8 {"slot":8,"blockNumber":7,"msgCount":0} 17:08:34 [17:08:34.090] VERBOSE: sequencer Processing pending txs {"slot":8,"slotStart":"2025-06-13T17:15:58.000Z","now":"2025-06-13T17:16:01.055Z"} 17:08:34 [17:08:34.119] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.189] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":66.4694060000038} 17:08:34 [17:08:34.220] VERBOSE: simulator:public-processor Processed tx 0x082c5103ef39b443286aeb7658cc6e6eb4a745a205370dbfcf67095155759bac with 1 public calls in 110.00039700000343ms {"txHash":"0x082c5103ef39b443286aeb7658cc6e6eb4a745a205370dbfcf67095155759bac","txFee":3994298100,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":78783},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":512,"l2Gas":52927},"billedGas":{"daGas":1536,"l2Gas":78783}},"publicDataWriteCount":2,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":110.00039700000343} 17:08:34 [17:08:34.223] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1313942160000006s {"duration":0.1313942160000006,"rate":402810.7295073001,"totalPublicGas":{"daGas":512,"l2Gas":52927},"totalBlockGas":{"daGas":1536,"l2Gas":78783},"totalSizeInBytes":320} 17:08:34 [17:08:34.348] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.357] INFO: sequencer Built block 7 for slot 8 with 1 txs and 0 messages. 187820.3304622145 mana/s {"blockHash":"0x24a7108c3d17c71fa13ecaea002ae8f88104b687c626a5b060aee4515c43acef","globalVariables":{"chainId":31337,"version":498363169,"blockNumber":7,"slotNumber":8,"timestamp":1749834958,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x082c5103ef39b443286aeb7658cc6e6eb4a745a205370dbfcf67095155759bac"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":281.2171120000057,"publicProcessDuration":131.9214559999964,"rollupCircuitsDuration":268.0152799999996,"txCount":1,"blockNumber":7,"blockTimestamp":1749834958,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:34 [17:08:34.359] VERBOSE: sequencer Attesting committee is empty 17:08:34 [17:08:34.602] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.612] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x648445a18ddc180e89d7172d29b44cc751fb48fc26d2319415db927da12a2fca 17:08:34 [17:08:34.612] VERBOSE: sequencer-client Sent L1 transaction 0x648445a18ddc180e89d7172d29b44cc751fb48fc26d2319415db927da12a2fca {"gasLimit":489714,"maxFeePerGas":"1.227700384","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:34 [17:08:34.627] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:34 [17:08:34.627] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x648445a18ddc180e89d7172d29b44cc751fb48fc26d2319415db927da12a2fca","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":7,"blockTimestamp":1749834958,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:34 [17:08:34.627] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:34 [17:08:34.630] INFO: blob-sink:server Received blob sidecar for block 0xcf5dfffb6f81d70e4e60dba57da0c48fc8ed4668056de983ddece37623ab7ceb 17:08:34 [17:08:34.635] INFO: blob-sink:server Blob sidecar stored successfully for block 0xcf5dfffb6f81d70e4e60dba57da0c48fc8ed4668056de983ddece37623ab7ceb 17:08:34 [17:08:34.657] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834994] on http://127.0.0.1:8545 17:08:34 [17:08:34.658] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:34 [17:08:34.659] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834994 17:08:34 [17:08:34.659] WARN: foundation:test-date-provider Time set to 2025-06-13T17:16:34.000Z {"offset":479341,"timeMs":1749834994000} 17:08:34 [17:08:34.659] INFO: aztecjs:utils:watcher Slot 8 was filled, jumped to next slot 17:08:34 [17:08:34.808] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000007"] on http://127.0.0.1:8545 17:08:34 [17:08:34.809] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7 17:08:34 [17:08:34.809] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.810] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 17:08:35 [17:08:35.011] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.257] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.271] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x24a7108c3d17c71fa13ecaea002ae8f88104b687c626a5b060aee4515c43acef","blockNumber":7,"txCount":1,"globalVariables":{"chainId":31337,"version":498363169,"blockNumber":7,"slotNumber":8,"timestamp":1749834958,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x1d2b47b9e27f778594d0e7496103b2c4001308807ec99f77b2136dad64ded635","archiveNextLeafIndex":8} 17:08:35 [17:08:35.273] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 17:08:35 [17:08:35.381] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":9.206303999999363,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1749834958,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:35 [17:08:35.386] VERBOSE: p2p Synched to latest block 7 17:08:35 [17:08:35.467] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.620] VERBOSE: pxe:service Updated pxe last block to 7 {"blockHash":{},"archive":"0x1d2b47b9e27f778594d0e7496103b2c4001308807ec99f77b2136dad64ded635","header":{"contentCommitment":{"blobsHash":"0x00575699384397917520383d7344d800885356e66641debba40a2a2835ed9ba7","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":8,"timestamp":1749834958,"version":498363169},"lastArchive":"0x1839aa1c24212482c89aab59729e00bd250751efe4e36da3760e0e2ff4d1c8df","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2c0a156865bd1dda2f9722d5d3096239725926e7b53d7b175ca66a15e2de089a","nullifierTree":"0x126d099299ead22f55bce4358b172c1d5355c1c9a5c6dda5b9a9477fd19101f7","publicDataTree":"0x17c4efcce492412ef1dc1f15f8b6c25529bce38002f4f29ccf9a81bee1bfa398"},"totalFees":3994298100,"totalManaUsed":78783}} 17:08:35 [17:08:35.695] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.724] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:35 [17:08:35.746] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x1d2b47b9e27f778594d0e7496103b2c4001308807ec99f77b2136dad64ded635","blockNumber":8,"slot":9} 17:08:35 [17:08:35.748] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:35 [17:08:35.748] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:35 [17:08:35.819] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:35 [17:08:35.826] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:35 [17:08:35.835] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:35 [17:08:35.836] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:35 [17:08:35.844] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:35 [17:08:35.845] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:35 [17:08:35.848] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:35 [17:08:35.850] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:35 [17:08:35.861] VERBOSE: simulator Utility simulation for 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71.0xd191fb1a completed 17:08:35 [17:08:35.902] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:35 [17:08:35.907] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:35 [17:08:35.910] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data failure case cancel before usage 17:08:35 [17:08:35.944] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.003] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:36 [17:08:36.017] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:36 [17:08:36.017] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:36 [17:08:36.090] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:36 [17:08:36.099] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:36 [17:08:36.110] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:36 [17:08:36.111] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:36 [17:08:36.119] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:36 [17:08:36.119] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:36 [17:08:36.123] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:36 [17:08:36.125] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:36 [17:08:36.137] VERBOSE: simulator Utility simulation for 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71.0xd191fb1a completed 17:08:36 [17:08:36.152] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.177] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:36 [17:08:36.182] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:36 [17:08:36.267] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:36 [17:08:36.311] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:36 [17:08:36.312] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:36 [17:08:36.365] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.381] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x1d2b47b9e27f778594d0e7496103b2c4001308807ec99f77b2136dad64ded635","blockNumber":8,"slot":9} 17:08:36 [17:08:36.427] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:36 [17:08:36.436] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:36 [17:08:36.445] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:36 [17:08:36.445] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:36 [17:08:36.450] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:36 [17:08:36.451] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:36 [17:08:36.454] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:36 [17:08:36.455] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:36 [17:08:36.468] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 as fee payer 17:08:36 [17:08:36.644] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.919] INFO: pxe:service Proving completed in 722.9043660000025ms {"timings":{"total":722.9043660000025,"sync":5.376806000000215,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":250.61913900000218,"oracles":{"debugLog":{"times":[0.694710000003397,0.5136289999936707,0.3539999999993597,0.39812199999869335,0.3185079999966547,0.30157700000563636,0.2349030000041239,0.4890979999981937]},"fetchTaggedLogs":{"times":[122.74004299999797]},"loadCapsule":{"times":[0.18686099999467842,0.16960999999719206,0.34054900000046473,0.1835709999941173,0.1798899999994319,0.21195199999783654]},"getSharedSecret":{"times":[2.7374760000020615]},"aes128Decrypt":{"times":[0.16634999999951106,0.669729000001098]},"getPublicKeysAndPartialAddress":{"times":[1.0867819999984931]},"getKeyValidationRequest":{"times":[1.2077489999937825]},"deliverNote":{"times":[3.2505349999992177]},"deleteCapsule":{"times":[0.2477939999953378]},"storeCapsule":{"times":[0.21953299999586307]},"getNotes":{"times":[2.2638890000016545]},"getAuthWitness":{"times":[0.15815899999870453]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.050662999994528946]},"notifyEnqueuedPublicFunctionCall":{"times":[0.05480299999908311]}}},{"functionName":"private_kernel_init","time":70.32545599999867},{"functionName":"private_kernel_reset","time":188.58217400000285},{"functionName":"private_kernel_tail","time":87.07826099999511}],"unaccounted":120.92253000000346}} 17:08:36 [17:08:36.947] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.981] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x1d2b47b9e27f778594d0e7496103b2c4001308807ec99f77b2136dad64ded635","blockNumber":8,"slot":9} 17:08:36 [17:08:36.986] VERBOSE: p2p:tx_pool Adding tx 0x1d2cf18b857d63849a0a3f50ba12f9eafbf1df7da4af12332c0b6a83e5e488a7 to pool {"eventName":"tx-added-to-pool","txHash":"0x1d2cf18b857d63849a0a3f50ba12f9eafbf1df7da4af12332c0b6a83e5e488a7","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 17:08:36 [17:08:36.996] INFO: node Received tx 0x1d2cf18b857d63849a0a3f50ba12f9eafbf1df7da4af12332c0b6a83e5e488a7 {"txHash":"0x1d2cf18b857d63849a0a3f50ba12f9eafbf1df7da4af12332c0b6a83e5e488a7"} 17:08:36 [17:08:36.996] INFO: pxe:service Sent transaction 0x1d2cf18b857d63849a0a3f50ba12f9eafbf1df7da4af12332c0b6a83e5e488a7 17:08:37 [17:08:37.155] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.358] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.514] VERBOSE: sequencer Building block 8 for slot 9 {"slot":9,"blockNumber":8,"msgCount":0} 17:08:37 [17:08:37.529] VERBOSE: sequencer Processing pending txs {"slot":9,"slotStart":"2025-06-13T17:16:34.000Z","now":"2025-06-13T17:16:36.870Z"} 17:08:37 [17:08:37.566] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.570] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":15.719496000005165} 17:08:37 [17:08:37.600] VERBOSE: simulator:public-processor Processed tx 0x1d2cf18b857d63849a0a3f50ba12f9eafbf1df7da4af12332c0b6a83e5e488a7 with 1 public calls in 54.52681599999778ms {"txHash":"0x1d2cf18b857d63849a0a3f50ba12f9eafbf1df7da4af12332c0b6a83e5e488a7","txFee":2327130000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":45900},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":512,"l2Gas":20044},"billedGas":{"daGas":1536,"l2Gas":45900}},"publicDataWriteCount":2,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":54.52681599999778} 17:08:37 [17:08:37.604] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.0738439370000051s {"duration":0.0738439370000051,"rate":271437.3151582995,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 17:08:37 [17:08:37.744] INFO: sequencer Built block 8 for slot 9 with 1 txs and 0 messages. 87188.42253281033 mana/s {"blockHash":"0x20ee20ad58ef816216a43ce89cdc21a7782dd32f0b5e43206c1cfee82d2ffe7d","globalVariables":{"chainId":31337,"version":498363169,"blockNumber":8,"slotNumber":9,"timestamp":1749834994,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x1d2cf18b857d63849a0a3f50ba12f9eafbf1df7da4af12332c0b6a83e5e488a7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":229.1508360000007,"publicProcessDuration":74.36985699999786,"rollupCircuitsDuration":215.46267599999555,"txCount":1,"blockNumber":8,"blockTimestamp":1749834994,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:37 [17:08:37.746] VERBOSE: sequencer Attesting committee is empty 17:08:37 [17:08:37.824] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.026] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xbff48917d50b74d2ae9e0c94364eaf0e39d56abb3c19baa513d6a74e0493abdc 17:08:38 [17:08:38.026] VERBOSE: sequencer-client Sent L1 transaction 0xbff48917d50b74d2ae9e0c94364eaf0e39d56abb3c19baa513d6a74e0493abdc {"gasLimit":470251,"maxFeePerGas":"1.221279844","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:38 [17:08:38.037] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.046] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000008"] on http://127.0.0.1:8545 17:08:38 [17:08:38.051] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 8 17:08:38 [17:08:38.054] INFO: aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8. 17:08:38 [17:08:38.061] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:38 [17:08:38.061] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xbff48917d50b74d2ae9e0c94364eaf0e39d56abb3c19baa513d6a74e0493abdc","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":8,"blockTimestamp":1749834994,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:38 [17:08:38.062] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:38 [17:08:38.065] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749835030] on http://127.0.0.1:8545 17:08:38 [17:08:38.067] INFO: blob-sink:server Received blob sidecar for block 0xc1c6db2febc90de4310157dc8e14184793222d3cd8e8a46535c3ed090734a722 17:08:38 [17:08:38.071] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:38 [17:08:38.077] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749835030 17:08:38 [17:08:38.078] WARN: foundation:test-date-provider Time set to 2025-06-13T17:17:10.000Z {"offset":511922,"timeMs":1749835030000} 17:08:38 [17:08:38.078] INFO: aztecjs:utils:watcher Slot 9 was filled, jumped to next slot 17:08:38 [17:08:38.078] INFO: blob-sink:server Blob sidecar stored successfully for block 0xc1c6db2febc90de4310157dc8e14184793222d3cd8e8a46535c3ed090734a722 17:08:38 [17:08:38.246] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.448] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.699] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.720] INFO: archiver Downloaded L2 block 8 {"blockHash":"0x20ee20ad58ef816216a43ce89cdc21a7782dd32f0b5e43206c1cfee82d2ffe7d","blockNumber":8,"txCount":1,"globalVariables":{"chainId":31337,"version":498363169,"blockNumber":8,"slotNumber":9,"timestamp":1749834994,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0d7f07394f6b37f1f4a3e5dd8ff9178de237db8815f990ced9f643a4735dafcf","archiveNextLeafIndex":9} 17:08:38 [17:08:38.723] INFO: archiver Updated proven chain to block 8 {"provenBlockNumber":8} 17:08:38 [17:08:38.826] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":9.883802999996988,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1749834994,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:38 [17:08:38.838] VERBOSE: p2p Synched to latest block 8 17:08:38 [17:08:38.908] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:39 [17:08:39.036] VERBOSE: pxe:service Updated pxe last block to 8 {"blockHash":{},"archive":"0x0d7f07394f6b37f1f4a3e5dd8ff9178de237db8815f990ced9f643a4735dafcf","header":{"contentCommitment":{"blobsHash":"0x00bc1e709d256edce5197d1751ef0ad122e63e5b6b1df039d8fcb868f2d67f65","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1749834994,"version":498363169},"lastArchive":"0x1d2b47b9e27f778594d0e7496103b2c4001308807ec99f77b2136dad64ded635","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2c0a156865bd1dda2f9722d5d3096239725926e7b53d7b175ca66a15e2de089a","nullifierTree":"0x049b398e36f952ef346dc836ea5595a6d6353c55441b69a88bf6625837162fa7","publicDataTree":"0x129ce0c371c30b83ba6dd6a866428586ab8ded021547474750187ccff35ecf7a"},"totalFees":2327130000,"totalManaUsed":45900}} 17:08:39 [17:08:39.102] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:39 [17:08:39.114] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:39 [17:08:39.116] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:39 [17:08:39.116] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:39 [17:08:39.158] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x0d7f07394f6b37f1f4a3e5dd8ff9178de237db8815f990ced9f643a4735dafcf","blockNumber":9,"slot":10} 17:08:39 [17:08:39.181] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:39 [17:08:39.188] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:39 [17:08:39.201] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:39 [17:08:39.202] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:39 [17:08:39.209] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:39 [17:08:39.210] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:39 [17:08:39.215] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:39 [17:08:39.217] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:39 [17:08:39.235] VERBOSE: simulator Utility simulation for 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71.0xd191fb1a completed 17:08:39 [17:08:39.281] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:39 [17:08:39.287] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:39 [17:08:39.337] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:39 [17:08:39.378] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:39 [17:08:39.418] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:39 [17:08:39.419] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:39 [17:08:39.476] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:39 [17:08:39.484] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:39 [17:08:39.503] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:39 [17:08:39.505] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:39 [17:08:39.513] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:39 [17:08:39.514] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:39 [17:08:39.519] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:39 [17:08:39.521] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:39 [17:08:39.537] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 as fee payer 17:08:39 [17:08:39.594] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.086] INFO: pxe:service Proving completed in 781.7834010000006ms {"timings":{"total":781.7834010000006,"sync":5.020936000000802,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":223.89270500000566,"oracles":{"debugLog":{"times":[0.5580520000003162,0.663457999995444,0.6530669999992824,0.6705979999969713,0.5184389999994892,0.38926200000423705,0.3158469999980298,0.5558020000025863]},"fetchTaggedLogs":{"times":[62.69132199999876]},"loadCapsule":{"times":[0.21100100000330713,0.4330649999974412,0.4526059999989229,0.34626000000571366,0.36877000000094995,0.3873119999989285]},"getSharedSecret":{"times":[6.515701000003901]},"aes128Decrypt":{"times":[0.44193499999528285,1.605732000003627]},"getPublicKeysAndPartialAddress":{"times":[2.346533999996609]},"getKeyValidationRequest":{"times":[1.9072180000002845]},"deliverNote":{"times":[5.450360000002547]},"deleteCapsule":{"times":[0.3790609999996377]},"storeCapsule":{"times":[0.39954299999953946]},"getNotes":{"times":[3.2955279999951017]},"getAuthWitness":{"times":[0.3101180000012391]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06484399999317247]},"notifyEnqueuedPublicFunctionCall":{"times":[0.11269700000411831]}}},{"functionName":"private_kernel_init","time":83.05849200000375},{"functionName":"private_kernel_reset","time":205.95213300000614},{"functionName":"private_kernel_tail","time":108.70700399999623}],"unaccounted":155.152130999988}} 17:08:40 [17:08:40.115] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.130] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x0d7f07394f6b37f1f4a3e5dd8ff9178de237db8815f990ced9f643a4735dafcf","blockNumber":9,"slot":10} 17:08:40 [17:08:40.157] VERBOSE: p2p:tx_pool Adding tx 0x05f18d86a8f4c1bcad80fb9a919eaf64234eb6f1b562adf15bebe104838b23b3 to pool {"eventName":"tx-added-to-pool","txHash":"0x05f18d86a8f4c1bcad80fb9a919eaf64234eb6f1b562adf15bebe104838b23b3","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 17:08:40 [17:08:40.165] INFO: node Received tx 0x05f18d86a8f4c1bcad80fb9a919eaf64234eb6f1b562adf15bebe104838b23b3 {"txHash":"0x05f18d86a8f4c1bcad80fb9a919eaf64234eb6f1b562adf15bebe104838b23b3"} 17:08:40 [17:08:40.166] INFO: pxe:service Sent transaction 0x05f18d86a8f4c1bcad80fb9a919eaf64234eb6f1b562adf15bebe104838b23b3 17:08:40 [17:08:40.325] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.529] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.654] VERBOSE: sequencer Building block 9 for slot 10 {"slot":10,"blockNumber":9,"msgCount":0} 17:08:40 [17:08:40.673] VERBOSE: sequencer Processing pending txs {"slot":10,"slotStart":"2025-06-13T17:17:10.000Z","now":"2025-06-13T17:17:12.595Z"} 17:08:40 [17:08:40.702] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":8.410859000003256} 17:08:40 [17:08:40.725] VERBOSE: simulator:public-processor Processed tx 0x05f18d86a8f4c1bcad80fb9a919eaf64234eb6f1b562adf15bebe104838b23b3 with 1 public calls in 41.70796600000176ms {"txHash":"0x05f18d86a8f4c1bcad80fb9a919eaf64234eb6f1b562adf15bebe104838b23b3","txFee":276318000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":45900},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":512,"l2Gas":20044},"billedGas":{"daGas":1536,"l2Gas":45900}},"publicDataWriteCount":2,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":41.70796600000176} 17:08:40 [17:08:40.727] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.0531992409999948s {"duration":0.0531992409999948,"rate":376772.2926724079,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 17:08:40 [17:08:40.734] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.845] INFO: sequencer Built block 9 for slot 10 with 1 txs and 0 messages. 103355.06452113936 mana/s {"blockHash":"0x103759570e8ccd229a74c267ee0f3b8f728b13742b8be732740c2df06099b710","globalVariables":{"chainId":31337,"version":498363169,"blockNumber":9,"slotNumber":10,"timestamp":1749835030,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHashes":["0x05f18d86a8f4c1bcad80fb9a919eaf64234eb6f1b562adf15bebe104838b23b3"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":193.4122600000046,"publicProcessDuration":53.59026299999823,"rollupCircuitsDuration":175.70714099999896,"txCount":1,"blockNumber":9,"blockTimestamp":1749835030,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:40 [17:08:40.847] VERBOSE: sequencer Attesting committee is empty 17:08:40 [17:08:40.938] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.127] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x723df981c9ce2d811ef5fb7ab65075a448e74d3723cb3b4aea4713ff6bac49d4 17:08:41 [17:08:41.127] VERBOSE: sequencer-client Sent L1 transaction 0x723df981c9ce2d811ef5fb7ab65075a448e74d3723cb3b4aea4713ff6bac49d4 {"gasLimit":470277,"maxFeePerGas":"1.216344974","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:41 [17:08:41.140] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.143] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:41 [17:08:41.144] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x723df981c9ce2d811ef5fb7ab65075a448e74d3723cb3b4aea4713ff6bac49d4","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":9,"blockTimestamp":1749835030,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:41 [17:08:41.145] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:41 [17:08:41.152] INFO: blob-sink:server Received blob sidecar for block 0x7b311259d15da63ca3cc7b03e39397aacb16b148aed4a04cf982c54755c8bca5 17:08:41 [17:08:41.157] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749835066] on http://127.0.0.1:8545 17:08:41 [17:08:41.166] INFO: blob-sink:server Blob sidecar stored successfully for block 0x7b311259d15da63ca3cc7b03e39397aacb16b148aed4a04cf982c54755c8bca5 17:08:41 [17:08:41.168] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:41 [17:08:41.170] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000009"] on http://127.0.0.1:8545 17:08:41 [17:08:41.172] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749835066 17:08:41 [17:08:41.172] WARN: foundation:test-date-provider Time set to 2025-06-13T17:17:46.000Z {"offset":544828,"timeMs":1749835066000} 17:08:41 [17:08:41.172] INFO: aztecjs:utils:watcher Slot 10 was filled, jumped to next slot 17:08:41 [17:08:41.173] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 9 17:08:41 [17:08:41.175] INFO: aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9. 17:08:41 [17:08:41.305] INFO: archiver Downloaded L2 block 9 {"blockHash":"0x103759570e8ccd229a74c267ee0f3b8f728b13742b8be732740c2df06099b710","blockNumber":9,"txCount":1,"globalVariables":{"chainId":31337,"version":498363169,"blockNumber":9,"slotNumber":10,"timestamp":1749835030,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"archiveRoot":"0x0b97e990d4ced9648c342f6aefff449fe759dce5a7859f47b26d6555fcd13d23","archiveNextLeafIndex":10} 17:08:41 [17:08:41.350] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.423] INFO: world_state World state updated with L2 block 9 {"eventName":"l2-block-handled","duration":11.707066999995732,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1749835030,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:41 [17:08:41.429] VERBOSE: p2p Synched to latest block 9 17:08:41 [17:08:41.553] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.685] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x0b97e990d4ced9648c342f6aefff449fe759dce5a7859f47b26d6555fcd13d23","blockNumber":10,"slot":11} 17:08:41 [17:08:41.755] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.821] INFO: archiver Updated proven chain to block 9 {"provenBlockNumber":9} 17:08:41 [17:08:41.958] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.161] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.186] VERBOSE: pxe:service Updated pxe last block to 9 {"blockHash":{},"archive":"0x0b97e990d4ced9648c342f6aefff449fe759dce5a7859f47b26d6555fcd13d23","header":{"contentCommitment":{"blobsHash":"0x002f89756d763888a0b9d27f6041c4002cb54202c0e7e401939d15c745688462","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1749835030,"version":498363169},"lastArchive":"0x0d7f07394f6b37f1f4a3e5dd8ff9178de237db8815f990ced9f643a4735dafcf","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x2c0a156865bd1dda2f9722d5d3096239725926e7b53d7b175ca66a15e2de089a","nullifierTree":"0x122f33bc9628a14f26f4259d535862cc7994307fb91777239f092ea9b5b30a79","publicDataTree":"0x2a032ef9222c8ce16009453ecd8a89829fea8f47fd2d1555699c4ec1a5946002"},"totalFees":276318000,"totalManaUsed":45900}} 17:08:42 [17:08:42.245] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x0b97e990d4ced9648c342f6aefff449fe759dce5a7859f47b26d6555fcd13d23","blockNumber":10,"slot":11} 17:08:42 [17:08:42.313] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","selector":"0xd191fb1a"} 17:08:42 [17:08:42.328] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:42 [17:08:42.328] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:42 [17:08:42.366] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.424] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71"} 17:08:42 [17:08:42.432] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0e8a5db00c46af1ba9c2f3a7961ac80d7ebb5f16bb3424488d9b2d9df98784be 17:08:42 [17:08:42.447] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:42 [17:08:42.448] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:42 [17:08:42.464] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:42 [17:08:42.464] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:42 [17:08:42.468] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0ebe4267f48c63b23476549b760b183d409e14c015bcbff7c03917262180f2bb","nullifier":"0x1c68f5bee2aa5b06f7ef3786f3dd4e58692669b2fed5716e28f3fd928d1b1c17"} 17:08:42 [17:08:42.470] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:42 [17:08:42.482] VERBOSE: simulator Utility simulation for 0x1869ec6700e5e7c0e412f5ad7f944b963b3c47b6771ea285d6a642695eab6b71.0xd191fb1a completed 17:08:42 [17:08:42.528] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:42 [17:08:42.533] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:42 [17:08:42.568] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 {"origin":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000001db46b21","authWitnesses":["0x15fac04652907f60fef03d1485032c88e61afb061a9a7295c7cc3cd5c6483925"]} 17:08:42 [17:08:42.568] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.657] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:42 [17:08:42.692] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:42 [17:08:42.692] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:42 [17:08:42.772] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.777] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54"} 17:08:42 [17:08:42.779] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x0b97e990d4ced9648c342f6aefff449fe759dce5a7859f47b26d6555fcd13d23","blockNumber":10,"slot":11} 17:08:42 [17:08:42.786] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1e315342f56803e785f2cea047299dd45741a26a1f27f8ba7145dbe41ea4b8cb 17:08:42 [17:08:42.798] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:42 [17:08:42.799] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:42 [17:08:42.809] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:42 [17:08:42.810] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:42 [17:08:42.818] VERBOSE: pxe:service Added note {"index":64,"contract":"0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1eb045d99f2df76090ca098c7da3efc3f61f70f43b39f2e485ac88cafa49007f","nullifier":"0x1e94e03dddbebbb69abc3064b3e4fe1308552e82d72b975c30e4585c529460f0"} 17:08:42 [17:08:42.821] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:42 [17:08:42.837] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2910ff2c79c955b3aa6fffe6f318f09c646d142ac387483aba6ba4d6d4ce3a54 as fee payer 17:08:43 [17:08:43.032] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:43 [17:08:43.350] VERBOSE: node Simulating public calls for tx 0x051005b6839837fa93fe16539a59c8abbc41192bd70af790745117585c3bbf8a {"globalVariables":{"chainId":31337,"version":498363169,"blockNumber":10,"slotNumber":11,"timestamp":1749835066,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHash":"0x051005b6839837fa93fe16539a59c8abbc41192bd70af790745117585c3bbf8a","blockNumber":10} 17:08:43 [17:08:43.353] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x0b97e990d4ced9648c342f6aefff449fe759dce5a7859f47b26d6555fcd13d23","blockNumber":10,"slot":11} 17:08:43 [17:08:43.390] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 reverted with reason Assertion failed: . {"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":21.36076800000592} 17:08:43 [17:08:43.390] WARN: simulator:public_tx_context APP_LOGIC phase reverted! 0x0000000000000000000000000000000000000000000000000000000000000001:0x2716b166 failed with reason: Assertion failed: 17:08:43 [17:08:43.420] VERBOSE: simulator:public-processor Processed tx 0x051005b6839837fa93fe16539a59c8abbc41192bd70af790745117585c3bbf8a with 1 public calls in 58.98363100000279ms {"txHash":"0x051005b6839837fa93fe16539a59c8abbc41192bd70af790745117585c3bbf8a","txFee":369032020,"revertCode":1,"revertReason":{"originalMessage":"Assertion failed: ","functionErrorStack":[{"contractAddress":"0x0000000000000000000000000000000000000000000000000000000000000001","functionName":"0x2716b166"}],"noirErrorStack":["0.46","0.2567","0.7632"],"revertData":["0x000000000000000000000000000000000000000000000000b0c4aef6fe76bc3f"]},"gasUsed":{"totalGas":{"daGas":1024,"l2Gas":61301},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":35445},"billedGas":{"daGas":1024,"l2Gas":61301}},"publicDataWriteCount":1,"nullifierCount":1,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":58.98363100000279} 17:08:43 [17:08:43.421] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.06694307499999559s {"duration":0.06694307499999559,"rate":529479.7109335407,"totalPublicGas":{"daGas":0,"l2Gas":35445},"totalBlockGas":{"daGas":1024,"l2Gas":61301},"totalSizeInBytes":256} 17:08:43 PASS src/e2e_authwit.test.ts 17:08:43 e2e_authwit_tests 17:08:43 Private 17:08:43 arbitrary data 17:08:43 happy path (7223 ms) 17:08:43 failure case 17:08:43 invalid chain id (1038 ms) 17:08:43 invalid version (1578 ms) 17:08:43 Public 17:08:43 arbitrary data 17:08:43 happy path (7282 ms) 17:08:43 failure case 17:08:43 cancel before usage (7546 ms) 17:08:43 17:08:43 Test Suites: 1 passed, 1 total 17:08:43 Tests: 5 passed, 5 total 17:08:43 Snapshots: 0 total 17:08:43 Time: 51.138 s 17:08:43 Ran all test suites matching /src\/e2e_authwit.test.ts/i. 17:08:43 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?