Parent Log: http://ci.aztec-labs.com/4f0a05f8d1d5ca3f Command: 97e7ef9a556fd7e6: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/015cb0cadef6a41094c3649f32a735392e1b9693 Env: REF_NAME=gh-readonly-queue/master/pr-15027-e9a2301883801edbe36ea8bba05dcca7e714f30a CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Wed Jun 18 14:22:44 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15027_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_06a902b1832ee6d0_master 14:22:44 +++ id -u 14:22:44 +++ id -g 14:22:44 ++ 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'\''' 14:22:45 + cid=88e555070c0d4a1b53dff93db4817cacb70a8371587bc92817d7bf41f1122f37 14:22:45 + set +x 14:22:45 {"level":25,"time":1750256565889,"pid":12,"hostname":"88e555070c0d","module":"logger","msg":"Logger initialized with level verbose"} 14:22:52 [14:22:52.007] INFO: e2e:e2e_authwit Logging metrics to log/unknown.jsonl 14:22:52 [14:22:52.312] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-n1yNu8/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 14:22:52 [14:22:52.343] INFO: e2e:e2e_authwit Calling anvil_setBlockTimestampInterval with params: [12] 14:22:52 [14:22:52.364] WARN: e2e:e2e_authwit Set block interval to 12 14:22:52 [14:22:52.365] VERBOSE: e2e:e2e_authwit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 14:22:52 [14:22:52.408] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 14:22:52 [14:22:52.416] VERBOSE: e2e:e2e_authwit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 14:22:52 [14:22:52.436] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 14:22:52 [14:22:52.442] VERBOSE: e2e:e2e_authwit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 14:22:52 [14:22:52.459] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 14:22:52 [14:22:52.464] VERBOSE: e2e:e2e_authwit Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 14:22:52 [14:22:52.477] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 14:22:52 [14:22:52.482] VERBOSE: e2e:e2e_authwit Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 14:22:52 [14:22:52.502] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 14:22:52 [14:22:52.509] VERBOSE: e2e:e2e_authwit Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 14:22:52 [14:22:52.524] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 14:22:52 [14:22:52.533] VERBOSE: e2e:e2e_authwit Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 14:22:52 [14:22:52.535] VERBOSE: e2e:e2e_authwit Waiting for deployments to complete 14:22:52 [14:22:52.536] INFO: e2e:e2e_authwit Waiting for 6 transactions to be mined... 14:22:52 [14:22:52.562] INFO: e2e:e2e_authwit All transactions mined successfully 14:22:52 [14:22:52.585] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 14:22:52 [14:22:52.585] VERBOSE: e2e:e2e_authwit Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 14:22:52 [14:22:52.601] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 14:22:52 [14:22:52.614] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 14:22:52 [14:22:52.621] VERBOSE: e2e:e2e_authwit Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 14:22:52 [14:22:52.638] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 14:22:52 [14:22:52.638] VERBOSE: e2e:e2e_authwit Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 14:22:52 [14:22:52.661] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 14:22:52 [14:22:52.669] VERBOSE: e2e:e2e_authwit Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 14:22:52 [14:22:52.690] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 14:22:52 [14:22:52.691] VERBOSE: e2e:e2e_authwit Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 14:22:52 [14:22:52.691] VERBOSE: e2e:e2e_authwit Waiting for deployments to complete 14:22:52 [14:22:52.691] INFO: e2e:e2e_authwit Waiting for 8 transactions to be mined... 14:22:52 [14:22:52.708] INFO: e2e:e2e_authwit All transactions mined successfully 14:22:52 [14:22:52.728] VERBOSE: e2e:e2e_authwit Deployed shared contracts 14:22:52 [14:22:52.752] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 14:22:52 [14:22:52.752] VERBOSE: e2e:e2e_authwit Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 14:22:52 [14:22:52.756] 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} 14:22:52 [14:22:52.769] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 14:22:52 [14:22:52.805] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 14:22:52 [14:22:52.811] VERBOSE: e2e:e2e_authwit Awaiting for linked libraries to be deployed 14:22:52 [14:22:52.854] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xe66803ec79f79eadeff474ad9ec0fa130866f0d5ac9b8961045a761772674d52 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 14:22:52 [14:22:52.862] 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} 14:22:52 [14:22:52.862] INFO: e2e:e2e_authwit Waiting for 9 transactions to be mined... 14:22:52 [14:22:52.880] INFO: e2e:e2e_authwit All transactions mined successfully 14:22:52 [14:22:52.881] VERBOSE: e2e:e2e_authwit All core contracts have been deployed 14:22:52 [14:22:52.910] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 14:22:52 [14:22:52.911] VERBOSE: e2e:e2e_authwit Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments) 14:22:52 [14:22:52.924] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 14:22:52 [14:22:52.928] VERBOSE: e2e:e2e_authwit Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 14:22:52 [14:22:52.946] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 14:22:52 [14:22:52.947] VERBOSE: e2e:e2e_authwit Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 14:22:52 [14:22:52.947] INFO: e2e:e2e_authwit Waiting for 10 transactions to be mined... 14:22:52 [14:22:52.964] INFO: e2e:e2e_authwit All transactions mined successfully 14:22:52 [14:22:52.973] VERBOSE: e2e:e2e_authwit Rollup deployed 14:22:52 [14:22:52.973] VERBOSE: e2e:e2e_authwit Waiting for rollup and slash factory to be deployed 14:22:52 [14:22:52.973] INFO: e2e:e2e_authwit Waiting for 10 transactions to be mined... 14:22:53 [14:22:52.999] INFO: e2e:e2e_authwit All transactions mined successfully 14:22:53 [14:22:52.999] VERBOSE: e2e:e2e_authwit All transactions for L1 deployment have been mined 14:22:53 [14:22:53.019] 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"} 14:22:53 [14:22:53.022] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 14:22:53 [14:22:53.024] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:53 [14:22:53.025] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 14:22:53 [14:22:53.026] INFO: telemetry:client Using NoopTelemetryClient 14:22:53 [14:22:53.032] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/6a68f87aa2e81293/blob-sink with map size 134217728 KB (LMDB v2) 14:22:53 [14:22:53.032] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 14:22:53 [14:22:53.033] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 14:22:53 [14:22:53.035] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:53 [14:22:53.038] INFO: aztecjs:utils:watcher New L1 time: 1750256812 14:22:53 [14:22:53.038] WARN: foundation:test-date-provider Time set to 2025-06-18T14:26:52.000Z {"offset":238962,"timeMs":1750256812000} 14:22:53 [14:22:53.040] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 14:22:53 [14:22:53.047] INFO: blob-sink:server Server is running on http://localhost:36811 14:22:53 [14:22:53.047] VERBOSE: e2e:e2e_authwit Creating and synching an aztec node... 14:22:53 [14:22:53.048] VERBOSE: e2e:e2e_authwit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/9d7684c6/acvm 14:22:53 [14:22:53.049] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:36811"} 14:22:53 [14:22:53.068] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 14:22:53 [14:22:53.069] INFO: archiver:lmdb Creating archiver data store at directory /tmp/6a68f87aa2e81293/archiver with map size 134217728 KB (LMDB v2) 14:22:53 [14:22:53.076] INFO: archiver:lmdb Starting data store with maxReaders 16 14:22:53 [14:22:53.310] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:53 [14:22:53.417] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:36811"} 14:22:53 [14:22:53.434] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:36811"} 14:22:53 [14:22:53.434] WARN: node:blob-sink:client No L1 consensus host urls configured 14:22:53 [14:22:53.434] WARN: node:blob-sink:client No archive client configured 14:22:53 [14:22:53.437] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xc0c53e4a4521024b7a3f1a80fd8921d22327a762fc3afdeb64f2c1cfff75e038 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xe9b597b7ffad4c244df35cb5c66dfa8a4e11da002fc324ec6a4b46abc5100dfe","l1BlockNumber":16}} 14:22:53 [14:22:53.453] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 14:22:53 [14:22:53.463] INFO: world-state:database Creating world state data store at directory /tmp/6a68f87aa2e81293/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 14:22:53 [14:22:53.487] INFO: world_state Created world state synchroniser with block history of 64 14:22:53 [14:22:53.488] WARN: node Aztec node is accepting fake proofs 14:22:53 [14:22:53.498] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/6a68f87aa2e81293/p2p with map size 134217728 KB (LMDB v2) 14:22:53 [14:22:53.500] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 14:22:53 [14:22:53.501] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/6a68f87aa2e81293/p2p-archive with map size 134217728 KB (LMDB v2) 14:22:53 [14:22:53.502] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 14:22:53 [14:22:53.503] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/6a68f87aa2e81293/p2p-peers with map size 134217728 KB (LMDB v2) 14:22:53 [14:22:53.504] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 14:22:53 [14:22:53.506] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 14:22:53 [14:22:53.507] VERBOSE: p2p P2P is disabled. Using dummy P2P service 14:22:53 [14:22:53.510] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 14:22:53 [14:22:53.511] INFO: world_state Started world state synchronizer from block 1 14:22:53 [14:22:53.513] VERBOSE: world-state:block_stream Starting sync from block number 0 14:22:53 [14:22:53.515] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:53 [14:22:53.518] INFO: p2p Starting p2p client from block 0 with empty mempools 14:22:53 [14:22:53.518] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 14:22:53 [14:22:53.519] INFO: slasher Slasher client initialized 14:22:53 [14:22:53.520] INFO: slasher Starting Slasher client... 14:22:53 [14:22:53.552] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:22:53 [14:22:53.553] VERBOSE: node All Aztec Node subsystems synced 14:22:53 [14:22:53.560] INFO: sequencer-client Deploying forwarder contract 14:22:53 [14:22:53.570] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 14:22:53 [14:22:53.582] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 14:22:53 [14:22:53.583] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 14:22:53 [14:22:53.587] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 14:22:53 [14:22:53.600] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:22:53 [14:22:53.600] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 14:22:53 [14:22:53.601] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/9d7684c6/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 14:22:53 [14:22:53.835] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 14:22:53 [14:22:53.837] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:22:53 [14:22:53.845] INFO: node Aztec Node version: 0.87.8 14:22:53 [14:22:53.845] 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"} 14:22:53 [14:22:53.847] VERBOSE: e2e:e2e_authwit Creating a pxe... 14:22:53 [14:22:53.851] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:53 [14:22:53.860] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/320ee3ec321763ed/pxe_data with map size 134217728 KB (LMDB v2) 14:22:53 [14:22:53.872] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f24f99405aebd5368874d2da8bfc22e2c735a5abaa809a5c088ff8cbee8fbc1","blockNumber":1,"slot":2} 14:22:53 [14:22:53.873] INFO: pxe:data:lmdb Starting data store with maxReaders 16 14:22:54 [14:22:54.071] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:54 [14:22:54.185] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 14:22:54 [14:22:54.186] INFO: pxe:service Started PXE connected to chain 31337 version 3599149864 14:22:54 [14:22:54.244] INFO: pxe:service Registered account 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a 14:22:54 [14:22:54.310] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:54 [14:22:54.313] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 14:22:54 [14:22:54.317] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a 14:22:54 [14:22:54.459] INFO: pxe:service Added contract SchnorrAccount at 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 14:22:54 [14:22:54.470] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f24f99405aebd5368874d2da8bfc22e2c735a5abaa809a5c088ff8cbee8fbc1","blockNumber":1,"slot":2} 14:22:54 [14:22:54.508] VERBOSE: pxe:block_stream Starting sync from block number 0 14:22:54 [14:22:54.514] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:54 [14:22:54.536] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 14:22:54 [14:22:54.667] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:22:55 [14:22:55.415] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 14:22:55 [14:22:55.555] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 14:22:55 [14:22:55.627] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:55 [14:22:55.696] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f24f99405aebd5368874d2da8bfc22e2c735a5abaa809a5c088ff8cbee8fbc1","blockNumber":1,"slot":2} 14:22:55 [14:22:55.815] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:22:55 [14:22:55.847] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:55 [14:22:55.856] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:55 [14:22:55.857] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:22:55 [14:22:55.932] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:22:55 [14:22:55.941] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:56 [14:22:56.059] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:56 [14:22:56.152] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:22:56 [14:22:56.200] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:56 [14:22:56.201] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:22:56 [14:22:56.261] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f24f99405aebd5368874d2da8bfc22e2c735a5abaa809a5c088ff8cbee8fbc1","blockNumber":1,"slot":2} 14:22:56 [14:22:56.267] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:56 [14:22:56.277] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:22:56 [14:22:56.281] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:56 [14:22:56.300] VERBOSE: simulator:client_execution_context:debug_log Setting 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a as fee payer 14:22:56 [14:22:56.507] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:56 [14:22:56.785] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:56 [14:22:56.910] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f24f99405aebd5368874d2da8bfc22e2c735a5abaa809a5c088ff8cbee8fbc1","blockNumber":1,"slot":2} 14:22:57 [14:22:57.025] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:57 [14:22:57.435] INFO: pxe:service Proving completed in 2928.926399ms {"timings":{"total":2928.926399,"sync":2.9949260000012146,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":206.03082299999733,"oracles":{"callPrivateFunction":{"times":[1035.2999959999997,431.69597200000135,259.203465999999]}}},{"functionName":"private_kernel_init","time":124.37752100000034},{"functionName":"ContractClassRegisterer:register","time":998.6189800000011,"oracles":{"loadCapsule":{"times":[36.5528630000008]},"notifyCreatedNullifier":{"times":[0.883972999999969]},"debugLog":{"times":[1.0316660000007687]},"notifyCreatedContractClassLog":{"times":[11.512580999999045]}}},{"functionName":"private_kernel_inner","time":145.0082820000007},{"functionName":"SchnorrAccount:constructor","time":394.2189159999998,"oracles":{"getContractInstance":{"times":[4.379170000000158]},"debugLog":{"times":[0.5633239999988291,1.46412699999928]},"fetchTaggedLogs":{"times":[79.83268599999974]},"loadCapsule":{"times":[0.6259359999985463,1.730254000000059,0.6508869999997842]},"notifyCreatedNullifier":{"times":[0.41170100000090315,0.3303780000005645]},"notifyCreatedNote":{"times":[0.8463110000011511]},"getRandomField":{"times":[0.5505139999986568,0.27205700000013167,0.10422300000027462,0.07185199999912584,0.06501199999911478,0.06959199999982957,0.05845200000112527,0.051441999999951804,0.07686199999989185,0.10094199999912234,0.06685199999992619]},"getIndexedTaggingSecretAsSender":{"times":[45.643081999998685]},"incrementAppTaggingSecretIndexAsSender":{"times":[27.449993000000177]}}},{"functionName":"private_kernel_inner","time":107.6542389999995},{"functionName":"SchnorrAccount:entrypoint","time":212.79171300000053,"oracles":{"debugLog":{"times":[0.7647089999991294,0.597074999999677,0.7939109999988432]},"fetchTaggedLogs":{"times":[78.76522900000055]},"loadCapsule":{"times":[0.3096879999993689,0.24933599999894795,0.3056670000005397]},"getNotes":{"times":[2.155343999998877]},"getAuthWitness":{"times":[0.4229200000008859]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0838679999997112]}}},{"functionName":"private_kernel_inner","time":112.2242839999999},{"functionName":"private_kernel_reset","time":151.72428200000104},{"functionName":"private_kernel_tail","time":67.11999500000093}],"unaccounted":406.16243799999756}} 14:22:57 [14:22:57.455] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:57 [14:22:57.536] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x2f24f99405aebd5368874d2da8bfc22e2c735a5abaa809a5c088ff8cbee8fbc1","blockNumber":1,"slot":2} 14:22:57 [14:22:57.623] VERBOSE: p2p:tx_pool Adding tx 0x2036a32c5fc18f7cec91e26530f7502ce2eb835c957b3310f0e554c697eca060 to pool {"eventName":"tx-added-to-pool","txHash":"0x2036a32c5fc18f7cec91e26530f7502ce2eb835c957b3310f0e554c697eca060","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 14:22:57 [14:22:57.648] INFO: node Received tx 0x2036a32c5fc18f7cec91e26530f7502ce2eb835c957b3310f0e554c697eca060 {"txHash":"0x2036a32c5fc18f7cec91e26530f7502ce2eb835c957b3310f0e554c697eca060"} 14:22:57 [14:22:57.648] INFO: pxe:service Sent transaction 0x2036a32c5fc18f7cec91e26530f7502ce2eb835c957b3310f0e554c697eca060 14:22:57 [14:22:57.661] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:57 [14:22:57.864] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:58 [14:22:58.055] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 14:22:58 [14:22:58.067] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:58 [14:22:58.070] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T14:27:16.000Z","now":"2025-06-18T14:26:57.032Z"} 14:22:58 [14:22:58.306] VERBOSE: simulator:public-processor Processed tx 0x2036a32c5fc18f7cec91e26530f7502ce2eb835c957b3310f0e554c697eca060 with no public calls in 156.68727699999909ms {"txHash":"0x2036a32c5fc18f7cec91e26530f7502ce2eb835c957b3310f0e554c697eca060","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":156.68727699999909} 14:22:58 [14:22:58.310] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:58 [14:22:58.312] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2403474900000001s {"duration":0.2403474900000001,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 14:22:58 [14:22:58.439] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2fc21200a43d36feba08c01e0e8b381b56ab64a928e62c8a3badf8f52773893b","globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":1,"slotNumber":2,"timestamp":1750256836,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2036a32c5fc18f7cec91e26530f7502ce2eb835c957b3310f0e554c697eca060"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":383.4033220000001,"publicProcessDuration":241.24335200000132,"rollupCircuitsDuration":371.28685700000096,"txCount":1,"blockNumber":1,"blockTimestamp":1750256836,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:22:58 [14:22:58.442] VERBOSE: sequencer Attesting committee is empty 14:22:58 [14:22:58.522] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:58 [14:22:58.766] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:58 [14:22:58.771] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xa32bfec576885a4864845e0d01db914d1463bdec5d7ad92515d0af96f86deb23 14:22:58 [14:22:58.772] VERBOSE: sequencer-client Sent L1 transaction 0xa32bfec576885a4864845e0d01db914d1463bdec5d7ad92515d0af96f86deb23 {"gasLimit":514585,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 14:22:58 [14:22:58.782] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:22:58 [14:22:58.783] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xa32bfec576885a4864845e0d01db914d1463bdec5d7ad92515d0af96f86deb23","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1750256836,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:22:58 [14:22:58.786] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:22:58 [14:22:58.802] INFO: blob-sink:server Received blob sidecar for block 0xe000498c0128581bdad304905d29540b256670bfc2df9e2bf822cbce059ba696 14:22:58 [14:22:58.809] INFO: blob-sink:server Blob sidecar stored successfully for block 0xe000498c0128581bdad304905d29540b256670bfc2df9e2bf822cbce059ba696 14:22:58 [14:22:58.969] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:58 [14:22:58.978] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 14:22:58 [14:22:58.981] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 14:22:58 [14:22:58.983] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 14:22:58 [14:22:58.988] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256872] on http://127.0.0.1:8545 14:22:58 [14:22:58.989] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:22:58 [14:22:58.991] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256872 14:22:58 [14:22:58.991] WARN: foundation:test-date-provider Time set to 2025-06-18T14:27:52.000Z {"offset":293009,"timeMs":1750256872000} 14:22:58 [14:22:58.991] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 14:22:59 [14:22:59.178] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:59 [14:22:59.194] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 14:22:59 [14:22:59.202] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2fc21200a43d36feba08c01e0e8b381b56ab64a928e62c8a3badf8f52773893b","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":1,"slotNumber":2,"timestamp":1750256836,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1ca7bd2d5e93163e50ceb2b5c3e7dd44681776eaefea6aeb5908e0c6beca32f6","archiveNextLeafIndex":2} 14:22:59 [14:22:59.210] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 14:22:59 [14:22:59.357] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":8.549316000000545,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750256836,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:22:59 [14:22:59.362] INFO: pxe:service Registered account 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd 14:22:59 [14:22:59.365] VERBOSE: p2p Synched to latest block 1 14:22:59 [14:22:59.471] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:59 [14:22:59.478] INFO: pxe:service Added contract SchnorrAccount at 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 14:22:59 [14:22:59.501] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x1ca7bd2d5e93163e50ceb2b5c3e7dd44681776eaefea6aeb5908e0c6beca32f6","header":{"contentCommitment":{"blobsHash":"0x008f44f0fc54e62cdaedc31d617ee57d9c3089f4db17b76461cda82a94b452a4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750256836,"version":3599149864},"lastArchive":"0x2f24f99405aebd5368874d2da8bfc22e2c735a5abaa809a5c088ff8cbee8fbc1","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0fa1ea303aaabe5364c730ecb7dd2c69d177df4026364e90e8b584038434a1ac","nullifierTree":"0x2ebc28ffc1dda012b0d76452a6a0c50617969006f12e90e25e0c0a2e711ceaef","publicDataTree":"0x1b788f96e843f2884afb80e02200c2330f49dfc283c1e29aebdbd37b11da9bfa"},"totalFees":6794052480,"totalManaUsed":20448}} 14:22:59 [14:22:59.515] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 14:22:59 [14:22:59.607] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:22:59 [14:22:59.647] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:59 [14:22:59.648] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:22:59 [14:22:59.677] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:59 [14:22:59.706] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:22:59 [14:22:59.711] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:22:59 [14:22:59.880] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:22:59 [14:22:59.906] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1ca7bd2d5e93163e50ceb2b5c3e7dd44681776eaefea6aeb5908e0c6beca32f6","blockNumber":2,"slot":3} 14:22:59 [14:22:59.941] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:22:59 [14:22:59.974] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:22:59 [14:22:59.975] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:00 [14:23:00.053] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:00 [14:23:00.057] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:00 [14:23:00.069] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd as fee payer 14:23:00 [14:23:00.193] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:00 [14:23:00.414] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:00 [14:23:00.871] INFO: pxe:service Proving completed in 1376.7971909999997ms {"timings":{"total":1376.7971909999997,"sync":8.727999999999156,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":97.42550199999823,"oracles":{"callPrivateFunction":{"times":[297.22191700000076,249.01007899999968]}}},{"functionName":"private_kernel_init","time":63.21322599999985},{"functionName":"SchnorrAccount:constructor","time":271.57763800000066,"oracles":{"getContractInstance":{"times":[2.513872999999876]},"debugLog":{"times":[0.48651299999983166,0.38385999999991327]},"fetchTaggedLogs":{"times":[61.99584500000128]},"loadCapsule":{"times":[0.31953799999973853,0.3044980000013311,0.2430660000009084]},"notifyCreatedNullifier":{"times":[0.2205050000011397,0.21522600000025705]},"notifyCreatedNote":{"times":[0.12331300000005285]},"getRandomField":{"times":[0.11398299999927985,0.20914599999923666,0.11584299999958603,0.09395199999926263,0.09077199999956065,0.06260199999996985,0.0680419999989681,0.06774199999927077,0.07177199999932782,0.04446099999950093,0.053651000000172644]},"getIndexedTaggingSecretAsSender":{"times":[56.96349800000098]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.68307900000036]}}},{"functionName":"private_kernel_inner","time":131.3082059999997},{"functionName":"SchnorrAccount:entrypoint","time":207.89841100000194,"oracles":{"debugLog":{"times":[0.7875899999999092,0.3888599999991129,0.492551999999705]},"fetchTaggedLogs":{"times":[81.74592499999926]},"loadCapsule":{"times":[0.2226250000003347,0.16229399999974703,0.1929550000004383]},"getNotes":{"times":[1.0665470000003552]},"getAuthWitness":{"times":[0.174074999998993]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.46449199999915436]}}},{"functionName":"private_kernel_inner","time":120.90675399999964},{"functionName":"private_kernel_reset","time":164.3848020000005},{"functionName":"private_kernel_tail","time":77.73003299999982}],"unaccounted":233.62461900000017}} 14:23:00 [14:23:00.891] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:00 [14:23:00.904] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1ca7bd2d5e93163e50ceb2b5c3e7dd44681776eaefea6aeb5908e0c6beca32f6","blockNumber":2,"slot":3} 14:23:00 [14:23:00.928] VERBOSE: p2p:tx_pool Adding tx 0x11913cbae57d71206b4c30e1d3d1cdd813f3cd3d5e1fa7256862348d3cd8da0d to pool {"eventName":"tx-added-to-pool","txHash":"0x11913cbae57d71206b4c30e1d3d1cdd813f3cd3d5e1fa7256862348d3cd8da0d","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 14:23:00 [14:23:00.934] INFO: node Received tx 0x11913cbae57d71206b4c30e1d3d1cdd813f3cd3d5e1fa7256862348d3cd8da0d {"txHash":"0x11913cbae57d71206b4c30e1d3d1cdd813f3cd3d5e1fa7256862348d3cd8da0d"} 14:23:00 [14:23:00.934] INFO: pxe:service Sent transaction 0x11913cbae57d71206b4c30e1d3d1cdd813f3cd3d5e1fa7256862348d3cd8da0d 14:23:01 [14:23:01.096] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:01 [14:23:01.300] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:01 [14:23:01.468] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 14:23:01 [14:23:01.483] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T14:27:52.000Z","now":"2025-06-18T14:27:54.492Z"} 14:23:01 [14:23:01.503] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:01 [14:23:01.512] VERBOSE: simulator:public-processor Processed tx 0x11913cbae57d71206b4c30e1d3d1cdd813f3cd3d5e1fa7256862348d3cd8da0d with no public calls in 16.98798899999929ms {"txHash":"0x11913cbae57d71206b4c30e1d3d1cdd813f3cd3d5e1fa7256862348d3cd8da0d","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":16.98798899999929} 14:23:01 [14:23:01.520] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.035786403999998585s {"duration":0.035786403999998585,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 14:23:01 [14:23:01.665] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1242d96d6ed901abdd45a329d7e30be790072d9d7896e809826844dec7c3ce7f","globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":2,"slotNumber":3,"timestamp":1750256872,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x11913cbae57d71206b4c30e1d3d1cdd813f3cd3d5e1fa7256862348d3cd8da0d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":197.6068499999983,"publicProcessDuration":36.37087799999972,"rollupCircuitsDuration":182.61458200000197,"txCount":1,"blockNumber":2,"blockTimestamp":1750256872,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:01 [14:23:01.668] VERBOSE: sequencer Attesting committee is empty 14:23:01 [14:23:01.746] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:01 [14:23:01.947] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xdb4d569437e1742d2d7edb5fa7058d9c82e71024c159fb9e151114fed70d5733 14:23:01 [14:23:01.947] VERBOSE: sequencer-client Sent L1 transaction 0xdb4d569437e1742d2d7edb5fa7058d9c82e71024c159fb9e151114fed70d5733 {"gasLimit":470283,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:23:01 [14:23:01.955] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:01 [14:23:01.966] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 14:23:01 [14:23:01.969] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:23:01 [14:23:01.970] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xdb4d569437e1742d2d7edb5fa7058d9c82e71024c159fb9e151114fed70d5733","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":2,"blockTimestamp":1750256872,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:01 [14:23:01.970] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:23:01 [14:23:01.973] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 14:23:01 [14:23:01.977] INFO: blob-sink:server Received blob sidecar for block 0x18718dcfca99c46adc03a335a4deb1568315aab9ad1ca4e56165b00c46edffc8 14:23:01 [14:23:01.980] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 14:23:01 [14:23:01.985] INFO: blob-sink:server Blob sidecar stored successfully for block 0x18718dcfca99c46adc03a335a4deb1568315aab9ad1ca4e56165b00c46edffc8 14:23:01 [14:23:01.995] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256908] on http://127.0.0.1:8545 14:23:01 [14:23:01.997] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:23:01 [14:23:01.999] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256908 14:23:01 [14:23:01.999] WARN: foundation:test-date-provider Time set to 2025-06-18T14:28:28.000Z {"offset":326001,"timeMs":1750256908000} 14:23:01 [14:23:01.999] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 14:23:02 [14:23:02.133] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x1242d96d6ed901abdd45a329d7e30be790072d9d7896e809826844dec7c3ce7f","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":2,"slotNumber":3,"timestamp":1750256872,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1c3d0814b516061ba0274490fcd8bb484daf040a50e2417a435216a5894a2f38","archiveNextLeafIndex":3} 14:23:02 [14:23:02.137] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 14:23:02 [14:23:02.162] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:02 [14:23:02.254] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":7.87514899999951,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750256872,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:02 [14:23:02.259] VERBOSE: p2p Synched to latest block 2 14:23:02 [14:23:02.375] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:02 [14:23:02.442] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x1c3d0814b516061ba0274490fcd8bb484daf040a50e2417a435216a5894a2f38","header":{"contentCommitment":{"blobsHash":"0x002129671fa1d6266732e1cab4879013f4b0622fc3fef594a87a656889303732","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750256872,"version":3599149864},"lastArchive":"0x1ca7bd2d5e93163e50ceb2b5c3e7dd44681776eaefea6aeb5908e0c6beca32f6","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x04abfbf3b2491ab60add94e528fca6a5c157ec7964ef7c17923b86cb643b51b6","nullifierTree":"0x07cd7cc865556bb54eb15654fcbfb6f78ed99e4f5e5b698e0ecfcac3a0cdc58c","publicDataTree":"0x2ea95898c580c506cbdc502167990a129bcce0eed992c6a821612c124b5f2b40"},"totalFees":5018455040,"totalManaUsed":15104}} 14:23:02 [14:23:02.531] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:02 [14:23:02.568] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:02 [14:23:02.568] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:02 [14:23:02.605] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:02 [14:23:02.616] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1c3d0814b516061ba0274490fcd8bb484daf040a50e2417a435216a5894a2f38","blockNumber":3,"slot":4} 14:23:02 [14:23:02.694] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:02 [14:23:02.702] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:02 [14:23:02.719] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:02 [14:23:02.720] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:02 [14:23:02.742] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:02 [14:23:02.743] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:02 [14:23:02.749] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:02 [14:23:02.752] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:02 [14:23:02.765] VERBOSE: simulator:client_execution_context:debug_log Setting 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a as fee payer 14:23:02 [14:23:02.796] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 14:23:02 [14:23:02.809] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:02 [14:23:02.844] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:23:02 [14:23:02.856] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a,0x0000000000000000000000000000000000000000000000000000000000000001,0x10c60155ea9bf6e8572f38ab0d1dd76ec85b530dd00a0a1f69c95b033199e96a,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x222e8ad2c8be5ea3a73999fa0367c14cb5aea7facb6f5b32aafa867e8cec11e9,0x07a68e8b0438ca465e98583320e7d8432ecdec607c5f3b594fa47e9ba31b5c07,0x1c576d8031b9f86ec45d6ec2e36c966c9091722ef37d2914c74cbfb49026d874,0x13f6734b78d4888c303d00f30896ec12d80e1583764d7dd2a2186c1521a938d7,0x21e4d53dc199f603ec0cbd8baabdcaa49a4e1950da4aefc49aba6a679412b2f3,0x00ae15acd10f2895c8c6e36e68688417725334386bd44dc2dc2eb4b1a8e6b074,0x1309d698347f0663ebaeb54307a156edfd7354e841749bdde3f3fe60225828f2,0x29901767d2870235c237008878ac9de878c070f77ae02a3796e29467e949489e,0x20cf45156aa755819b1c7ccb89f6ae61defa8de4b8f67e07be56659098a1d165,0x0000000000000000000000000000000000000000000000000000000000000000 14:23:02 [14:23:02.895] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 14:23:02 [14:23:02.927] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:23:02 [14:23:02.938] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd,0x0000000000000000000000000000000000000000000000000000000000000001,0x25ba0bf889c6d61a365c5667845baa410eb2ecd2263faff458d5949f0ac3c716,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x04ab15c8e38fb7a931de7b404e0a1e0ef7fd96f34e57eebcf863805a4206f841,0x0a1a6df4051ff707b39c6db3720063fbf57b57cf4a22f1c221d79e3d4db5af7a,0x154c826fa7a293c6b19fbfadf913229d117699129a7a4c086ec8f999924b0b06,0x1b7cb404d059f8b1771f3125d746c1218a3c70c650cc8d089b1d69007286e416,0x1263fa23430e15c24f6c370b3e459abe7bd7667a4694238bb3bc626ba8b0dd33,0x18a9711ae81e70d0c5fe83dd47c0b42cc19b8b2674a3845afa00a2e80b65aab6,0x0c690ee7629c357155e27142e1b6be0adc6b03b7f3ca628e70e23a1d6f9af367,0x24ec7c1c8716d92a70fae98e80a4fd9fb5aacb1a3b5e9b346e46f033383fc679,0x208fbf6fe5826788e8ff85eb2422e38353e14e0eeb7e5dbe6b4c4c2ac49c4419,0x0000000000000000000000000000000000000000000000000000000000000000 14:23:03 [14:23:03.052] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:03 [14:23:03.251] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1c3d0814b516061ba0274490fcd8bb484daf040a50e2417a435216a5894a2f38","blockNumber":3,"slot":4} 14:23:03 [14:23:03.417] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:03 [14:23:03.693] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:03 [14:23:03.945] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:04 [14:23:04.020] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1c3d0814b516061ba0274490fcd8bb484daf040a50e2417a435216a5894a2f38","blockNumber":3,"slot":4} 14:23:04 [14:23:04.189] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:04 [14:23:04.436] INFO: pxe:service Proving completed in 2004.1689899999983ms {"timings":{"total":2004.1689899999983,"sync":11.92370099999971,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":316.58205599999565,"oracles":{"debugLog":{"times":[0.6729569999988598,0.6627870000011171,0.6865370000014082,0.722037999999884,0.8334409999988566,0.6403169999975944,0.38095899999825633,0.608844999998837]},"fetchTaggedLogs":{"times":[130.761725999997]},"loadCapsule":{"times":[0.36847000000125263,0.30187800000203424,0.5796049999989918,0.2708669999992708,0.21860599999854458,0.43877100000099745]},"getSharedSecret":{"times":[6.028302999999141]},"aes128Decrypt":{"times":[1.5743409999995492,1.3858150000014575]},"getPublicKeysAndPartialAddress":{"times":[12.094817999997758]},"getKeyValidationRequest":{"times":[5.62404400000014]},"deliverNote":{"times":[5.898239999998623]},"deleteCapsule":{"times":[0.43890100000135135]},"storeCapsule":{"times":[0.37585000000035507]},"getNotes":{"times":[2.2144459999981336]},"getAuthWitness":{"times":[0.16839400000026217]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0656219999982568]},"callPrivateFunction":{"times":[94.34424000000217,81.35715999999957]}}},{"functionName":"private_kernel_init","time":63.98801699999967},{"functionName":"ContractInstanceDeployer:deploy","time":44.98727499999586,"oracles":{"storeInExecutionCache":{"times":[0.3771290000004228]},"callPrivateFunction":{"times":[49.15288099999816]},"notifyCreatedNullifier":{"times":[0.2869969999992463]},"debugLog":{"times":[0.5723649999999907]}}},{"functionName":"private_kernel_inner","time":161.10217799999737},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":36.45408600000519,"oracles":{}},{"functionName":"private_kernel_inner","time":175.26588899999842},{"functionName":"ContractInstanceDeployer:deploy","time":50.76151100000425,"oracles":{"storeInExecutionCache":{"times":[0.0609519999998156]},"callPrivateFunction":{"times":[35.068082000001596]},"notifyCreatedNullifier":{"times":[0.3967300000003888]},"debugLog":{"times":[0.6628969999983383]}}},{"functionName":"private_kernel_inner","time":145.7885189999979},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":21.151147999997193,"oracles":{}},{"functionName":"private_kernel_inner","time":148.40722499999902},{"functionName":"private_kernel_reset","time":183.66822299999694},{"functionName":"private_kernel_tail","time":65.85666600000332}],"unaccounted":578.2324960000078}} 14:23:04 [14:23:04.451] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:04 [14:23:04.477] VERBOSE: p2p:tx_pool Adding tx 0x123e566e92d5196bfb3d57a1ba5c5947a898f5047d00bccdda0d2deb42f4b983 to pool {"eventName":"tx-added-to-pool","txHash":"0x123e566e92d5196bfb3d57a1ba5c5947a898f5047d00bccdda0d2deb42f4b983","noteHashCount":0,"nullifierCount":3,"privateLogCount":2,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 14:23:04 [14:23:04.484] INFO: node Received tx 0x123e566e92d5196bfb3d57a1ba5c5947a898f5047d00bccdda0d2deb42f4b983 {"txHash":"0x123e566e92d5196bfb3d57a1ba5c5947a898f5047d00bccdda0d2deb42f4b983"} 14:23:04 [14:23:04.484] INFO: pxe:service Sent transaction 0x123e566e92d5196bfb3d57a1ba5c5947a898f5047d00bccdda0d2deb42f4b983 14:23:04 [14:23:04.540] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 14:23:04 [14:23:04.554] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T14:28:28.000Z","now":"2025-06-18T14:28:30.555Z"} 14:23:04 [14:23:04.580] VERBOSE: simulator:public-processor Processed tx 0x123e566e92d5196bfb3d57a1ba5c5947a898f5047d00bccdda0d2deb42f4b983 with no public calls in 15.022221999999601ms {"txHash":"0x123e566e92d5196bfb3d57a1ba5c5947a898f5047d00bccdda0d2deb42f4b983","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":15.022221999999601} 14:23:04 [14:23:04.581] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02667219800000021s {"duration":0.02667219800000021,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":18432,"l2Gas":16544},"totalSizeInBytes":1376} 14:23:04 [14:23:04.708] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:04 [14:23:04.735] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x12675f8c8a24177f3c8fe368fd0579643e74da73e26ef71f0aad55082092bc17","globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":3,"slotNumber":4,"timestamp":1750256908,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x123e566e92d5196bfb3d57a1ba5c5947a898f5047d00bccdda0d2deb42f4b983"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":194.39373500000147,"publicProcessDuration":27.073059000002104,"rollupCircuitsDuration":181.17304800000056,"txCount":1,"blockNumber":3,"blockTimestamp":1750256908,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:04 [14:23:04.738] VERBOSE: sequencer Attesting committee is empty 14:23:04 [14:23:04.914] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:05 [14:23:05.019] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x44f6c2b9550e6963634262581cd1de043319f9c1ffe94377849a4f38900f4ecb 14:23:05 [14:23:05.019] VERBOSE: sequencer-client Sent L1 transaction 0x44f6c2b9550e6963634262581cd1de043319f9c1ffe94377849a4f38900f4ecb {"gasLimit":470283,"maxFeePerGas":"1.279583409","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:23:05 [14:23:05.031] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256944] on http://127.0.0.1:8545 14:23:05 [14:23:05.034] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:23:05 [14:23:05.037] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256944 14:23:05 [14:23:05.037] WARN: foundation:test-date-provider Time set to 2025-06-18T14:29:04.000Z {"offset":358963,"timeMs":1750256944000} 14:23:05 [14:23:05.038] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 14:23:05 [14:23:05.041] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:23:05 [14:23:05.041] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x44f6c2b9550e6963634262581cd1de043319f9c1ffe94377849a4f38900f4ecb","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":3,"blockTimestamp":1750256908,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:05 [14:23:05.041] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:23:05 [14:23:05.045] INFO: blob-sink:server Received blob sidecar for block 0x07ba2c5d80a517f4aa5215f57cea337aba3cacc281fbf2c17f06f9cb6eae8512 14:23:05 [14:23:05.050] INFO: blob-sink:server Blob sidecar stored successfully for block 0x07ba2c5d80a517f4aa5215f57cea337aba3cacc281fbf2c17f06f9cb6eae8512 14:23:05 [14:23:05.120] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:05 [14:23:05.126] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 14:23:05 [14:23:05.129] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 14:23:05 [14:23:05.132] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 14:23:05 [14:23:05.327] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:05 [14:23:05.538] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:05 [14:23:05.751] VERBOSE: archiver:block-helper Store contract instance at 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a 14:23:05 [14:23:05.751] VERBOSE: archiver:block-helper Store contract instance at 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd 14:23:05 [14:23:05.753] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:05 [14:23:05.758] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x12675f8c8a24177f3c8fe368fd0579643e74da73e26ef71f0aad55082092bc17","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":3,"slotNumber":4,"timestamp":1750256908,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0cf0694a906582fbfadf948f772d4e12995c87a47a8249f1c5b1143a9358740a","archiveNextLeafIndex":4} 14:23:05 [14:23:05.763] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 14:23:05 [14:23:05.859] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":8.532327000000805,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750256908,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:05 [14:23:05.873] VERBOSE: p2p Synched to latest block 3 14:23:05 [14:23:05.960] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:06 [14:23:06.102] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0cf0694a906582fbfadf948f772d4e12995c87a47a8249f1c5b1143a9358740a","blockNumber":4,"slot":5} 14:23:06 [14:23:06.165] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:06 [14:23:06.368] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:06 [14:23:06.503] WARN: pxe:service No artifact found for contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c when looking for its metadata 14:23:06 [14:23:06.504] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c as part of deployment for 0x274b704344ad8974cdfa8a09b0b1b1b160667606b9783de3a156d5bf679a995b 14:23:06 [14:23:06.585] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:06 [14:23:06.605] INFO: pxe:service Added contract AuthWitTest at 0x274b704344ad8974cdfa8a09b0b1b1b160667606b9783de3a156d5bf679a995b with class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c 14:23:06 [14:23:06.635] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0cf0694a906582fbfadf948f772d4e12995c87a47a8249f1c5b1143a9358740a","blockNumber":4,"slot":5} 14:23:06 [14:23:06.639] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x0cf0694a906582fbfadf948f772d4e12995c87a47a8249f1c5b1143a9358740a","header":{"contentCommitment":{"blobsHash":"0x00665234b6d830000de9afda52202f2f19764aa837c7479fb28a9618c515cec0","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750256908,"version":3599149864},"lastArchive":"0x1c3d0814b516061ba0274490fcd8bb484daf040a50e2417a435216a5894a2f38","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x04abfbf3b2491ab60add94e528fca6a5c157ec7964ef7c17923b86cb643b51b6","nullifierTree":"0x03f06495bc8af4be4e8fb06914c4e8ca375d47f2f6c7f86bd523e67d1483603c","publicDataTree":"0x282452f626e053e0063e5ae5cd8f4c3cbb8a62a51a3907b16ee40f7d610b988f"},"totalFees":5496909440,"totalManaUsed":16544}} 14:23:06 [14:23:06.716] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:06 [14:23:06.751] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:06 [14:23:06.752] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:06 [14:23:06.800] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:06 [14:23:06.826] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:06 [14:23:06.840] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:06 [14:23:06.850] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:06 [14:23:06.851] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:06 [14:23:06.872] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:06 [14:23:06.873] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:06 [14:23:06.876] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:06 [14:23:06.878] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:06 [14:23:06.891] VERBOSE: simulator:client_execution_context:debug_log Setting 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a as fee payer 14:23:06 [14:23:06.934] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:23:07 [14:23:07.432] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0b531072c192262f69310be602c8bfeb8f4e36acff72ed861afd4f76ee50de56,0x2054c0397fca7702b6f9252401dd1f653f4e20cff98e2eb5395de9bbdc250278,0x2b6ecadb0b2de2c700fc27a25c15b4c8eb590b62f353cdd047a57ce195071418 14:23:07 [14:23:07.543] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 14:23:07 [14:23:07.592] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:07 [14:23:07.650] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 14:23:07 [14:23:07.658] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0cf0694a906582fbfadf948f772d4e12995c87a47a8249f1c5b1143a9358740a","blockNumber":4,"slot":5} 14:23:07 [14:23:07.681] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:23:07 [14:23:07.691] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x274b704344ad8974cdfa8a09b0b1b1b160667606b9783de3a156d5bf679a995b,0x0000000000000000000000000000000000000000000000000000000000000001,0x1bb7537cb0312f2ef413ca0cbafac4bdd1a8b4c8d3f114ec321aad69c0016825,0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a 14:23:07 [14:23:07.845] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:08 [14:23:08.066] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:08 [14:23:08.330] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:08 [14:23:08.518] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0cf0694a906582fbfadf948f772d4e12995c87a47a8249f1c5b1143a9358740a","blockNumber":4,"slot":5} 14:23:08 [14:23:08.760] INFO: pxe:service Proving completed in 2129.4886970000007ms {"timings":{"total":2129.4886970000007,"sync":10.06606599999941,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":276.2708070000044,"oracles":{"debugLog":{"times":[0.6144550000026356,0.43564100000003236,0.5851650000004156,0.6726269999999204,0.6835169999976642,0.49110300000029383,0.31587800000124844,0.45867100000032224]},"fetchTaggedLogs":{"times":[86.01934799999799]},"loadCapsule":{"times":[0.3212280000007013,0.2154549999977462,0.511993000000075,0.18685399999958463,0.21816599999874597,1.7871159999995143]},"getSharedSecret":{"times":[2.6659880000006524]},"aes128Decrypt":{"times":[0.1978449999987788,1.0585170000013022]},"getPublicKeysAndPartialAddress":{"times":[2.0239720000026864]},"getKeyValidationRequest":{"times":[15.29758899999797]},"deliverNote":{"times":[3.569980000000214]},"deleteCapsule":{"times":[0.36963900000046124]},"storeCapsule":{"times":[0.2474160000019765]},"getNotes":{"times":[1.4566780000022845]},"getAuthWitness":{"times":[0.15553500000169151]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.052580999999918276]},"callPrivateFunction":{"times":[694.3404819999996,109.12153600000238]}}},{"functionName":"private_kernel_init","time":68.27821699999913},{"functionName":"ContractClassRegisterer:register","time":675.9094439999972,"oracles":{"loadCapsule":{"times":[6.5956179999993765]},"notifyCreatedNullifier":{"times":[0.48782200000277953]},"debugLog":{"times":[1.0341870000011113]},"notifyCreatedContractClassLog":{"times":[5.160091999998258]}}},{"functionName":"private_kernel_inner","time":121.30760600000212},{"functionName":"ContractInstanceDeployer:deploy","time":63.33881200000178,"oracles":{"storeInExecutionCache":{"times":[0.053842000001168344]},"callPrivateFunction":{"times":[33.474771000001056]},"notifyCreatedNullifier":{"times":[0.3484790000002249]},"debugLog":{"times":[0.4919819999995525]}}},{"functionName":"private_kernel_inner","time":119.78244700000141},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":25.355634999999893,"oracles":{}},{"functionName":"private_kernel_inner","time":139.42738699999973},{"functionName":"private_kernel_reset","time":171.98426400000244},{"functionName":"private_kernel_tail","time":69.15755900000295}],"unaccounted":388.61045299999023}} 14:23:08 [14:23:08.772] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:08 [14:23:08.907] VERBOSE: p2p:tx_pool Adding tx 0x16c4078e52d1c92795439502718b661c572a779e781a8ca218fec652ce53f470 to pool {"eventName":"tx-added-to-pool","txHash":"0x16c4078e52d1c92795439502718b661c572a779e781a8ca218fec652ce53f470","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":55,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 14:23:08 [14:23:08.928] INFO: node Received tx 0x16c4078e52d1c92795439502718b661c572a779e781a8ca218fec652ce53f470 {"txHash":"0x16c4078e52d1c92795439502718b661c572a779e781a8ca218fec652ce53f470"} 14:23:08 [14:23:08.929] INFO: pxe:service Sent transaction 0x16c4078e52d1c92795439502718b661c572a779e781a8ca218fec652ce53f470 14:23:08 [14:23:08.978] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:09 [14:23:09.049] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 14:23:09 [14:23:09.061] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-18T14:29:04.000Z","now":"2025-06-18T14:29:08.024Z"} 14:23:09 [14:23:09.260] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:09 [14:23:09.339] VERBOSE: simulator:public-processor Processed tx 0x16c4078e52d1c92795439502718b661c572a779e781a8ca218fec652ce53f470 with no public calls in 186.98101700000188ms {"txHash":"0x16c4078e52d1c92795439502718b661c572a779e781a8ca218fec652ce53f470","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":186.98101700000188} 14:23:09 [14:23:09.350] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2874208509999989s {"duration":0.2874208509999989,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":39424,"l2Gas":16544},"totalSizeInBytes":2720} 14:23:09 [14:23:09.484] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:09 [14:23:09.495] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x301a8fcadc48add9243969101e6c6e834d18cf2125b77c1009fb99db15d67b35","globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":4,"slotNumber":5,"timestamp":1750256944,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x16c4078e52d1c92795439502718b661c572a779e781a8ca218fec652ce53f470"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":446.2879319999993,"publicProcessDuration":287.97574499999973,"rollupCircuitsDuration":434.37374900000214,"txCount":1,"blockNumber":4,"blockTimestamp":1750256944,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 14:23:09 [14:23:09.497] VERBOSE: sequencer Attesting committee is empty 14:23:09 [14:23:09.788] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:09 [14:23:09.797] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x6e38f45f4a6d156bc3ec8ff87d8ba4b8123a940d97ce5c92462d7ad5721cb3c3 14:23:09 [14:23:09.798] VERBOSE: sequencer-client Sent L1 transaction 0x6e38f45f4a6d156bc3ec8ff87d8ba4b8123a940d97ce5c92462d7ad5721cb3c3 {"gasLimit":470295,"maxFeePerGas":"1.26112774","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:23:09 [14:23:09.816] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:23:09 [14:23:09.817] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x6e38f45f4a6d156bc3ec8ff87d8ba4b8123a940d97ce5c92462d7ad5721cb3c3","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":4,"blockTimestamp":1750256944,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 14:23:09 [14:23:09.817] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:23:09 [14:23:09.822] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750256980] on http://127.0.0.1:8545 14:23:09 [14:23:09.825] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:23:09 [14:23:09.830] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750256980 14:23:09 [14:23:09.830] WARN: foundation:test-date-provider Time set to 2025-06-18T14:29:40.000Z {"offset":390170,"timeMs":1750256980000} 14:23:09 [14:23:09.830] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 14:23:09 [14:23:09.833] INFO: blob-sink:server Received blob sidecar for block 0x60ef5e8fda143e5f304d7583eb33d731ed9b45b5957878cd6cd3d27540e64e9e 14:23:09 [14:23:09.840] INFO: blob-sink:server Blob sidecar stored successfully for block 0x60ef5e8fda143e5f304d7583eb33d731ed9b45b5957878cd6cd3d27540e64e9e 14:23:10 [14:23:10.038] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:10 [14:23:10.061] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 14:23:10 [14:23:10.070] VERBOSE: archiver:block-helper Store contract instance at 0x274b704344ad8974cdfa8a09b0b1b1b160667606b9783de3a156d5bf679a995b 14:23:10 [14:23:10.074] VERBOSE: archiver:block-helper Store contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c 14:23:10 [14:23:10.077] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 14:23:10 [14:23:10.085] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 14:23:10 [14:23:10.088] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x301a8fcadc48add9243969101e6c6e834d18cf2125b77c1009fb99db15d67b35","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":4,"slotNumber":5,"timestamp":1750256944,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x2ce157df6d76acd77474d4333cfe3fd57911f6fa27a3016c00055eed22b4d6dc","archiveNextLeafIndex":5} 14:23:10 [14:23:10.174] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":7.203503000000637,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750256944,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 14:23:10 [14:23:10.211] VERBOSE: p2p Synched to latest block 4 14:23:10 [14:23:10.252] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:10 [14:23:10.344] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2ce157df6d76acd77474d4333cfe3fd57911f6fa27a3016c00055eed22b4d6dc","blockNumber":5,"slot":6} 14:23:10 [14:23:10.454] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:10 [14:23:10.607] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 14:23:10 [14:23:10.657] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:10 [14:23:10.861] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:10 [14:23:10.864] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2ce157df6d76acd77474d4333cfe3fd57911f6fa27a3016c00055eed22b4d6dc","blockNumber":5,"slot":6} 14:23:11 [14:23:11.064] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:11 [14:23:11.074] INFO: aztecjs:deploy_sent_tx Contract 0x274b704344ad8974cdfa8a09b0b1b1b160667606b9783de3a156d5bf679a995b successfully deployed. 14:23:11 [14:23:11.078] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data happy path 14:23:11 [14:23:11.095] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x2ce157df6d76acd77474d4333cfe3fd57911f6fa27a3016c00055eed22b4d6dc","header":{"contentCommitment":{"blobsHash":"0x00d6a3230ebf9096d4af0b08ba602be0834b821f8a58cbfb1afbea209747571f","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750256944,"version":3599149864},"lastArchive":"0x0cf0694a906582fbfadf948f772d4e12995c87a47a8249f1c5b1143a9358740a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x04abfbf3b2491ab60add94e528fca6a5c157ec7964ef7c17923b86cb643b51b6","nullifierTree":"0x0326b96df87e9c5d174d9946e88547abc20b06da0aaea0c2d684a0a3ed2e763a","publicDataTree":"0x09f458e68e35182c0af45b5d9c56d6420d431915af2780dbfd52ba1ce6792ce5"},"totalFees":838780800,"totalManaUsed":16544}} 14:23:11 [14:23:11.228] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:11 [14:23:11.248] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:11 [14:23:11.249] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:11 [14:23:11.267] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:11 [14:23:11.423] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2ce157df6d76acd77474d4333cfe3fd57911f6fa27a3016c00055eed22b4d6dc","blockNumber":5,"slot":6} 14:23:11 [14:23:11.435] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:11 [14:23:11.456] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:11 [14:23:11.471] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:11 [14:23:11.473] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:11 [14:23:11.475] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:11 [14:23:11.485] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:11 [14:23:11.487] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:11 [14:23:11.495] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:11 [14:23:11.503] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:11 [14:23:11.523] VERBOSE: simulator Utility simulation for 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a.0xd191fb1a completed 14:23:11 [14:23:11.597] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:11 [14:23:11.611] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:11 [14:23:11.680] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:11 [14:23:11.765] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","selector":"0xd191fb1a"} 14:23:11 [14:23:11.778] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:11 [14:23:11.779] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:11 [14:23:11.892] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:11 [14:23:11.914] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:11 [14:23:11.970] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x24802acc1b722b27809d2e0dce07db29dd6cf1324d0a86c015b31845e0a5c1a5 14:23:11 [14:23:11.989] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:11 [14:23:11.990] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:12 [14:23:12.010] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2ce157df6d76acd77474d4333cfe3fd57911f6fa27a3016c00055eed22b4d6dc","blockNumber":5,"slot":6} 14:23:12 [14:23:12.013] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:12 [14:23:12.014] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:12 [14:23:12.020] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x10781af8ffd3b369c53c1ccaed43f80496977af54acb0ad900c9eb544d40bd7b","nullifier":"0x1893f00bb8f7877c7562bd9acc3f75fc88d774823f35e99c367356c1a2e82cc1"} 14:23:12 [14:23:12.023] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:12 [14:23:12.033] VERBOSE: simulator Utility simulation for 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd.0xd191fb1a completed 14:23:12 [14:23:12.089] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:12 [14:23:12.094] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:12 [14:23:12.095] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:12 [14:23:12.215] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:12 [14:23:12.267] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:12 [14:23:12.268] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:12 [14:23:12.304] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:12 [14:23:12.441] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:12 [14:23:12.451] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x24802acc1b722b27809d2e0dce07db29dd6cf1324d0a86c015b31845e0a5c1a5 14:23:12 [14:23:12.464] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:12 [14:23:12.465] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:12 [14:23:12.503] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:12 [14:23:12.505] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:12 [14:23:12.520] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:12 [14:23:12.560] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x10781af8ffd3b369c53c1ccaed43f80496977af54acb0ad900c9eb544d40bd7b","nullifier":"0x1893f00bb8f7877c7562bd9acc3f75fc88d774823f35e99c367356c1a2e82cc1"} 14:23:12 [14:23:12.568] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:12 [14:23:12.574] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2ce157df6d76acd77474d4333cfe3fd57911f6fa27a3016c00055eed22b4d6dc","blockNumber":5,"slot":6} 14:23:12 [14:23:12.593] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd as fee payer 14:23:12 [14:23:12.621] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x274b704344ad8974cdfa8a09b0b1b1b160667606b9783de3a156d5bf679a995b"} 14:23:12 [14:23:12.745] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:12 [14:23:12.782] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:12 [14:23:12.813] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:12 [14:23:12.814] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:12 [14:23:12.950] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:12 [14:23:12.992] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:13 [14:23:13.043] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:13 [14:23:13.046] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:13 [14:23:13.048] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:13 [14:23:13.117] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:13 [14:23:13.119] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:13 [14:23:13.148] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:13 [14:23:13.149] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2ce157df6d76acd77474d4333cfe3fd57911f6fa27a3016c00055eed22b4d6dc","blockNumber":5,"slot":6} 14:23:13 [14:23:13.162] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:13 [14:23:13.312] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:13 [14:23:13.526] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:13 [14:23:13.745] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:13 [14:23:13.920] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x2ce157df6d76acd77474d4333cfe3fd57911f6fa27a3016c00055eed22b4d6dc","blockNumber":5,"slot":6} 14:23:14 [14:23:14.071] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:14 [14:23:14.365] INFO: pxe:service Proving completed in 2248.3645319999996ms {"timings":{"total":2248.3645319999996,"sync":10.159949000000779,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":470.12194899999304,"oracles":{"debugLog":{"times":[0.9697149999992689,0.5582539999995788,0.5406629999997676,0.586963999998261,1.1891499999983353,0.42095100000005914,0.4426110000022163,0.8859620000002906]},"fetchTaggedLogs":{"times":[180.9345919999978]},"loadCapsule":{"times":[0.19306499999947846,0.2108459999981278,0.494472999998834,0.4316709999984596,0.2779069999996864,0.9721050000007381]},"getSharedSecret":{"times":[4.441563000000315]},"aes128Decrypt":{"times":[0.44727100000091013,1.262032000002364]},"getPublicKeysAndPartialAddress":{"times":[6.548245999998471]},"getKeyValidationRequest":{"times":[23.00989599999957]},"deliverNote":{"times":[55.61712400000033]},"deleteCapsule":{"times":[5.657444000000396]},"storeCapsule":{"times":[0.5436140000019805]},"getNotes":{"times":[6.577848000000813]},"getAuthWitness":{"times":[0.29716800000096555]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08637199999793665]},"callPrivateFunction":{"times":[616.2041939999981]}}},{"functionName":"private_kernel_init","time":91.22822100000121},{"functionName":"AuthWitTest:consume","time":81.80108100000507,"oracles":{"storeInExecutionCache":{"times":[0.09159300000101211]},"callPrivateFunction":{"times":[574.596166000003]},"loadFromExecutionCache":{"times":[0.2359759999999369]},"notifyCreatedNullifier":{"times":[0.3041379999995115]}}},{"functionName":"private_kernel_inner","time":161.73179399999935},{"functionName":"SchnorrAccount:verify_private_authwit","time":524.5308519999999,"oracles":{"debugLog":{"times":[0.8389119999992545,0.5022019999996701,1.6155309999994643,1.031366999999591,1.6050109999996494,0.6251959999972314,0.7505590000000666]},"fetchTaggedLogs":{"times":[175.06783299999734]},"loadCapsule":{"times":[0.3552090000011958,0.26247700000021723,0.48638299999947776,5.840339000002132,5.020027999999002,3.7107640000031097]},"getSharedSecret":{"times":[28.141246000002866]},"aes128Decrypt":{"times":[4.759100999999646,4.388392000000749]},"getPublicKeysAndPartialAddress":{"times":[36.64079199999833]},"getKeyValidationRequest":{"times":[28.7388409999985]},"deliverNote":{"times":[29.84070900000006]},"deleteCapsule":{"times":[0.8721319999967818]},"storeCapsule":{"times":[0.5358129999985977]},"getNotes":{"times":[10.435735999999451]},"getAuthWitness":{"times":[0.21752500000002328]},"storeInExecutionCache":{"times":[0.2682169999970938]}}},{"functionName":"private_kernel_inner","time":139.2142219999987},{"functionName":"private_kernel_reset","time":193.64907599999788},{"functionName":"private_kernel_tail","time":103.91924399999698}],"unaccounted":472.0081440000067}} 14:23:14 [14:23:14.384] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:14 [14:23:14.415] VERBOSE: p2p:tx_pool Adding tx 0x0eb60b4bea40c38338f0cc63eb50cb630f1ddad57df7598559d815693da2b85b to pool {"eventName":"tx-added-to-pool","txHash":"0x0eb60b4bea40c38338f0cc63eb50cb630f1ddad57df7598559d815693da2b85b","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 14:23:14 [14:23:14.425] INFO: node Received tx 0x0eb60b4bea40c38338f0cc63eb50cb630f1ddad57df7598559d815693da2b85b {"txHash":"0x0eb60b4bea40c38338f0cc63eb50cb630f1ddad57df7598559d815693da2b85b"} 14:23:14 [14:23:14.425] INFO: pxe:service Sent transaction 0x0eb60b4bea40c38338f0cc63eb50cb630f1ddad57df7598559d815693da2b85b 14:23:14 [14:23:14.470] VERBOSE: sequencer Building block 5 for slot 6 {"slot":6,"blockNumber":5,"msgCount":0} 14:23:14 [14:23:14.498] VERBOSE: sequencer Processing pending txs {"slot":6,"slotStart":"2025-06-18T14:29:40.000Z","now":"2025-06-18T14:29:44.668Z"} 14:23:14 [14:23:14.535] VERBOSE: simulator:public-processor Processed tx 0x0eb60b4bea40c38338f0cc63eb50cb630f1ddad57df7598559d815693da2b85b with no public calls in 18.603643000002194ms {"txHash":"0x0eb60b4bea40c38338f0cc63eb50cb630f1ddad57df7598559d815693da2b85b","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":18.603643000002194} 14:23:14 [14:23:14.538] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03765607699999964s {"duration":0.03765607699999964,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":11200},"totalSizeInBytes":288} 14:23:14 [14:23:14.698] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:14 [14:23:14.726] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2ddfe188f5d5e3cfdf5384d24d22de1fae76e2aea476bd18a7e1afd0b9cbd2c2","globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":5,"slotNumber":6,"timestamp":1750256980,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x0eb60b4bea40c38338f0cc63eb50cb630f1ddad57df7598559d815693da2b85b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":255.7923359999986,"publicProcessDuration":38.48545899999954,"rollupCircuitsDuration":235.1229209999983,"txCount":1,"blockNumber":5,"blockTimestamp":1750256980,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:14 [14:23:14.732] VERBOSE: sequencer Attesting committee is empty 14:23:14 [14:23:14.908] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:15 [14:23:15.059] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x87e1c415f218b4be30d5ae7e7e32de8b2735dc9d0b6c3c2e327a19f44a73eac2 14:23:15 [14:23:15.059] VERBOSE: sequencer-client Sent L1 transaction 0x87e1c415f218b4be30d5ae7e7e32de8b2735dc9d0b6c3c2e327a19f44a73eac2 {"gasLimit":470310,"maxFeePerGas":"1.246952011","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:23:15 [14:23:15.078] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:23:15 [14:23:15.079] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x87e1c415f218b4be30d5ae7e7e32de8b2735dc9d0b6c3c2e327a19f44a73eac2","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":5,"blockTimestamp":1750256980,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:15 [14:23:15.079] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:23:15 [14:23:15.090] INFO: blob-sink:server Received blob sidecar for block 0xb356b32d04b75c16cb93d20a4331d96202c5bf2d017c629895de11b68cbb9366 14:23:15 [14:23:15.103] INFO: blob-sink:server Blob sidecar stored successfully for block 0xb356b32d04b75c16cb93d20a4331d96202c5bf2d017c629895de11b68cbb9366 14:23:15 [14:23:15.112] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:15 [14:23:15.139] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 14:23:15 [14:23:15.142] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 14:23:15 [14:23:15.153] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 14:23:15 [14:23:15.174] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750257016] on http://127.0.0.1:8545 14:23:15 [14:23:15.176] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:23:15 [14:23:15.180] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750257016 14:23:15 [14:23:15.180] WARN: foundation:test-date-provider Time set to 2025-06-18T14:30:16.000Z {"offset":420820,"timeMs":1750257016000} 14:23:15 [14:23:15.180] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 14:23:15 [14:23:15.326] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:15 [14:23:15.534] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:15 [14:23:15.757] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:15 [14:23:15.775] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x2ddfe188f5d5e3cfdf5384d24d22de1fae76e2aea476bd18a7e1afd0b9cbd2c2","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":5,"slotNumber":6,"timestamp":1750256980,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","archiveNextLeafIndex":6} 14:23:15 [14:23:15.777] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 14:23:15 [14:23:15.878] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":7.167192000000796,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750256980,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:15 [14:23:15.895] VERBOSE: p2p Synched to latest block 5 14:23:15 [14:23:15.968] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:16 [14:23:16.151] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:16 [14:23:16.170] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:16 [14:23:16.373] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:16 [14:23:16.502] VERBOSE: pxe:service Updated pxe last block to 5 {"blockHash":{},"archive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","header":{"contentCommitment":{"blobsHash":"0x0036dbfde7a9ee1d54796f3761577896bae28fab739adf7cd08636e28c6e962a","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750256980,"version":3599149864},"lastArchive":"0x2ce157df6d76acd77474d4333cfe3fd57911f6fa27a3016c00055eed22b4d6dc","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x04abfbf3b2491ab60add94e528fca6a5c157ec7964ef7c17923b86cb643b51b6","nullifierTree":"0x227bf5a7760b090b513b21dcf0eaa1794a14ec4539da395e7f9c6dc29629fcd5","publicDataTree":"0x1156aa53d756efb3a9bf29778045a88d945b3a1d52da0ed35a874fe2aa51af41"},"totalFees":567840000,"totalManaUsed":11200}} 14:23:16 [14:23:16.625] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:16 [14:23:16.696] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:16 [14:23:16.718] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:16 [14:23:16.719] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:16 [14:23:16.942] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:16 [14:23:16.955] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:17 [14:23:17.119] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:17 [14:23:17.140] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:17 [14:23:17.157] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:17 [14:23:17.159] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:17 [14:23:17.161] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:17 [14:23:17.172] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:17 [14:23:17.172] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:17 [14:23:17.177] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:17 [14:23:17.184] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:17 [14:23:17.193] WARN: node Nullifier 17896477122649688611104700173768619591184066583317830930364164211211715971963 already exists in the tree 14:23:17 [14:23:17.196] VERBOSE: simulator Utility simulation for 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a.0xd191fb1a completed 14:23:17 [14:23:17.246] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:17 [14:23:17.275] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:17 [14:23:17.399] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:17 [14:23:17.430] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:17 [14:23:17.477] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:17 [14:23:17.477] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:17 [14:23:17.552] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:17 [14:23:17.631] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:17 [14:23:17.657] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x24802acc1b722b27809d2e0dce07db29dd6cf1324d0a86c015b31845e0a5c1a5 14:23:17 [14:23:17.685] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:17 [14:23:17.688] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:17 [14:23:17.690] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:17 [14:23:17.718] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:17 [14:23:17.719] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:17 [14:23:17.728] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x10781af8ffd3b369c53c1ccaed43f80496977af54acb0ad900c9eb544d40bd7b","nullifier":"0x1893f00bb8f7877c7562bd9acc3f75fc88d774823f35e99c367356c1a2e82cc1"} 14:23:17 [14:23:17.735] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:17 [14:23:17.784] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd as fee payer 14:23:17 [14:23:17.831] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x274b704344ad8974cdfa8a09b0b1b1b160667606b9783de3a156d5bf679a995b"} 14:23:17 [14:23:17.899] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:17 [14:23:17.942] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:17 [14:23:17.971] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:17 [14:23:17.972] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:18 [14:23:18.104] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:18 [14:23:18.126] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:18 [14:23:18.169] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:18 [14:23:18.185] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:18 [14:23:18.203] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:18 [14:23:18.204] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:18 [14:23:18.212] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:18 [14:23:18.212] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:18 [14:23:18.217] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:18 [14:23:18.220] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:18 [14:23:18.318] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:18 [14:23:18.526] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:18 [14:23:18.730] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:18 [14:23:18.797] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:19 [14:23:19.233] INFO: pxe:service Proving completed in 1928.0372829999978ms {"timings":{"total":1928.0372829999978,"sync":3.8960489999990386,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":472.7051539999957,"oracles":{"debugLog":{"times":[0.6823069999991276,1.4135959999985062,0.959194999999454,1.959298999998282,0.6788280000000668,0.5162029999992228,0.6681269999971846,2.2287859999996726]},"fetchTaggedLogs":{"times":[175.05170299999736]},"loadCapsule":{"times":[2.2270360000002256,0.19941499999913503,0.5032629999986966,0.2570059999998193,0.5398240000031365,0.2764470000001893]},"getSharedSecret":{"times":[14.512839000002714]},"aes128Decrypt":{"times":[2.812391999999818,3.258363000000827]},"getPublicKeysAndPartialAddress":{"times":[7.9272019999989425]},"getKeyValidationRequest":{"times":[17.813332999998238]},"deliverNote":{"times":[8.896425999999337]},"deleteCapsule":{"times":[3.7585760000001756]},"storeCapsule":{"times":[1.1740800000006857]},"getNotes":{"times":[14.81004600000233]},"getAuthWitness":{"times":[6.7408319999995]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1220130000001518]},"callPrivateFunction":{"times":[466.01982500000304]}}},{"functionName":"private_kernel_init","time":81.23227600000246},{"functionName":"AuthWitTest:consume","time":97.66921400000138,"oracles":{"storeInExecutionCache":{"times":[0.13137300000016694]},"callPrivateFunction":{"times":[406.25652400000035]},"loadFromExecutionCache":{"times":[0.07426200000190875]},"notifyCreatedNullifier":{"times":[0.9054329999999027]}}},{"functionName":"private_kernel_inner","time":150.88584299999638},{"functionName":"SchnorrAccount:verify_private_authwit","time":357.67363800000385,"oracles":{"debugLog":{"times":[1.4235259999986738,0.636475999999675,0.5681149999945774,0.6365359999981592,0.40997000000061234,0.3726890000034473,0.3480779999954393]},"fetchTaggedLogs":{"times":[210.91431400000147]},"loadCapsule":{"times":[0.23529499999858672,0.2024950000050012,0.4652720000012778,0.21229599999787752,0.22065599999768892,0.22052599999733502]},"getSharedSecret":{"times":[5.333554999997432]},"aes128Decrypt":{"times":[0.29284699999698205,1.3957050000026356]},"getPublicKeysAndPartialAddress":{"times":[2.4115810000002966]},"getKeyValidationRequest":{"times":[2.8081919999967795]},"deliverNote":{"times":[4.471132999999099]},"deleteCapsule":{"times":[0.9396639999977197]},"storeCapsule":{"times":[0.5248540000029607]},"getNotes":{"times":[2.6362970000045607]},"getAuthWitness":{"times":[0.12214300000050571]},"storeInExecutionCache":{"times":[0.23919599999499042]}}},{"functionName":"private_kernel_inner","time":137.3836350000056},{"functionName":"private_kernel_reset","time":219.5155919999961},{"functionName":"private_kernel_tail","time":74.47746600000391}],"unaccounted":332.59841599999345}} 14:23:19 [14:23:19.251] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:19 [14:23:19.267] VERBOSE: p2p:tx_validator:tx_double_spend Rejecting tx 0x0dc100b25f5f241e49c1929c49a4e9661185c154c96c4c53c563af19e87665e0 for repeating a nullifier 14:23:19 [14:23:19.270] WARN: node Received invalid tx 0x0dc100b25f5f241e49c1929c49a4e9661185c154c96c4c53c563af19e87665e0: Existing nullifier {"txHash":"0x0dc100b25f5f241e49c1929c49a4e9661185c154c96c4c53c563af19e87665e0"} 14:23:19 [14:23:19.277] ERROR: pxe:service Error: Error: Invalid tx: Existing nullifier 14:23:19 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19) 14:23:19 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 14:23:19 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 14:23:19 [14:23:19.281] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid chain id 14:23:19 [14:23:19.348] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:19 [14:23:19.380] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:19 [14:23:19.391] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:19 [14:23:19.392] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:19 [14:23:19.456] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:19 [14:23:19.481] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:19 [14:23:19.494] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:19 [14:23:19.510] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:19 [14:23:19.512] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:19 [14:23:19.524] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:19 [14:23:19.525] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:19 [14:23:19.537] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:19 [14:23:19.540] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:19 [14:23:19.684] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:19 [14:23:19.692] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:19 [14:23:19.719] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:19 [14:23:19.772] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd {"origin":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000d686ab28","authWitnesses":["0x1a96c97ebb708070ea8baeac77ba9e45b2cf9d91c09c26cbf26cc8b41b226a4d"]} 14:23:19 [14:23:19.920] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:19 [14:23:19.975] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:19 [14:23:19.975] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:19 [14:23:19.977] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:20 [14:23:20.053] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:20 [14:23:20.086] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:20 [14:23:20.095] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x24802acc1b722b27809d2e0dce07db29dd6cf1324d0a86c015b31845e0a5c1a5 14:23:20 [14:23:20.111] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:20 [14:23:20.112] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:20 [14:23:20.120] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:20 [14:23:20.121] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:20 [14:23:20.125] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x10781af8ffd3b369c53c1ccaed43f80496977af54acb0ad900c9eb544d40bd7b","nullifier":"0x1893f00bb8f7877c7562bd9acc3f75fc88d774823f35e99c367356c1a2e82cc1"} 14:23:20 [14:23:20.128] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:20 [14:23:20.146] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd as fee payer 14:23:20 [14:23:20.163] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x274b704344ad8974cdfa8a09b0b1b1b160667606b9783de3a156d5bf679a995b"} 14:23:20 [14:23:20.191] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:20 [14:23:20.254] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:20 [14:23:20.278] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:20 [14:23:20.279] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:20 [14:23:20.352] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:20 [14:23:20.360] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:20 [14:23:20.372] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:20 [14:23:20.373] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:20 [14:23:20.380] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:20 [14:23:20.381] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:20 [14:23:20.384] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:20 [14:23:20.386] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:20 [14:23:20.546] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid version 14:23:20 [14:23:20.579] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:20 [14:23:20.784] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:20 [14:23:20.823] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:20 [14:23:20.863] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:20 [14:23:20.874] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:20 [14:23:20.874] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:21 [14:23:21.076] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:21 [14:23:21.133] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:21 [14:23:21.145] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:21 [14:23:21.158] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:21 [14:23:21.159] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:21 [14:23:21.167] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:21 [14:23:21.168] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:21 [14:23:21.173] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:21 [14:23:21.177] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:21 [14:23:21.252] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:21 [14:23:21.258] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:21 [14:23:21.273] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd {"origin":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000d686ab28","authWitnesses":["0x2715738af5ab62a4859e3a0a7e9eb88216a86ff3158f0847848a6cec2d10fc1b"]} 14:23:21 [14:23:21.310] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:21 [14:23:21.369] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:21 [14:23:21.415] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:21 [14:23:21.416] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:21 [14:23:21.460] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:21 [14:23:21.498] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:21 [14:23:21.512] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x24802acc1b722b27809d2e0dce07db29dd6cf1324d0a86c015b31845e0a5c1a5 14:23:21 [14:23:21.524] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:21 [14:23:21.525] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:21 [14:23:21.536] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:21 [14:23:21.537] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:21 [14:23:21.542] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x10781af8ffd3b369c53c1ccaed43f80496977af54acb0ad900c9eb544d40bd7b","nullifier":"0x1893f00bb8f7877c7562bd9acc3f75fc88d774823f35e99c367356c1a2e82cc1"} 14:23:21 [14:23:21.545] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:21 [14:23:21.548] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:21 [14:23:21.560] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd as fee payer 14:23:21 [14:23:21.574] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x274b704344ad8974cdfa8a09b0b1b1b160667606b9783de3a156d5bf679a995b"} 14:23:21 [14:23:21.674] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:21 [14:23:21.695] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:21 [14:23:21.695] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:21 [14:23:21.750] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:21 [14:23:21.781] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:21 [14:23:21.789] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:21 [14:23:21.801] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:21 [14:23:21.802] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:21 [14:23:21.817] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:21 [14:23:21.818] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:21 [14:23:21.822] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:21 [14:23:21.824] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:21 [14:23:21.965] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:22 [14:23:22.160] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:22 [14:23:22.175] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:22 [14:23:22.179] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:22 [14:23:22.180] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:22 [14:23:22.193] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:22 [14:23:22.281] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:22 [14:23:22.293] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:22 [14:23:22.308] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:22 [14:23:22.309] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:22 [14:23:22.331] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:22 [14:23:22.332] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:22 [14:23:22.342] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:22 [14:23:22.346] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:22 [14:23:22.393] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:22 [14:23:22.396] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:22 [14:23:22.401] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:22 [14:23:22.403] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data happy path 14:23:22 [14:23:22.513] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:22 [14:23:22.529] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:22 [14:23:22.530] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:22 [14:23:22.600] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:22 [14:23:22.611] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:22 [14:23:22.618] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:22 [14:23:22.630] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:22 [14:23:22.631] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:22 [14:23:22.638] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:22 [14:23:22.639] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:22 [14:23:22.642] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:22 [14:23:22.644] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:22 [14:23:22.654] VERBOSE: simulator Utility simulation for 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a.0xd191fb1a completed 14:23:22 [14:23:22.707] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:22 [14:23:22.714] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:22 [14:23:22.732] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:22 [14:23:22.828] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:22 [14:23:22.874] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:22 [14:23:22.875] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:22 [14:23:22.877] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:22 [14:23:22.967] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:22 [14:23:22.973] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:22 [14:23:22.982] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:22 [14:23:22.983] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:22 [14:23:22.992] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:22 [14:23:22.993] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:22 [14:23:22.996] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:22 [14:23:22.998] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:23 [14:23:23.011] VERBOSE: simulator:client_execution_context:debug_log Setting 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a as fee payer 14:23:23 [14:23:23.162] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:23 [14:23:23.590] INFO: pxe:service Proving completed in 859.4725500000059ms {"timings":{"total":859.4725500000059,"sync":4.289139000000432,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":254.31114199999865,"oracles":{"debugLog":{"times":[0.5942240000003949,0.4222869999939576,0.729049000001396,0.6837070000037784,0.5881539999973029,0.322003000001132,0.309291999998095,0.6783070000019507]},"fetchTaggedLogs":{"times":[96.65624899999966]},"loadCapsule":{"times":[0.13746499999979278,0.16989699999976438,0.29953199999727076,0.2214190000013332,0.18582799999421695,0.15760600000066916]},"getSharedSecret":{"times":[3.0983029999988503]},"aes128Decrypt":{"times":[0.20093800000176998,0.6575860000011744]},"getPublicKeysAndPartialAddress":{"times":[3.5326290000011795]},"getKeyValidationRequest":{"times":[2.1691849999988335]},"deliverNote":{"times":[3.6557640000028186]},"deleteCapsule":{"times":[0.4249469999995199]},"storeCapsule":{"times":[0.3135019999972428]},"getNotes":{"times":[1.949996999996074]},"getAuthWitness":{"times":[0.2005379999973229]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.23094900000432972]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3317430000024615]}}},{"functionName":"private_kernel_init","time":84.80643199999759},{"functionName":"private_kernel_reset","time":221.7648709999994},{"functionName":"private_kernel_tail","time":102.16340900000068}],"unaccounted":192.1375570000091}} 14:23:23 [14:23:23.629] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:23 [14:23:23.673] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","blockNumber":6,"slot":7} 14:23:23 [14:23:23.688] VERBOSE: p2p:tx_pool Adding tx 0x26e78ab887c4c3e8effab51b3a4cf5a9369e5e40a3e1b69fd15b47f50342f041 to pool {"eventName":"tx-added-to-pool","txHash":"0x26e78ab887c4c3e8effab51b3a4cf5a9369e5e40a3e1b69fd15b47f50342f041","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 14:23:23 [14:23:23.700] INFO: node Received tx 0x26e78ab887c4c3e8effab51b3a4cf5a9369e5e40a3e1b69fd15b47f50342f041 {"txHash":"0x26e78ab887c4c3e8effab51b3a4cf5a9369e5e40a3e1b69fd15b47f50342f041"} 14:23:23 [14:23:23.700] INFO: pxe:service Sent transaction 0x26e78ab887c4c3e8effab51b3a4cf5a9369e5e40a3e1b69fd15b47f50342f041 14:23:23 [14:23:23.846] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:24 [14:23:24.049] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:24 [14:23:24.229] VERBOSE: sequencer Building block 6 for slot 7 {"slot":7,"blockNumber":6,"msgCount":0} 14:23:24 [14:23:24.248] VERBOSE: sequencer Processing pending txs {"slot":7,"slotStart":"2025-06-18T14:30:16.000Z","now":"2025-06-18T14:30:25.068Z"} 14:23:24 [14:23:24.255] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:24 [14:23:24.323] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":43.85313700000552} 14:23:24 [14:23:24.382] VERBOSE: simulator:public-processor Processed tx 0x26e78ab887c4c3e8effab51b3a4cf5a9369e5e40a3e1b69fd15b47f50342f041 with 1 public calls in 120.0150119999962ms {"txHash":"0x26e78ab887c4c3e8effab51b3a4cf5a9369e5e40a3e1b69fd15b47f50342f041","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":120.0150119999962} 14:23:24 [14:23:24.385] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.13583127700000477s {"duration":0.13583127700000477,"rate":147565.42412539708,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 14:23:24 [14:23:24.508] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:24 [14:23:24.522] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 67137.96576298046 mana/s {"blockHash":"0x16373c6933fb074bc2a8769bbfe971ff14bb4a775efbaffd4550f1ad1e6d0690","globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":6,"slotNumber":7,"timestamp":1750257016,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x26e78ab887c4c3e8effab51b3a4cf5a9369e5e40a3e1b69fd15b47f50342f041"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":297.7637190000023,"publicProcessDuration":136.37999200000195,"rollupCircuitsDuration":274.68286099999386,"txCount":1,"blockNumber":6,"blockTimestamp":1750257016,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:24 [14:23:24.524] VERBOSE: sequencer Attesting committee is empty 14:23:24 [14:23:24.713] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:24 [14:23:24.857] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x036d2467234aaf03bcc2cac2bff2e19592e5a6b943a04f2592deab852ca9d21a 14:23:24 [14:23:24.857] VERBOSE: sequencer-client Sent L1 transaction 0x036d2467234aaf03bcc2cac2bff2e19592e5a6b943a04f2592deab852ca9d21a {"gasLimit":470310,"maxFeePerGas":"1.236063686","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:23:24 [14:23:24.873] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:23:24 [14:23:24.873] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x036d2467234aaf03bcc2cac2bff2e19592e5a6b943a04f2592deab852ca9d21a","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":6,"blockTimestamp":1750257016,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:24 [14:23:24.874] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:23:24 [14:23:24.878] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750257052] on http://127.0.0.1:8545 14:23:24 [14:23:24.882] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:23:24 [14:23:24.886] INFO: blob-sink:server Received blob sidecar for block 0x15507eea1ff1beab72e6cdf04a4b61c5b3ee12af775c52e927cf39d9f97d0fef 14:23:24 [14:23:24.891] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750257052 14:23:24 [14:23:24.891] WARN: foundation:test-date-provider Time set to 2025-06-18T14:30:52.000Z {"offset":447109,"timeMs":1750257052000} 14:23:24 [14:23:24.891] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 14:23:24 [14:23:24.895] INFO: blob-sink:server Blob sidecar stored successfully for block 0x15507eea1ff1beab72e6cdf04a4b61c5b3ee12af775c52e927cf39d9f97d0fef 14:23:24 [14:23:24.916] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:24 [14:23:24.925] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000006"] on http://127.0.0.1:8545 14:23:24 [14:23:24.927] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 14:23:24 [14:23:24.930] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 14:23:25 [14:23:25.120] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:25 [14:23:25.324] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:25 [14:23:25.551] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:25 [14:23:25.569] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x16373c6933fb074bc2a8769bbfe971ff14bb4a775efbaffd4550f1ad1e6d0690","blockNumber":6,"txCount":1,"globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":6,"slotNumber":7,"timestamp":1750257016,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x2d1a238a4f608f6a34e5131295f28be89bd9b9d364a96d1e04219fee7fffb844","archiveNextLeafIndex":7} 14:23:25 [14:23:25.574] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 14:23:25 [14:23:25.673] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":8.60887499999808,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750257016,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:25 [14:23:25.690] VERBOSE: p2p Synched to latest block 6 14:23:25 [14:23:25.722] VERBOSE: pxe:service Updated pxe last block to 6 {"blockHash":{},"archive":"0x2d1a238a4f608f6a34e5131295f28be89bd9b9d364a96d1e04219fee7fffb844","header":{"contentCommitment":{"blobsHash":"0x009584792fe7c53aca3e01409149550d93195bf78e26b1bf8c3109ec560c8708","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750257016,"version":3599149864},"lastArchive":"0x1ea2248e4047e6bbe448d026084eac6433a251ccb99f32ebe0a8cabcd2c22f2b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x04abfbf3b2491ab60add94e528fca6a5c157ec7964ef7c17923b86cb643b51b6","nullifierTree":"0x0dfb85cb95bebff32c4e5b2081a647f6195fd872091328ab6a05fa0c58bdc89c","publicDataTree":"0x133c913d2b2962824a0b9d05437e081f56df7fb5111a96d132db3533b478ea50"},"totalFees":2327130000,"totalManaUsed":45900}} 14:23:25 [14:23:25.768] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:25 [14:23:25.860] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:25 [14:23:25.875] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:25 [14:23:25.876] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:25 [14:23:25.931] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x2d1a238a4f608f6a34e5131295f28be89bd9b9d364a96d1e04219fee7fffb844","blockNumber":7,"slot":8} 14:23:25 [14:23:25.973] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:26 [14:23:26.015] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:26 [14:23:26.025] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:26 [14:23:26.043] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:26 [14:23:26.044] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:26 [14:23:26.052] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:26 [14:23:26.052] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:26 [14:23:26.056] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:26 [14:23:26.060] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:26 [14:23:26.069] VERBOSE: simulator Utility simulation for 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a.0xd191fb1a completed 14:23:26 [14:23:26.146] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:26 [14:23:26.152] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:26 [14:23:26.197] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:26 [14:23:26.319] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:26 [14:23:26.367] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:26 [14:23:26.368] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:26 [14:23:26.423] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:26 [14:23:26.461] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x2d1a238a4f608f6a34e5131295f28be89bd9b9d364a96d1e04219fee7fffb844","blockNumber":7,"slot":8} 14:23:26 [14:23:26.490] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:26 [14:23:26.512] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x24802acc1b722b27809d2e0dce07db29dd6cf1324d0a86c015b31845e0a5c1a5 14:23:26 [14:23:26.530] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:26 [14:23:26.531] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:26 [14:23:26.539] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:26 [14:23:26.539] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:26 [14:23:26.543] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x10781af8ffd3b369c53c1ccaed43f80496977af54acb0ad900c9eb544d40bd7b","nullifier":"0x1893f00bb8f7877c7562bd9acc3f75fc88d774823f35e99c367356c1a2e82cc1"} 14:23:26 [14:23:26.545] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:26 [14:23:26.559] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd as fee payer 14:23:26 [14:23:26.694] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:27 [14:23:27.115] INFO: pxe:service Proving completed in 896.2669619999942ms {"timings":{"total":896.2669619999942,"sync":3.190619000000879,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":313.3291779999927,"oracles":{"debugLog":{"times":[0.8385909999997239,0.8751419999971404,0.6662769999966258,0.7294889999975567,0.41150099999504164,0.4431410000033793,0.35625900000013644,0.47348199999396456]},"fetchTaggedLogs":{"times":[137.45683899999858]},"loadCapsule":{"times":[2.0017599999991944,0.2939669999977923,2.859231999995245,0.20229500000277767,0.21879599999374477,0.8100899999990361]},"getSharedSecret":{"times":[8.350328000000445]},"aes128Decrypt":{"times":[0.38915000000270084,1.089538000000175]},"getPublicKeysAndPartialAddress":{"times":[2.4807119999968563]},"getKeyValidationRequest":{"times":[1.6973930000021937]},"deliverNote":{"times":[4.03560099999595]},"deleteCapsule":{"times":[0.2620870000027935]},"storeCapsule":{"times":[0.3705400000035297]},"getNotes":{"times":[1.7095719999997527]},"getAuthWitness":{"times":[0.25424699999712175]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.11761300000216579]},"notifyEnqueuedPublicFunctionCall":{"times":[0.07529200000135461]}}},{"functionName":"private_kernel_init","time":82.73099999999977},{"functionName":"private_kernel_reset","time":203.7898290000012},{"functionName":"private_kernel_tail","time":108.03474299999652}],"unaccounted":185.1915930000032}} 14:23:27 [14:23:27.149] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:27 [14:23:27.184] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x2d1a238a4f608f6a34e5131295f28be89bd9b9d364a96d1e04219fee7fffb844","blockNumber":7,"slot":8} 14:23:27 [14:23:27.189] VERBOSE: p2p:tx_pool Adding tx 0x1051a21ea9f378613e1d826a5d9907ff9e00c5d0778c993f5cf959bcb18df9a4 to pool {"eventName":"tx-added-to-pool","txHash":"0x1051a21ea9f378613e1d826a5d9907ff9e00c5d0778c993f5cf959bcb18df9a4","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 14:23:27 [14:23:27.196] INFO: node Received tx 0x1051a21ea9f378613e1d826a5d9907ff9e00c5d0778c993f5cf959bcb18df9a4 {"txHash":"0x1051a21ea9f378613e1d826a5d9907ff9e00c5d0778c993f5cf959bcb18df9a4"} 14:23:27 [14:23:27.197] INFO: pxe:service Sent transaction 0x1051a21ea9f378613e1d826a5d9907ff9e00c5d0778c993f5cf959bcb18df9a4 14:23:27 [14:23:27.357] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:27 [14:23:27.560] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:27 [14:23:27.712] VERBOSE: sequencer Building block 7 for slot 8 {"slot":8,"blockNumber":7,"msgCount":0} 14:23:27 [14:23:27.725] VERBOSE: sequencer Processing pending txs {"slot":8,"slotStart":"2025-06-18T14:30:52.000Z","now":"2025-06-18T14:30:54.834Z"} 14:23:27 [14:23:27.777] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:27 [14:23:27.807] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":60.173075000006065} 14:23:27 [14:23:27.838] VERBOSE: simulator:public-processor Processed tx 0x1051a21ea9f378613e1d826a5d9907ff9e00c5d0778c993f5cf959bcb18df9a4 with 1 public calls in 98.17970699999569ms {"txHash":"0x1051a21ea9f378613e1d826a5d9907ff9e00c5d0778c993f5cf959bcb18df9a4","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":98.17970699999569} 14:23:27 [14:23:27.840] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1140593630000003s {"duration":0.1140593630000003,"rate":464030.2962239046,"totalPublicGas":{"daGas":512,"l2Gas":52927},"totalBlockGas":{"daGas":1536,"l2Gas":78783},"totalSizeInBytes":320} 14:23:27 [14:23:27.948] INFO: sequencer Built block 7 for slot 8 with 1 txs and 0 messages. 224543.65448826234 mana/s {"blockHash":"0x11ac5f35c42d62b9617879f01f3725ca78c4114e2b9c099111cf8144f3f204bf","globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":7,"slotNumber":8,"timestamp":1750257052,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x1051a21ea9f378613e1d826a5d9907ff9e00c5d0778c993f5cf959bcb18df9a4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":235.17051399999764,"publicProcessDuration":114.57211599999573,"rollupCircuitsDuration":222.84972500000003,"txCount":1,"blockNumber":7,"blockTimestamp":1750257052,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:27 [14:23:27.950] VERBOSE: sequencer Attesting committee is empty 14:23:28 [14:23:28.037] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:28 [14:23:28.213] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x31384ec7d3be538539fc7ff31863d3e49ca56bee3a878e0a13552d767983fc2f 14:23:28 [14:23:28.214] VERBOSE: sequencer-client Sent L1 transaction 0x31384ec7d3be538539fc7ff31863d3e49ca56bee3a878e0a13552d767983fc2f {"gasLimit":489742,"maxFeePerGas":"1.2277004","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:23:28 [14:23:28.226] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:23:28 [14:23:28.227] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x31384ec7d3be538539fc7ff31863d3e49ca56bee3a878e0a13552d767983fc2f","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":7,"blockTimestamp":1750257052,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:28 [14:23:28.227] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:23:28 [14:23:28.232] INFO: blob-sink:server Received blob sidecar for block 0xec59c403038ffd4572427758789116ebc2e868878a6756d2b0dd285aac5b7311 14:23:28 [14:23:28.239] INFO: blob-sink:server Blob sidecar stored successfully for block 0xec59c403038ffd4572427758789116ebc2e868878a6756d2b0dd285aac5b7311 14:23:28 [14:23:28.241] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:28 [14:23:28.249] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000007"] on http://127.0.0.1:8545 14:23:28 [14:23:28.252] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7 14:23:28 [14:23:28.256] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 14:23:28 [14:23:28.269] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750257088] on http://127.0.0.1:8545 14:23:28 [14:23:28.273] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:23:28 [14:23:28.376] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750257088 14:23:28 [14:23:28.377] WARN: foundation:test-date-provider Time set to 2025-06-18T14:31:28.000Z {"offset":479623,"timeMs":1750257088000} 14:23:28 [14:23:28.377] INFO: aztecjs:utils:watcher Slot 8 was filled, jumped to next slot 14:23:28 [14:23:28.383] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x11ac5f35c42d62b9617879f01f3725ca78c4114e2b9c099111cf8144f3f204bf","blockNumber":7,"txCount":1,"globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":7,"slotNumber":8,"timestamp":1750257052,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x09d44424afbf15e8543a290fa50fa51fe45cc5e01df12b4965b2a17cf3f876ee","archiveNextLeafIndex":8} 14:23:28 [14:23:28.446] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:28 [14:23:28.498] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":10.520112999998673,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1750257052,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:28 [14:23:28.503] VERBOSE: p2p Synched to latest block 7 14:23:28 [14:23:28.649] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:28 [14:23:28.746] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x09d44424afbf15e8543a290fa50fa51fe45cc5e01df12b4965b2a17cf3f876ee","blockNumber":8,"slot":9} 14:23:28 [14:23:28.854] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:28 [14:23:28.897] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 14:23:29 [14:23:29.057] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:29 [14:23:29.234] VERBOSE: pxe:service Updated pxe last block to 7 {"blockHash":{},"archive":"0x09d44424afbf15e8543a290fa50fa51fe45cc5e01df12b4965b2a17cf3f876ee","header":{"contentCommitment":{"blobsHash":"0x009b312fdbf816ad01be9171d9633abac072d6e523b7fca731b212aabdeadd72","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":8,"timestamp":1750257052,"version":3599149864},"lastArchive":"0x2d1a238a4f608f6a34e5131295f28be89bd9b9d364a96d1e04219fee7fffb844","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x04abfbf3b2491ab60add94e528fca6a5c157ec7964ef7c17923b86cb643b51b6","nullifierTree":"0x18ce69cef526913a0934fd0b1112c11e47aa78c5126ec58f1a4f14bf13e3e5cb","publicDataTree":"0x0b4523a2670f1aad4d79f54ca13d4d6fdbd5ce4fff3aeb851a42eb74daafadbb"},"totalFees":3994298100,"totalManaUsed":78783}} 14:23:29 [14:23:29.261] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:29 [14:23:29.320] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:29 [14:23:29.333] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:29 [14:23:29.334] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:29 [14:23:29.335] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x09d44424afbf15e8543a290fa50fa51fe45cc5e01df12b4965b2a17cf3f876ee","blockNumber":8,"slot":9} 14:23:29 [14:23:29.420] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:29 [14:23:29.437] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:29 [14:23:29.451] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:29 [14:23:29.452] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:29 [14:23:29.460] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:29 [14:23:29.460] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:29 [14:23:29.466] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:29 [14:23:29.470] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:29 [14:23:29.474] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:29 [14:23:29.482] VERBOSE: simulator Utility simulation for 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a.0xd191fb1a completed 14:23:29 [14:23:29.514] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:29 [14:23:29.522] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:29 [14:23:29.524] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data failure case cancel before usage 14:23:29 [14:23:29.617] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:29 [14:23:29.629] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:29 [14:23:29.629] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:29 [14:23:29.670] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:29 [14:23:29.705] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:29 [14:23:29.714] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:29 [14:23:29.726] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:29 [14:23:29.727] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:29 [14:23:29.734] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:29 [14:23:29.735] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:29 [14:23:29.738] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:29 [14:23:29.739] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:29 [14:23:29.750] VERBOSE: simulator Utility simulation for 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a.0xd191fb1a completed 14:23:29 [14:23:29.795] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:29 [14:23:29.808] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:29 [14:23:29.878] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:29 [14:23:29.901] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:29 [14:23:29.941] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:29 [14:23:29.942] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:29 [14:23:29.989] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x09d44424afbf15e8543a290fa50fa51fe45cc5e01df12b4965b2a17cf3f876ee","blockNumber":8,"slot":9} 14:23:30 [14:23:30.028] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:30 [14:23:30.035] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:30 [14:23:30.046] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:30 [14:23:30.047] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:30 [14:23:30.052] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:30 [14:23:30.052] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:30 [14:23:30.056] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:30 [14:23:30.058] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:30 [14:23:30.069] VERBOSE: simulator:client_execution_context:debug_log Setting 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a as fee payer 14:23:30 [14:23:30.170] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:30 [14:23:30.648] INFO: pxe:service Proving completed in 826.8542749999979ms {"timings":{"total":826.8542749999979,"sync":2.5398839999979828,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":229.6275039999964,"oracles":{"debugLog":{"times":[0.6109859999996843,0.5032429999992019,0.41803000000072643,0.4315009999991162,0.307807999997749,0.38769999999931315,0.32846799999970244,0.46771199999784585]},"fetchTaggedLogs":{"times":[91.55864100000326]},"loadCapsule":{"times":[0.18034400000033202,0.1861239999998361,0.5130730000018957,0.1783450000002631,0.18906499999866355,0.17840399999840884]},"getSharedSecret":{"times":[3.4150960000042687]},"aes128Decrypt":{"times":[0.2270760000028531,0.9288830000004964]},"getPublicKeysAndPartialAddress":{"times":[1.230211000001873]},"getKeyValidationRequest":{"times":[1.0680670000001555]},"deliverNote":{"times":[4.114173000001756]},"deleteCapsule":{"times":[0.24094599999807542]},"storeCapsule":{"times":[0.26024600000528153]},"getNotes":{"times":[1.3927050000056624]},"getAuthWitness":{"times":[0.27000699999916833]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04385099999490194]},"notifyEnqueuedPublicFunctionCall":{"times":[0.0589719999989029]}}},{"functionName":"private_kernel_init","time":94.30574999999953},{"functionName":"private_kernel_reset","time":240.9971779999978},{"functionName":"private_kernel_tail","time":127.05615800000669}],"unaccounted":132.32780099999945}} 14:23:30 [14:23:30.684] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:30 [14:23:30.751] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x09d44424afbf15e8543a290fa50fa51fe45cc5e01df12b4965b2a17cf3f876ee","blockNumber":8,"slot":9} 14:23:30 [14:23:30.752] VERBOSE: p2p:tx_pool Adding tx 0x28e34a2281cd9c24c3ae5ab9875e37da3dbcf3726d583e735209f7d3b728dc12 to pool {"eventName":"tx-added-to-pool","txHash":"0x28e34a2281cd9c24c3ae5ab9875e37da3dbcf3726d583e735209f7d3b728dc12","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 14:23:30 [14:23:30.762] INFO: node Received tx 0x28e34a2281cd9c24c3ae5ab9875e37da3dbcf3726d583e735209f7d3b728dc12 {"txHash":"0x28e34a2281cd9c24c3ae5ab9875e37da3dbcf3726d583e735209f7d3b728dc12"} 14:23:30 [14:23:30.763] INFO: pxe:service Sent transaction 0x28e34a2281cd9c24c3ae5ab9875e37da3dbcf3726d583e735209f7d3b728dc12 14:23:30 [14:23:30.892] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:31 [14:23:31.095] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:31 [14:23:31.272] VERBOSE: sequencer Building block 8 for slot 9 {"slot":9,"blockNumber":8,"msgCount":0} 14:23:31 [14:23:31.284] VERBOSE: sequencer Processing pending txs {"slot":9,"slotStart":"2025-06-18T14:31:28.000Z","now":"2025-06-18T14:31:30.907Z"} 14:23:31 [14:23:31.297] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:31 [14:23:31.344] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":33.42084600000089} 14:23:31 [14:23:31.371] VERBOSE: simulator:public-processor Processed tx 0x28e34a2281cd9c24c3ae5ab9875e37da3dbcf3726d583e735209f7d3b728dc12 with 1 public calls in 70.4191009999995ms {"txHash":"0x28e34a2281cd9c24c3ae5ab9875e37da3dbcf3726d583e735209f7d3b728dc12","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":70.4191009999995} 14:23:31 [14:23:31.372] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08742017599999963s {"duration":0.08742017599999963,"rate":229283.4551145274,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 14:23:31 [14:23:31.483] INFO: sequencer Built block 8 for slot 9 with 1 txs and 0 messages. 94557.96681463627 mana/s {"blockHash":"0x23fc6bfb40218696222bdd2e91b46ecd05e5ea082e79acca18da0bc820b7888a","globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":8,"slotNumber":9,"timestamp":1750257088,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x28e34a2281cd9c24c3ae5ab9875e37da3dbcf3726d583e735209f7d3b728dc12"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":211.2680560000008,"publicProcessDuration":87.71182399999816,"rollupCircuitsDuration":199.5842730000004,"txCount":1,"blockNumber":8,"blockTimestamp":1750257088,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:31 [14:23:31.485] VERBOSE: sequencer Attesting committee is empty 14:23:31 [14:23:31.568] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:31 [14:23:31.739] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x9dc994f279be04f10abc81bb72a9e27ffd84443099b2525ab93abe7a871c35a2 14:23:31 [14:23:31.739] VERBOSE: sequencer-client Sent L1 transaction 0x9dc994f279be04f10abc81bb72a9e27ffd84443099b2525ab93abe7a871c35a2 {"gasLimit":470251,"maxFeePerGas":"1.221279858","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:23:31 [14:23:31.751] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:23:31 [14:23:31.751] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x9dc994f279be04f10abc81bb72a9e27ffd84443099b2525ab93abe7a871c35a2","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":8,"blockTimestamp":1750257088,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:31 [14:23:31.752] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:23:31 [14:23:31.757] INFO: blob-sink:server Received blob sidecar for block 0xc86c63ff2f824bf4a585c00545712b363199d0f0de953dbc560c705b4bb157dd 14:23:31 [14:23:31.762] INFO: blob-sink:server Blob sidecar stored successfully for block 0xc86c63ff2f824bf4a585c00545712b363199d0f0de953dbc560c705b4bb157dd 14:23:31 [14:23:31.771] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:31 [14:23:31.777] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000008"] on http://127.0.0.1:8545 14:23:31 [14:23:31.780] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 8 14:23:31 [14:23:31.782] INFO: aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8. 14:23:31 [14:23:31.787] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750257124] on http://127.0.0.1:8545 14:23:31 [14:23:31.789] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:23:31 [14:23:31.790] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750257124 14:23:31 [14:23:31.790] WARN: foundation:test-date-provider Time set to 2025-06-18T14:32:04.000Z {"offset":512210,"timeMs":1750257124000} 14:23:31 [14:23:31.791] INFO: aztecjs:utils:watcher Slot 9 was filled, jumped to next slot 14:23:31 [14:23:31.926] INFO: archiver Downloaded L2 block 8 {"blockHash":"0x23fc6bfb40218696222bdd2e91b46ecd05e5ea082e79acca18da0bc820b7888a","blockNumber":8,"txCount":1,"globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":8,"slotNumber":9,"timestamp":1750257088,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0451eac74a4824dd545ac4e2f68eccb453907cf05a4374e1bcd2e7400a728d0d","archiveNextLeafIndex":9} 14:23:31 [14:23:31.928] INFO: archiver Updated proven chain to block 8 {"provenBlockNumber":8} 14:23:31 [14:23:31.976] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:32 [14:23:32.038] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":10.045090999999957,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1750257088,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:32 [14:23:32.045] VERBOSE: p2p Synched to latest block 8 14:23:32 [14:23:32.178] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:32 [14:23:32.269] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x0451eac74a4824dd545ac4e2f68eccb453907cf05a4374e1bcd2e7400a728d0d","blockNumber":9,"slot":10} 14:23:32 [14:23:32.381] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:32 [14:23:32.583] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:32 [14:23:32.787] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:32 [14:23:32.790] VERBOSE: pxe:service Updated pxe last block to 8 {"blockHash":{},"archive":"0x0451eac74a4824dd545ac4e2f68eccb453907cf05a4374e1bcd2e7400a728d0d","header":{"contentCommitment":{"blobsHash":"0x009ff44155a64e00ac4ba487edc31fed7f8696b0f5859cbb2eaf86ab9ec5c6e0","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750257088,"version":3599149864},"lastArchive":"0x09d44424afbf15e8543a290fa50fa51fe45cc5e01df12b4965b2a17cf3f876ee","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x04abfbf3b2491ab60add94e528fca6a5c157ec7964ef7c17923b86cb643b51b6","nullifierTree":"0x2d145b5bd8fbc37aefa3ad75d3fdbac8c690e3707284e0e16e39d60213ffdbf4","publicDataTree":"0x0a1412ded349e75ed8baf6f3108718785cf12d97036cbc493472bdcb15091ff1"},"totalFees":2327130000,"totalManaUsed":45900}} 14:23:32 [14:23:32.792] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x0451eac74a4824dd545ac4e2f68eccb453907cf05a4374e1bcd2e7400a728d0d","blockNumber":9,"slot":10} 14:23:32 [14:23:32.875] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:32 [14:23:32.887] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:32 [14:23:32.887] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:32 [14:23:32.944] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:32 [14:23:32.959] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:32 [14:23:32.970] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:32 [14:23:32.970] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:32 [14:23:32.977] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:32 [14:23:32.978] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:32 [14:23:32.981] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:32 [14:23:32.983] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:32 [14:23:32.990] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:32 [14:23:32.996] VERBOSE: simulator Utility simulation for 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a.0xd191fb1a completed 14:23:33 [14:23:33.032] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:33 [14:23:33.040] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:33 [14:23:33.138] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:33 [14:23:33.170] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:33 [14:23:33.171] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:33 [14:23:33.196] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:33 [14:23:33.234] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:33 [14:23:33.241] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:33 [14:23:33.259] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:33 [14:23:33.260] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:33 [14:23:33.268] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:33 [14:23:33.269] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:33 [14:23:33.272] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:33 [14:23:33.278] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:33 [14:23:33.294] VERBOSE: simulator:client_execution_context:debug_log Setting 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a as fee payer 14:23:33 [14:23:33.419] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:33 [14:23:33.778] INFO: pxe:service Proving completed in 725.5383199999997ms {"timings":{"total":725.5383199999997,"sync":3.1548689999981434,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":229.60444399999687,"oracles":{"debugLog":{"times":[0.5113629999978002,0.4388810000018566,0.53301300000021,0.6308950000020559,0.5927149999988615,0.46597200000542216,0.5014819999996689,0.5393330000006245]},"fetchTaggedLogs":{"times":[67.9959119999985]},"loadCapsule":{"times":[0.16947500000242144,0.13661300000239862,0.42272999999840977,2.007369999999355,0.3200780000042869,0.37138899999990826]},"getSharedSecret":{"times":[10.388319999998203]},"aes128Decrypt":{"times":[0.2670060000018566,1.021825000003446]},"getPublicKeysAndPartialAddress":{"times":[2.1214429999963613]},"getKeyValidationRequest":{"times":[1.770594000001438]},"deliverNote":{"times":[3.4042950000002747]},"deleteCapsule":{"times":[0.5155329999979585]},"storeCapsule":{"times":[1.6420119999966118]},"getNotes":{"times":[1.466856999999436]},"getAuthWitness":{"times":[0.24952699999994365]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.062031999994360376]},"notifyEnqueuedPublicFunctionCall":{"times":[0.11897299999691313]}}},{"functionName":"private_kernel_init","time":67.29654299999675},{"functionName":"private_kernel_reset","time":186.22247799999604},{"functionName":"private_kernel_tail","time":87.3497450000068}],"unaccounted":151.91024100000504}} 14:23:33 [14:23:33.805] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x0451eac74a4824dd545ac4e2f68eccb453907cf05a4374e1bcd2e7400a728d0d","blockNumber":9,"slot":10} 14:23:33 [14:23:33.807] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:33 [14:23:33.847] VERBOSE: p2p:tx_pool Adding tx 0x2d070ed7eac70a726277e95c6c20a2f9a8678d8ed29c919592825fbbbf32e4af to pool {"eventName":"tx-added-to-pool","txHash":"0x2d070ed7eac70a726277e95c6c20a2f9a8678d8ed29c919592825fbbbf32e4af","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 14:23:33 [14:23:33.859] INFO: node Received tx 0x2d070ed7eac70a726277e95c6c20a2f9a8678d8ed29c919592825fbbbf32e4af {"txHash":"0x2d070ed7eac70a726277e95c6c20a2f9a8678d8ed29c919592825fbbbf32e4af"} 14:23:33 [14:23:33.859] INFO: pxe:service Sent transaction 0x2d070ed7eac70a726277e95c6c20a2f9a8678d8ed29c919592825fbbbf32e4af 14:23:34 [14:23:34.014] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:34 [14:23:34.220] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:34 [14:23:34.341] VERBOSE: sequencer Building block 9 for slot 10 {"slot":10,"blockNumber":9,"msgCount":0} 14:23:34 [14:23:34.359] VERBOSE: sequencer Processing pending txs {"slot":10,"slotStart":"2025-06-18T14:32:04.000Z","now":"2025-06-18T14:32:06.569Z"} 14:23:34 [14:23:34.408] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":13.035745999994106} 14:23:34 [14:23:34.427] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:34 [14:23:34.437] VERBOSE: simulator:public-processor Processed tx 0x2d070ed7eac70a726277e95c6c20a2f9a8678d8ed29c919592825fbbbf32e4af with 1 public calls in 59.9995609999969ms {"txHash":"0x2d070ed7eac70a726277e95c6c20a2f9a8678d8ed29c919592825fbbbf32e4af","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":59.9995609999969} 14:23:34 [14:23:34.439] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.0794390080000012s {"duration":0.0794390080000012,"rate":252319.36431028566,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 14:23:34 [14:23:34.556] INFO: sequencer Built block 9 for slot 10 with 1 txs and 0 messages. 93171.69974046704 mana/s {"blockHash":"0x0ba4db22303365d5e7e096c4e7268c4f74c8d9fc530abd7757446c67759831ba","globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":9,"slotNumber":10,"timestamp":1750257124,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHashes":["0x2d070ed7eac70a726277e95c6c20a2f9a8678d8ed29c919592825fbbbf32e4af"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":214.55423799999699,"publicProcessDuration":79.74825499999861,"rollupCircuitsDuration":199.23612500000309,"txCount":1,"blockNumber":9,"blockTimestamp":1750257124,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:34 [14:23:34.558] VERBOSE: sequencer Attesting committee is empty 14:23:34 [14:23:34.639] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:34 [14:23:34.832] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x683baff1bdf0a612ade2c52d0f1f017c5b990abb745c40f471b9750c9f80a956 14:23:34 [14:23:34.833] VERBOSE: sequencer-client Sent L1 transaction 0x683baff1bdf0a612ade2c52d0f1f017c5b990abb745c40f471b9750c9f80a956 {"gasLimit":470292,"maxFeePerGas":"1.216344983","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:23:34 [14:23:34.843] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:23:34 [14:23:34.843] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x683baff1bdf0a612ade2c52d0f1f017c5b990abb745c40f471b9750c9f80a956","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":9,"blockTimestamp":1750257124,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:34 [14:23:34.844] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:23:34 [14:23:34.845] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:34 [14:23:34.848] INFO: blob-sink:server Received blob sidecar for block 0xb13c8b68b687a1bb5e976212af6b00d19d6de8d426299f1e3fc88403309fd376 14:23:34 [14:23:34.857] INFO: blob-sink:server Blob sidecar stored successfully for block 0xb13c8b68b687a1bb5e976212af6b00d19d6de8d426299f1e3fc88403309fd376 14:23:34 [14:23:34.858] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000009"] on http://127.0.0.1:8545 14:23:34 [14:23:34.859] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 9 14:23:34 [14:23:34.860] INFO: aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9. 14:23:34 [14:23:34.910] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750257160] on http://127.0.0.1:8545 14:23:34 [14:23:34.921] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:23:34 [14:23:34.923] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750257160 14:23:34 [14:23:34.924] WARN: foundation:test-date-provider Time set to 2025-06-18T14:32:40.000Z {"offset":545076,"timeMs":1750257160000} 14:23:34 [14:23:34.924] INFO: aztecjs:utils:watcher Slot 10 was filled, jumped to next slot 14:23:35 [14:23:35.046] INFO: archiver Downloaded L2 block 9 {"blockHash":"0x0ba4db22303365d5e7e096c4e7268c4f74c8d9fc530abd7757446c67759831ba","blockNumber":9,"txCount":1,"globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":9,"slotNumber":10,"timestamp":1750257124,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"archiveRoot":"0x1f3bb4df2bf30cab7d9f9c43c207273286bc68db35700efdb75c614813bd3dad","archiveNextLeafIndex":10} 14:23:35 [14:23:35.048] INFO: archiver Updated proven chain to block 9 {"provenBlockNumber":9} 14:23:35 [14:23:35.054] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:35 [14:23:35.155] INFO: world_state World state updated with L2 block 9 {"eventName":"l2-block-handled","duration":9.025691999995615,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1750257124,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:23:35 [14:23:35.160] VERBOSE: p2p Synched to latest block 9 14:23:35 [14:23:35.256] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:35 [14:23:35.372] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x1f3bb4df2bf30cab7d9f9c43c207273286bc68db35700efdb75c614813bd3dad","blockNumber":10,"slot":11} 14:23:35 [14:23:35.459] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:35 [14:23:35.661] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:35 [14:23:35.871] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:35 [14:23:35.906] VERBOSE: pxe:service Updated pxe last block to 9 {"blockHash":{},"archive":"0x1f3bb4df2bf30cab7d9f9c43c207273286bc68db35700efdb75c614813bd3dad","header":{"contentCommitment":{"blobsHash":"0x0076d0b660bae32ad5e27fd5c01bac072fb4bb3ebbed819dbac3d1c4cb5361b6","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750257124,"version":3599149864},"lastArchive":"0x0451eac74a4824dd545ac4e2f68eccb453907cf05a4374e1bcd2e7400a728d0d","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x04abfbf3b2491ab60add94e528fca6a5c157ec7964ef7c17923b86cb643b51b6","nullifierTree":"0x0a0108ebb45a4c39553d8f6a5547ddb21b16ff927dc476f194bb78446ef274bd","publicDataTree":"0x209349fd831dc6bbadb3f2a27fb49b0e81cf33688ad713025cbf5678f2fe4274"},"totalFees":276318000,"totalManaUsed":45900}} 14:23:35 [14:23:35.922] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x1f3bb4df2bf30cab7d9f9c43c207273286bc68db35700efdb75c614813bd3dad","blockNumber":10,"slot":11} 14:23:36 [14:23:36.060] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","selector":"0xd191fb1a"} 14:23:36 [14:23:36.074] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:23:36 [14:23:36.075] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:36 [14:23:36.080] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:36 [14:23:36.203] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a"} 14:23:36 [14:23:36.219] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x1eb4c76a7acc092e0bc8ade545b21870fdb65a070938011ff171937359598f14 14:23:36 [14:23:36.232] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:23:36 [14:23:36.234] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:36 [14:23:36.242] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:36 [14:23:36.243] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:36 [14:23:36.247] VERBOSE: pxe:service Added note {"index":0,"contract":"0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x09199914119605484f5fb554281e3a540499abb5e5583d903ca606e5804ec31e","nullifier":"0x2d4d296708ed15aff2292740ac7ef75333d7d95df2c659974587da004e406dd2"} 14:23:36 [14:23:36.251] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:36 [14:23:36.264] VERBOSE: simulator Utility simulation for 0x098438a650e6cd748de5023d38b63606ff4605b1959783b5b96c8396d16ce92a.0xd191fb1a completed 14:23:36 [14:23:36.294] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:36 [14:23:36.330] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:23:36 [14:23:36.339] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:23:36 [14:23:36.382] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd {"origin":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000d686ab28","authWitnesses":["0x00caffb7927c77afe05a8c6f67602354618f9479b8b081820d30b9b27171a325"]} 14:23:36 [14:23:36.549] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:36 [14:23:36.578] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:36 [14:23:36.628] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:23:36 [14:23:36.629] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:36 [14:23:36.675] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x1f3bb4df2bf30cab7d9f9c43c207273286bc68db35700efdb75c614813bd3dad","blockNumber":10,"slot":11} 14:23:36 [14:23:36.709] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd"} 14:23:36 [14:23:36.719] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x24802acc1b722b27809d2e0dce07db29dd6cf1324d0a86c015b31845e0a5c1a5 14:23:36 [14:23:36.732] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:23:36 [14:23:36.734] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:23:36 [14:23:36.746] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:23:36 [14:23:36.747] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:23:36 [14:23:36.752] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x10781af8ffd3b369c53c1ccaed43f80496977af54acb0ad900c9eb544d40bd7b","nullifier":"0x1893f00bb8f7877c7562bd9acc3f75fc88d774823f35e99c367356c1a2e82cc1"} 14:23:36 [14:23:36.754] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:23:36 [14:23:36.768] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1a7059ec8e4c28fba8755adf6b5334c3a287fc6555edebefd90601bf8baee4dd as fee payer 14:23:36 [14:23:36.835] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:37 [14:23:37.409] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:23:37 [14:23:37.451] VERBOSE: node Simulating public calls for tx 0x0f7a7bc4d61fe2db347659b25c93075698caddbaf7062030887365c53f293a4f {"globalVariables":{"chainId":31337,"version":3599149864,"blockNumber":10,"slotNumber":11,"timestamp":1750257160,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHash":"0x0f7a7bc4d61fe2db347659b25c93075698caddbaf7062030887365c53f293a4f","blockNumber":10} 14:23:37 [14:23:37.463] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x1f3bb4df2bf30cab7d9f9c43c207273286bc68db35700efdb75c614813bd3dad","blockNumber":10,"slot":11} 14:23:37 [14:23:37.527] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 reverted with reason Assertion failed: . {"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":34.03537800000049} 14:23:37 [14:23:37.527] WARN: simulator:public_tx_context APP_LOGIC phase reverted! 0x0000000000000000000000000000000000000000000000000000000000000001:0x2716b166 failed with reason: Assertion failed: 14:23:37 [14:23:37.562] VERBOSE: simulator:public-processor Processed tx 0x0f7a7bc4d61fe2db347659b25c93075698caddbaf7062030887365c53f293a4f with 1 public calls in 91.56607999999687ms {"txHash":"0x0f7a7bc4d61fe2db347659b25c93075698caddbaf7062030887365c53f293a4f","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":91.56607999999687} 14:23:37 [14:23:37.564] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.10552189999999974s {"duration":0.10552189999999974,"rate":335901.8364908146,"totalPublicGas":{"daGas":0,"l2Gas":35445},"totalBlockGas":{"daGas":1024,"l2Gas":61301},"totalSizeInBytes":256} 14:23:37 PASS src/e2e_authwit.test.ts 14:23:37 e2e_authwit_tests 14:23:37 Private 14:23:37 arbitrary data 14:23:37 ✓ happy path (8203 ms) 14:23:37 failure case 14:23:37 ✓ invalid chain id (1265 ms) 14:23:37 ✓ invalid version (1857 ms) 14:23:37 Public 14:23:37 arbitrary data 14:23:37 ✓ happy path (7121 ms) 14:23:37 failure case 14:23:37 ✓ cancel before usage (8084 ms) 14:23:37 14:23:37 Test Suites: 1 passed, 1 total 14:23:37 Tests: 5 passed, 5 total 14:23:37 Snapshots: 0 total 14:23:37 Time: 51.925 s 14:23:37 Ran all test suites matching /src\/e2e_authwit.test.ts/i. 14:23:37 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?