Parent Log: http://ci.aztec-labs.com/d447f9a13417abbf Command: d2a1f586812a792c: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/71fe6b444df8fafa5531226cf458dbd22d2f3ab7 Env: REF_NAME=gh-readonly-queue/master/pr-15117-c06f30929f18b85bcea93c0926a8d640a3819f00 CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Tue Jun 17 19:25:57 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15117_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_06a902b1832ee6d0_master 19:25:57 +++ id -u 19:25:57 +++ id -g 19:25:57 ++ 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'\''' 19:25:58 + cid=304ddbd0ae194b94600e1eb2869c137fb7b907a232a5e7e67b663cf1ef0b3f30 19:25:58 + set +x 19:25:58 {"level":25,"time":1750188358771,"pid":12,"hostname":"304ddbd0ae19","module":"logger","msg":"Logger initialized with level verbose"} 19:26:04 [19:26:04.825] INFO: e2e:e2e_authwit Logging metrics to log/unknown.jsonl 19:26:05 [19:26:05.081] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-pfI6nO/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 19:26:05 [19:26:05.117] INFO: e2e:e2e_authwit Calling anvil_setBlockTimestampInterval with params: [12] 19:26:05 [19:26:05.141] WARN: e2e:e2e_authwit Set block interval to 12 19:26:05 [19:26:05.142] VERBOSE: e2e:e2e_authwit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:26:05 [19:26:05.186] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 19:26:05 [19:26:05.195] VERBOSE: e2e:e2e_authwit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 19:26:05 [19:26:05.217] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 19:26:05 [19:26:05.222] VERBOSE: e2e:e2e_authwit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 19:26:05 [19:26:05.236] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 19:26:05 [19:26:05.243] VERBOSE: e2e:e2e_authwit Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 19:26:05 [19:26:05.257] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 19:26:05 [19:26:05.262] VERBOSE: e2e:e2e_authwit Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 19:26:05 [19:26:05.281] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 19:26:05 [19:26:05.286] VERBOSE: e2e:e2e_authwit Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 19:26:05 [19:26:05.298] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 19:26:05 [19:26:05.303] VERBOSE: e2e:e2e_authwit Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 19:26:05 [19:26:05.304] VERBOSE: e2e:e2e_authwit Waiting for deployments to complete 19:26:05 [19:26:05.304] INFO: e2e:e2e_authwit Waiting for 6 transactions to be mined... 19:26:05 [19:26:05.325] INFO: e2e:e2e_authwit All transactions mined successfully 19:26:05 [19:26:05.345] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 19:26:05 [19:26:05.345] VERBOSE: e2e:e2e_authwit Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 19:26:05 [19:26:05.360] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 19:26:05 [19:26:05.377] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 19:26:05 [19:26:05.384] VERBOSE: e2e:e2e_authwit Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 19:26:05 [19:26:05.398] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 19:26:05 [19:26:05.398] VERBOSE: e2e:e2e_authwit Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 19:26:05 [19:26:05.418] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 19:26:05 [19:26:05.423] VERBOSE: e2e:e2e_authwit Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 19:26:05 [19:26:05.433] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 19:26:05 [19:26:05.434] VERBOSE: e2e:e2e_authwit Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 19:26:05 [19:26:05.434] VERBOSE: e2e:e2e_authwit Waiting for deployments to complete 19:26:05 [19:26:05.434] INFO: e2e:e2e_authwit Waiting for 8 transactions to be mined... 19:26:05 [19:26:05.448] INFO: e2e:e2e_authwit All transactions mined successfully 19:26:05 [19:26:05.468] VERBOSE: e2e:e2e_authwit Deployed shared contracts 19:26:05 [19:26:05.483] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 19:26:05 [19:26:05.483] VERBOSE: e2e:e2e_authwit Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 19:26:05 [19:26:05.486] 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} 19:26:05 [19:26:05.497] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 19:26:05 [19:26:05.522] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 19:26:05 [19:26:05.527] VERBOSE: e2e:e2e_authwit Awaiting for linked libraries to be deployed 19:26:05 [19:26:05.564] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x441a8780699fa979fd87164f52bc4b69c092134bb40784ea7a4046cb13ad3577 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 19:26:05 [19:26:05.570] 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} 19:26:05 [19:26:05.570] INFO: e2e:e2e_authwit Waiting for 9 transactions to be mined... 19:26:05 [19:26:05.589] INFO: e2e:e2e_authwit All transactions mined successfully 19:26:05 [19:26:05.590] VERBOSE: e2e:e2e_authwit All core contracts have been deployed 19:26:05 [19:26:05.602] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 19:26:05 [19:26:05.602] VERBOSE: e2e:e2e_authwit Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments) 19:26:05 [19:26:05.614] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 19:26:05 [19:26:05.621] VERBOSE: e2e:e2e_authwit Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 19:26:05 [19:26:05.644] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 19:26:05 [19:26:05.645] VERBOSE: e2e:e2e_authwit Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 19:26:05 [19:26:05.645] INFO: e2e:e2e_authwit Waiting for 10 transactions to be mined... 19:26:05 [19:26:05.669] INFO: e2e:e2e_authwit All transactions mined successfully 19:26:05 [19:26:05.675] VERBOSE: e2e:e2e_authwit Rollup deployed 19:26:05 [19:26:05.676] VERBOSE: e2e:e2e_authwit Waiting for rollup and slash factory to be deployed 19:26:05 [19:26:05.676] INFO: e2e:e2e_authwit Waiting for 10 transactions to be mined... 19:26:05 [19:26:05.694] INFO: e2e:e2e_authwit All transactions mined successfully 19:26:05 [19:26:05.694] VERBOSE: e2e:e2e_authwit All transactions for L1 deployment have been mined 19:26:05 [19:26:05.712] 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"} 19:26:05 [19:26:05.716] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 19:26:05 [19:26:05.719] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:05 [19:26:05.720] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 19:26:05 [19:26:05.721] INFO: telemetry:client Using NoopTelemetryClient 19:26:05 [19:26:05.725] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/a75960638af80224/blob-sink with map size 134217728 KB (LMDB v2) 19:26:05 [19:26:05.729] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 19:26:05 [19:26:05.729] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 19:26:05 [19:26:05.732] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:05 [19:26:05.734] INFO: aztecjs:utils:watcher New L1 time: 1750188604 19:26:05 [19:26:05.734] WARN: foundation:test-date-provider Time set to 2025-06-17T19:30:04.000Z {"offset":238266,"timeMs":1750188604000} 19:26:05 [19:26:05.736] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 19:26:05 [19:26:05.741] INFO: blob-sink:server Server is running on http://localhost:42007 19:26:05 [19:26:05.741] VERBOSE: e2e:e2e_authwit Creating and synching an aztec node... 19:26:05 [19:26:05.742] VERBOSE: e2e:e2e_authwit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/a4dcd867/acvm 19:26:05 [19:26:05.742] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42007"} 19:26:05 [19:26:05.759] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 19:26:05 [19:26:05.760] INFO: archiver:lmdb Creating archiver data store at directory /tmp/a75960638af80224/archiver with map size 134217728 KB (LMDB v2) 19:26:05 [19:26:05.761] INFO: archiver:lmdb Starting data store with maxReaders 16 19:26:05 [19:26:05.949] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:06 [19:26:06.033] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:42007"} 19:26:06 [19:26:06.049] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:42007"} 19:26:06 [19:26:06.050] WARN: node:blob-sink:client No L1 consensus host urls configured 19:26:06 [19:26:06.050] WARN: node:blob-sink:client No archive client configured 19:26:06 [19:26:06.057] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x3039f3c70ee6e802c98c4ad5c8e35fd474934a81c1bdce74a000a2591a0af5a7 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x117cb550c1a0d0a981dee801b6971f0183ef4c38d7f0293883936e4b64d6f8bb","l1BlockNumber":16}} 19:26:06 [19:26:06.075] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:26:06 [19:26:06.084] INFO: world-state:database Creating world state data store at directory /tmp/a75960638af80224/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:26:06 [19:26:06.107] INFO: world_state Created world state synchroniser with block history of 64 19:26:06 [19:26:06.107] WARN: node Aztec node is accepting fake proofs 19:26:06 [19:26:06.117] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/a75960638af80224/p2p with map size 134217728 KB (LMDB v2) 19:26:06 [19:26:06.118] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 19:26:06 [19:26:06.119] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/a75960638af80224/p2p-archive with map size 134217728 KB (LMDB v2) 19:26:06 [19:26:06.120] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 19:26:06 [19:26:06.120] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/a75960638af80224/p2p-peers with map size 134217728 KB (LMDB v2) 19:26:06 [19:26:06.121] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 19:26:06 [19:26:06.122] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 19:26:06 [19:26:06.123] VERBOSE: p2p P2P is disabled. Using dummy P2P service 19:26:06 [19:26:06.125] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 19:26:06 [19:26:06.126] INFO: world_state Started world state synchronizer from block 1 19:26:06 [19:26:06.128] VERBOSE: world-state:block_stream Starting sync from block number 0 19:26:06 [19:26:06.129] INFO: p2p Starting p2p client from block 0 with empty mempools 19:26:06 [19:26:06.129] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 19:26:06 [19:26:06.130] INFO: slasher Slasher client initialized 19:26:06 [19:26:06.130] INFO: slasher Starting Slasher client... 19:26:06 [19:26:06.167] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:26:06 [19:26:06.168] VERBOSE: node All Aztec Node subsystems synced 19:26:06 [19:26:06.175] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:06 [19:26:06.179] INFO: sequencer-client Deploying forwarder contract 19:26:06 [19:26:06.187] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 19:26:06 [19:26:06.201] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 19:26:06 [19:26:06.201] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 19:26:06 [19:26:06.205] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:26:06 [19:26:06.219] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:26:06 [19:26:06.219] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 19:26:06 [19:26:06.220] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/a4dcd867/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 19:26:06 [19:26:06.435] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 19:26:06 [19:26:06.437] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:26:06 [19:26:06.438] INFO: node Aztec Node version: 0.87.8 19:26:06 [19:26:06.438] 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"} 19:26:06 [19:26:06.439] VERBOSE: e2e:e2e_authwit Creating a pxe... 19:26:06 [19:26:06.442] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:06 [19:26:06.447] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/a31430fefbb47716/pxe_data with map size 134217728 KB (LMDB v2) 19:26:06 [19:26:06.457] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27259faf408176faefdc483a038b9e09ea8b495a5c487b38a2b61b20fdc9c41a","blockNumber":1,"slot":2} 19:26:06 [19:26:06.458] INFO: pxe:data:lmdb Starting data store with maxReaders 16 19:26:06 [19:26:06.651] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:06 [19:26:06.768] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 19:26:06 [19:26:06.769] INFO: pxe:service Started PXE connected to chain 31337 version 2928111036 19:26:06 [19:26:06.838] INFO: pxe:service Registered account 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 19:26:06 [19:26:06.912] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:06 [19:26:06.915] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 19:26:06 [19:26:06.918] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 19:26:07 [19:26:07.043] INFO: pxe:service Added contract SchnorrAccount at 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 19:26:07 [19:26:07.053] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27259faf408176faefdc483a038b9e09ea8b495a5c487b38a2b61b20fdc9c41a","blockNumber":1,"slot":2} 19:26:07 [19:26:07.099] VERBOSE: pxe:block_stream Starting sync from block number 0 19:26:07 [19:26:07.124] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 19:26:07 [19:26:07.168] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:07 [19:26:07.225] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:26:07 [19:26:07.989] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 19:26:08 [19:26:08.115] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:26:08 [19:26:08.190] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:08 [19:26:08.219] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27259faf408176faefdc483a038b9e09ea8b495a5c487b38a2b61b20fdc9c41a","blockNumber":1,"slot":2} 19:26:08 [19:26:08.321] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:08 [19:26:08.380] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:08 [19:26:08.381] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:08 [19:26:08.412] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:08 [19:26:08.445] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:08 [19:26:08.454] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:08 [19:26:08.621] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:08 [19:26:08.686] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:08 [19:26:08.753] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:08 [19:26:08.754] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:08 [19:26:08.819] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27259faf408176faefdc483a038b9e09ea8b495a5c487b38a2b61b20fdc9c41a","blockNumber":1,"slot":2} 19:26:08 [19:26:08.835] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:08 [19:26:08.842] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:08 [19:26:08.858] VERBOSE: simulator:client_execution_context:debug_log Setting 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 as fee payer 19:26:09 [19:26:09.040] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:09 [19:26:09.311] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:09 [19:26:09.419] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27259faf408176faefdc483a038b9e09ea8b495a5c487b38a2b61b20fdc9c41a","blockNumber":1,"slot":2} 19:26:09 [19:26:09.565] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:10 [19:26:10.151] INFO: pxe:service Proving completed in 3056.501779ms {"timings":{"total":3056.501779,"sync":5.995317999999315,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":179.76594999999725,"oracles":{"callPrivateFunction":{"times":[1017.2093079999995,398.3752690000001,290.191182999999]}}},{"functionName":"private_kernel_init","time":111.27039299999888},{"functionName":"ContractClassRegisterer:register","time":997.1985490000006,"oracles":{"loadCapsule":{"times":[56.945918999999776]},"notifyCreatedNullifier":{"times":[1.0248310000006313]},"debugLog":{"times":[1.330348999999842]},"notifyCreatedContractClassLog":{"times":[10.042355000001407]}}},{"functionName":"private_kernel_inner","time":154.24960199999987},{"functionName":"SchnorrAccount:constructor","time":351.41892299999927,"oracles":{"getContractInstance":{"times":[1.8038489999999001]},"debugLog":{"times":[0.5617519999996148,0.49852999999893655]},"fetchTaggedLogs":{"times":[72.12504499999886]},"loadCapsule":{"times":[0.43050899999980174,0.27473600000121223,2.97217400000045]},"notifyCreatedNullifier":{"times":[0.3284670000011829,0.5185810000002675]},"notifyCreatedNote":{"times":[0.9477600000009261]},"getRandomField":{"times":[0.34178700000120443,0.19469399999979942,0.08804199999940465,0.065441999999166,0.04979099999945902,0.05369099999916216,0.04942100000153005,0.08153200000015204,0.0504320000000007,0.06990099999893573,0.07564099999945029]},"getIndexedTaggingSecretAsSender":{"times":[41.123719999999594]},"incrementAppTaggingSecretIndexAsSender":{"times":[43.24147599999924]}}},{"functionName":"private_kernel_inner","time":141.2555740000007},{"functionName":"SchnorrAccount:entrypoint","time":244.37710200000038,"oracles":{"debugLog":{"times":[1.0382929999996122,0.3896890000014537,0.661073999999644]},"fetchTaggedLogs":{"times":[85.9831809999996]},"loadCapsule":{"times":[0.3898979999994481,0.8411980000000767,0.2330949999995937]},"getNotes":{"times":[2.0606239999997342]},"getAuthWitness":{"times":[0.43793900000127906]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.9204900000004272]}}},{"functionName":"private_kernel_inner","time":158.27701900000102},{"functionName":"private_kernel_reset","time":221.17188499999975},{"functionName":"private_kernel_tail","time":100.40678900000057}],"unaccounted":391.11467500000253}} 19:26:10 [19:26:10.175] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:10 [19:26:10.252] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27259faf408176faefdc483a038b9e09ea8b495a5c487b38a2b61b20fdc9c41a","blockNumber":1,"slot":2} 19:26:10 [19:26:10.325] VERBOSE: p2p:tx_pool Adding tx 0x29a68a3d8998055110a269495ffdfb33bb19ad0a3e053acd2fd25e0242bbd20a to pool {"eventName":"tx-added-to-pool","txHash":"0x29a68a3d8998055110a269495ffdfb33bb19ad0a3e053acd2fd25e0242bbd20a","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 19:26:10 [19:26:10.354] INFO: node Received tx 0x29a68a3d8998055110a269495ffdfb33bb19ad0a3e053acd2fd25e0242bbd20a {"txHash":"0x29a68a3d8998055110a269495ffdfb33bb19ad0a3e053acd2fd25e0242bbd20a"} 19:26:10 [19:26:10.355] INFO: pxe:service Sent transaction 0x29a68a3d8998055110a269495ffdfb33bb19ad0a3e053acd2fd25e0242bbd20a 19:26:10 [19:26:10.385] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:10 [19:26:10.589] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:10 [19:26:10.771] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 19:26:10 [19:26:10.784] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-17T19:30:28.000Z","now":"2025-06-17T19:30:09.050Z"} 19:26:10 [19:26:10.803] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:11 [19:26:11.050] VERBOSE: simulator:public-processor Processed tx 0x29a68a3d8998055110a269495ffdfb33bb19ad0a3e053acd2fd25e0242bbd20a with no public calls in 181.87122400000044ms {"txHash":"0x29a68a3d8998055110a269495ffdfb33bb19ad0a3e053acd2fd25e0242bbd20a","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":181.87122400000044} 19:26:11 [19:26:11.053] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2671030090000004s {"duration":0.2671030090000004,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 19:26:11 [19:26:11.060] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:11 [19:26:11.253] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1efc7c79d3d2123d59d8f672cdbea50b325dcd1d52dbad09afcc315274c6fbfb","globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":1,"slotNumber":2,"timestamp":1750188628,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x29a68a3d8998055110a269495ffdfb33bb19ad0a3e053acd2fd25e0242bbd20a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":481.2217920000003,"publicProcessDuration":268.2654139999995,"rollupCircuitsDuration":468.70797499999935,"txCount":1,"blockNumber":1,"blockTimestamp":1750188628,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:26:11 [19:26:11.256] VERBOSE: sequencer Attesting committee is empty 19:26:11 [19:26:11.351] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:11 [19:26:11.560] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:11 [19:26:11.654] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xad817d4fd7fc1328e9cd3fdd029d5d723adb6e71cc9cb941e09fb60b3f3d3d03 19:26:11 [19:26:11.654] VERBOSE: sequencer-client Sent L1 transaction 0xad817d4fd7fc1328e9cd3fdd029d5d723adb6e71cc9cb941e09fb60b3f3d3d03 {"gasLimit":514567,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 19:26:11 [19:26:11.668] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:26:11 [19:26:11.669] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xad817d4fd7fc1328e9cd3fdd029d5d723adb6e71cc9cb941e09fb60b3f3d3d03","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1750188628,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:26:11 [19:26:11.670] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:26:11 [19:26:11.694] INFO: blob-sink:server Received blob sidecar for block 0xc0e13f4212538b6f5504d91757b443c4954b9fbfbd1f6fd3c27667c5b1c82468 19:26:11 [19:26:11.701] INFO: blob-sink:server Blob sidecar stored successfully for block 0xc0e13f4212538b6f5504d91757b443c4954b9fbfbd1f6fd3c27667c5b1c82468 19:26:11 [19:26:11.765] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:11 [19:26:11.767] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 19:26:11 [19:26:11.770] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 19:26:11 [19:26:11.773] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 19:26:11 [19:26:11.897] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 19:26:11 [19:26:11.908] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1efc7c79d3d2123d59d8f672cdbea50b325dcd1d52dbad09afcc315274c6fbfb","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":1,"slotNumber":2,"timestamp":1750188628,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2199e03c033c0ee8aff8314d238c266e4e8ed90b2c125b5233e8b5b4c852c61a","archiveNextLeafIndex":2} 19:26:11 [19:26:11.910] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188664] on http://127.0.0.1:8545 19:26:11 [19:26:11.912] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:26:11 [19:26:11.919] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188664 19:26:11 [19:26:11.919] WARN: foundation:test-date-provider Time set to 2025-06-17T19:31:04.000Z {"offset":292081,"timeMs":1750188664000} 19:26:11 [19:26:11.920] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 19:26:11 [19:26:11.920] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 19:26:11 [19:26:11.971] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:12 [19:26:12.049] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":51.80627900000036,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750188628,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:26:12 [19:26:12.082] INFO: pxe:service Registered account 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 19:26:12 [19:26:12.083] VERBOSE: p2p Synched to latest block 1 19:26:12 [19:26:12.186] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:12 [19:26:12.193] INFO: pxe:service Added contract SchnorrAccount at 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 19:26:12 [19:26:12.225] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2199e03c033c0ee8aff8314d238c266e4e8ed90b2c125b5233e8b5b4c852c61a","blockNumber":2,"slot":3} 19:26:12 [19:26:12.241] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x2199e03c033c0ee8aff8314d238c266e4e8ed90b2c125b5233e8b5b4c852c61a","header":{"contentCommitment":{"blobsHash":"0x00c6a6234c7c35331d21b48bae8ad241aa34048abc697bb415415ea22311ef06","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750188628,"version":2928111036},"lastArchive":"0x27259faf408176faefdc483a038b9e09ea8b495a5c487b38a2b61b20fdc9c41a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x14c6015c933b587d3e38389ac5d4889f3b6770bf0d85aed7fbf2b4846ca13d6e","nullifierTree":"0x1f0dc33d5cf2f0dddfd083a548385390dc6cd2d093479d8993630420b9f9fec2","publicDataTree":"0x1334dd952072695bdcd48ebc17e7689ae12756e6d7771a3e1a1f76dc4056dc7f"},"totalFees":6794052480,"totalManaUsed":20448}} 19:26:12 [19:26:12.269] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 19:26:12 [19:26:12.369] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:12 [19:26:12.412] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:12 [19:26:12.420] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:12 [19:26:12.420] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:12 [19:26:12.497] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:12 [19:26:12.502] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:12 [19:26:12.625] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:12 [19:26:12.691] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:12 [19:26:12.752] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:12 [19:26:12.753] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:12 [19:26:12.802] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2199e03c033c0ee8aff8314d238c266e4e8ed90b2c125b5233e8b5b4c852c61a","blockNumber":2,"slot":3} 19:26:12 [19:26:12.822] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:12 [19:26:12.827] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:12 [19:26:12.842] VERBOSE: simulator:client_execution_context:debug_log Setting 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 as fee payer 19:26:12 [19:26:12.873] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:13 [19:26:13.190] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:13 [19:26:13.703] INFO: pxe:service Proving completed in 1480.9999439999992ms {"timings":{"total":1480.9999439999992,"sync":29.71307700000034,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":107.52980600000228,"oracles":{"callPrivateFunction":{"times":[309.026996999999,268.2567130000007]}}},{"functionName":"private_kernel_init","time":72.08902800000033},{"functionName":"SchnorrAccount:constructor","time":269.1390419999989,"oracles":{"getContractInstance":{"times":[5.3123540000015055]},"debugLog":{"times":[0.4625500000001921,0.43944899999951303]},"fetchTaggedLogs":{"times":[80.3402900000001]},"loadCapsule":{"times":[0.47729099999924074,0.2529950000007375,0.2585159999998723]},"notifyCreatedNullifier":{"times":[0.22179499999947438,0.2297049999997398]},"notifyCreatedNote":{"times":[0.14676300000064657]},"getRandomField":{"times":[0.11385299999892595,0.13136299999860057,0.06666100000074948,0.053121000000828644,0.054990999999063206,0.04668099999980768,0.04295099999944796,0.046590999998443294,0.04242100000010396,0.042220999999699416,0.03867100000024948]},"getIndexedTaggingSecretAsSender":{"times":[42.960229999998774]},"incrementAppTaggingSecretIndexAsSender":{"times":[23.274357999998756]}}},{"functionName":"private_kernel_inner","time":118.79868399999941},{"functionName":"SchnorrAccount:entrypoint","time":233.2244320000009,"oracles":{"debugLog":{"times":[0.7184160000015254,0.42446899999958987,0.7405159999998432]},"fetchTaggedLogs":{"times":[72.84112699999969]},"loadCapsule":{"times":[0.2658159999991767,0.3088270000007469,0.1838239999997313]},"getNotes":{"times":[0.9527510000007169]},"getAuthWitness":{"times":[0.17342400000052294]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6448740000014368]}}},{"functionName":"private_kernel_inner","time":142.26785399999972},{"functionName":"private_kernel_reset","time":187.77863400000024},{"functionName":"private_kernel_tail","time":85.95920999999908}],"unaccounted":234.50017699999808}} 19:26:13 [19:26:13.719] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:13 [19:26:13.763] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x2199e03c033c0ee8aff8314d238c266e4e8ed90b2c125b5233e8b5b4c852c61a","blockNumber":2,"slot":3} 19:26:13 [19:26:13.768] VERBOSE: p2p:tx_pool Adding tx 0x2974005547a23adef1e120fb74a95ac9e76f9cd9e96d92fe2e89810d2119320b to pool {"eventName":"tx-added-to-pool","txHash":"0x2974005547a23adef1e120fb74a95ac9e76f9cd9e96d92fe2e89810d2119320b","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 19:26:13 [19:26:13.774] INFO: node Received tx 0x2974005547a23adef1e120fb74a95ac9e76f9cd9e96d92fe2e89810d2119320b {"txHash":"0x2974005547a23adef1e120fb74a95ac9e76f9cd9e96d92fe2e89810d2119320b"} 19:26:13 [19:26:13.774] INFO: pxe:service Sent transaction 0x2974005547a23adef1e120fb74a95ac9e76f9cd9e96d92fe2e89810d2119320b 19:26:13 [19:26:13.926] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:14 [19:26:14.131] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:14 [19:26:14.311] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 19:26:14 [19:26:14.337] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:14 [19:26:14.341] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-17T19:31:04.000Z","now":"2025-06-17T19:31:06.422Z"} 19:26:14 [19:26:14.381] VERBOSE: simulator:public-processor Processed tx 0x2974005547a23adef1e120fb74a95ac9e76f9cd9e96d92fe2e89810d2119320b with no public calls in 17.527562000001126ms {"txHash":"0x2974005547a23adef1e120fb74a95ac9e76f9cd9e96d92fe2e89810d2119320b","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":17.527562000001126} 19:26:14 [19:26:14.384] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04248470400000042s {"duration":0.04248470400000042,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 19:26:14 [19:26:14.507] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0bf5452a608a5a5887d99ba10d432f4d9ed6d39069ed2013ee67e0c7349a3ff9","globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":2,"slotNumber":3,"timestamp":1750188664,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2974005547a23adef1e120fb74a95ac9e76f9cd9e96d92fe2e89810d2119320b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":197.59126800000013,"publicProcessDuration":42.89190299999973,"rollupCircuitsDuration":170.6454909999993,"txCount":1,"blockNumber":2,"blockTimestamp":1750188664,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:14 [19:26:14.509] VERBOSE: sequencer Attesting committee is empty 19:26:14 [19:26:14.586] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:14 [19:26:14.806] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:14 [19:26:14.812] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xce2844c25def96a59e8c3c863f6f0aa8f0e1a4483b6d6e6fee79599607bd399b 19:26:14 [19:26:14.812] VERBOSE: sequencer-client Sent L1 transaction 0xce2844c25def96a59e8c3c863f6f0aa8f0e1a4483b6d6e6fee79599607bd399b {"gasLimit":470269,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:26:14 [19:26:14.822] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 19:26:14 [19:26:14.825] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 19:26:14 [19:26:14.829] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 19:26:14 [19:26:14.832] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:26:14 [19:26:14.833] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xce2844c25def96a59e8c3c863f6f0aa8f0e1a4483b6d6e6fee79599607bd399b","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":2,"blockTimestamp":1750188664,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:14 [19:26:14.833] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:26:14 [19:26:14.839] INFO: blob-sink:server Received blob sidecar for block 0x465f7eaf635b2ab377980b366d7fdc71153ecfaa3836bd5228e93ac73dab8359 19:26:14 [19:26:14.843] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188700] on http://127.0.0.1:8545 19:26:14 [19:26:14.846] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:26:14 [19:26:14.847] INFO: blob-sink:server Blob sidecar stored successfully for block 0x465f7eaf635b2ab377980b366d7fdc71153ecfaa3836bd5228e93ac73dab8359 19:26:14 [19:26:14.849] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188700 19:26:14 [19:26:14.849] WARN: foundation:test-date-provider Time set to 2025-06-17T19:31:40.000Z {"offset":325151,"timeMs":1750188700000} 19:26:14 [19:26:14.849] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 19:26:15 [19:26:15.010] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0bf5452a608a5a5887d99ba10d432f4d9ed6d39069ed2013ee67e0c7349a3ff9","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":2,"slotNumber":3,"timestamp":1750188664,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x14d424c5de1feaacd7e1b5d7ac500c40615d842fa1b2fa6673e8093b4aa7f17a","archiveNextLeafIndex":3} 19:26:15 [19:26:15.011] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:15 [19:26:15.016] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 19:26:15 [19:26:15.139] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":12.962351999998646,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750188664,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:15 [19:26:15.153] VERBOSE: p2p Synched to latest block 2 19:26:15 [19:26:15.227] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:15 [19:26:15.322] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x14d424c5de1feaacd7e1b5d7ac500c40615d842fa1b2fa6673e8093b4aa7f17a","header":{"contentCommitment":{"blobsHash":"0x009b7c16f09e9c9e3f7a64bb42d20e9475851c3e8c4be1018afde4e3f8d65ad4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750188664,"version":2928111036},"lastArchive":"0x2199e03c033c0ee8aff8314d238c266e4e8ed90b2c125b5233e8b5b4c852c61a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x098e3036cb9d540ad28cc81c249bae6eeeee572d2a1734425889346cbb101a52","nullifierTree":"0x2646db5bec949e75c3e7c191f9283a9b016f0dd20c21fb78f768d9affe9888fd","publicDataTree":"0x2d51ef536b5491ee12fb6a31059620ac978643aedabff7cfb5478395a1e59ab7"},"totalFees":5018455040,"totalManaUsed":15104}} 19:26:15 [19:26:15.417] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:15 [19:26:15.469] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:15 [19:26:15.470] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:15 [19:26:15.471] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:15 [19:26:15.502] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x14d424c5de1feaacd7e1b5d7ac500c40615d842fa1b2fa6673e8093b4aa7f17a","blockNumber":3,"slot":4} 19:26:15 [19:26:15.572] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:15 [19:26:15.579] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:15 [19:26:15.599] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:15 [19:26:15.600] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:15 [19:26:15.610] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:15 [19:26:15.611] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:15 [19:26:15.616] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:15 [19:26:15.618] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:15 [19:26:15.637] VERBOSE: simulator:client_execution_context:debug_log Setting 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 as fee payer 19:26:15 [19:26:15.685] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 19:26:15 [19:26:15.696] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:15 [19:26:15.729] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:26:15 [19:26:15.745] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8,0x0000000000000000000000000000000000000000000000000000000000000001,0x1bbc9fdeda21b8b7d375d21844e675d849826746fc1c5b39d7e094b57db8122d,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x13321c163034dbefbc59d56ccc5dc7ca76a2f43d73346e0e6b570075ac779141,0x209e826460566c215f89b9595f55465c0f50f2d66a37dcb19aa6fafc9d41bddf,0x1708b67a32a79a9f32f32828c160fdb1437967e6829b4e88154dc343bd23a31d,0x2730c756d918070f835f750ca6920f03c9933cf96568bbe97d06cb99a3eb42cb,0x16a69afd57b189101c627c553cccdd5cef042ccb69f81925b2c3733444cccabe,0x044fe0e7f792ce4c02227afa0d503e59f85dd41891ba3a5d84dee28f7d10817c,0x1e41ceb72a4fe2275a753a47623dc3f47780a236c53fc4c97b9df1d7e9114f93,0x0c60880c5d9d344e2cf39a4ee543086528cc7fab3b27f3024278e79a3eab5e6c,0x1626f4fda87449c945db40c4aa70ba8dc6c3623759de89209fc93745fadc991d,0x0000000000000000000000000000000000000000000000000000000000000000 19:26:15 [19:26:15.796] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 19:26:15 [19:26:15.842] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:26:15 [19:26:15.854] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92,0x0000000000000000000000000000000000000000000000000000000000000001,0x0c8b8d67784df26d47d90c05d8ce9b5db4c199084c323119aecf96f5e89a5d46,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x0d33c64a3707ba3078807dc661dc57d72693e92a5d40cc28bc0bb14133421171,0x27009a4f7224561ac40e18c0e33211f9f0660af3012a69fcdfa22e6fd66d55ad,0x0e7cdca0f59cc720a79f84b7792cab93bfdca5d3298d3f6a254fdcb0e44c9cf6,0x014606afffab01f3707cebc28386cb836943b8b4d502489c7819296eeff7e4ca,0x13c448cc697a856d423957a183f399793e268030663dff849f3a9911e4883d10,0x035d2fba815363e4538fb5057ce5f43f4aa3359035cbf7e9702974afd3acd149,0x249d65515917e43a28266fdefa62331a5af9c139c5d7f928ec0c930e73f645ff,0x02f5c39f321c128b42ba7892c4e2d779f1e557682e5218de7ebbff568aae3eca,0x1ac20e881f641d641b433231b541e2896f6fca283b83b1b89275bb41222e9db1,0x0000000000000000000000000000000000000000000000000000000000000000 19:26:15 [19:26:15.910] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:16 [19:26:16.141] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:16 [19:26:16.324] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x14d424c5de1feaacd7e1b5d7ac500c40615d842fa1b2fa6673e8093b4aa7f17a","blockNumber":3,"slot":4} 19:26:16 [19:26:16.370] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:16 [19:26:16.574] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:16 [19:26:16.792] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:17 [19:26:17.267] INFO: pxe:service Proving completed in 1951.987795000001ms {"timings":{"total":1951.987795000001,"sync":8.517065000000002,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":329.60221900000033,"oracles":{"debugLog":{"times":[0.6403040000004694,0.5319820000004256,0.4984710000026098,0.5509919999967678,0.5220119999976305,0.4251189999995404,0.35407800000029965,0.6556739999978163]},"fetchTaggedLogs":{"times":[106.78702300000077]},"loadCapsule":{"times":[0.30934699999852455,0.3965390000012121,0.7517569999981788,0.45183000000179163,0.23423499999989872,0.27653600000121514]},"getSharedSecret":{"times":[9.267651999998634]},"aes128Decrypt":{"times":[1.2980089999982738,1.2561969999987923]},"getPublicKeysAndPartialAddress":{"times":[2.204967999998189]},"getKeyValidationRequest":{"times":[3.4000339999984135]},"deliverNote":{"times":[5.258684000000358]},"deleteCapsule":{"times":[0.4269590000003518]},"storeCapsule":{"times":[0.4510000000009313]},"getNotes":{"times":[2.117075999998633]},"getAuthWitness":{"times":[0.28594599999996717]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05201099999976577]},"callPrivateFunction":{"times":[116.96489400000064,103.86475900000005]}}},{"functionName":"private_kernel_init","time":72.34847399999853},{"functionName":"ContractInstanceDeployer:deploy","time":61.66111000000092,"oracles":{"storeInExecutionCache":{"times":[0.33415700000114157]},"callPrivateFunction":{"times":[45.596981999999116]},"notifyCreatedNullifier":{"times":[0.35592800000085845]},"debugLog":{"times":[0.6076730000022508]}}},{"functionName":"private_kernel_inner","time":136.1195399999997},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":32.5076169999993,"oracles":{}},{"functionName":"private_kernel_inner","time":138.5576629999996},{"functionName":"ContractInstanceDeployer:deploy","time":54.89149399999951,"oracles":{"storeInExecutionCache":{"times":[0.10324200000104611]},"callPrivateFunction":{"times":[46.114653000000544]},"notifyCreatedNullifier":{"times":[0.3262570000006235]},"debugLog":{"times":[0.6010629999982484]}}},{"functionName":"private_kernel_inner","time":145.15315700000065},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":33.748193999999785,"oracles":{}},{"functionName":"private_kernel_inner","time":148.04767999999967},{"functionName":"private_kernel_reset","time":231.80444200000056},{"functionName":"private_kernel_tail","time":81.14519500000097}],"unaccounted":477.8839450000014}} 19:26:17 [19:26:17.287] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:17 [19:26:17.308] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x14d424c5de1feaacd7e1b5d7ac500c40615d842fa1b2fa6673e8093b4aa7f17a","blockNumber":3,"slot":4} 19:26:17 [19:26:17.323] VERBOSE: p2p:tx_pool Adding tx 0x28f4dc92e18bb2374772b517a420a2d0b83684d3fe6d9f70f312e85b15ae1b63 to pool {"eventName":"tx-added-to-pool","txHash":"0x28f4dc92e18bb2374772b517a420a2d0b83684d3fe6d9f70f312e85b15ae1b63","noteHashCount":0,"nullifierCount":3,"privateLogCount":2,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 19:26:17 [19:26:17.330] INFO: node Received tx 0x28f4dc92e18bb2374772b517a420a2d0b83684d3fe6d9f70f312e85b15ae1b63 {"txHash":"0x28f4dc92e18bb2374772b517a420a2d0b83684d3fe6d9f70f312e85b15ae1b63"} 19:26:17 [19:26:17.330] INFO: pxe:service Sent transaction 0x28f4dc92e18bb2374772b517a420a2d0b83684d3fe6d9f70f312e85b15ae1b63 19:26:17 [19:26:17.498] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:17 [19:26:17.702] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:17 [19:26:17.859] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 19:26:17 [19:26:17.883] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-17T19:31:40.000Z","now":"2025-06-17T19:31:43.034Z"} 19:26:17 [19:26:17.907] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:17 [19:26:17.917] VERBOSE: simulator:public-processor Processed tx 0x28f4dc92e18bb2374772b517a420a2d0b83684d3fe6d9f70f312e85b15ae1b63 with no public calls in 21.228182000002562ms {"txHash":"0x28f4dc92e18bb2374772b517a420a2d0b83684d3fe6d9f70f312e85b15ae1b63","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":21.228182000002562} 19:26:17 [19:26:17.919] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03473720500000127s {"duration":0.03473720500000127,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":18432,"l2Gas":16544},"totalSizeInBytes":1376} 19:26:18 [19:26:18.061] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1c4b62aff1aa91b10258db8c8ddbbf495b667cd2b65e80c3cecf63479c4c8414","globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":3,"slotNumber":4,"timestamp":1750188700,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x28f4dc92e18bb2374772b517a420a2d0b83684d3fe6d9f70f312e85b15ae1b63"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":209.94411599999876,"publicProcessDuration":35.371188999997685,"rollupCircuitsDuration":186.8056429999997,"txCount":1,"blockNumber":3,"blockTimestamp":1750188700,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:18 [19:26:18.064] VERBOSE: sequencer Attesting committee is empty 19:26:18 [19:26:18.150] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:18 [19:26:18.357] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x97f5166b9e40e287713584b3de2de6f552bd192c5e10ddcb594c30ae622a16ed 19:26:18 [19:26:18.357] VERBOSE: sequencer-client Sent L1 transaction 0x97f5166b9e40e287713584b3de2de6f552bd192c5e10ddcb594c30ae622a16ed {"gasLimit":470298,"maxFeePerGas":"1.279583398","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:26:18 [19:26:18.359] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:18 [19:26:18.366] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 19:26:18 [19:26:18.370] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 19:26:18 [19:26:18.373] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 19:26:18 [19:26:18.377] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:26:18 [19:26:18.377] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x97f5166b9e40e287713584b3de2de6f552bd192c5e10ddcb594c30ae622a16ed","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1750188700,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:18 [19:26:18.378] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:26:18 [19:26:18.387] INFO: blob-sink:server Received blob sidecar for block 0xd5461c6c8a8ac191e47ee608b26a42434ed28bb5d64ece2a3863494e24a12329 19:26:18 [19:26:18.397] INFO: blob-sink:server Blob sidecar stored successfully for block 0xd5461c6c8a8ac191e47ee608b26a42434ed28bb5d64ece2a3863494e24a12329 19:26:18 [19:26:18.401] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188736] on http://127.0.0.1:8545 19:26:18 [19:26:18.404] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:26:18 [19:26:18.406] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188736 19:26:18 [19:26:18.406] WARN: foundation:test-date-provider Time set to 2025-06-17T19:32:16.000Z {"offset":357594,"timeMs":1750188736000} 19:26:18 [19:26:18.406] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 19:26:18 [19:26:18.560] VERBOSE: archiver:block-helper Store contract instance at 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 19:26:18 [19:26:18.560] VERBOSE: archiver:block-helper Store contract instance at 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 19:26:18 [19:26:18.565] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1c4b62aff1aa91b10258db8c8ddbbf495b667cd2b65e80c3cecf63479c4c8414","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":3,"slotNumber":4,"timestamp":1750188700,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0a59620edd95d1264a38a79fd7da2d7234c666b2138dd4099079ec50c7f8fb23","archiveNextLeafIndex":4} 19:26:18 [19:26:18.569] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:18 [19:26:18.575] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 19:26:18 [19:26:18.677] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":7.767749000002368,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750188700,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:18 [19:26:18.683] VERBOSE: p2p Synched to latest block 3 19:26:18 [19:26:18.774] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:18 [19:26:18.897] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0a59620edd95d1264a38a79fd7da2d7234c666b2138dd4099079ec50c7f8fb23","blockNumber":4,"slot":5} 19:26:18 [19:26:18.975] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:19 [19:26:19.180] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:19 [19:26:19.382] WARN: pxe:service No artifact found for contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c when looking for its metadata 19:26:19 [19:26:19.383] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c as part of deployment for 0x119596348c864a1f1337a635600195cfa3ba8cd7eede6cb73b72933290f9fe95 19:26:19 [19:26:19.391] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:19 [19:26:19.500] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0a59620edd95d1264a38a79fd7da2d7234c666b2138dd4099079ec50c7f8fb23","blockNumber":4,"slot":5} 19:26:19 [19:26:19.523] INFO: pxe:service Added contract AuthWitTest at 0x119596348c864a1f1337a635600195cfa3ba8cd7eede6cb73b72933290f9fe95 with class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c 19:26:19 [19:26:19.543] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x0a59620edd95d1264a38a79fd7da2d7234c666b2138dd4099079ec50c7f8fb23","header":{"contentCommitment":{"blobsHash":"0x00803585a005a6a3b2dd6644219f8283ea5f621e2b3a62c5364d1e7ed19a149c","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750188700,"version":2928111036},"lastArchive":"0x14d424c5de1feaacd7e1b5d7ac500c40615d842fa1b2fa6673e8093b4aa7f17a","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x098e3036cb9d540ad28cc81c249bae6eeeee572d2a1734425889346cbb101a52","nullifierTree":"0x2934b24ab0eaba1be66223e29ff42f3d1f0a17d01aa87642e4aec719a78f5d73","publicDataTree":"0x19ef59e7caf5f2dfb3abfc003c116eaf14d9a6bfb332109b606bafcf36bc1926"},"totalFees":5496909440,"totalManaUsed":16544}} 19:26:19 [19:26:19.609] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:19 [19:26:19.645] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:19 [19:26:19.706] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:19 [19:26:19.707] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:19 [19:26:19.802] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:19 [19:26:19.809] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:19 [19:26:19.822] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:19 [19:26:19.823] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:19 [19:26:19.830] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:19 [19:26:19.831] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:19 [19:26:19.834] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:19 [19:26:19.836] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:19 [19:26:19.847] VERBOSE: simulator:client_execution_context:debug_log Setting 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 as fee payer 19:26:19 [19:26:19.878] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:26:20 [19:26:20.296] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0b531072c192262f69310be602c8bfeb8f4e36acff72ed861afd4f76ee50de56,0x2054c0397fca7702b6f9252401dd1f653f4e20cff98e2eb5395de9bbdc250278,0x2b6ecadb0b2de2c700fc27a25c15b4c8eb590b62f353cdd047a57ce195071418 19:26:20 [19:26:20.425] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:26:20 [19:26:20.499] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:20 [19:26:20.576] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 19:26:20 [19:26:20.600] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0a59620edd95d1264a38a79fd7da2d7234c666b2138dd4099079ec50c7f8fb23","blockNumber":4,"slot":5} 19:26:20 [19:26:20.644] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:26:20 [19:26:20.665] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x119596348c864a1f1337a635600195cfa3ba8cd7eede6cb73b72933290f9fe95,0x0000000000000000000000000000000000000000000000000000000000000001,0x29e3555162ceecb185e18ddbdf7343bc14e8512aa714a8484796d9227ae6d516,0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 19:26:20 [19:26:20.730] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:20 [19:26:20.940] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:21 [19:26:21.229] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:21 [19:26:21.315] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0a59620edd95d1264a38a79fd7da2d7234c666b2138dd4099079ec50c7f8fb23","blockNumber":4,"slot":5} 19:26:21 [19:26:21.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:22 [19:26:22.060] INFO: pxe:service Proving completed in 2523.415423000002ms {"timings":{"total":2523.415423000002,"sync":8.271969999997964,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":315.14044300000023,"oracles":{"debugLog":{"times":[4.390206000000035,0.45619000000078813,0.49442099999942,0.567482000002201,0.5024110000013025,0.3331770000004326,0.22920499999963795,0.44715999999971245]},"fetchTaggedLogs":{"times":[100.70049999999901]},"loadCapsule":{"times":[0.21076499999981024,0.17580300000190618,0.5561419999976351,0.3067960000007588,0.24466599999868777,0.1732640000009269]},"getSharedSecret":{"times":[5.319225999999617]},"aes128Decrypt":{"times":[0.2387349999989965,0.7517659999975876]},"getPublicKeysAndPartialAddress":{"times":[2.771629999999277]},"getKeyValidationRequest":{"times":[1.8263200000001234]},"deliverNote":{"times":[3.074306999998953]},"deleteCapsule":{"times":[0.28159600000071805]},"storeCapsule":{"times":[0.2761060000011639]},"getNotes":{"times":[1.347089999999298]},"getAuthWitness":{"times":[0.202794000000722]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07201200000054087]},"callPrivateFunction":{"times":[649.0096059999996,175.77253299999938]}}},{"functionName":"private_kernel_init","time":86.67775600000095},{"functionName":"ContractClassRegisterer:register","time":637.3666630000007,"oracles":{"loadCapsule":{"times":[3.1252779999995255]},"notifyCreatedNullifier":{"times":[0.4019079999998212]},"debugLog":{"times":[0.5715129999989585]},"notifyCreatedContractClassLog":{"times":[9.760753000002296]}}},{"functionName":"private_kernel_inner","time":177.00994999999966},{"functionName":"ContractInstanceDeployer:deploy","time":105.72074899999643,"oracles":{"storeInExecutionCache":{"times":[0.15263300000151503]},"callPrivateFunction":{"times":[70.83069999999861]},"notifyCreatedNullifier":{"times":[0.40251899999930174]},"debugLog":{"times":[0.6855649999997695]}}},{"functionName":"private_kernel_inner","time":151.2844299999997},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":47.137956000002305,"oracles":{}},{"functionName":"private_kernel_inner","time":169.38698400000067},{"functionName":"private_kernel_reset","time":198.90018599999894},{"functionName":"private_kernel_tail","time":80.82938799999829}],"unaccounted":545.6889480000063}} 19:26:22 [19:26:22.075] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:22 [19:26:22.276] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x0a59620edd95d1264a38a79fd7da2d7234c666b2138dd4099079ec50c7f8fb23","blockNumber":4,"slot":5} 19:26:22 [19:26:22.282] VERBOSE: p2p:tx_pool Adding tx 0x26adf41e5dfc9407c3d573e5eb454b9cf6e7aab21f504b54c0ec2934df192f0f to pool {"eventName":"tx-added-to-pool","txHash":"0x26adf41e5dfc9407c3d573e5eb454b9cf6e7aab21f504b54c0ec2934df192f0f","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":55,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 19:26:22 [19:26:22.289] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:22 [19:26:22.324] INFO: node Received tx 0x26adf41e5dfc9407c3d573e5eb454b9cf6e7aab21f504b54c0ec2934df192f0f {"txHash":"0x26adf41e5dfc9407c3d573e5eb454b9cf6e7aab21f504b54c0ec2934df192f0f"} 19:26:22 [19:26:22.325] INFO: pxe:service Sent transaction 0x26adf41e5dfc9407c3d573e5eb454b9cf6e7aab21f504b54c0ec2934df192f0f 19:26:22 [19:26:22.526] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:22 [19:26:22.731] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:22 [19:26:22.828] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 19:26:22 [19:26:22.866] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-17T19:32:16.000Z","now":"2025-06-17T19:32:20.460Z"} 19:26:22 [19:26:22.938] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:23 [19:26:23.271] VERBOSE: simulator:public-processor Processed tx 0x26adf41e5dfc9407c3d573e5eb454b9cf6e7aab21f504b54c0ec2934df192f0f with no public calls in 235.1341440000033ms {"txHash":"0x26adf41e5dfc9407c3d573e5eb454b9cf6e7aab21f504b54c0ec2934df192f0f","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":235.1341440000033} 19:26:23 [19:26:23.273] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:23 [19:26:23.275] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.4082428790000013s {"duration":0.4082428790000013,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":39424,"l2Gas":16544},"totalSizeInBytes":2720} 19:26:23 [19:26:23.415] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1760bfc38264f63ef1a230a450453f1aadd8145fb40c3316a96e049e708df75c","globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":4,"slotNumber":5,"timestamp":1750188736,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x26adf41e5dfc9407c3d573e5eb454b9cf6e7aab21f504b54c0ec2934df192f0f"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":590.910391999998,"publicProcessDuration":408.56405599999925,"rollupCircuitsDuration":554.9925409999996,"txCount":1,"blockNumber":4,"blockTimestamp":1750188736,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 19:26:23 [19:26:23.421] VERBOSE: sequencer Attesting committee is empty 19:26:23 [19:26:23.514] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:23 [19:26:23.760] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:23 [19:26:23.799] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xdbef2932a54e608ef37c18d7837b958a345d0540b2e15ed8c8d951a5cf4763c1 19:26:23 [19:26:23.800] VERBOSE: sequencer-client Sent L1 transaction 0xdbef2932a54e608ef37c18d7837b958a345d0540b2e15ed8c8d951a5cf4763c1 {"gasLimit":470246,"maxFeePerGas":"1.26112774","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:26:23 [19:26:23.810] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 19:26:23 [19:26:23.817] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 19:26:23 [19:26:23.819] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188772] on http://127.0.0.1:8545 19:26:23 [19:26:23.821] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 19:26:23 [19:26:23.822] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:26:23 [19:26:23.824] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188772 19:26:23 [19:26:23.825] WARN: foundation:test-date-provider Time set to 2025-06-17T19:32:52.000Z {"offset":388175,"timeMs":1750188772000} 19:26:23 [19:26:23.825] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 19:26:23 [19:26:23.828] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:26:23 [19:26:23.829] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xdbef2932a54e608ef37c18d7837b958a345d0540b2e15ed8c8d951a5cf4763c1","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":4,"blockTimestamp":1750188736,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 19:26:23 [19:26:23.829] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:26:23 [19:26:23.834] INFO: blob-sink:server Received blob sidecar for block 0xbb2259de0eab571ca4cc89a41e9d687a10e7019527c6af13c48ee0df8acec839 19:26:23 [19:26:23.839] INFO: blob-sink:server Blob sidecar stored successfully for block 0xbb2259de0eab571ca4cc89a41e9d687a10e7019527c6af13c48ee0df8acec839 19:26:24 [19:26:23.999] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:24 [19:26:24.204] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:24 [19:26:24.440] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:24 [19:26:24.476] VERBOSE: archiver:block-helper Store contract instance at 0x119596348c864a1f1337a635600195cfa3ba8cd7eede6cb73b72933290f9fe95 19:26:24 [19:26:24.481] VERBOSE: archiver:block-helper Store contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c 19:26:24 [19:26:24.512] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x1760bfc38264f63ef1a230a450453f1aadd8145fb40c3316a96e049e708df75c","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":4,"slotNumber":5,"timestamp":1750188736,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x08103c4af93a5bc858fc8c0ce3a04b4454a50220ea0f6cb17b25297eaaae875f","archiveNextLeafIndex":5} 19:26:24 [19:26:24.521] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 19:26:24 [19:26:24.584] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":17.818488000000798,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750188736,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 19:26:24 [19:26:24.654] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:24 [19:26:24.665] VERBOSE: p2p Synched to latest block 4 19:26:24 [19:26:24.862] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:25 [19:26:25.049] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x08103c4af93a5bc858fc8c0ce3a04b4454a50220ea0f6cb17b25297eaaae875f","blockNumber":5,"slot":6} 19:26:25 [19:26:25.070] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:25 [19:26:25.272] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:25 [19:26:25.476] INFO: aztecjs:deploy_sent_tx Contract 0x119596348c864a1f1337a635600195cfa3ba8cd7eede6cb73b72933290f9fe95 successfully deployed. 19:26:25 [19:26:25.480] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data happy path 19:26:25 [19:26:25.486] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:25 [19:26:25.501] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x08103c4af93a5bc858fc8c0ce3a04b4454a50220ea0f6cb17b25297eaaae875f","header":{"contentCommitment":{"blobsHash":"0x000a4c1dab0d0d3fd1096eb2b92d1c9c801015c4c16341cd19df1fb73cbf6523","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750188736,"version":2928111036},"lastArchive":"0x0a59620edd95d1264a38a79fd7da2d7234c666b2138dd4099079ec50c7f8fb23","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x098e3036cb9d540ad28cc81c249bae6eeeee572d2a1734425889346cbb101a52","nullifierTree":"0x105d2335ebf008b32616754acd5779b1e4b65b43fa02b45a3835d7b0262b7d61","publicDataTree":"0x0de1419dbb78b473b9d3ef70528e54440410597d915d0c72a876d281d6c53dce"},"totalFees":838780800,"totalManaUsed":16544}} 19:26:25 [19:26:25.616] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:25 [19:26:25.643] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:25 [19:26:25.644] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:25 [19:26:25.708] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:25 [19:26:25.741] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x08103c4af93a5bc858fc8c0ce3a04b4454a50220ea0f6cb17b25297eaaae875f","blockNumber":5,"slot":6} 19:26:25 [19:26:25.793] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:25 [19:26:25.802] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:25 [19:26:25.814] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:25 [19:26:25.815] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:25 [19:26:25.821] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:25 [19:26:25.821] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:25 [19:26:25.824] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:25 [19:26:25.826] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:25 [19:26:25.848] VERBOSE: simulator Utility simulation for 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8.0xd191fb1a completed 19:26:25 [19:26:25.898] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:25 [19:26:25.902] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:25 [19:26:25.912] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:26 [19:26:26.031] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","selector":"0xd191fb1a"} 19:26:26 [19:26:26.050] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:26 [19:26:26.051] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:26 [19:26:26.118] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:26 [19:26:26.136] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:26 [19:26:26.142] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2a95f23b192d081735519486e9d69390edd56b5fe1d19f803ad872fa241dc0b8 19:26:26 [19:26:26.156] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:26 [19:26:26.158] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:26 [19:26:26.181] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:26 [19:26:26.182] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:26 [19:26:26.189] VERBOSE: pxe:service Added note {"index":64,"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x18d5faecf024666c8b0281f2beeda5c339ad96f3cfe7c761a41a2d11adaaee0f","nullifier":"0x288269cd2776fae62673bd0a6d400df53145f511e8812e9d82ef86adb20ec2a0"} 19:26:26 [19:26:26.195] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:26 [19:26:26.215] VERBOSE: simulator Utility simulation for 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92.0xd191fb1a completed 19:26:26 [19:26:26.279] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:26 [19:26:26.289] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:26 [19:26:26.296] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x08103c4af93a5bc858fc8c0ce3a04b4454a50220ea0f6cb17b25297eaaae875f","blockNumber":5,"slot":6} 19:26:26 [19:26:26.324] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:26 [19:26:26.450] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:26 [19:26:26.513] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:26 [19:26:26.513] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:26 [19:26:26.547] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:26 [19:26:26.583] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:26 [19:26:26.590] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2a95f23b192d081735519486e9d69390edd56b5fe1d19f803ad872fa241dc0b8 19:26:26 [19:26:26.600] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:26 [19:26:26.601] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:26 [19:26:26.608] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:26 [19:26:26.609] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:26 [19:26:26.613] VERBOSE: pxe:service Added note {"index":64,"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x18d5faecf024666c8b0281f2beeda5c339ad96f3cfe7c761a41a2d11adaaee0f","nullifier":"0x288269cd2776fae62673bd0a6d400df53145f511e8812e9d82ef86adb20ec2a0"} 19:26:26 [19:26:26.621] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:26 [19:26:26.652] VERBOSE: simulator:client_execution_context:debug_log Setting 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 as fee payer 19:26:26 [19:26:26.673] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x119596348c864a1f1337a635600195cfa3ba8cd7eede6cb73b72933290f9fe95"} 19:26:26 [19:26:26.792] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:26 [19:26:26.825] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:26 [19:26:26.866] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:26 [19:26:26.867] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:27 [19:26:27.006] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x08103c4af93a5bc858fc8c0ce3a04b4454a50220ea0f6cb17b25297eaaae875f","blockNumber":5,"slot":6} 19:26:27 [19:26:27.082] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:27 [19:26:27.091] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:27 [19:26:27.099] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:27 [19:26:27.122] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:27 [19:26:27.123] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:27 [19:26:27.140] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:27 [19:26:27.141] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:27 [19:26:27.146] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:27 [19:26:27.148] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:27 [19:26:27.391] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:27 [19:26:27.677] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:27 [19:26:27.980] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:27 [19:26:27.990] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x08103c4af93a5bc858fc8c0ce3a04b4454a50220ea0f6cb17b25297eaaae875f","blockNumber":5,"slot":6} 19:26:28 [19:26:28.322] INFO: pxe:service Proving completed in 2015.7528610000008ms {"timings":{"total":2015.7528610000008,"sync":20.08771699999852,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":316.6323360000024,"oracles":{"debugLog":{"times":[0.6753449999996519,0.47303000000101747,0.472700000002078,0.6694940000015777,0.5857120000000577,0.3768679999993765,0.5275709999987157,0.7094749999996566]},"fetchTaggedLogs":{"times":[74.51825100000133]},"loadCapsule":{"times":[0.23665499999697204,0.40594899999996414,0.42107899999973597,0.1943539999992936,0.5037009999978181,1.0051319999984116]},"getSharedSecret":{"times":[2.9162230000001728]},"aes128Decrypt":{"times":[0.3555080000005546,0.9602799999993294]},"getPublicKeysAndPartialAddress":{"times":[2.1255160000000615]},"getKeyValidationRequest":{"times":[1.697877000002336]},"deliverNote":{"times":[3.9468959999976505]},"deleteCapsule":{"times":[2.298800000000483]},"storeCapsule":{"times":[4.3428339999991294]},"getNotes":{"times":[10.191870999999082]},"getAuthWitness":{"times":[0.31061699999918346]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06481199999689125]},"callPrivateFunction":{"times":[528.4417939999985]}}},{"functionName":"private_kernel_init","time":100.9590160000007},{"functionName":"AuthWitTest:consume","time":73.14916200000152,"oracles":{"storeInExecutionCache":{"times":[0.1254129999979341]},"callPrivateFunction":{"times":[491.4438489999993]},"loadFromExecutionCache":{"times":[0.27173599999878206]},"notifyCreatedNullifier":{"times":[0.3079969999998866]}}},{"functionName":"private_kernel_inner","time":196.5552549999993},{"functionName":"SchnorrAccount:verify_private_authwit","time":445.65317199999845,"oracles":{"debugLog":{"times":[0.8725990000020829,0.7417960000020685,0.7437659999995958,0.7929680000015651,0.5644720000018424,0.49420000000100117,0.3937079999996058]},"fetchTaggedLogs":{"times":[229.3590890000014]},"loadCapsule":{"times":[0.21436399999947753,0.19142500000089058,0.5018110000019078,0.17029299999921932,0.21074399999997695,0.19490399999995134]},"getSharedSecret":{"times":[13.912892000000284]},"aes128Decrypt":{"times":[0.38621799999964423,1.092904000000999]},"getPublicKeysAndPartialAddress":{"times":[5.250024000000849]},"getKeyValidationRequest":{"times":[7.283229000000574]},"deliverNote":{"times":[4.53219800000079]},"deleteCapsule":{"times":[0.23079499999948894]},"storeCapsule":{"times":[1.167035999998916]},"getNotes":{"times":[1.940841999999975]},"getAuthWitness":{"times":[0.1516540000011446]},"storeInExecutionCache":{"times":[0.2020940000002156]}}},{"functionName":"private_kernel_inner","time":153.25361300000077},{"functionName":"private_kernel_reset","time":238.80363399999987},{"functionName":"private_kernel_tail","time":104.19649600000048}],"unaccounted":366.4624599999988}} 19:26:28 [19:26:28.336] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:28 [19:26:28.368] VERBOSE: p2p:tx_pool Adding tx 0x02416daef992ba566dee19b9c16c6ac56d462a7f2247833c99c073ce7248767c to pool {"eventName":"tx-added-to-pool","txHash":"0x02416daef992ba566dee19b9c16c6ac56d462a7f2247833c99c073ce7248767c","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 19:26:28 [19:26:28.376] INFO: node Received tx 0x02416daef992ba566dee19b9c16c6ac56d462a7f2247833c99c073ce7248767c {"txHash":"0x02416daef992ba566dee19b9c16c6ac56d462a7f2247833c99c073ce7248767c"} 19:26:28 [19:26:28.377] INFO: pxe:service Sent transaction 0x02416daef992ba566dee19b9c16c6ac56d462a7f2247833c99c073ce7248767c 19:26:28 [19:26:28.541] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:28 [19:26:28.565] VERBOSE: sequencer Building block 5 for slot 6 {"slot":6,"blockNumber":5,"msgCount":0} 19:26:28 [19:26:28.598] VERBOSE: sequencer Processing pending txs {"slot":6,"slotStart":"2025-06-17T19:32:52.000Z","now":"2025-06-17T19:32:56.773Z"} 19:26:28 [19:26:28.736] VERBOSE: simulator:public-processor Processed tx 0x02416daef992ba566dee19b9c16c6ac56d462a7f2247833c99c073ce7248767c with no public calls in 55.03601699999854ms {"txHash":"0x02416daef992ba566dee19b9c16c6ac56d462a7f2247833c99c073ce7248767c","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":55.03601699999854} 19:26:28 [19:26:28.739] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.13989603299999726s {"duration":0.13989603299999726,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":11200},"totalSizeInBytes":288} 19:26:28 [19:26:28.749] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:29 [19:26:29.173] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:29 [19:26:29.210] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x215c839e813de63d7535c93f876633cffdb6369c9867f4c4b5e35157e188bcd8","globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":5,"slotNumber":6,"timestamp":1750188772,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x02416daef992ba566dee19b9c16c6ac56d462a7f2247833c99c073ce7248767c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":647.7361029999993,"publicProcessDuration":140.81314199999906,"rollupCircuitsDuration":617.5113549999987,"txCount":1,"blockNumber":5,"blockTimestamp":1750188772,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:29 [19:26:29.218] VERBOSE: sequencer Attesting committee is empty 19:26:29 [19:26:29.395] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:29 [19:26:29.600] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:29 [19:26:29.609] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x53545499349c0faf22e0f0c7b9e7879fb8049d2223a2c6a0057acbb9392f19b5 19:26:29 [19:26:29.609] VERBOSE: sequencer-client Sent L1 transaction 0x53545499349c0faf22e0f0c7b9e7879fb8049d2223a2c6a0057acbb9392f19b5 {"gasLimit":470310,"maxFeePerGas":"1.246952005","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:26:29 [19:26:29.621] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 19:26:29 [19:26:29.626] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188808] on http://127.0.0.1:8545 19:26:29 [19:26:29.628] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 19:26:29 [19:26:29.633] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:26:29 [19:26:29.637] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:26:29 [19:26:29.638] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x53545499349c0faf22e0f0c7b9e7879fb8049d2223a2c6a0057acbb9392f19b5","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":5,"blockTimestamp":1750188772,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:29 [19:26:29.638] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:26:29 [19:26:29.641] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188808 19:26:29 [19:26:29.641] WARN: foundation:test-date-provider Time set to 2025-06-17T19:33:28.000Z {"offset":418359,"timeMs":1750188808000} 19:26:29 [19:26:29.641] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 19:26:29 [19:26:29.642] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 19:26:29 [19:26:29.644] INFO: blob-sink:server Received blob sidecar for block 0xc1595cf0450e9ccc7ddbf1edfc282f2e8115b0dbeba274de2a84fff6ec151fa3 19:26:29 [19:26:29.648] INFO: blob-sink:server Blob sidecar stored successfully for block 0xc1595cf0450e9ccc7ddbf1edfc282f2e8115b0dbeba274de2a84fff6ec151fa3 19:26:29 [19:26:29.804] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:30 [19:26:30.058] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:30 [19:26:30.080] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x215c839e813de63d7535c93f876633cffdb6369c9867f4c4b5e35157e188bcd8","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":5,"slotNumber":6,"timestamp":1750188772,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","archiveNextLeafIndex":6} 19:26:30 [19:26:30.085] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 19:26:30 [19:26:30.213] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":25.041353000000527,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750188772,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:30 [19:26:30.227] VERBOSE: p2p Synched to latest block 5 19:26:30 [19:26:30.265] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:30 [19:26:30.423] VERBOSE: pxe:service Updated pxe last block to 5 {"blockHash":{},"archive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","header":{"contentCommitment":{"blobsHash":"0x00901f71c40b4f89c4c7656ff95cc516f59b5f3abff4af55d55a88d1bfb7347d","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750188772,"version":2928111036},"lastArchive":"0x08103c4af93a5bc858fc8c0ce3a04b4454a50220ea0f6cb17b25297eaaae875f","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x098e3036cb9d540ad28cc81c249bae6eeeee572d2a1734425889346cbb101a52","nullifierTree":"0x2e51cdc3d9bf963329c8cb833563eec7063ac441878871d74782718c0524204f","publicDataTree":"0x0bec75171152cab752bc6ef1d1369e84606aa98f981e8a1060a4679a21f53910"},"totalFees":567840000,"totalManaUsed":11200}} 19:26:30 [19:26:30.509] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:30 [19:26:30.662] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:30 [19:26:30.692] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:30 [19:26:30.692] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:30 [19:26:30.722] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:30 [19:26:30.795] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","blockNumber":6,"slot":7} 19:26:30 [19:26:30.879] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:30 [19:26:30.906] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:30 [19:26:30.933] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:30 [19:26:30.958] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:30 [19:26:30.959] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:30 [19:26:30.971] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:30 [19:26:30.972] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:30 [19:26:30.980] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:30 [19:26:30.984] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:31 [19:26:31.007] WARN: node Nullifier 5173558886763428424491504912029339299506888402038511223614635241147183322696 already exists in the tree 19:26:31 [19:26:31.009] VERBOSE: simulator Utility simulation for 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8.0xd191fb1a completed 19:26:31 [19:26:31.085] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:31 [19:26:31.091] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:31 [19:26:31.188] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:31 [19:26:31.307] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:31 [19:26:31.397] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:31 [19:26:31.397] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:31 [19:26:31.452] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:31 [19:26:31.463] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","blockNumber":6,"slot":7} 19:26:31 [19:26:31.497] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:31 [19:26:31.506] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2a95f23b192d081735519486e9d69390edd56b5fe1d19f803ad872fa241dc0b8 19:26:31 [19:26:31.520] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:31 [19:26:31.521] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:31 [19:26:31.532] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:31 [19:26:31.533] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:31 [19:26:31.545] VERBOSE: pxe:service Added note {"index":64,"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x18d5faecf024666c8b0281f2beeda5c339ad96f3cfe7c761a41a2d11adaaee0f","nullifier":"0x288269cd2776fae62673bd0a6d400df53145f511e8812e9d82ef86adb20ec2a0"} 19:26:31 [19:26:31.549] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:31 [19:26:31.571] VERBOSE: simulator:client_execution_context:debug_log Setting 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 as fee payer 19:26:31 [19:26:31.597] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x119596348c864a1f1337a635600195cfa3ba8cd7eede6cb73b72933290f9fe95"} 19:26:31 [19:26:31.681] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:31 [19:26:31.719] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:31 [19:26:31.750] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:31 [19:26:31.750] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:31 [19:26:31.875] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:31 [19:26:31.882] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:31 [19:26:31.893] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:31 [19:26:31.894] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:31 [19:26:31.906] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:31 [19:26:31.906] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:31 [19:26:31.910] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:31 [19:26:31.913] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:31 [19:26:31.960] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:32 [19:26:32.150] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","blockNumber":6,"slot":7} 19:26:32 [19:26:32.340] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:32 [19:26:32.655] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:32 [19:26:32.995] INFO: pxe:service Proving completed in 1867.1352750000005ms {"timings":{"total":1867.1352750000005,"sync":4.380415999999968,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":397.1873789999954,"oracles":{"debugLog":{"times":[0.4988710000034189,0.5327319999996689,0.5563419999962207,0.6165030000047409,0.4806010000029346,0.46203099999547703,0.4684999999954016,0.6726239999989048]},"fetchTaggedLogs":{"times":[107.0910739999963]},"loadCapsule":{"times":[0.2602760000008857,0.20104400000127498,0.44720999999844935,0.19690499999705935,0.7393470000024536,0.2206850000002305]},"getSharedSecret":{"times":[4.228883000003407]},"aes128Decrypt":{"times":[0.26140599999780534,1.1165250000049127]},"getPublicKeysAndPartialAddress":{"times":[2.467785000000731]},"getKeyValidationRequest":{"times":[5.9557609999974375]},"deliverNote":{"times":[12.776852999995754]},"deleteCapsule":{"times":[0.7223159999994095]},"storeCapsule":{"times":[0.3881879999971716]},"getNotes":{"times":[6.2323079999987385]},"getAuthWitness":{"times":[0.3868590000056429]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0918519999977434]},"callPrivateFunction":{"times":[371.1524649999992]}}},{"functionName":"private_kernel_init","time":77.26431600000069},{"functionName":"AuthWitTest:consume","time":74.10458499999368,"oracles":{"storeInExecutionCache":{"times":[0.10819199999968987]},"callPrivateFunction":{"times":[333.33956999999646]},"loadFromExecutionCache":{"times":[0.07544200000120327]},"notifyCreatedNullifier":{"times":[0.38986799999838695]}}},{"functionName":"private_kernel_inner","time":159.26026700000511},{"functionName":"SchnorrAccount:verify_private_authwit","time":288.97302100000525,"oracles":{"debugLog":{"times":[0.7241159999975935,0.5155919999961043,0.4218789999940782,0.5340309999955934,0.5595719999982975,0.33545800000138115,0.3470980000056443]},"fetchTaggedLogs":{"times":[128.9824379999991]},"loadCapsule":{"times":[0.19338499999867054,0.17478400000254624,1.0446630000005825,0.18992399999842746,0.2091050000017276,0.22000499999558087]},"getSharedSecret":{"times":[4.622371999997995]},"aes128Decrypt":{"times":[0.23773599999549333,0.7026259999984177]},"getPublicKeysAndPartialAddress":{"times":[4.8733179999981076]},"getKeyValidationRequest":{"times":[2.989825999997265]},"deliverNote":{"times":[4.5021599999963655]},"deleteCapsule":{"times":[0.3282970000000205]},"storeCapsule":{"times":[0.3470880000022589]},"getNotes":{"times":[1.6367559999998775]},"getAuthWitness":{"times":[0.1548530000000028]},"storeInExecutionCache":{"times":[0.14668300000630552]}}},{"functionName":"private_kernel_inner","time":170.9274740000037},{"functionName":"private_kernel_reset","time":242.96416500000487},{"functionName":"private_kernel_tail","time":98.61479800000234}],"unaccounted":353.4588539999895}} 19:26:33 [19:26:33.010] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:33 [19:26:33.044] VERBOSE: p2p:tx_validator:tx_double_spend Rejecting tx 0x023734c5682d4d543895b1c4cc83619d4ae9eda5bc0b141f3ef2cbd42cfef7fb for repeating a nullifier 19:26:33 [19:26:33.047] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","blockNumber":6,"slot":7} 19:26:33 [19:26:33.051] WARN: node Received invalid tx 0x023734c5682d4d543895b1c4cc83619d4ae9eda5bc0b141f3ef2cbd42cfef7fb: Existing nullifier {"txHash":"0x023734c5682d4d543895b1c4cc83619d4ae9eda5bc0b141f3ef2cbd42cfef7fb"} 19:26:33 [19:26:33.061] ERROR: pxe:service Error: Error: Invalid tx: Existing nullifier 19:26:33 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19) 19:26:33 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 19:26:33 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 19:26:33 [19:26:33.067] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid chain id 19:26:33 [19:26:33.218] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:33 [19:26:33.231] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:33 [19:26:33.234] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:33 [19:26:33.234] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:33 [19:26:33.374] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:33 [19:26:33.382] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:33 [19:26:33.408] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:33 [19:26:33.409] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:33 [19:26:33.419] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:33 [19:26:33.420] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:33 [19:26:33.429] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:33 [19:26:33.432] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:33 [19:26:33.441] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:33 [19:26:33.507] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:33 [19:26:33.587] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:33 [19:26:33.644] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:33 [19:26:33.672] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 {"origin":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000ae876dbc","authWitnesses":["0x13606c7fc616d53fb1d2db487b4138c55d8cbc83eee583f400e16f49bcc4b2cb"]} 19:26:33 [19:26:33.681] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","blockNumber":6,"slot":7} 19:26:33 [19:26:33.791] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:33 [19:26:33.858] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:33 [19:26:33.860] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:33 [19:26:33.866] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:33 [19:26:33.953] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:33 [19:26:33.961] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2a95f23b192d081735519486e9d69390edd56b5fe1d19f803ad872fa241dc0b8 19:26:33 [19:26:33.976] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:33 [19:26:33.978] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:33 [19:26:33.984] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:33 [19:26:33.985] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:33 [19:26:33.990] VERBOSE: pxe:service Added note {"index":64,"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x18d5faecf024666c8b0281f2beeda5c339ad96f3cfe7c761a41a2d11adaaee0f","nullifier":"0x288269cd2776fae62673bd0a6d400df53145f511e8812e9d82ef86adb20ec2a0"} 19:26:33 [19:26:33.992] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:34 [19:26:34.009] VERBOSE: simulator:client_execution_context:debug_log Setting 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 as fee payer 19:26:34 [19:26:34.028] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x119596348c864a1f1337a635600195cfa3ba8cd7eede6cb73b72933290f9fe95"} 19:26:34 [19:26:34.113] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:34 [19:26:34.144] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:34 [19:26:34.172] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:34 [19:26:34.173] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:34 [19:26:34.229] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","blockNumber":6,"slot":7} 19:26:34 [19:26:34.252] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:34 [19:26:34.259] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:34 [19:26:34.268] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:34 [19:26:34.269] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:34 [19:26:34.274] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:34 [19:26:34.275] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:34 [19:26:34.277] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:34 [19:26:34.279] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:34 [19:26:34.336] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid version 19:26:34 [19:26:34.401] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:34 [19:26:34.432] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:34 [19:26:34.453] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:34 [19:26:34.453] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:34 [19:26:34.525] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:34 [19:26:34.533] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:34 [19:26:34.542] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:34 [19:26:34.543] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:34 [19:26:34.548] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:34 [19:26:34.549] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:34 [19:26:34.552] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:34 [19:26:34.554] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:34 [19:26:34.637] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:34 [19:26:34.648] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:34 [19:26:34.652] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:34 [19:26:34.698] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 {"origin":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000ae876dbc","authWitnesses":["0x1ae0a438ab1137a08079c5f0025e5539d110d99d458f24f1cddd5fa32d7d5864"]} 19:26:34 [19:26:34.826] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:34 [19:26:34.884] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:34 [19:26:34.885] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:34 [19:26:34.886] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:34 [19:26:34.948] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","blockNumber":6,"slot":7} 19:26:34 [19:26:34.988] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:34 [19:26:34.999] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2a95f23b192d081735519486e9d69390edd56b5fe1d19f803ad872fa241dc0b8 19:26:35 [19:26:35.013] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:35 [19:26:35.014] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:35 [19:26:35.025] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:35 [19:26:35.026] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:35 [19:26:35.030] VERBOSE: pxe:service Added note {"index":64,"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x18d5faecf024666c8b0281f2beeda5c339ad96f3cfe7c761a41a2d11adaaee0f","nullifier":"0x288269cd2776fae62673bd0a6d400df53145f511e8812e9d82ef86adb20ec2a0"} 19:26:35 [19:26:35.033] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:35 [19:26:35.048] VERBOSE: simulator:client_execution_context:debug_log Setting 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 as fee payer 19:26:35 [19:26:35.070] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x119596348c864a1f1337a635600195cfa3ba8cd7eede6cb73b72933290f9fe95"} 19:26:35 [19:26:35.117] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:35 [19:26:35.174] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:35 [19:26:35.207] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:35 [19:26:35.207] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:35 [19:26:35.275] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:35 [19:26:35.282] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:35 [19:26:35.294] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:35 [19:26:35.295] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:35 [19:26:35.305] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:35 [19:26:35.306] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:35 [19:26:35.316] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:35 [19:26:35.320] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:35 [19:26:35.367] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:35 [19:26:35.471] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:35 [19:26:35.506] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:35 [19:26:35.507] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:35 [19:26:35.552] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","blockNumber":6,"slot":7} 19:26:35 [19:26:35.574] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:35 [19:26:35.605] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:35 [19:26:35.613] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:35 [19:26:35.628] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:35 [19:26:35.629] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:35 [19:26:35.640] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:35 [19:26:35.641] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:35 [19:26:35.644] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:35 [19:26:35.647] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:35 [19:26:35.714] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:35 [19:26:35.724] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:35 [19:26:35.726] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data happy path 19:26:35 [19:26:35.788] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:35 [19:26:35.822] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:35 [19:26:35.838] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:35 [19:26:35.838] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:35 [19:26:35.899] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:35 [19:26:35.906] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:35 [19:26:35.921] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:35 [19:26:35.922] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:35 [19:26:35.940] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:35 [19:26:35.940] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:35 [19:26:35.950] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:35 [19:26:35.954] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:35 [19:26:35.970] VERBOSE: simulator Utility simulation for 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8.0xd191fb1a completed 19:26:36 [19:26:36.020] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:36 [19:26:36.027] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:36 [19:26:36.042] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:36 [19:26:36.149] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:36 [19:26:36.196] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:36 [19:26:36.197] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:36 [19:26:36.221] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","blockNumber":6,"slot":7} 19:26:36 [19:26:36.249] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:36 [19:26:36.296] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:36 [19:26:36.307] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:36 [19:26:36.330] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:36 [19:26:36.331] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:36 [19:26:36.342] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:36 [19:26:36.343] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:36 [19:26:36.347] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:36 [19:26:36.351] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:36 [19:26:36.368] VERBOSE: simulator:client_execution_context:debug_log Setting 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 as fee payer 19:26:36 [19:26:36.486] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:36 [19:26:36.942] INFO: pxe:service Proving completed in 900.0992539999934ms {"timings":{"total":900.0992539999934,"sync":8.842024999998102,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":287.6149110000042,"oracles":{"debugLog":{"times":[0.5092609999992419,0.5586619999958202,0.6122840000025462,0.6293239999940852,0.5043510000032256,0.4005689999976312,0.49150099999678787,0.4774210000032326]},"fetchTaggedLogs":{"times":[103.60365699999966]},"loadCapsule":{"times":[0.3181670000049053,2.397753000004741,2.09043599999859,2.1312870000037947,0.28298699999868404,0.6785350000063772]},"getSharedSecret":{"times":[14.849477999996452]},"aes128Decrypt":{"times":[0.30143600000155857,0.983912000003329]},"getPublicKeysAndPartialAddress":{"times":[3.2062000000005355]},"getKeyValidationRequest":{"times":[3.9581680000046617]},"deliverNote":{"times":[3.784004000001005]},"deleteCapsule":{"times":[0.3894880000007106]},"storeCapsule":{"times":[0.2509460000001127]},"getNotes":{"times":[3.6936710000009043]},"getAuthWitness":{"times":[0.23273499999777414]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.27034599999751663]},"notifyEnqueuedPublicFunctionCall":{"times":[0.30406699999730336]}}},{"functionName":"private_kernel_init","time":95.7034829999975},{"functionName":"private_kernel_reset","time":233.8743239999967},{"functionName":"private_kernel_tail","time":107.79330000000482}],"unaccounted":166.27121099999204}} 19:26:36 [19:26:36.967] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:36 [19:26:36.993] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","blockNumber":6,"slot":7} 19:26:36 [19:26:36.998] VERBOSE: p2p:tx_pool Adding tx 0x12d77a82bc4a461e265e0195c95bf50be376c73138fa0c95ea3183a3ee470370 to pool {"eventName":"tx-added-to-pool","txHash":"0x12d77a82bc4a461e265e0195c95bf50be376c73138fa0c95ea3183a3ee470370","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 19:26:37 [19:26:37.008] INFO: node Received tx 0x12d77a82bc4a461e265e0195c95bf50be376c73138fa0c95ea3183a3ee470370 {"txHash":"0x12d77a82bc4a461e265e0195c95bf50be376c73138fa0c95ea3183a3ee470370"} 19:26:37 [19:26:37.008] INFO: pxe:service Sent transaction 0x12d77a82bc4a461e265e0195c95bf50be376c73138fa0c95ea3183a3ee470370 19:26:37 [19:26:37.173] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:37 [19:26:37.378] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:37 [19:26:37.540] VERBOSE: sequencer Building block 6 for slot 7 {"slot":7,"blockNumber":6,"msgCount":0} 19:26:37 [19:26:37.560] VERBOSE: sequencer Processing pending txs {"slot":7,"slotStart":"2025-06-17T19:33:28.000Z","now":"2025-06-17T19:33:35.919Z"} 19:26:37 [19:26:37.586] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:37 [19:26:37.644] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":34.47298199999932} 19:26:37 [19:26:37.672] VERBOSE: simulator:public-processor Processed tx 0x12d77a82bc4a461e265e0195c95bf50be376c73138fa0c95ea3183a3ee470370 with 1 public calls in 95.59290100000362ms {"txHash":"0x12d77a82bc4a461e265e0195c95bf50be376c73138fa0c95ea3183a3ee470370","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":95.59290100000362} 19:26:37 [19:26:37.678] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1171593570000041s {"duration":0.1171593570000041,"rate":171083.21958441014,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 19:26:37 [19:26:37.815] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:37 [19:26:37.830] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 67009.71759586396 mana/s {"blockHash":"0x000dde477771e0ffe400db18928ace75150b042c2639dbbe8a48d8d7efe303a7","globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":6,"slotNumber":7,"timestamp":1750188808,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x12d77a82bc4a461e265e0195c95bf50be376c73138fa0c95ea3183a3ee470370"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":298.457859999995,"publicProcessDuration":117.74618899999768,"rollupCircuitsDuration":272.41334500000085,"txCount":1,"blockNumber":6,"blockTimestamp":1750188808,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:37 [19:26:37.833] VERBOSE: sequencer Attesting committee is empty 19:26:38 [19:26:38.020] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:38 [19:26:38.147] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x86790db7e525798ce812e8d931751126892733aa3a17e983c458a55610ad8a2a 19:26:38 [19:26:38.148] VERBOSE: sequencer-client Sent L1 transaction 0x86790db7e525798ce812e8d931751126892733aa3a17e983c458a55610ad8a2a {"gasLimit":470248,"maxFeePerGas":"1.23606368","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:26:38 [19:26:38.160] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188844] on http://127.0.0.1:8545 19:26:38 [19:26:38.163] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:26:38 [19:26:38.164] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x86790db7e525798ce812e8d931751126892733aa3a17e983c458a55610ad8a2a","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":6,"blockTimestamp":1750188808,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:38 [19:26:38.164] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:26:38 [19:26:38.166] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:26:38 [19:26:38.170] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188844 19:26:38 [19:26:38.170] WARN: foundation:test-date-provider Time set to 2025-06-17T19:34:04.000Z {"offset":445830,"timeMs":1750188844000} 19:26:38 [19:26:38.170] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 19:26:38 [19:26:38.173] INFO: blob-sink:server Received blob sidecar for block 0xadbaa83efb05ebc5708dc267a6d6a142b1736f439bca698c08f7adbc4d9527d6 19:26:38 [19:26:38.178] INFO: blob-sink:server Blob sidecar stored successfully for block 0xadbaa83efb05ebc5708dc267a6d6a142b1736f439bca698c08f7adbc4d9527d6 19:26:38 [19:26:38.229] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:38 [19:26:38.234] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000006"] on http://127.0.0.1:8545 19:26:38 [19:26:38.236] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 19:26:38 [19:26:38.238] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 19:26:38 [19:26:38.432] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:38 [19:26:38.635] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:38 [19:26:38.811] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x000dde477771e0ffe400db18928ace75150b042c2639dbbe8a48d8d7efe303a7","blockNumber":6,"txCount":1,"globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":6,"slotNumber":7,"timestamp":1750188808,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x29663838e17b4f7b0c1baf2df1506dcad91c9932ebb28fb10f5220d2a4050600","archiveNextLeafIndex":7} 19:26:38 [19:26:38.817] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 19:26:38 [19:26:38.838] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:38 [19:26:38.923] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":10.832718999998178,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750188808,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:38 [19:26:38.933] VERBOSE: p2p Synched to latest block 6 19:26:39 [19:26:39.023] VERBOSE: pxe:service Updated pxe last block to 6 {"blockHash":{},"archive":"0x29663838e17b4f7b0c1baf2df1506dcad91c9932ebb28fb10f5220d2a4050600","header":{"contentCommitment":{"blobsHash":"0x00613bb63292880dc7f6faa66f19496d7289f187b01102d89ed19c2878a5573a","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750188808,"version":2928111036},"lastArchive":"0x2f219b37b5120c03beec8fdf4ee6e21650640038aad651a2866c0dd43fbd99dd","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x098e3036cb9d540ad28cc81c249bae6eeeee572d2a1734425889346cbb101a52","nullifierTree":"0x0c5f090a40020a8c8679318ce6f441333d9b6146770cc00d858f4dd0f4b46b24","publicDataTree":"0x1478282e55661b7eabfda3f969ff1470d415893aea7527626f78c11dc23c969a"},"totalFees":2327130000,"totalManaUsed":45900}} 19:26:39 [19:26:39.060] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:39 [19:26:39.110] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:39 [19:26:39.130] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:39 [19:26:39.131] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:39 [19:26:39.209] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:39 [19:26:39.212] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x29663838e17b4f7b0c1baf2df1506dcad91c9932ebb28fb10f5220d2a4050600","blockNumber":7,"slot":8} 19:26:39 [19:26:39.216] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:39 [19:26:39.225] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:39 [19:26:39.225] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:39 [19:26:39.230] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:39 [19:26:39.231] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:39 [19:26:39.233] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:39 [19:26:39.238] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:39 [19:26:39.247] VERBOSE: simulator Utility simulation for 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8.0xd191fb1a completed 19:26:39 [19:26:39.271] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:39 [19:26:39.284] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:39 [19:26:39.299] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:39 [19:26:39.397] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:39 [19:26:39.443] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:39 [19:26:39.443] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:39 [19:26:39.491] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:39 [19:26:39.524] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:39 [19:26:39.530] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2a95f23b192d081735519486e9d69390edd56b5fe1d19f803ad872fa241dc0b8 19:26:39 [19:26:39.539] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:39 [19:26:39.540] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:39 [19:26:39.546] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:39 [19:26:39.547] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:39 [19:26:39.552] VERBOSE: pxe:service Added note {"index":64,"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x18d5faecf024666c8b0281f2beeda5c339ad96f3cfe7c761a41a2d11adaaee0f","nullifier":"0x288269cd2776fae62673bd0a6d400df53145f511e8812e9d82ef86adb20ec2a0"} 19:26:39 [19:26:39.554] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:39 [19:26:39.567] VERBOSE: simulator:client_execution_context:debug_log Setting 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 as fee payer 19:26:39 [19:26:39.732] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:40 [19:26:40.077] INFO: pxe:service Proving completed in 751.8329299999968ms {"timings":{"total":751.8329299999968,"sync":4.845467000006465,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":227.1638060000114,"oracles":{"debugLog":{"times":[0.49520099999790546,0.4297299999961979,0.6688450000001467,0.45521000000007916,0.7479770000063581,0.607492999995884,0.3265269999974407,0.5360020000007353]},"fetchTaggedLogs":{"times":[84.82253299999866]},"loadCapsule":{"times":[0.18227399999886984,0.2047339999990072,0.36687800000072457,0.2428650000001653,0.1551030000046012,0.1511030000037863]},"getSharedSecret":{"times":[2.73337100000208]},"aes128Decrypt":{"times":[0.17786399999749847,1.1738360000017565]},"getPublicKeysAndPartialAddress":{"times":[1.4398520000031567]},"getKeyValidationRequest":{"times":[1.7737689999994473]},"deliverNote":{"times":[4.654452000002493]},"deleteCapsule":{"times":[0.27257600000302773]},"storeCapsule":{"times":[0.20947500000329455]},"getNotes":{"times":[1.5069230000008247]},"getAuthWitness":{"times":[0.15809399999852758]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09338199999911012]},"notifyEnqueuedPublicFunctionCall":{"times":[0.0789809999987483]}}},{"functionName":"private_kernel_init","time":68.16800499999954},{"functionName":"private_kernel_reset","time":219.25248999999894},{"functionName":"private_kernel_tail","time":127.83450199999788}],"unaccounted":104.56865999998263}} 19:26:40 [19:26:40.119] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:40 [19:26:40.156] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x29663838e17b4f7b0c1baf2df1506dcad91c9932ebb28fb10f5220d2a4050600","blockNumber":7,"slot":8} 19:26:40 [19:26:40.166] VERBOSE: p2p:tx_pool Adding tx 0x16ed7e9564d968be477eaa6073741bd256a792a7a4bd87b60fbb0ec12887b704 to pool {"eventName":"tx-added-to-pool","txHash":"0x16ed7e9564d968be477eaa6073741bd256a792a7a4bd87b60fbb0ec12887b704","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 19:26:40 [19:26:40.176] INFO: node Received tx 0x16ed7e9564d968be477eaa6073741bd256a792a7a4bd87b60fbb0ec12887b704 {"txHash":"0x16ed7e9564d968be477eaa6073741bd256a792a7a4bd87b60fbb0ec12887b704"} 19:26:40 [19:26:40.176] INFO: pxe:service Sent transaction 0x16ed7e9564d968be477eaa6073741bd256a792a7a4bd87b60fbb0ec12887b704 19:26:40 [19:26:40.328] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:40 [19:26:40.530] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:40 [19:26:40.677] VERBOSE: sequencer Building block 7 for slot 8 {"slot":8,"blockNumber":7,"msgCount":0} 19:26:40 [19:26:40.689] VERBOSE: sequencer Processing pending txs {"slot":8,"slotStart":"2025-06-17T19:34:04.000Z","now":"2025-06-17T19:34:06.519Z"} 19:26:40 [19:26:40.734] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:40 [19:26:40.752] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":42.5673900000038} 19:26:40 [19:26:40.774] VERBOSE: simulator:public-processor Processed tx 0x16ed7e9564d968be477eaa6073741bd256a792a7a4bd87b60fbb0ec12887b704 with 1 public calls in 73.48127200000454ms {"txHash":"0x16ed7e9564d968be477eaa6073741bd256a792a7a4bd87b60fbb0ec12887b704","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":73.48127200000454} 19:26:40 [19:26:40.775] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08503023799999937s {"duration":0.08503023799999937,"rate":622449.157439738,"totalPublicGas":{"daGas":512,"l2Gas":52927},"totalBlockGas":{"daGas":1536,"l2Gas":78783},"totalSizeInBytes":320} 19:26:40 [19:26:40.890] INFO: sequencer Built block 7 for slot 8 with 1 txs and 0 messages. 246877.81565053636 mana/s {"blockHash":"0x18e705ee24d82f4c3f2d53cb9570db110c586bb488fa49b95056067dd2c726ef","globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":7,"slotNumber":8,"timestamp":1750188844,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x16ed7e9564d968be477eaa6073741bd256a792a7a4bd87b60fbb0ec12887b704"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":213.7621500000023,"publicProcessDuration":85.33223400000134,"rollupCircuitsDuration":201.0563189999957,"txCount":1,"blockNumber":7,"blockTimestamp":1750188844,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:40 [19:26:40.892] VERBOSE: sequencer Attesting committee is empty 19:26:40 [19:26:40.992] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:41 [19:26:41.175] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xcb4e0774d44e8a32de426418b9112922ee70df33091cb4bfde63cdb92f581056 19:26:41 [19:26:41.176] VERBOSE: sequencer-client Sent L1 transaction 0xcb4e0774d44e8a32de426418b9112922ee70df33091cb4bfde63cdb92f581056 {"gasLimit":489775,"maxFeePerGas":"1.227700384","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:26:41 [19:26:41.189] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:26:41 [19:26:41.189] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xcb4e0774d44e8a32de426418b9112922ee70df33091cb4bfde63cdb92f581056","calldataSize":1444,"calldataGas":12316,"txCount":1,"blockNumber":7,"blockTimestamp":1750188844,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:41 [19:26:41.190] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:26:41 [19:26:41.194] INFO: blob-sink:server Received blob sidecar for block 0xe6749f7350d2b49a6896867ecb398bfb19be2f84640108e1a74dec11b2f99ef5 19:26:41 [19:26:41.196] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:41 [19:26:41.202] INFO: blob-sink:server Blob sidecar stored successfully for block 0xe6749f7350d2b49a6896867ecb398bfb19be2f84640108e1a74dec11b2f99ef5 19:26:41 [19:26:41.208] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000007"] on http://127.0.0.1:8545 19:26:41 [19:26:41.211] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7 19:26:41 [19:26:41.213] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 19:26:41 [19:26:41.219] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188880] on http://127.0.0.1:8545 19:26:41 [19:26:41.221] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:26:41 [19:26:41.222] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188880 19:26:41 [19:26:41.222] WARN: foundation:test-date-provider Time set to 2025-06-17T19:34:40.000Z {"offset":478778,"timeMs":1750188880000} 19:26:41 [19:26:41.223] INFO: aztecjs:utils:watcher Slot 8 was filled, jumped to next slot 19:26:41 [19:26:41.343] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x18e705ee24d82f4c3f2d53cb9570db110c586bb488fa49b95056067dd2c726ef","blockNumber":7,"txCount":1,"globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":7,"slotNumber":8,"timestamp":1750188844,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x1bf40533f4abc8d9ea035a931e802dea8cbf44269d82771837855de0a5f5861e","archiveNextLeafIndex":8} 19:26:41 [19:26:41.405] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:41 [19:26:41.449] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":6.588395999999193,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1750188844,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:41 [19:26:41.457] VERBOSE: p2p Synched to latest block 7 19:26:41 [19:26:41.608] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:41 [19:26:41.713] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x1bf40533f4abc8d9ea035a931e802dea8cbf44269d82771837855de0a5f5861e","blockNumber":8,"slot":9} 19:26:41 [19:26:41.811] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:41 [19:26:41.859] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 19:26:42 [19:26:42.015] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:42 [19:26:42.188] VERBOSE: pxe:service Updated pxe last block to 7 {"blockHash":{},"archive":"0x1bf40533f4abc8d9ea035a931e802dea8cbf44269d82771837855de0a5f5861e","header":{"contentCommitment":{"blobsHash":"0x007884f7286832733321da8ba1bb8ff19c4ee8592f79e0f1a15b11e315bc0745","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":8,"timestamp":1750188844,"version":2928111036},"lastArchive":"0x29663838e17b4f7b0c1baf2df1506dcad91c9932ebb28fb10f5220d2a4050600","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x098e3036cb9d540ad28cc81c249bae6eeeee572d2a1734425889346cbb101a52","nullifierTree":"0x1e4cdb361707d71c169f53c709bb042bb4c0e945a721e1d45116c92bcb29d235","publicDataTree":"0x216fe1baec8a24f05d155e407f2a8f1d8add1a6704eb18e868d5cdf5eaf269cb"},"totalFees":3994298100,"totalManaUsed":78783}} 19:26:42 [19:26:42.219] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:42 [19:26:42.269] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:42 [19:26:42.289] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:42 [19:26:42.290] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:42 [19:26:42.294] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x1bf40533f4abc8d9ea035a931e802dea8cbf44269d82771837855de0a5f5861e","blockNumber":8,"slot":9} 19:26:42 [19:26:42.350] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:42 [19:26:42.356] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:42 [19:26:42.365] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:42 [19:26:42.366] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:42 [19:26:42.374] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:42 [19:26:42.375] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:42 [19:26:42.383] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:42 [19:26:42.386] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:42 [19:26:42.396] VERBOSE: simulator Utility simulation for 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8.0xd191fb1a completed 19:26:42 [19:26:42.423] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:42 [19:26:42.432] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:42 [19:26:42.438] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:42 [19:26:42.440] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data failure case cancel before usage 19:26:42 [19:26:42.509] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:42 [19:26:42.522] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:42 [19:26:42.523] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:42 [19:26:42.588] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:42 [19:26:42.595] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:42 [19:26:42.604] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:42 [19:26:42.605] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:42 [19:26:42.612] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:42 [19:26:42.612] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:42 [19:26:42.614] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:42 [19:26:42.616] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:42 [19:26:42.625] VERBOSE: simulator Utility simulation for 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8.0xd191fb1a completed 19:26:42 [19:26:42.643] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:42 [19:26:42.676] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:42 [19:26:42.682] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:42 [19:26:42.781] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:42 [19:26:42.824] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:42 [19:26:42.824] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:42 [19:26:42.875] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:42 [19:26:42.883] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x1bf40533f4abc8d9ea035a931e802dea8cbf44269d82771837855de0a5f5861e","blockNumber":8,"slot":9} 19:26:42 [19:26:42.926] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:42 [19:26:42.934] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:42 [19:26:42.946] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:42 [19:26:42.947] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:42 [19:26:42.955] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:42 [19:26:42.955] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:42 [19:26:42.958] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:42 [19:26:42.960] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:42 [19:26:42.977] VERBOSE: simulator:client_execution_context:debug_log Setting 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 as fee payer 19:26:43 [19:26:43.086] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:43 [19:26:43.492] INFO: pxe:service Proving completed in 795.5849159999998ms {"timings":{"total":795.5849159999998,"sync":3.7762129999973695,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":265.73967700000503,"oracles":{"debugLog":{"times":[0.7708570000031614,0.43096899999363814,0.5082910000055563,0.6331839999984368,0.3994289999973262,0.36256800000410294,0.30539699999644654,0.8031580000024405]},"fetchTaggedLogs":{"times":[108.12461799999437]},"loadCapsule":{"times":[0.23230499999772292,0.16628399999899557,0.5079709999990882,0.2345560000030673,0.15379299999767682,0.2296649999989313]},"getSharedSecret":{"times":[3.9617469999939203]},"aes128Decrypt":{"times":[0.24653599999874132,1.019981999997981]},"getPublicKeysAndPartialAddress":{"times":[1.7611289999986184]},"getKeyValidationRequest":{"times":[1.9731939999983297]},"deliverNote":{"times":[2.658489000001282]},"deleteCapsule":{"times":[0.3278470000004745]},"storeCapsule":{"times":[0.24921599999652244]},"getNotes":{"times":[1.5833850000053644]},"getAuthWitness":{"times":[0.3460969999941881]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.103092999997898]},"notifyEnqueuedPublicFunctionCall":{"times":[0.10966200000257231]}}},{"functionName":"private_kernel_init","time":72.26289499999984},{"functionName":"private_kernel_reset","time":206.93223900000157},{"functionName":"private_kernel_tail","time":111.41907099999662}],"unaccounted":135.45482099999936}} 19:26:43 [19:26:43.525] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:43 [19:26:43.559] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x1bf40533f4abc8d9ea035a931e802dea8cbf44269d82771837855de0a5f5861e","blockNumber":8,"slot":9} 19:26:43 [19:26:43.566] VERBOSE: p2p:tx_pool Adding tx 0x0d49fd9a18a938c5d30604e29164106c761afc4d185aedbf2eb3019261bd6524 to pool {"eventName":"tx-added-to-pool","txHash":"0x0d49fd9a18a938c5d30604e29164106c761afc4d185aedbf2eb3019261bd6524","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 19:26:43 [19:26:43.574] INFO: node Received tx 0x0d49fd9a18a938c5d30604e29164106c761afc4d185aedbf2eb3019261bd6524 {"txHash":"0x0d49fd9a18a938c5d30604e29164106c761afc4d185aedbf2eb3019261bd6524"} 19:26:43 [19:26:43.575] INFO: pxe:service Sent transaction 0x0d49fd9a18a938c5d30604e29164106c761afc4d185aedbf2eb3019261bd6524 19:26:43 [19:26:43.733] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:43 [19:26:43.941] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:44 [19:26:44.074] VERBOSE: sequencer Building block 8 for slot 9 {"slot":9,"blockNumber":8,"msgCount":0} 19:26:44 [19:26:44.088] VERBOSE: sequencer Processing pending txs {"slot":9,"slotStart":"2025-06-17T19:34:40.000Z","now":"2025-06-17T19:34:42.866Z"} 19:26:44 [19:26:44.126] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":12.887174999996205} 19:26:44 [19:26:44.147] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:44 [19:26:44.150] VERBOSE: simulator:public-processor Processed tx 0x0d49fd9a18a938c5d30604e29164106c761afc4d185aedbf2eb3019261bd6524 with 1 public calls in 46.96151600000303ms {"txHash":"0x0d49fd9a18a938c5d30604e29164106c761afc4d185aedbf2eb3019261bd6524","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":46.96151600000303} 19:26:44 [19:26:44.153] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.06460776700000133s {"duration":0.06460776700000133,"rate":310241.3367730166,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 19:26:44 [19:26:44.278] INFO: sequencer Built block 8 for slot 9 with 1 txs and 0 messages. 98207.88445468972 mana/s {"blockHash":"0x21af729afd0fff03ba92ee1c73c474a772bcc2b9d8dd1630617ec32584155f66","globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":8,"slotNumber":9,"timestamp":1750188880,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x0d49fd9a18a938c5d30604e29164106c761afc4d185aedbf2eb3019261bd6524"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":203.5485140000019,"publicProcessDuration":64.96451399999933,"rollupCircuitsDuration":190.55574699999852,"txCount":1,"blockNumber":8,"blockTimestamp":1750188880,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:44 [19:26:44.279] VERBOSE: sequencer Attesting committee is empty 19:26:44 [19:26:44.356] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:44 [19:26:44.538] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x5a5565416271ca23a60213894fe85674a270aaf59007e3ea062e1887fcb956f4 19:26:44 [19:26:44.539] VERBOSE: sequencer-client Sent L1 transaction 0x5a5565416271ca23a60213894fe85674a270aaf59007e3ea062e1887fcb956f4 {"gasLimit":470251,"maxFeePerGas":"1.221279852","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:26:44 [19:26:44.551] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:26:44 [19:26:44.552] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x5a5565416271ca23a60213894fe85674a270aaf59007e3ea062e1887fcb956f4","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":8,"blockTimestamp":1750188880,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:44 [19:26:44.552] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:26:44 [19:26:44.557] INFO: blob-sink:server Received blob sidecar for block 0xa7a67f8826d503334f8332a182b2e5136760a28bef1b4f4922e9e36415ba1ac9 19:26:44 [19:26:44.559] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:44 [19:26:44.563] INFO: blob-sink:server Blob sidecar stored successfully for block 0xa7a67f8826d503334f8332a182b2e5136760a28bef1b4f4922e9e36415ba1ac9 19:26:44 [19:26:44.567] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000008"] on http://127.0.0.1:8545 19:26:44 [19:26:44.568] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 8 19:26:44 [19:26:44.570] INFO: aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8. 19:26:44 [19:26:44.604] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188916] on http://127.0.0.1:8545 19:26:44 [19:26:44.606] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:26:44 [19:26:44.608] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188916 19:26:44 [19:26:44.609] WARN: foundation:test-date-provider Time set to 2025-06-17T19:35:16.000Z {"offset":511392,"timeMs":1750188916000} 19:26:44 [19:26:44.609] INFO: aztecjs:utils:watcher Slot 9 was filled, jumped to next slot 19:26:44 [19:26:44.739] INFO: archiver Downloaded L2 block 8 {"blockHash":"0x21af729afd0fff03ba92ee1c73c474a772bcc2b9d8dd1630617ec32584155f66","blockNumber":8,"txCount":1,"globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":8,"slotNumber":9,"timestamp":1750188880,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x1af69e9fcf6e88260e8008e70341716ca23f5e66e5f7b5a58df4156e966aa823","archiveNextLeafIndex":9} 19:26:44 [19:26:44.742] INFO: archiver Updated proven chain to block 8 {"provenBlockNumber":8} 19:26:44 [19:26:44.763] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:44 [19:26:44.850] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":9.894908999995096,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1750188880,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:44 [19:26:44.854] VERBOSE: p2p Synched to latest block 8 19:26:44 [19:26:44.966] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:45 [19:26:45.071] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x1af69e9fcf6e88260e8008e70341716ca23f5e66e5f7b5a58df4156e966aa823","blockNumber":9,"slot":10} 19:26:45 [19:26:45.169] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:45 [19:26:45.371] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:45 [19:26:45.573] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:45 [19:26:45.602] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x1af69e9fcf6e88260e8008e70341716ca23f5e66e5f7b5a58df4156e966aa823","blockNumber":9,"slot":10} 19:26:45 [19:26:45.606] VERBOSE: pxe:service Updated pxe last block to 8 {"blockHash":{},"archive":"0x1af69e9fcf6e88260e8008e70341716ca23f5e66e5f7b5a58df4156e966aa823","header":{"contentCommitment":{"blobsHash":"0x00e8d054d15e2f4716525324a1d1694346feec5a6e91367dca4a990ed4e42cac","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1750188880,"version":2928111036},"lastArchive":"0x1bf40533f4abc8d9ea035a931e802dea8cbf44269d82771837855de0a5f5861e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x098e3036cb9d540ad28cc81c249bae6eeeee572d2a1734425889346cbb101a52","nullifierTree":"0x2dc350cc00b7c8122cec452a17a7e7fe0cda18ceed6889748e4c3a5988c2ab71","publicDataTree":"0x26c8ba0f0965bff6e10ac3c588d9e8fc7068014e139bd7ffffef018887d3620a"},"totalFees":2327130000,"totalManaUsed":45900}} 19:26:45 [19:26:45.697] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:45 [19:26:45.718] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:45 [19:26:45.719] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:45 [19:26:45.781] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:45 [19:26:45.805] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:45 [19:26:45.813] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:45 [19:26:45.826] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:45 [19:26:45.827] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:45 [19:26:45.838] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:45 [19:26:45.838] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:45 [19:26:45.841] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:45 [19:26:45.844] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:45 [19:26:45.857] VERBOSE: simulator Utility simulation for 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8.0xd191fb1a completed 19:26:45 [19:26:45.890] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:45 [19:26:45.894] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:45 [19:26:45.983] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:46 [19:26:46.021] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:46 [19:26:46.075] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:46 [19:26:46.076] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:46 [19:26:46.144] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x1af69e9fcf6e88260e8008e70341716ca23f5e66e5f7b5a58df4156e966aa823","blockNumber":9,"slot":10} 19:26:46 [19:26:46.162] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:46 [19:26:46.168] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:46 [19:26:46.177] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:46 [19:26:46.178] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:46 [19:26:46.185] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:46 [19:26:46.185] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:46 [19:26:46.188] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:46 [19:26:46.190] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:46 [19:26:46.206] VERBOSE: simulator:client_execution_context:debug_log Setting 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 as fee payer 19:26:46 [19:26:46.301] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:46 [19:26:46.752] INFO: pxe:service Proving completed in 840.2650040000008ms {"timings":{"total":840.2650040000008,"sync":4.899204000001191,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":261.1784370000023,"oracles":{"debugLog":{"times":[0.8763180000023567,0.40148799999587936,0.4817699999985052,0.5942429999995511,0.4468489999999292,0.34552699999767356,0.3577469999945606,0.6053630000023986]},"fetchTaggedLogs":{"times":[90.23629000000074]},"loadCapsule":{"times":[0.2359950000027311,0.15894299999490613,0.29831600000034086,0.2043240000057267,0.17638399999850662,0.3564879999976256]},"getSharedSecret":{"times":[3.00067300000228]},"aes128Decrypt":{"times":[0.18360399999801302,0.5758220000061556]},"getPublicKeysAndPartialAddress":{"times":[1.6976660000000265]},"getKeyValidationRequest":{"times":[1.7851579999987734]},"deliverNote":{"times":[2.8694009999962873]},"deleteCapsule":{"times":[0.27407600000151433]},"storeCapsule":{"times":[0.2429550000015297]},"getNotes":{"times":[2.793269000001601]},"getAuthWitness":{"times":[0.2248249999975087]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1214929999987362]},"notifyEnqueuedPublicFunctionCall":{"times":[0.08766200000536628]}}},{"functionName":"private_kernel_init","time":92.5879700000005},{"functionName":"private_kernel_reset","time":239.37873700000637},{"functionName":"private_kernel_tail","time":99.7539919999981}],"unaccounted":142.4666639999923}} 19:26:46 [19:26:46.789] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:46 [19:26:46.826] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x1af69e9fcf6e88260e8008e70341716ca23f5e66e5f7b5a58df4156e966aa823","blockNumber":9,"slot":10} 19:26:46 [19:26:46.834] VERBOSE: p2p:tx_pool Adding tx 0x128997ebab070c53ef4187e413c0c209745213e9eba08a034082d2c30012f530 to pool {"eventName":"tx-added-to-pool","txHash":"0x128997ebab070c53ef4187e413c0c209745213e9eba08a034082d2c30012f530","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 19:26:46 [19:26:46.845] INFO: node Received tx 0x128997ebab070c53ef4187e413c0c209745213e9eba08a034082d2c30012f530 {"txHash":"0x128997ebab070c53ef4187e413c0c209745213e9eba08a034082d2c30012f530"} 19:26:46 [19:26:46.845] INFO: pxe:service Sent transaction 0x128997ebab070c53ef4187e413c0c209745213e9eba08a034082d2c30012f530 19:26:46 [19:26:46.996] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:47 [19:26:47.199] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:47 [19:26:47.350] VERBOSE: sequencer Building block 9 for slot 10 {"slot":10,"blockNumber":9,"msgCount":0} 19:26:47 [19:26:47.362] VERBOSE: sequencer Processing pending txs {"slot":10,"slotStart":"2025-06-17T19:35:16.000Z","now":"2025-06-17T19:35:18.754Z"} 19:26:47 [19:26:47.396] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":12.677998000006482} 19:26:47 [19:26:47.405] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:47 [19:26:47.418] VERBOSE: simulator:public-processor Processed tx 0x128997ebab070c53ef4187e413c0c209745213e9eba08a034082d2c30012f530 with 1 public calls in 44.14510399999563ms {"txHash":"0x128997ebab070c53ef4187e413c0c209745213e9eba08a034082d2c30012f530","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":44.14510399999563} 19:26:47 [19:26:47.422] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.058938747000000145s {"duration":0.058938747000000145,"rate":340081.8819578901,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 19:26:47 [19:26:47.582] INFO: sequencer Built block 9 for slot 10 with 1 txs and 0 messages. 86289.82125759343 mana/s {"blockHash":"0x0d5b1e3f2580c987fbc9921e80ded2e7217dfc687ffc4eeb3ec24318556d0791","globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":9,"slotNumber":10,"timestamp":1750188916,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHashes":["0x128997ebab070c53ef4187e413c0c209745213e9eba08a034082d2c30012f530"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":231.871017999998,"publicProcessDuration":59.36107600000105,"rollupCircuitsDuration":220.91481600000407,"txCount":1,"blockNumber":9,"blockTimestamp":1750188916,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:47 [19:26:47.585] VERBOSE: sequencer Attesting committee is empty 19:26:47 [19:26:47.667] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:47 [19:26:47.876] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:47 [19:26:47.881] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xf47988e18d6edd1804f56cf4d0ed97fc62a78be45408257b2e7438d219cac29b 19:26:47 [19:26:47.881] VERBOSE: sequencer-client Sent L1 transaction 0xf47988e18d6edd1804f56cf4d0ed97fc62a78be45408257b2e7438d219cac29b {"gasLimit":470277,"maxFeePerGas":"1.216344979","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:26:47 [19:26:47.890] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000009"] on http://127.0.0.1:8545 19:26:47 [19:26:47.897] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 9 19:26:47 [19:26:47.898] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188952] on http://127.0.0.1:8545 19:26:47 [19:26:47.901] INFO: aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9. 19:26:47 [19:26:47.903] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:26:47 [19:26:47.905] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188952 19:26:47 [19:26:47.906] WARN: foundation:test-date-provider Time set to 2025-06-17T19:35:52.000Z {"offset":544095,"timeMs":1750188952000} 19:26:47 [19:26:47.906] INFO: aztecjs:utils:watcher Slot 10 was filled, jumped to next slot 19:26:47 [19:26:47.908] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:26:47 [19:26:47.908] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xf47988e18d6edd1804f56cf4d0ed97fc62a78be45408257b2e7438d219cac29b","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":9,"blockTimestamp":1750188916,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:47 [19:26:47.909] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:26:47 [19:26:47.917] INFO: blob-sink:server Received blob sidecar for block 0x9e7c11d92a5bc6809539434cace6bc8d95dcc2ae2d4940787101e76447414b46 19:26:47 [19:26:47.922] INFO: blob-sink:server Blob sidecar stored successfully for block 0x9e7c11d92a5bc6809539434cace6bc8d95dcc2ae2d4940787101e76447414b46 19:26:48 [19:26:48.086] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:48 [19:26:48.289] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:48 [19:26:48.588] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:48 [19:26:48.624] INFO: archiver Downloaded L2 block 9 {"blockHash":"0x0d5b1e3f2580c987fbc9921e80ded2e7217dfc687ffc4eeb3ec24318556d0791","blockNumber":9,"txCount":1,"globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":9,"slotNumber":10,"timestamp":1750188916,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"archiveRoot":"0x11ae12bf1ad206e76e1afa4be444d5f1414496220c26ef22dd76c140c7cfe7b0","archiveNextLeafIndex":10} 19:26:48 [19:26:48.628] INFO: archiver Updated proven chain to block 9 {"provenBlockNumber":9} 19:26:48 [19:26:48.733] INFO: world_state World state updated with L2 block 9 {"eventName":"l2-block-handled","duration":9.8922390000007,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1750188916,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:48 [19:26:48.745] VERBOSE: p2p Synched to latest block 9 19:26:48 [19:26:48.807] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:48 [19:26:48.904] VERBOSE: pxe:service Updated pxe last block to 9 {"blockHash":{},"archive":"0x11ae12bf1ad206e76e1afa4be444d5f1414496220c26ef22dd76c140c7cfe7b0","header":{"contentCommitment":{"blobsHash":"0x002fe5f4ecc0b5e48b2e33db5b3882923f42e6ef399e91958b7ac5641444757d","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1750188916,"version":2928111036},"lastArchive":"0x1af69e9fcf6e88260e8008e70341716ca23f5e66e5f7b5a58df4156e966aa823","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x098e3036cb9d540ad28cc81c249bae6eeeee572d2a1734425889346cbb101a52","nullifierTree":"0x05e1211cdb6d69815c6e0b8a60c6c0e15e623d5284b11e5d99ae8adb85f68a47","publicDataTree":"0x2284a0ea9c5ce9f538a6bbe00c5353a782eb01c3dc22057825d050f045b988a0"},"totalFees":276318000,"totalManaUsed":45900}} 19:26:48 [19:26:48.993] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x11ae12bf1ad206e76e1afa4be444d5f1414496220c26ef22dd76c140c7cfe7b0","blockNumber":10,"slot":11} 19:26:49 [19:26:49.026] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","selector":"0xd191fb1a"} 19:26:49 [19:26:49.052] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:49 [19:26:49.059] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:49 [19:26:49.061] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:49 [19:26:49.188] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8"} 19:26:49 [19:26:49.197] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x261898da95d3ffc1461d11b0c6b7143315c9f4e809cb958275a47a8a0720102b 19:26:49 [19:26:49.207] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 19:26:49 [19:26:49.208] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:49 [19:26:49.213] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:49 [19:26:49.214] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:49 [19:26:49.216] VERBOSE: pxe:service Added note {"index":0,"contract":"0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08a0b97ada0ad0c907221fb21603118d0d83fea8d61dfb193eded25403a06543","nullifier":"0x06715ab94af27c70d493a60ec7091c28e89d6f41ca925e2712b936dd678dd550"} 19:26:49 [19:26:49.218] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:49 [19:26:49.226] VERBOSE: simulator Utility simulation for 0x260078e449031bd9717022a00d8dbd57eb52c7afded634cce599b59a591ec5a8.0xd191fb1a completed 19:26:49 [19:26:49.256] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 19:26:49 [19:26:49.262] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:49 [19:26:49.265] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 19:26:49 [19:26:49.302] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 {"origin":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x00000000000000000000000000000000000000000000000000000000ae876dbc","authWitnesses":["0x2aae07e8436d1768a724eed84476042eb9c3bd04cfc3aa55c51f5a301d1f1d5e"]} 19:26:49 [19:26:49.418] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:49 [19:26:49.487] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:49 [19:26:49.488] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:49 [19:26:49.489] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:49 [19:26:49.543] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x11ae12bf1ad206e76e1afa4be444d5f1414496220c26ef22dd76c140c7cfe7b0","blockNumber":10,"slot":11} 19:26:49 [19:26:49.585] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92"} 19:26:49 [19:26:49.592] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2a95f23b192d081735519486e9d69390edd56b5fe1d19f803ad872fa241dc0b8 19:26:49 [19:26:49.605] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:49 [19:26:49.605] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:49 [19:26:49.616] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:49 [19:26:49.617] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:49 [19:26:49.621] VERBOSE: pxe:service Added note {"index":64,"contract":"0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x18d5faecf024666c8b0281f2beeda5c339ad96f3cfe7c761a41a2d11adaaee0f","nullifier":"0x288269cd2776fae62673bd0a6d400df53145f511e8812e9d82ef86adb20ec2a0"} 19:26:49 [19:26:49.624] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:49 [19:26:49.643] VERBOSE: simulator:client_execution_context:debug_log Setting 0x07c00d3afc415461232881ff3ce94ad3bb89183876339ff5209dd6fec33cdf92 as fee payer 19:26:49 [19:26:49.765] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:50 [19:26:50.234] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:50 [19:26:50.261] VERBOSE: node Simulating public calls for tx 0x18638770fa08607950e42a53eebfd44e40273cf0c31232a0f0ccdec612a2b9fb {"globalVariables":{"chainId":31337,"version":2928111036,"blockNumber":10,"slotNumber":11,"timestamp":1750188952,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHash":"0x18638770fa08607950e42a53eebfd44e40273cf0c31232a0f0ccdec612a2b9fb","blockNumber":10} 19:26:50 [19:26:50.264] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x11ae12bf1ad206e76e1afa4be444d5f1414496220c26ef22dd76c140c7cfe7b0","blockNumber":10,"slot":11} 19:26:50 [19:26:50.302] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 reverted with reason Assertion failed: . {"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":21.56414599999698} 19:26:50 [19:26:50.303] WARN: simulator:public_tx_context APP_LOGIC phase reverted! 0x0000000000000000000000000000000000000000000000000000000000000001:0x2716b166 failed with reason: Assertion failed: 19:26:50 [19:26:50.329] VERBOSE: simulator:public-processor Processed tx 0x18638770fa08607950e42a53eebfd44e40273cf0c31232a0f0ccdec612a2b9fb with 1 public calls in 57.966506999997364ms {"txHash":"0x18638770fa08607950e42a53eebfd44e40273cf0c31232a0f0ccdec612a2b9fb","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":57.966506999997364} 19:26:50 [19:26:50.331] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.06514088800000173s {"duration":0.06514088800000173,"rate":544128.2900533848,"totalPublicGas":{"daGas":0,"l2Gas":35445},"totalBlockGas":{"daGas":1024,"l2Gas":61301},"totalSizeInBytes":256} 19:26:50 PASS src/e2e_authwit.test.ts 19:26:50 e2e_authwit_tests 19:26:50 Private 19:26:50 arbitrary data 19:26:50 ✓ happy path (7586 ms) 19:26:50 failure case 19:26:50 ✓ invalid chain id (1269 ms) 19:26:50 ✓ invalid version (1389 ms) 19:26:50 Public 19:26:50 arbitrary data 19:26:50 ✓ happy path (6713 ms) 19:26:50 failure case 19:26:50 ✓ cancel before usage (7931 ms) 19:26:50 19:26:50 Test Suites: 1 passed, 1 total 19:26:50 Tests: 5 passed, 5 total 19:26:50 Snapshots: 0 total 19:26:50 Time: 51.8 s 19:26:50 Ran all test suites matching /src\/e2e_authwit.test.ts/i. 19:26:50 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?