Parent Log: http://ci.aztec-labs.com/203368854ee7e10a Command: 4bfd2d3585b9db66: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/267ac35e8ccb487bdc79bbe12d428f4c8b4d4d9f Env: REF_NAME=gh-readonly-queue/master/pr-15002-1338cef09c870378254c56748f972ae827c4d482 CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Fri Jun 13 14:53:17 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15002_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_06a902b1832ee6d0_master 14:53:17 +++ id -u 14:53:17 +++ id -g 14:53:17 ++ docker run -d --name e2e_authwit --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_authwit.test.ts'\''' 14:53:17 + cid=338235e785586fa530ebfcb686963040393477ee7b061172b42cd9125f676aa4 14:53:17 + set +x 14:53:18 {"level":25,"time":1749826398238,"pid":12,"hostname":"338235e78558","module":"logger","msg":"Logger initialized with level verbose"} 14:53:24 [14:53:24.276] INFO: e2e:e2e_authwit Logging metrics to log/unknown.jsonl 14:53:24 [14:53:24.625] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-bFFNVX/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 14:53:24 [14:53:24.668] INFO: e2e:e2e_authwit Calling anvil_setBlockTimestampInterval with params: [12] 14:53:24 [14:53:24.697] WARN: e2e:e2e_authwit Set block interval to 12 14:53:24 [14:53:24.698] VERBOSE: e2e:e2e_authwit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 14:53:24 [14:53:24.749] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 14:53:24 [14:53:24.757] VERBOSE: e2e:e2e_authwit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 14:53:24 [14:53:24.777] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 14:53:24 [14:53:24.783] VERBOSE: e2e:e2e_authwit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 14:53:24 [14:53:24.801] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 14:53:24 [14:53:24.806] VERBOSE: e2e:e2e_authwit Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 14:53:24 [14:53:24.820] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 14:53:24 [14:53:24.826] VERBOSE: e2e:e2e_authwit Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 14:53:24 [14:53:24.850] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 14:53:24 [14:53:24.856] VERBOSE: e2e:e2e_authwit Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 14:53:24 [14:53:24.871] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 14:53:24 [14:53:24.879] VERBOSE: e2e:e2e_authwit Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 14:53:24 [14:53:24.880] VERBOSE: e2e:e2e_authwit Waiting for deployments to complete 14:53:24 [14:53:24.880] INFO: e2e:e2e_authwit Waiting for 6 transactions to be mined... 14:53:24 [14:53:24.899] INFO: e2e:e2e_authwit All transactions mined successfully 14:53:24 [14:53:24.917] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 14:53:24 [14:53:24.917] VERBOSE: e2e:e2e_authwit Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 14:53:24 [14:53:24.932] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 14:53:24 [14:53:24.948] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 14:53:24 [14:53:24.953] VERBOSE: e2e:e2e_authwit Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 14:53:24 [14:53:24.970] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 14:53:24 [14:53:24.971] VERBOSE: e2e:e2e_authwit Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 14:53:25 [14:53:25.005] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 14:53:25 [14:53:25.011] VERBOSE: e2e:e2e_authwit Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 14:53:25 [14:53:25.033] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 14:53:25 [14:53:25.034] VERBOSE: e2e:e2e_authwit Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 14:53:25 [14:53:25.034] VERBOSE: e2e:e2e_authwit Waiting for deployments to complete 14:53:25 [14:53:25.034] INFO: e2e:e2e_authwit Waiting for 8 transactions to be mined... 14:53:25 [14:53:25.062] INFO: e2e:e2e_authwit All transactions mined successfully 14:53:25 [14:53:25.074] VERBOSE: e2e:e2e_authwit Deployed shared contracts 14:53:25 [14:53:25.097] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 14:53:25 [14:53:25.098] VERBOSE: e2e:e2e_authwit Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 14:53:25 [14:53:25.101] VERBOSE: e2e:e2e_authwit Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 14:53:25 [14:53:25.113] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 14:53:25 [14:53:25.140] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 14:53:25 [14:53:25.147] VERBOSE: e2e:e2e_authwit Awaiting for linked libraries to be deployed 14:53:25 [14:53:25.201] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x1e0eb3aece639581f2146b421cb64870111f25a671167f3e79604064e7f5b7ed {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 14:53:25 [14:53:25.207] VERBOSE: e2e:e2e_authwit Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 14:53:25 [14:53:25.207] INFO: e2e:e2e_authwit Waiting for 9 transactions to be mined... 14:53:25 [14:53:25.224] INFO: e2e:e2e_authwit All transactions mined successfully 14:53:25 [14:53:25.224] VERBOSE: e2e:e2e_authwit All core contracts have been deployed 14:53:25 [14:53:25.270] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 14:53:25 [14:53:25.270] VERBOSE: e2e:e2e_authwit Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments) 14:53:25 [14:53:25.295] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 14:53:25 [14:53:25.301] VERBOSE: e2e:e2e_authwit Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 14:53:25 [14:53:25.345] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 14:53:25 [14:53:25.345] VERBOSE: e2e:e2e_authwit Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 14:53:25 [14:53:25.346] INFO: e2e:e2e_authwit Waiting for 10 transactions to be mined... 14:53:25 [14:53:25.371] INFO: e2e:e2e_authwit All transactions mined successfully 14:53:25 [14:53:25.378] VERBOSE: e2e:e2e_authwit Rollup deployed 14:53:25 [14:53:25.379] VERBOSE: e2e:e2e_authwit Waiting for rollup and slash factory to be deployed 14:53:25 [14:53:25.379] INFO: e2e:e2e_authwit Waiting for 10 transactions to be mined... 14:53:25 [14:53:25.402] INFO: e2e:e2e_authwit All transactions mined successfully 14:53:25 [14:53:25.403] VERBOSE: e2e:e2e_authwit All transactions for L1 deployment have been mined 14:53:25 [14:53:25.438] INFO: e2e:e2e_authwit Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 14:53:25 [14:53:25.443] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 14:53:25 [14:53:25.446] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:25 [14:53:25.447] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 14:53:25 [14:53:25.448] INFO: telemetry:client Using NoopTelemetryClient 14:53:25 [14:53:25.453] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 14:53:25 [14:53:25.453] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 14:53:25 [14:53:25.454] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/719a76bfd564537c/blob-sink with map size 134217728 KB (LMDB v2) 14:53:25 [14:53:25.456] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:25 [14:53:25.459] INFO: aztecjs:utils:watcher New L1 time: 1749826644 14:53:25 [14:53:25.459] WARN: foundation:test-date-provider Time set to 2025-06-13T14:57:24.000Z {"offset":238541,"timeMs":1749826644000} 14:53:25 [14:53:25.461] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 14:53:25 [14:53:25.469] INFO: blob-sink:server Server is running on http://localhost:42335 14:53:25 [14:53:25.469] VERBOSE: e2e:e2e_authwit Creating and synching an aztec node... 14:53:25 [14:53:25.470] VERBOSE: e2e:e2e_authwit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/77f6de5a/acvm 14:53:25 [14:53:25.471] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42335"} 14:53:25 [14:53:25.490] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 14:53:25 [14:53:25.491] INFO: archiver:lmdb Creating archiver data store at directory /tmp/719a76bfd564537c/archiver with map size 134217728 KB (LMDB v2) 14:53:25 [14:53:25.494] INFO: archiver:lmdb Starting data store with maxReaders 16 14:53:25 [14:53:25.742] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:25 [14:53:25.870] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:42335"} 14:53:25 [14:53:25.897] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:42335"} 14:53:25 [14:53:25.897] WARN: node:blob-sink:client No L1 consensus host urls configured 14:53:25 [14:53:25.897] WARN: node:blob-sink:client No archive client configured 14:53:25 [14:53:25.903] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xdd4d1b343b81b18943b7303e9f4340d5a05fbc3da9a2df70b41d4c92c5375253 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xab92383d36ec616e4e0614351564e5c468be23ffeea5198d377db78bd93fd56b","l1BlockNumber":16}} 14:53:25 [14:53:25.923] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xdd4d1b343b81b18943b7303e9f4340d5a05fbc3da9a2df70b41d4c92c5375253","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 14:53:25 [14:53:25.936] INFO: world-state:database Creating world state data store at directory /tmp/719a76bfd564537c/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 14:53:25 [14:53:25.967] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:25 [14:53:25.978] INFO: world_state Created world state synchroniser with block history of 64 14:53:25 [14:53:25.978] WARN: node Aztec node is accepting fake proofs 14:53:25 [14:53:25.991] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/719a76bfd564537c/p2p with map size 134217728 KB (LMDB v2) 14:53:25 [14:53:25.993] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 14:53:25 [14:53:25.996] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/719a76bfd564537c/p2p-archive with map size 134217728 KB (LMDB v2) 14:53:26 [14:53:25.999] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 14:53:26 [14:53:26.003] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/719a76bfd564537c/p2p-peers with map size 134217728 KB (LMDB v2) 14:53:26 [14:53:26.005] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 14:53:26 [14:53:26.007] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 14:53:26 [14:53:26.009] VERBOSE: p2p P2P is disabled. Using dummy P2P service 14:53:26 [14:53:26.013] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 14:53:26 [14:53:26.014] INFO: world_state Started world state synchronizer from block 1 14:53:26 [14:53:26.016] VERBOSE: world-state:block_stream Starting sync from block number 0 14:53:26 [14:53:26.019] INFO: p2p Starting p2p client from block 0 with empty mempools 14:53:26 [14:53:26.019] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 14:53:26 [14:53:26.021] INFO: slasher Slasher client initialized 14:53:26 [14:53:26.021] INFO: slasher Starting Slasher client... 14:53:26 [14:53:26.070] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:53:26 [14:53:26.070] VERBOSE: node All Aztec Node subsystems synced 14:53:26 [14:53:26.081] INFO: sequencer-client Deploying forwarder contract 14:53:26 [14:53:26.089] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 14:53:26 [14:53:26.101] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 14:53:26 [14:53:26.101] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 14:53:26 [14:53:26.107] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 14:53:26 [14:53:26.132] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:53:26 [14:53:26.133] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 14:53:26 [14:53:26.133] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/77f6de5a/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 14:53:26 [14:53:26.339] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 14:53:26 [14:53:26.341] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:53:26 [14:53:26.342] INFO: node Aztec Node version: 0.87.8 14:53:26 [14:53:26.342] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 14:53:26 [14:53:26.343] VERBOSE: e2e:e2e_authwit Creating a pxe... 14:53:26 [14:53:26.345] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:26 [14:53:26.353] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/fd3e29b86cc7b43b/pxe_data with map size 134217728 KB (LMDB v2) 14:53:26 [14:53:26.371] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1cf7b4c17429cb69fe189bb326537c3208dc7e258b0147803de3f883d04cd958","blockNumber":1,"slot":2} 14:53:26 [14:53:26.373] INFO: pxe:data:lmdb Starting data store with maxReaders 16 14:53:26 [14:53:26.569] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:26 [14:53:26.599] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 14:53:26 [14:53:26.599] INFO: pxe:service Started PXE connected to chain 31337 version 720795365 14:53:26 [14:53:26.650] INFO: pxe:service Registered account 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 14:53:26 [14:53:26.705] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 14:53:26 [14:53:26.706] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 14:53:26 [14:53:26.791] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:26 [14:53:26.848] INFO: pxe:service Added contract SchnorrAccount at 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 14:53:26 [14:53:26.897] VERBOSE: pxe:block_stream Starting sync from block number 0 14:53:26 [14:53:26.903] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1cf7b4c17429cb69fe189bb326537c3208dc7e258b0147803de3f883d04cd958","blockNumber":1,"slot":2} 14:53:26 [14:53:26.929] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 14:53:27 [14:53:27.039] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:53:27 [14:53:27.738] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 14:53:27 [14:53:27.846] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 14:53:27 [14:53:27.928] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:27 [14:53:27.951] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1cf7b4c17429cb69fe189bb326537c3208dc7e258b0147803de3f883d04cd958","blockNumber":1,"slot":2} 14:53:28 [14:53:28.074] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:28 [14:53:28.131] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:28 [14:53:28.132] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:28 [14:53:28.164] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:28 [14:53:28.205] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:28 [14:53:28.212] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:28 [14:53:28.380] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:28 [14:53:28.401] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:28 [14:53:28.448] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:28 [14:53:28.449] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:28 [14:53:28.490] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1cf7b4c17429cb69fe189bb326537c3208dc7e258b0147803de3f883d04cd958","blockNumber":1,"slot":2} 14:53:28 [14:53:28.499] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:28 [14:53:28.502] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:28 [14:53:28.516] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 as fee payer 14:53:28 [14:53:28.697] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:29 [14:53:29.002] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:29 [14:53:29.151] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1cf7b4c17429cb69fe189bb326537c3208dc7e258b0147803de3f883d04cd958","blockNumber":1,"slot":2} 14:53:29 [14:53:29.328] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:29 [14:53:29.915] INFO: pxe:service Proving completed in 3026.3633009999994ms {"timings":{"total":3026.3633009999994,"sync":9.171448999999484,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":174.4413519999962,"oracles":{"callPrivateFunction":{"times":[943.0290409999998,404.7596259999991,202.073930999999]}}},{"functionName":"private_kernel_init","time":106.58001800000056},{"functionName":"ContractClassRegisterer:register","time":920.4231610000006,"oracles":{"loadCapsule":{"times":[41.6869859999988]},"notifyCreatedNullifier":{"times":[19.149998000000778]},"debugLog":{"times":[1.020554999999149]},"notifyCreatedContractClassLog":{"times":[9.122878000000128]}}},{"functionName":"private_kernel_inner","time":178.71839199999886},{"functionName":"SchnorrAccount:constructor","time":364.980144000001,"oracles":{"getContractInstance":{"times":[1.4663350000009814]},"debugLog":{"times":[0.7200470000007044,0.6695159999999305]},"fetchTaggedLogs":{"times":[78.27661100000114]},"loadCapsule":{"times":[0.46972099999948114,0.35504799999944225,0.33087800000066636]},"notifyCreatedNullifier":{"times":[0.3544689999998809,0.24943600000005972]},"notifyCreatedNote":{"times":[0.6464259999993374]},"getRandomField":{"times":[0.614464999998745,0.20112499999959255,0.05627199999980803,0.0529210000004241,0.05806200000006356,0.04601099999854341,0.04077099999994971,0.048151000000871136,0.04239100000086182,0.06973199999993085,0.05294099999991886]},"getIndexedTaggingSecretAsSender":{"times":[55.80789399999958]},"incrementAppTaggingSecretIndexAsSender":{"times":[27.48682700000063]}}},{"functionName":"private_kernel_inner","time":168.94172799999978},{"functionName":"SchnorrAccount:entrypoint","time":175.97456500000226,"oracles":{"debugLog":{"times":[0.7342779999999038,0.3619490000000951,1.3105410000007396]},"fetchTaggedLogs":{"times":[52.598307000000204]},"loadCapsule":{"times":[0.27725699999973585,0.20190499999989697,0.17360399999961373]},"getNotes":{"times":[1.396772999998575]},"getAuthWitness":{"times":[0.28522700000030454]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.9564829999999347]}}},{"functionName":"private_kernel_inner","time":150.51523799999995},{"functionName":"private_kernel_reset","time":224.87724499999968},{"functionName":"private_kernel_tail","time":79.98054199999933}],"unaccounted":471.7594670000017}} 14:53:29 [14:53:29.929] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:29 [14:53:29.994] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1cf7b4c17429cb69fe189bb326537c3208dc7e258b0147803de3f883d04cd958","blockNumber":1,"slot":2} 14:53:30 [14:53:30.046] VERBOSE: p2p:tx_pool Adding tx 0x10402477838c150fdf6f98885034d29b8668bd30dcb3b2127c7dc2ba0de14d7c to pool {"eventName":"tx-added-to-pool","txHash":"0x10402477838c150fdf6f98885034d29b8668bd30dcb3b2127c7dc2ba0de14d7c","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 14:53:30 [14:53:30.061] INFO: node Received tx 0x10402477838c150fdf6f98885034d29b8668bd30dcb3b2127c7dc2ba0de14d7c {"txHash":"0x10402477838c150fdf6f98885034d29b8668bd30dcb3b2127c7dc2ba0de14d7c"} 14:53:30 [14:53:30.062] INFO: pxe:service Sent transaction 0x10402477838c150fdf6f98885034d29b8668bd30dcb3b2127c7dc2ba0de14d7c 14:53:30 [14:53:30.135] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:30 [14:53:30.339] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:30 [14:53:30.507] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 14:53:30 [14:53:30.520] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T14:57:48.000Z","now":"2025-06-13T14:57:29.061Z"} 14:53:30 [14:53:30.589] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:30 [14:53:30.769] VERBOSE: simulator:public-processor Processed tx 0x10402477838c150fdf6f98885034d29b8668bd30dcb3b2127c7dc2ba0de14d7c with no public calls in 152.68543899999895ms {"txHash":"0x10402477838c150fdf6f98885034d29b8668bd30dcb3b2127c7dc2ba0de14d7c","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":152.68543899999895} 14:53:30 [14:53:30.777] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.25581584499999915s {"duration":0.25581584499999915,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 14:53:30 [14:53:30.811] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:30 [14:53:30.939] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1f6fb79de5b77d79d66d4a0155b5989b3cd628c35c7dbfcb72da0961b142681d","globalVariables":{"chainId":31337,"version":720795365,"blockNumber":1,"slotNumber":2,"timestamp":1749826668,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x10402477838c150fdf6f98885034d29b8668bd30dcb3b2127c7dc2ba0de14d7c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":431.6909190000006,"publicProcessDuration":257.03985400000056,"rollupCircuitsDuration":419.73745299999973,"txCount":1,"blockNumber":1,"blockTimestamp":1749826668,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:53:30 [14:53:30.941] VERBOSE: sequencer Attesting committee is empty 14:53:31 [14:53:31.028] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:31 [14:53:31.307] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:31 [14:53:31.312] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xdffbcb339b8e58fab94525562d697c49b8bdbd1ebe6dd8514532ce61fb107c68 14:53:31 [14:53:31.313] VERBOSE: sequencer-client Sent L1 transaction 0xdffbcb339b8e58fab94525562d697c49b8bdbd1ebe6dd8514532ce61fb107c68 {"gasLimit":514567,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 14:53:31 [14:53:31.327] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:53:31 [14:53:31.328] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xdffbcb339b8e58fab94525562d697c49b8bdbd1ebe6dd8514532ce61fb107c68","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1749826668,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:53:31 [14:53:31.328] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:53:31 [14:53:31.350] INFO: blob-sink:server Received blob sidecar for block 0x7ff326f3337168f0e4f154d244440d620bb2e62bcdd6c6a71329e2f368d818a6 14:53:31 [14:53:31.360] INFO: blob-sink:server Blob sidecar stored successfully for block 0x7ff326f3337168f0e4f154d244440d620bb2e62bcdd6c6a71329e2f368d818a6 14:53:31 [14:53:31.371] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749826704] on http://127.0.0.1:8545 14:53:31 [14:53:31.374] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:53:31 [14:53:31.376] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749826704 14:53:31 [14:53:31.377] WARN: foundation:test-date-provider Time set to 2025-06-13T14:58:24.000Z {"offset":292623,"timeMs":1749826704000} 14:53:31 [14:53:31.377] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 14:53:31 [14:53:31.510] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:31 [14:53:31.518] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 14:53:31 [14:53:31.520] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 14:53:31 [14:53:31.522] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 14:53:31 [14:53:31.697] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 14:53:31 [14:53:31.703] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1f6fb79de5b77d79d66d4a0155b5989b3cd628c35c7dbfcb72da0961b142681d","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":720795365,"blockNumber":1,"slotNumber":2,"timestamp":1749826668,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0cfdabe171dd697d5f4802f8f420024bffa761e0d7403fef9a48a38c3df1aefb","archiveNextLeafIndex":2} 14:53:31 [14:53:31.709] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 14:53:31 [14:53:31.714] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:31 [14:53:31.846] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":9.833835000001272,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749826668,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:53:31 [14:53:31.859] INFO: pxe:service Registered account 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 14:53:31 [14:53:31.861] VERBOSE: p2p Synched to latest block 1 14:53:31 [14:53:31.961] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:31 [14:53:31.973] INFO: pxe:service Added contract SchnorrAccount at 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 14:53:32 [14:53:32.006] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x0cfdabe171dd697d5f4802f8f420024bffa761e0d7403fef9a48a38c3df1aefb","header":{"contentCommitment":{"blobsHash":"0x00df1851f89bb893c9c2f6a273c5e9a8b53615c6a6c373f28c8c28466a549a96","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749826668,"version":720795365},"lastArchive":"0x1cf7b4c17429cb69fe189bb326537c3208dc7e258b0147803de3f883d04cd958","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x283d088f45d4d1528006fd35c93e3e1fdd0aac62b2e3261b80c94685dc8657b8","nullifierTree":"0x0fd76a1159f32be7920463d311c1a09544c1dab8863da3b7b705a6850a997c3e","publicDataTree":"0x27e5f27b998125931d59ceb8fc72d709b95cf30881f3ac5ed69d447808595928"},"totalFees":6794052480,"totalManaUsed":20448}} 14:53:32 [14:53:32.024] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 14:53:32 [14:53:32.133] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:32 [14:53:32.185] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:32 [14:53:32.193] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:32 [14:53:32.193] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:32 [14:53:32.299] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:32 [14:53:32.306] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:32 [14:53:32.387] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0cfdabe171dd697d5f4802f8f420024bffa761e0d7403fef9a48a38c3df1aefb","blockNumber":2,"slot":3} 14:53:32 [14:53:32.418] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:32 [14:53:32.525] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:32 [14:53:32.572] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:32 [14:53:32.573] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:32 [14:53:32.622] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:32 [14:53:32.636] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:32 [14:53:32.641] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:32 [14:53:32.652] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 as fee payer 14:53:32 [14:53:32.830] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:33 [14:53:33.087] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:33 [14:53:33.209] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0cfdabe171dd697d5f4802f8f420024bffa761e0d7403fef9a48a38c3df1aefb","blockNumber":2,"slot":3} 14:53:33 [14:53:33.698] INFO: pxe:service Proving completed in 1699.849053ms {"timings":{"total":1699.849053,"sync":9.189839999999094,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":86.0597859999998,"oracles":{"callPrivateFunction":{"times":[390.6891090000008,225.6981250000008]}}},{"functionName":"private_kernel_init","time":94.01941699999952},{"functionName":"SchnorrAccount:constructor","time":367.0482240000001,"oracles":{"getContractInstance":{"times":[5.498021999999764]},"debugLog":{"times":[0.4226909999997588,0.4265209999994113]},"fetchTaggedLogs":{"times":[111.19841799999995]},"loadCapsule":{"times":[0.24965599999995902,0.2969379999994999,0.29239699999925506]},"notifyCreatedNullifier":{"times":[0.16683299999931478,0.247906000000512]},"notifyCreatedNote":{"times":[0.15268400000059046]},"getRandomField":{"times":[0.2696169999999256,0.23305600000094273,0.08601199999975506,0.08757200000036391,0.05502100000012433,0.053631000000677886,0.0484310000010737,0.03714100000070175,0.03512099999898055,0.04239100000086182,0.03672100000039791]},"getIndexedTaggingSecretAsSender":{"times":[48.59309099999882]},"incrementAppTaggingSecretIndexAsSender":{"times":[52.89211500000056]}}},{"functionName":"private_kernel_inner","time":150.44886699999915},{"functionName":"SchnorrAccount:entrypoint","time":202.62992399999894,"oracles":{"debugLog":{"times":[0.9299530000007508,0.5575640000006388,0.542793000000529]},"fetchTaggedLogs":{"times":[67.1413649999995]},"loadCapsule":{"times":[0.23220600000058766,0.23069500000019616,0.30190700000093784]},"getNotes":{"times":[1.1446070000001782]},"getAuthWitness":{"times":[0.15603399999963585]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.47171200000047975]}}},{"functionName":"private_kernel_inner","time":171.35703599999943},{"functionName":"private_kernel_reset","time":217.56814099999974},{"functionName":"private_kernel_tail","time":86.21216099999947}],"unaccounted":315.31565700000465}} 14:53:33 [14:53:33.717] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:33 [14:53:33.776] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x0cfdabe171dd697d5f4802f8f420024bffa761e0d7403fef9a48a38c3df1aefb","blockNumber":2,"slot":3} 14:53:33 [14:53:33.782] VERBOSE: p2p:tx_pool Adding tx 0x26ae22305acb0c1f9fde1f89e5a61649f7a317d1e68dc6b76304ebbc961b51f9 to pool {"eventName":"tx-added-to-pool","txHash":"0x26ae22305acb0c1f9fde1f89e5a61649f7a317d1e68dc6b76304ebbc961b51f9","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 14:53:33 [14:53:33.789] INFO: node Received tx 0x26ae22305acb0c1f9fde1f89e5a61649f7a317d1e68dc6b76304ebbc961b51f9 {"txHash":"0x26ae22305acb0c1f9fde1f89e5a61649f7a317d1e68dc6b76304ebbc961b51f9"} 14:53:33 [14:53:33.790] INFO: pxe:service Sent transaction 0x26ae22305acb0c1f9fde1f89e5a61649f7a317d1e68dc6b76304ebbc961b51f9 14:53:33 [14:53:33.928] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:34 [14:53:34.131] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:34 [14:53:34.316] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 14:53:34 [14:53:34.333] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T14:58:24.000Z","now":"2025-06-13T14:58:26.956Z"} 14:53:34 [14:53:34.334] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:34 [14:53:34.358] VERBOSE: simulator:public-processor Processed tx 0x26ae22305acb0c1f9fde1f89e5a61649f7a317d1e68dc6b76304ebbc961b51f9 with no public calls in 14.349483000001783ms {"txHash":"0x26ae22305acb0c1f9fde1f89e5a61649f7a317d1e68dc6b76304ebbc961b51f9","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":14.349483000001783} 14:53:34 [14:53:34.362] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02829418600000281s {"duration":0.02829418600000281,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 14:53:34 [14:53:34.480] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0d91e638214db3132874554eebbc14e4f5506c4e4598d1be7ce447390d9583b1","globalVariables":{"chainId":31337,"version":720795365,"blockNumber":2,"slotNumber":3,"timestamp":1749826704,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x26ae22305acb0c1f9fde1f89e5a61649f7a317d1e68dc6b76304ebbc961b51f9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":164.2901270000002,"publicProcessDuration":28.60927399999855,"rollupCircuitsDuration":148.49287000000186,"txCount":1,"blockNumber":2,"blockTimestamp":1749826704,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:34 [14:53:34.483] VERBOSE: sequencer Attesting committee is empty 14:53:34 [14:53:34.566] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:34 [14:53:34.758] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x93137a844c0b2e5dce4bded8f1a89437307712ad0215b349ab0ce4bee0178744 14:53:34 [14:53:34.758] VERBOSE: sequencer-client Sent L1 transaction 0x93137a844c0b2e5dce4bded8f1a89437307712ad0215b349ab0ce4bee0178744 {"gasLimit":470251,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:53:34 [14:53:34.768] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:34 [14:53:34.771] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:53:34 [14:53:34.771] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x93137a844c0b2e5dce4bded8f1a89437307712ad0215b349ab0ce4bee0178744","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":2,"blockTimestamp":1749826704,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:34 [14:53:34.771] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:53:34 [14:53:34.779] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 14:53:34 [14:53:34.782] INFO: blob-sink:server Received blob sidecar for block 0x4c2b8c9fdc5280b7db4a54f35a90c52c26c256cfaa1f1246ae68337a5a369475 14:53:34 [14:53:34.784] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 14:53:34 [14:53:34.788] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 14:53:34 [14:53:34.788] INFO: blob-sink:server Blob sidecar stored successfully for block 0x4c2b8c9fdc5280b7db4a54f35a90c52c26c256cfaa1f1246ae68337a5a369475 14:53:34 [14:53:34.823] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749826740] on http://127.0.0.1:8545 14:53:34 [14:53:34.825] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:53:34 [14:53:34.827] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749826740 14:53:34 [14:53:34.827] WARN: foundation:test-date-provider Time set to 2025-06-13T14:59:00.000Z {"offset":325173,"timeMs":1749826740000} 14:53:34 [14:53:34.827] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 14:53:34 [14:53:34.952] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0d91e638214db3132874554eebbc14e4f5506c4e4598d1be7ce447390d9583b1","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":720795365,"blockNumber":2,"slotNumber":3,"timestamp":1749826704,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1f8404e2e6c89ee42dc480f1f3a68cd1300824c585a9b3c81236674fe603b46b","archiveNextLeafIndex":3} 14:53:34 [14:53:34.954] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 14:53:34 [14:53:34.976] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:35 [14:53:35.078] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":10.558951999999408,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749826704,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:35 [14:53:35.090] VERBOSE: p2p Synched to latest block 2 14:53:35 [14:53:35.208] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:35 [14:53:35.254] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x1f8404e2e6c89ee42dc480f1f3a68cd1300824c585a9b3c81236674fe603b46b","header":{"contentCommitment":{"blobsHash":"0x0046b79e7d9aea6f921c4390b4012d0d3d7dc122e70a8bf1cf5b1cf4da033b51","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749826704,"version":720795365},"lastArchive":"0x0cfdabe171dd697d5f4802f8f420024bffa761e0d7403fef9a48a38c3df1aefb","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21493a057b3ec8941ae01cae9e5e830f83118c1ac3fe88c1e9abdbce7f1da102","nullifierTree":"0x06f31741dc120cf2cc6f9eff76e371444592bf5a9914dbd4cee45efcdb1a602e","publicDataTree":"0x095a1720a7eaf1214468aea11d02f361fff2862c7ae9471be9afcf26060b22e0"},"totalFees":5018455040,"totalManaUsed":15104}} 14:53:35 [14:53:35.342] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:35 [14:53:35.395] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:35 [14:53:35.396] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:35 [14:53:35.430] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:35 [14:53:35.435] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1f8404e2e6c89ee42dc480f1f3a68cd1300824c585a9b3c81236674fe603b46b","blockNumber":3,"slot":4} 14:53:35 [14:53:35.486] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:35 [14:53:35.493] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:35 [14:53:35.505] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:35 [14:53:35.506] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:35 [14:53:35.515] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:35 [14:53:35.515] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:35 [14:53:35.521] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:35 [14:53:35.524] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:35 [14:53:35.543] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 as fee payer 14:53:35 [14:53:35.588] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 14:53:35 [14:53:35.631] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:53:35 [14:53:35.647] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86,0x0000000000000000000000000000000000000000000000000000000000000001,0x1d0dd859df17549650285a25e51c1bd3ee3c426a1826c304e77f17e9cf252af0,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x2c5bcec32c688bb3bdb8aa906e19f954192efb8ada54101bf7c57ce986098863,0x25e60bc320a3ce61d03e64bacb36dafd40d4a2bd8f9fd605ae05c72b2864ade5,0x1f9d2143c8de8f66c6c7d848aebff9f81ff145c3d7b1528fbd42b628c2e5a941,0x0bd22a2c2cdeaaaccf3144d3f862189d152c7f865a82689c91774b44e4e844a6,0x2a146bc273f581c60fb25a1154e1f264c01b96023a04913b35e3401056a60119,0x167a22163dea43bbda6929495d31ef5cfa250b44f7c2a1791198cde9a88ac128,0x1e7e596aa40d5cc12990cafd0868c2b119f5e4c9c38a558bf7473dfd54728874,0x1c77d5d9a8bdbfd1ad1d11b34d9055cad2f4e8d9052798ed028c9d310e79da17,0x026342a197caf80420b3049a8290dd9db920e0a1b73ccd38a611055241965297,0x0000000000000000000000000000000000000000000000000000000000000000 14:53:35 [14:53:35.656] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:35 [14:53:35.701] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 14:53:35 [14:53:35.736] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:53:35 [14:53:35.749] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922,0x0000000000000000000000000000000000000000000000000000000000000001,0x29b399f5ef5c28e5b5b25ae7ac8b83a8c729e880878d97695e28559a8961d82a,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x19cafb01c63dc8686b3f9deb1a5b4fef5d2dc743d12ab9d40f2c8e9c3dc5c280,0x2801f3462333c8c503be05a8fca6e6ba5e47b89ecf343c050c47e3ed5a4ca12c,0x24fdc38c01f3f20df53b1032251c48fa6a5c12069975eaf9beb84da3d02dd8ab,0x0c102e009cd2cc8040e1ce0745ab8fecf3eb8976613354d2b9f3ce4c0686c82e,0x1709283822adadafdf16c77b33747bde27a27025c3c1d9e54e51c52e3300fa70,0x06316f03f23f42f96d50d4fe336054aafa3bbcd4afce7ee957faf87e4e2a0d62,0x0eed117d452c99350a14454a17e3371b829eb540eb41cbc036384237ca4b0640,0x005cf4fdc22ac184dbfd6aab50499882c8ed260106aecf7f472a108279948e31,0x0d9bd71608d8dfcc7724ec499869e59fffc06e7d94ad0ab854660a2fed38d0d2,0x0000000000000000000000000000000000000000000000000000000000000000 14:53:35 [14:53:35.936] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:36 [14:53:36.169] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:36 [14:53:36.172] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1f8404e2e6c89ee42dc480f1f3a68cd1300824c585a9b3c81236674fe603b46b","blockNumber":3,"slot":4} 14:53:36 [14:53:36.387] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:36 [14:53:36.650] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:36 [14:53:36.873] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:36 [14:53:36.892] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1f8404e2e6c89ee42dc480f1f3a68cd1300824c585a9b3c81236674fe603b46b","blockNumber":3,"slot":4} 14:53:37 [14:53:37.170] INFO: pxe:service Proving completed in 1922.4533940000001ms {"timings":{"total":1922.4533940000001,"sync":7.609822000002168,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":309.687925000002,"oracles":{"debugLog":{"times":[0.7130280000019411,0.44791000000259373,0.44038000000000466,0.4405800000022282,0.5677729999988514,0.4981709999992745,0.36504799999966053,0.6460349999979371]},"fetchTaggedLogs":{"times":[96.09243700000297]},"loadCapsule":{"times":[0.22390500000255997,0.24418599999989965,0.31695699999909266,0.25461599999835016,0.26294599999891943,0.1976539999996021]},"getSharedSecret":{"times":[4.232361000002129]},"aes128Decrypt":{"times":[1.0581449999990582,0.7365680000002612]},"getPublicKeysAndPartialAddress":{"times":[2.7841369999987364]},"getKeyValidationRequest":{"times":[2.6306230000009236]},"deliverNote":{"times":[5.722175999999308]},"deleteCapsule":{"times":[0.5340230000001611]},"storeCapsule":{"times":[0.466841999997996]},"getNotes":{"times":[2.177592000000004]},"getAuthWitness":{"times":[0.27000600000246777]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0691210000004503]},"callPrivateFunction":{"times":[109.30955299999914,105.08396200000061]}}},{"functionName":"private_kernel_init","time":69.17889300000024},{"functionName":"ContractInstanceDeployer:deploy","time":63.37962399999742,"oracles":{"storeInExecutionCache":{"times":[0.27030699999886565]},"callPrivateFunction":{"times":[46.18187399999806]},"notifyCreatedNullifier":{"times":[0.31840700000248034]},"debugLog":{"times":[0.6371049999979732]}}},{"functionName":"private_kernel_inner","time":131.30105900000126},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":28.96414300000106,"oracles":{}},{"functionName":"private_kernel_inner","time":144.7606999999989},{"functionName":"ContractInstanceDeployer:deploy","time":58.05558700000256,"oracles":{"storeInExecutionCache":{"times":[0.09759199999825796]},"callPrivateFunction":{"times":[38.63876299999902]},"notifyCreatedNullifier":{"times":[0.29516700000021956]},"debugLog":{"times":[0.6143650000012713]}}},{"functionName":"private_kernel_inner","time":178.7108420000004},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":26.44719199999963,"oracles":{}},{"functionName":"private_kernel_inner","time":115.73082699999941},{"functionName":"private_kernel_reset","time":216.74366100000043},{"functionName":"private_kernel_tail","time":80.71439999999711}],"unaccounted":491.1687189999975}} 14:53:37 [14:53:37.183] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:37 [14:53:37.207] VERBOSE: p2p:tx_pool Adding tx 0x1a0f0d239e8755b6f6ab02dc4b68e049ef2ce8e654e7f0e5b740e6fb6f31b40f to pool {"eventName":"tx-added-to-pool","txHash":"0x1a0f0d239e8755b6f6ab02dc4b68e049ef2ce8e654e7f0e5b740e6fb6f31b40f","noteHashCount":0,"nullifierCount":3,"privateLogCount":2,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 14:53:37 [14:53:37.213] INFO: node Received tx 0x1a0f0d239e8755b6f6ab02dc4b68e049ef2ce8e654e7f0e5b740e6fb6f31b40f {"txHash":"0x1a0f0d239e8755b6f6ab02dc4b68e049ef2ce8e654e7f0e5b740e6fb6f31b40f"} 14:53:37 [14:53:37.213] INFO: pxe:service Sent transaction 0x1a0f0d239e8755b6f6ab02dc4b68e049ef2ce8e654e7f0e5b740e6fb6f31b40f 14:53:37 [14:53:37.387] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:37 [14:53:37.422] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 14:53:37 [14:53:37.433] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T14:59:00.000Z","now":"2025-06-13T14:59:02.606Z"} 14:53:37 [14:53:37.454] VERBOSE: simulator:public-processor Processed tx 0x1a0f0d239e8755b6f6ab02dc4b68e049ef2ce8e654e7f0e5b740e6fb6f31b40f with no public calls in 13.696657999997115ms {"txHash":"0x1a0f0d239e8755b6f6ab02dc4b68e049ef2ce8e654e7f0e5b740e6fb6f31b40f","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":13.696657999997115} 14:53:37 [14:53:37.456] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.021831191999997827s {"duration":0.021831191999997827,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":18432,"l2Gas":16544},"totalSizeInBytes":1376} 14:53:37 [14:53:37.615] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:37 [14:53:37.631] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x14156f6b79711b2b010cef741f3666f04711eacea9add1edc82fb4eef8ef2024","globalVariables":{"chainId":31337,"version":720795365,"blockNumber":3,"slotNumber":4,"timestamp":1749826740,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1a0f0d239e8755b6f6ab02dc4b68e049ef2ce8e654e7f0e5b740e6fb6f31b40f"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":208.41973199999848,"publicProcessDuration":22.161639999998442,"rollupCircuitsDuration":198.0790249999991,"txCount":1,"blockNumber":3,"blockTimestamp":1749826740,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:37 [14:53:37.634] VERBOSE: sequencer Attesting committee is empty 14:53:37 [14:53:37.891] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:37 [14:53:37.899] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x0dab37d5b0b00986a3a19d498635a471d75a2fb6770ea47ea7f91cd2adb64dd7 14:53:37 [14:53:37.899] VERBOSE: sequencer-client Sent L1 transaction 0x0dab37d5b0b00986a3a19d498635a471d75a2fb6770ea47ea7f91cd2adb64dd7 {"gasLimit":470298,"maxFeePerGas":"1.279583398","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:53:37 [14:53:37.912] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:53:37 [14:53:37.912] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x0dab37d5b0b00986a3a19d498635a471d75a2fb6770ea47ea7f91cd2adb64dd7","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1749826740,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:37 [14:53:37.913] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:53:37 [14:53:37.917] INFO: blob-sink:server Received blob sidecar for block 0x638aeb24a767e06399c303e22cd3e04ebeaee21f5c029748a3e5958921bddd6f 14:53:37 [14:53:37.925] INFO: blob-sink:server Blob sidecar stored successfully for block 0x638aeb24a767e06399c303e22cd3e04ebeaee21f5c029748a3e5958921bddd6f 14:53:37 [14:53:37.933] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749826776] on http://127.0.0.1:8545 14:53:37 [14:53:37.935] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:53:37 [14:53:37.937] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749826776 14:53:37 [14:53:37.938] WARN: foundation:test-date-provider Time set to 2025-06-13T14:59:36.000Z {"offset":358062,"timeMs":1749826776000} 14:53:37 [14:53:37.938] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 14:53:38 [14:53:38.085] VERBOSE: archiver:block-helper Store contract instance at 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 14:53:38 [14:53:38.086] VERBOSE: archiver:block-helper Store contract instance at 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 14:53:38 [14:53:38.088] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x14156f6b79711b2b010cef741f3666f04711eacea9add1edc82fb4eef8ef2024","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":720795365,"blockNumber":3,"slotNumber":4,"timestamp":1749826740,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x169b6ce9e34db7f4b475251f941d9bc8366702a34c1b63bb9bd0f2baa46d712e","archiveNextLeafIndex":4} 14:53:38 [14:53:38.094] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:38 [14:53:38.103] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 14:53:38 [14:53:38.105] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 14:53:38 [14:53:38.107] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 14:53:38 [14:53:38.200] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":11.915485000001354,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749826740,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:38 [14:53:38.206] VERBOSE: p2p Synched to latest block 3 14:53:38 [14:53:38.235] WARN: pxe:service No artifact found for contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c when looking for its metadata 14:53:38 [14:53:38.237] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c as part of deployment for 0x16f0d03f427753a7e25c2fc05565e8b130913bce1eab57ab319e891668af756b 14:53:38 [14:53:38.308] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:38 [14:53:38.366] INFO: pxe:service Added contract AuthWitTest at 0x16f0d03f427753a7e25c2fc05565e8b130913bce1eab57ab319e891668af756b with class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c 14:53:38 [14:53:38.405] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x169b6ce9e34db7f4b475251f941d9bc8366702a34c1b63bb9bd0f2baa46d712e","header":{"contentCommitment":{"blobsHash":"0x00d3b35d68d81c7bb30805a1b21f4a553ff7341ff44b27a5bba4d488432f3131","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749826740,"version":720795365},"lastArchive":"0x1f8404e2e6c89ee42dc480f1f3a68cd1300824c585a9b3c81236674fe603b46b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21493a057b3ec8941ae01cae9e5e830f83118c1ac3fe88c1e9abdbce7f1da102","nullifierTree":"0x1f44fff04327c83401910d1e54009bfb7817773c034515684772da96dc728911","publicDataTree":"0x2165bb64dbfe8e35c85baf66e22edc3293e00b68bc4b4b24ddb4bac0145ae30b"},"totalFees":5496909440,"totalManaUsed":16544}} 14:53:38 [14:53:38.517] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:38 [14:53:38.579] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:38 [14:53:38.580] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:38 [14:53:38.586] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:38 [14:53:38.640] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x169b6ce9e34db7f4b475251f941d9bc8366702a34c1b63bb9bd0f2baa46d712e","blockNumber":4,"slot":5} 14:53:38 [14:53:38.645] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 14:53:38 [14:53:38.686] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:38 [14:53:38.695] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:38 [14:53:38.707] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:38 [14:53:38.708] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:38 [14:53:38.715] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:38 [14:53:38.715] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:38 [14:53:38.719] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:38 [14:53:38.722] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:38 [14:53:38.737] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 as fee payer 14:53:38 [14:53:38.779] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:53:39 [14:53:39.287] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0b531072c192262f69310be602c8bfeb8f4e36acff72ed861afd4f76ee50de56,0x2054c0397fca7702b6f9252401dd1f653f4e20cff98e2eb5395de9bbdc250278,0x2b6ecadb0b2de2c700fc27a25c15b4c8eb590b62f353cdd047a57ce195071418 14:53:39 [14:53:39.393] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 14:53:39 [14:53:39.452] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:39 [14:53:39.523] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 14:53:39 [14:53:39.533] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x169b6ce9e34db7f4b475251f941d9bc8366702a34c1b63bb9bd0f2baa46d712e","blockNumber":4,"slot":5} 14:53:39 [14:53:39.556] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 14:53:39 [14:53:39.566] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x16f0d03f427753a7e25c2fc05565e8b130913bce1eab57ab319e891668af756b,0x0000000000000000000000000000000000000000000000000000000000000001,0x04244293769865cdee985c7a5c9349116ff5d5a1ba2894a41f65a9dac79b6fe3,0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 14:53:39 [14:53:39.718] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:39 [14:53:39.958] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:40 [14:53:40.161] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:40 [14:53:40.189] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x169b6ce9e34db7f4b475251f941d9bc8366702a34c1b63bb9bd0f2baa46d712e","blockNumber":4,"slot":5} 14:53:40 [14:53:40.631] INFO: pxe:service Proving completed in 2245.567938ms {"timings":{"total":2245.567938,"sync":21.25616799999989,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":342.54782799999884,"oracles":{"debugLog":{"times":[0.6945560000021942,0.5510729999987234,0.3700890000000072,0.43213099999775295,0.4609009999985574,0.4141700000000128,0.5544630000003963,0.595763999997871]},"fetchTaggedLogs":{"times":[112.15663199999835]},"loadCapsule":{"times":[0.23710600000049453,0.2604060000012396,0.5086719999999332,0.3488980000001902,1.5067459999991115,0.24694599999929778]},"getSharedSecret":{"times":[4.985038999999233]},"aes128Decrypt":{"times":[0.2331850000009581,0.7108870000010938]},"getPublicKeysAndPartialAddress":{"times":[1.3969029999971099]},"getKeyValidationRequest":{"times":[1.9903879999983474]},"deliverNote":{"times":[3.6948689999990165]},"deleteCapsule":{"times":[0.39095999999699416]},"storeCapsule":{"times":[0.385309999997844]},"getNotes":{"times":[1.9358260000008158]},"getAuthWitness":{"times":[0.20454399999653106]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09560199999759789]},"callPrivateFunction":{"times":[706.7582140000013,122.36665499999799]}}},{"functionName":"private_kernel_init","time":60.85770499999853},{"functionName":"ContractClassRegisterer:register","time":688.6201909999982,"oracles":{"loadCapsule":{"times":[5.272295999999187]},"notifyCreatedNullifier":{"times":[0.759689000002254]},"debugLog":{"times":[1.116336000002775]},"notifyCreatedContractClassLog":{"times":[10.116570999998657]}}},{"functionName":"private_kernel_inner","time":132.03331700000126},{"functionName":"ContractInstanceDeployer:deploy","time":80.90914500000144,"oracles":{"storeInExecutionCache":{"times":[0.0849320000015723]},"callPrivateFunction":{"times":[33.51724099999774]},"notifyCreatedNullifier":{"times":[0.31540700000186916]},"debugLog":{"times":[0.40442000000257394]}}},{"functionName":"private_kernel_inner","time":113.22095700000136},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":25.19778099999894,"oracles":{}},{"functionName":"private_kernel_inner","time":126.08236399999805},{"functionName":"private_kernel_reset","time":210.71666600000026},{"functionName":"private_kernel_tail","time":100.66879700000209}],"unaccounted":343.4570190000013}} 14:53:40 [14:53:40.650] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:40 [14:53:40.811] VERBOSE: p2p:tx_pool Adding tx 0x1cc40ee39bf255d97284682e31d62938b0d4284c8720b1284422fe90dbeee49d to pool {"eventName":"tx-added-to-pool","txHash":"0x1cc40ee39bf255d97284682e31d62938b0d4284c8720b1284422fe90dbeee49d","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":55,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 14:53:40 [14:53:40.836] INFO: node Received tx 0x1cc40ee39bf255d97284682e31d62938b0d4284c8720b1284422fe90dbeee49d {"txHash":"0x1cc40ee39bf255d97284682e31d62938b0d4284c8720b1284422fe90dbeee49d"} 14:53:40 [14:53:40.837] INFO: pxe:service Sent transaction 0x1cc40ee39bf255d97284682e31d62938b0d4284c8720b1284422fe90dbeee49d 14:53:40 [14:53:40.861] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:40 [14:53:40.891] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 14:53:40 [14:53:40.915] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-13T14:59:36.000Z","now":"2025-06-13T14:59:38.977Z"} 14:53:41 [14:53:41.170] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:41 [14:53:41.261] VERBOSE: simulator:public-processor Processed tx 0x1cc40ee39bf255d97284682e31d62938b0d4284c8720b1284422fe90dbeee49d with no public calls in 229.6421999999984ms {"txHash":"0x1cc40ee39bf255d97284682e31d62938b0d4284c8720b1284422fe90dbeee49d","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":229.6421999999984} 14:53:41 [14:53:41.265] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.349082864s {"duration":0.349082864,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":39424,"l2Gas":16544},"totalSizeInBytes":2720} 14:53:41 [14:53:41.421] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:41 [14:53:41.449] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x20796976f06c9aed2922ab3974fb30dd6b073997fbdc033f79841a0047ff8eb8","globalVariables":{"chainId":31337,"version":720795365,"blockNumber":4,"slotNumber":5,"timestamp":1749826776,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x1cc40ee39bf255d97284682e31d62938b0d4284c8720b1284422fe90dbeee49d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":577.6229469999998,"publicProcessDuration":349.5861560000012,"rollupCircuitsDuration":537.3128830000023,"txCount":1,"blockNumber":4,"blockTimestamp":1749826776,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 14:53:41 [14:53:41.483] VERBOSE: sequencer Attesting committee is empty 14:53:41 [14:53:41.627] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:41 [14:53:41.812] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xaccffd59e878a4f62f8746951b8e91bdcd6a978640ffbdbbc494872d797bae44 14:53:41 [14:53:41.813] VERBOSE: sequencer-client Sent L1 transaction 0xaccffd59e878a4f62f8746951b8e91bdcd6a978640ffbdbbc494872d797bae44 {"gasLimit":470215,"maxFeePerGas":"1.26112774","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:53:41 [14:53:41.829] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:41 [14:53:41.832] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:53:41 [14:53:41.833] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xaccffd59e878a4f62f8746951b8e91bdcd6a978640ffbdbbc494872d797bae44","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":4,"blockTimestamp":1749826776,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 14:53:41 [14:53:41.833] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:53:41 [14:53:41.843] INFO: blob-sink:server Received blob sidecar for block 0xa1de6159a969980eb2683fb3d1467ae4da4c15bc1bdce788d36ea9652c176b86 14:53:41 [14:53:41.845] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749826812] on http://127.0.0.1:8545 14:53:41 [14:53:41.851] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:53:41 [14:53:41.858] INFO: blob-sink:server Blob sidecar stored successfully for block 0xa1de6159a969980eb2683fb3d1467ae4da4c15bc1bdce788d36ea9652c176b86 14:53:41 [14:53:41.863] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749826812 14:53:41 [14:53:41.864] WARN: foundation:test-date-provider Time set to 2025-06-13T15:00:12.000Z {"offset":390136,"timeMs":1749826812000} 14:53:41 [14:53:41.864] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 14:53:41 [14:53:41.868] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 14:53:41 [14:53:41.871] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 14:53:41 [14:53:41.874] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 14:53:41 [14:53:41.986] VERBOSE: archiver:block-helper Store contract instance at 0x16f0d03f427753a7e25c2fc05565e8b130913bce1eab57ab319e891668af756b 14:53:42 [14:53:41.997] VERBOSE: archiver:block-helper Store contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c 14:53:42 [14:53:42.044] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:42 [14:53:42.058] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x20796976f06c9aed2922ab3974fb30dd6b073997fbdc033f79841a0047ff8eb8","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":720795365,"blockNumber":4,"slotNumber":5,"timestamp":1749826776,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0fb2fb5bba8a1aac9db502f0e073c99420d42741f74d960734732f04863127d9","archiveNextLeafIndex":5} 14:53:42 [14:53:42.192] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":27.61409999999887,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749826776,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 14:53:42 [14:53:42.218] VERBOSE: p2p Synched to latest block 4 14:53:42 [14:53:42.257] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:42 [14:53:42.355] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2fb5bba8a1aac9db502f0e073c99420d42741f74d960734732f04863127d9","blockNumber":5,"slot":6} 14:53:42 [14:53:42.460] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:42 [14:53:42.646] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 14:53:42 [14:53:42.664] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:42 [14:53:42.869] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:42 [14:53:42.893] INFO: aztecjs:deploy_sent_tx Contract 0x16f0d03f427753a7e25c2fc05565e8b130913bce1eab57ab319e891668af756b successfully deployed. 14:53:42 [14:53:42.896] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data happy path 14:53:42 [14:53:42.904] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2fb5bba8a1aac9db502f0e073c99420d42741f74d960734732f04863127d9","blockNumber":5,"slot":6} 14:53:42 [14:53:42.922] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x0fb2fb5bba8a1aac9db502f0e073c99420d42741f74d960734732f04863127d9","header":{"contentCommitment":{"blobsHash":"0x00964b5f5185e9f29025036b0ee253c8ef764cc4ef58acb334a29d4d375a8279","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749826776,"version":720795365},"lastArchive":"0x169b6ce9e34db7f4b475251f941d9bc8366702a34c1b63bb9bd0f2baa46d712e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21493a057b3ec8941ae01cae9e5e830f83118c1ac3fe88c1e9abdbce7f1da102","nullifierTree":"0x1da5d32686211bc01879e569eaa934a09d54a7df5e41b0041166e94004814adb","publicDataTree":"0x2bbf66f3dbffa88d0d1fbae3ac48384864764b9f561647b45327bd2c26819e15"},"totalFees":838780800,"totalManaUsed":16544}} 14:53:43 [14:53:43.051] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:53:43 [14:53:43.072] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:53:43 [14:53:43.073] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:43 [14:53:43.078] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:43 [14:53:43.211] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:43 [14:53:43.230] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:43 [14:53:43.255] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:53:43 [14:53:43.256] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:43 [14:53:43.273] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:43 [14:53:43.273] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:43 [14:53:43.292] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:43 [14:53:43.309] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:43 [14:53:43.321] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:43 [14:53:43.349] VERBOSE: simulator Utility simulation for 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86.0xd191fb1a completed 14:53:43 [14:53:43.438] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:53:43 [14:53:43.452] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:53:43 [14:53:43.477] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2fb5bba8a1aac9db502f0e073c99420d42741f74d960734732f04863127d9","blockNumber":5,"slot":6} 14:53:43 [14:53:43.514] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:43 [14:53:43.629] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","selector":"0xd191fb1a"} 14:53:43 [14:53:43.644] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:53:43 [14:53:43.644] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:43 [14:53:43.729] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:43 [14:53:43.814] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:43 [14:53:43.827] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x18b5d0f802875a1e2aac6f666b52a68aed67cb035dfe672214e762dfd008fcba 14:53:43 [14:53:43.841] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:53:43 [14:53:43.842] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:43 [14:53:43.860] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:43 [14:53:43.861] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:43 [14:53:43.871] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x00d7f36c90e1f085251b88f86ba4f4a7a14824b2e2acf7cb1076ba2d2dafdcf4","nullifier":"0x19cf976a055d616acced99ca7656a2b2e1cfa378a80915ff8a95fd4254f3dea2"} 14:53:43 [14:53:43.875] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:43 [14:53:43.890] VERBOSE: simulator Utility simulation for 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922.0xd191fb1a completed 14:53:43 [14:53:43.937] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:53:43 [14:53:43.943] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:43 [14:53:43.948] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:53:44 [14:53:44.078] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:44 [14:53:44.141] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:44 [14:53:44.141] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:44 [14:53:44.145] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2fb5bba8a1aac9db502f0e073c99420d42741f74d960734732f04863127d9","blockNumber":5,"slot":6} 14:53:44 [14:53:44.148] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:44 [14:53:44.216] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:44 [14:53:44.226] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x18b5d0f802875a1e2aac6f666b52a68aed67cb035dfe672214e762dfd008fcba 14:53:44 [14:53:44.236] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:44 [14:53:44.236] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:44 [14:53:44.242] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:44 [14:53:44.242] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:44 [14:53:44.245] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x00d7f36c90e1f085251b88f86ba4f4a7a14824b2e2acf7cb1076ba2d2dafdcf4","nullifier":"0x19cf976a055d616acced99ca7656a2b2e1cfa378a80915ff8a95fd4254f3dea2"} 14:53:44 [14:53:44.247] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:44 [14:53:44.269] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 as fee payer 14:53:44 [14:53:44.294] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x16f0d03f427753a7e25c2fc05565e8b130913bce1eab57ab319e891668af756b"} 14:53:44 [14:53:44.372] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:44 [14:53:44.479] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:44 [14:53:44.512] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:44 [14:53:44.512] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:44 [14:53:44.659] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:44 [14:53:44.740] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:44 [14:53:44.741] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2fb5bba8a1aac9db502f0e073c99420d42741f74d960734732f04863127d9","blockNumber":5,"slot":6} 14:53:44 [14:53:44.756] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:44 [14:53:44.774] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:44 [14:53:44.775] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:44 [14:53:44.791] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:44 [14:53:44.792] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:44 [14:53:44.799] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:44 [14:53:44.804] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:44 [14:53:44.879] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:45 [14:53:45.116] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:45 [14:53:45.385] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:45 [14:53:45.403] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2fb5bba8a1aac9db502f0e073c99420d42741f74d960734732f04863127d9","blockNumber":5,"slot":6} 14:53:45 [14:53:45.904] INFO: pxe:service Proving completed in 1937.9104579999985ms {"timings":{"total":1937.9104579999985,"sync":10.511231000000407,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":288.7234839999983,"oracles":{"debugLog":{"times":[0.5985540000001492,0.4297100000003411,0.372019000002183,0.39461999999912223,0.30193700000018,0.29428700000062236,0.30515699999887147,0.7136769999997341]},"fetchTaggedLogs":{"times":[82.71006799999668]},"loadCapsule":{"times":[0.1971850000008999,0.17341499999747612,0.31647700000030454,0.3230680000015127,0.2141349999983504,0.35487799999827985]},"getSharedSecret":{"times":[3.824192000000039]},"aes128Decrypt":{"times":[0.40921999999773107,1.0010340000008]},"getPublicKeysAndPartialAddress":{"times":[1.1635580000001937]},"getKeyValidationRequest":{"times":[1.54509699999835]},"deliverNote":{"times":[3.0579739999993762]},"deleteCapsule":{"times":[0.2846269999972719]},"storeCapsule":{"times":[0.40398999999888474]},"getNotes":{"times":[5.338098000000173]},"getAuthWitness":{"times":[0.263915999999881]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06774199999927077]},"callPrivateFunction":{"times":[567.7187649999978]}}},{"functionName":"private_kernel_init","time":94.46488900000259},{"functionName":"AuthWitTest:consume","time":79.5712429999985,"oracles":{"storeInExecutionCache":{"times":[0.14503399999739486]},"callPrivateFunction":{"times":[528.4546559999981]},"loadFromExecutionCache":{"times":[0.17925499999910244]},"notifyCreatedNullifier":{"times":[0.35685799999919254]}}},{"functionName":"private_kernel_inner","time":128.45384199999899},{"functionName":"SchnorrAccount:verify_private_authwit","time":477.6337600000006,"oracles":{"debugLog":{"times":[0.5331530000003113,0.6174549999996088,0.4506310000033409,0.5695039999991423,0.7501179999999295,0.46845099999700324,0.6415759999981674]},"fetchTaggedLogs":{"times":[240.05680899999788]},"loadCapsule":{"times":[0.6657059999997728,0.5198530000016035,0.7382680000009714,0.9178419999989273,0.6161240000001271,0.9987029999974766]},"getSharedSecret":{"times":[9.778433999999834]},"aes128Decrypt":{"times":[0.3918699999994715,1.1387270000013814]},"getPublicKeysAndPartialAddress":{"times":[3.838242000001628]},"getKeyValidationRequest":{"times":[8.637226000002556]},"deliverNote":{"times":[8.02552199999991]},"deleteCapsule":{"times":[0.5861839999997756]},"storeCapsule":{"times":[0.3525789999985136]},"getNotes":{"times":[7.245332999998936]},"getAuthWitness":{"times":[0.2002539999994042]},"storeInExecutionCache":{"times":[0.20716499999980442]}}},{"functionName":"private_kernel_inner","time":170.66668100000243},{"functionName":"private_kernel_reset","time":223.53353499999866},{"functionName":"private_kernel_tail","time":100.1010239999996}],"unaccounted":364.2507689999984}} 14:53:45 [14:53:45.919] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:45 [14:53:45.966] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x0fb2fb5bba8a1aac9db502f0e073c99420d42741f74d960734732f04863127d9","blockNumber":5,"slot":6} 14:53:45 [14:53:45.968] VERBOSE: p2p:tx_pool Adding tx 0x2a07926eec4e182819c63703ec9240567e5f3ccbb0c591dabdb17e511344f76f to pool {"eventName":"tx-added-to-pool","txHash":"0x2a07926eec4e182819c63703ec9240567e5f3ccbb0c591dabdb17e511344f76f","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 14:53:45 [14:53:45.972] INFO: node Received tx 0x2a07926eec4e182819c63703ec9240567e5f3ccbb0c591dabdb17e511344f76f {"txHash":"0x2a07926eec4e182819c63703ec9240567e5f3ccbb0c591dabdb17e511344f76f"} 14:53:45 [14:53:45.973] INFO: pxe:service Sent transaction 0x2a07926eec4e182819c63703ec9240567e5f3ccbb0c591dabdb17e511344f76f 14:53:46 [14:53:46.125] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:46 [14:53:46.333] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:46 [14:53:46.540] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:46 [14:53:46.567] VERBOSE: sequencer Building block 5 for slot 6 {"slot":6,"blockNumber":5,"msgCount":0} 14:53:46 [14:53:46.588] VERBOSE: sequencer Processing pending txs {"slot":6,"slotStart":"2025-06-13T15:00:12.000Z","now":"2025-06-13T15:00:16.724Z"} 14:53:46 [14:53:46.623] VERBOSE: simulator:public-processor Processed tx 0x2a07926eec4e182819c63703ec9240567e5f3ccbb0c591dabdb17e511344f76f with no public calls in 18.50397299999895ms {"txHash":"0x2a07926eec4e182819c63703ec9240567e5f3ccbb0c591dabdb17e511344f76f","txFee":567840000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":11200},"billedGas":{"daGas":1536,"l2Gas":11200},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":18.50397299999895} 14:53:46 [14:53:46.627] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03828243500000099s {"duration":0.03828243500000099,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":11200},"totalSizeInBytes":288} 14:53:46 [14:53:46.747] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:46 [14:53:46.756] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0155a5271a6d4c1e999c0e079e2f82b845bf70f2af343c371e1e48cfb7c37015","globalVariables":{"chainId":31337,"version":720795365,"blockNumber":5,"slotNumber":6,"timestamp":1749826812,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x2a07926eec4e182819c63703ec9240567e5f3ccbb0c591dabdb17e511344f76f"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":189.82445899999948,"publicProcessDuration":39.57329599999866,"rollupCircuitsDuration":169.35253899999952,"txCount":1,"blockNumber":5,"blockTimestamp":1749826812,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:46 [14:53:46.758] VERBOSE: sequencer Attesting committee is empty 14:53:47 [14:53:47.075] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:47 [14:53:47.105] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x37578858ddeea0af520772911b96cd8c699466a10b87c98a6b4b279a73e2bd28 14:53:47 [14:53:47.106] VERBOSE: sequencer-client Sent L1 transaction 0x37578858ddeea0af520772911b96cd8c699466a10b87c98a6b4b279a73e2bd28 {"gasLimit":470277,"maxFeePerGas":"1.246952001","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:53:47 [14:53:47.190] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749826848] on http://127.0.0.1:8545 14:53:47 [14:53:47.195] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:53:47 [14:53:47.196] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x37578858ddeea0af520772911b96cd8c699466a10b87c98a6b4b279a73e2bd28","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":5,"blockTimestamp":1749826812,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:47 [14:53:47.197] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:53:47 [14:53:47.205] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:53:47 [14:53:47.221] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749826848 14:53:47 [14:53:47.221] WARN: foundation:test-date-provider Time set to 2025-06-13T15:00:48.000Z {"offset":420779,"timeMs":1749826848000} 14:53:47 [14:53:47.221] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 14:53:47 [14:53:47.229] INFO: blob-sink:server Received blob sidecar for block 0xf5ed29595a1c2182903774edff058abc5f06fafd9671e5492bcb4ee68896bcc4 14:53:47 [14:53:47.245] INFO: blob-sink:server Blob sidecar stored successfully for block 0xf5ed29595a1c2182903774edff058abc5f06fafd9671e5492bcb4ee68896bcc4 14:53:47 [14:53:47.295] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:47 [14:53:47.318] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 14:53:47 [14:53:47.320] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 14:53:47 [14:53:47.322] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 14:53:47 [14:53:47.499] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:47 [14:53:47.702] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:47 [14:53:47.950] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:47 [14:53:47.974] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x0155a5271a6d4c1e999c0e079e2f82b845bf70f2af343c371e1e48cfb7c37015","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":720795365,"blockNumber":5,"slotNumber":6,"timestamp":1749826812,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","archiveNextLeafIndex":6} 14:53:47 [14:53:47.978] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 14:53:48 [14:53:48.084] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":11.017502999999124,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749826812,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:48 [14:53:48.098] VERBOSE: p2p Synched to latest block 5 14:53:48 [14:53:48.118] VERBOSE: pxe:service Updated pxe last block to 5 {"blockHash":{},"archive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","header":{"contentCommitment":{"blobsHash":"0x00df10afe080e6058699a61a6b5afe30c81691ccf2518d75220702ff4127cb5c","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749826812,"version":720795365},"lastArchive":"0x0fb2fb5bba8a1aac9db502f0e073c99420d42741f74d960734732f04863127d9","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21493a057b3ec8941ae01cae9e5e830f83118c1ac3fe88c1e9abdbce7f1da102","nullifierTree":"0x2c53608196cc787dba6bb6b0571a1c4eb6f57d28894d583b415e1138349f4fe7","publicDataTree":"0x0f479e85d860f4476a9546aaf9b86ecc83e7d4c54a000c4361045f9cc1597507"},"totalFees":567840000,"totalManaUsed":11200}} 14:53:48 [14:53:48.158] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:48 [14:53:48.315] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:53:48 [14:53:48.396] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:48 [14:53:48.399] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:53:48 [14:53:48.400] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:48 [14:53:48.621] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:48 [14:53:48.687] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:48 [14:53:48.688] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:48 [14:53:48.697] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:48 [14:53:48.707] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:53:48 [14:53:48.708] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:48 [14:53:48.725] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:48 [14:53:48.726] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:48 [14:53:48.733] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:48 [14:53:48.742] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:48 [14:53:48.753] WARN: node Nullifier 19400969099526031287116223089854051474824529229754688993095810715243275555039 already exists in the tree 14:53:48 [14:53:48.756] VERBOSE: simulator Utility simulation for 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86.0xd191fb1a completed 14:53:48 [14:53:48.818] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:53:48 [14:53:48.824] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:53:48 [14:53:48.912] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:49 [14:53:49.015] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:49 [14:53:49.103] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:49 [14:53:49.103] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:49 [14:53:49.163] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:49 [14:53:49.227] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:49 [14:53:49.311] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:49 [14:53:49.338] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x18b5d0f802875a1e2aac6f666b52a68aed67cb035dfe672214e762dfd008fcba 14:53:49 [14:53:49.356] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:49 [14:53:49.357] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:49 [14:53:49.373] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:49 [14:53:49.374] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:49 [14:53:49.380] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x00d7f36c90e1f085251b88f86ba4f4a7a14824b2e2acf7cb1076ba2d2dafdcf4","nullifier":"0x19cf976a055d616acced99ca7656a2b2e1cfa378a80915ff8a95fd4254f3dea2"} 14:53:49 [14:53:49.384] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:49 [14:53:49.409] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 as fee payer 14:53:49 [14:53:49.411] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:49 [14:53:49.455] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x16f0d03f427753a7e25c2fc05565e8b130913bce1eab57ab319e891668af756b"} 14:53:49 [14:53:49.588] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:49 [14:53:49.635] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:49 [14:53:49.636] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:49 [14:53:49.644] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:49 [14:53:49.720] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:49 [14:53:49.730] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:49 [14:53:49.750] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:49 [14:53:49.751] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:49 [14:53:49.762] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:49 [14:53:49.764] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:49 [14:53:49.765] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:49 [14:53:49.769] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:49 [14:53:49.772] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:49 [14:53:49.859] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:50 [14:53:50.077] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:50 [14:53:50.313] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:50 [14:53:50.486] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:50 [14:53:50.683] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:51 [14:53:51.046] INFO: pxe:service Proving completed in 2197.4547109999985ms {"timings":{"total":2197.4547109999985,"sync":9.142328000001726,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":511.61843200000294,"oracles":{"debugLog":{"times":[0.6164940000016941,0.5554630000006,0.6971369999992021,0.841591000000335,0.6366450000023178,0.5573629999998957,0.5671030000012252,0.7780579999998736]},"fetchTaggedLogs":{"times":[226.5015459999995]},"loadCapsule":{"times":[1.3550319999994827,2.7040849999975762,2.4040270000004966,0.3232579999967129,0.8493600000001607,2.1485720000018773]},"getSharedSecret":{"times":[8.733038000002125]},"aes128Decrypt":{"times":[0.39526000000114436,1.2704310000008263]},"getPublicKeysAndPartialAddress":{"times":[2.1274499999999534]},"getKeyValidationRequest":{"times":[9.286683000002085]},"deliverNote":{"times":[6.252260000001115]},"deleteCapsule":{"times":[1.501166000001831]},"storeCapsule":{"times":[0.5070219999979599]},"getNotes":{"times":[7.357636000000639]},"getAuthWitness":{"times":[0.4443699999974342]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07505099999980303]},"callPrivateFunction":{"times":[384.3024779999978]}}},{"functionName":"private_kernel_init","time":98.14139599999908},{"functionName":"AuthWitTest:consume","time":80.99250699999902,"oracles":{"storeInExecutionCache":{"times":[0.08559199999945122]},"callPrivateFunction":{"times":[328.13489499999923]},"loadFromExecutionCache":{"times":[0.07437199999912991]},"notifyCreatedNullifier":{"times":[0.38113000000157626]}}},{"functionName":"private_kernel_inner","time":176.68719399999827},{"functionName":"SchnorrAccount:verify_private_authwit","time":291.40390800000023,"oracles":{"debugLog":{"times":[1.225640000000567,0.7168569999994361,0.3901590000023134,0.32023800000024494,0.26483599999846774,0.22132500000225264,0.2816469999997935]},"fetchTaggedLogs":{"times":[90.63244699999996]},"loadCapsule":{"times":[0.1789439999993192,0.8254100000012841,0.9952840000005381,0.27763599999889266,0.17938499999945634,0.2023750000007567]},"getSharedSecret":{"times":[13.320658000000549]},"aes128Decrypt":{"times":[0.21162600000025122,0.6265149999999267]},"getPublicKeysAndPartialAddress":{"times":[5.003128999996989]},"getKeyValidationRequest":{"times":[5.7189370000014605]},"deliverNote":{"times":[5.232046000000992]},"deleteCapsule":{"times":[0.3236770000003162]},"storeCapsule":{"times":[0.41762999999991735]},"getNotes":{"times":[1.7996339999990596]},"getAuthWitness":{"times":[0.14847300000110408]},"storeInExecutionCache":{"times":[0.10018300000228919]}}},{"functionName":"private_kernel_inner","time":187.74343899999803},{"functionName":"private_kernel_reset","time":245.68696400000044},{"functionName":"private_kernel_tail","time":118.43287100000452}],"unaccounted":477.60567199999423}} 14:53:51 [14:53:51.068] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:51 [14:53:51.115] VERBOSE: p2p:tx_validator:tx_double_spend Rejecting tx 0x19fec6349bf7e144e26089a843f203b4b12f0fec9458135d03e6beaf00c4b91d for repeating a nullifier 14:53:51 [14:53:51.117] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:51 [14:53:51.119] WARN: node Received invalid tx 0x19fec6349bf7e144e26089a843f203b4b12f0fec9458135d03e6beaf00c4b91d: Existing nullifier {"txHash":"0x19fec6349bf7e144e26089a843f203b4b12f0fec9458135d03e6beaf00c4b91d"} 14:53:51 [14:53:51.127] ERROR: pxe:service Error: Error: Invalid tx: Existing nullifier 14:53:51 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19) 14:53:51 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 14:53:51 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 14:53:51 [14:53:51.132] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid chain id 14:53:51 [14:53:51.243] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:53:51 [14:53:51.259] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:53:51 [14:53:51.260] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:51 [14:53:51.303] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:51 [14:53:51.367] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:51 [14:53:51.375] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:51 [14:53:51.385] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:53:51 [14:53:51.386] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:51 [14:53:51.397] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:51 [14:53:51.398] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:51 [14:53:51.403] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:51 [14:53:51.405] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:51 [14:53:51.466] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:53:51 [14:53:51.481] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:53:51 [14:53:51.502] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 {"origin":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000002af676e5","authWitnesses":["0x21fd92c9321e865b73ba515c21c8af0b638915cd1717044fffd1fbcd49bfcc69"]} 14:53:51 [14:53:51.509] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:51 [14:53:51.624] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:51 [14:53:51.670] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:51 [14:53:51.671] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:51 [14:53:51.714] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:51 [14:53:51.767] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:51 [14:53:51.813] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:51 [14:53:51.823] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x18b5d0f802875a1e2aac6f666b52a68aed67cb035dfe672214e762dfd008fcba 14:53:51 [14:53:51.841] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:51 [14:53:51.842] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:51 [14:53:51.856] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:51 [14:53:51.856] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:51 [14:53:51.862] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x00d7f36c90e1f085251b88f86ba4f4a7a14824b2e2acf7cb1076ba2d2dafdcf4","nullifier":"0x19cf976a055d616acced99ca7656a2b2e1cfa378a80915ff8a95fd4254f3dea2"} 14:53:51 [14:53:51.865] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:51 [14:53:51.878] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 as fee payer 14:53:51 [14:53:51.894] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x16f0d03f427753a7e25c2fc05565e8b130913bce1eab57ab319e891668af756b"} 14:53:51 [14:53:51.968] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:52 [14:53:52.018] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:52 [14:53:52.051] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:52 [14:53:52.052] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:52 [14:53:52.177] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:52 [14:53:52.191] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:52 [14:53:52.211] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:52 [14:53:52.212] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:52 [14:53:52.221] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:52 [14:53:52.222] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:52 [14:53:52.226] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:52 [14:53:52.228] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:52 [14:53:52.308] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid version 14:53:52 [14:53:52.312] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:52 [14:53:52.430] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:52 [14:53:52.500] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:53:52 [14:53:52.519] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:53:52 [14:53:52.520] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:52 [14:53:52.528] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:52 [14:53:52.633] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:52 [14:53:52.641] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:52 [14:53:52.654] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:53:52 [14:53:52.655] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:52 [14:53:52.666] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:52 [14:53:52.667] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:52 [14:53:52.670] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:52 [14:53:52.672] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:52 [14:53:52.733] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:53:52 [14:53:52.741] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:52 [14:53:52.748] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:53:52 [14:53:52.762] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 {"origin":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000002af676e5","authWitnesses":["0x0d94c7100c50bae0b9ab94782a22dd7a5cf9d84a5a88ca798286d910573441fd"]} 14:53:52 [14:53:52.867] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:52 [14:53:52.926] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:52 [14:53:52.927] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:52 [14:53:52.945] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:52 [14:53:52.983] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:53 [14:53:53.034] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:53 [14:53:53.050] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x18b5d0f802875a1e2aac6f666b52a68aed67cb035dfe672214e762dfd008fcba 14:53:53 [14:53:53.066] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:53 [14:53:53.068] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:53 [14:53:53.080] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:53 [14:53:53.082] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:53 [14:53:53.092] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x00d7f36c90e1f085251b88f86ba4f4a7a14824b2e2acf7cb1076ba2d2dafdcf4","nullifier":"0x19cf976a055d616acced99ca7656a2b2e1cfa378a80915ff8a95fd4254f3dea2"} 14:53:53 [14:53:53.100] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:53 [14:53:53.137] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 as fee payer 14:53:53 [14:53:53.174] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x16f0d03f427753a7e25c2fc05565e8b130913bce1eab57ab319e891668af756b"} 14:53:53 [14:53:53.184] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:53 [14:53:53.399] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:53 [14:53:53.470] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:53 [14:53:53.473] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:53 [14:53:53.478] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:53 [14:53:53.592] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:53 [14:53:53.632] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:53 [14:53:53.647] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:53 [14:53:53.662] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:53 [14:53:53.663] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:53 [14:53:53.680] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:53 [14:53:53.680] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:53 [14:53:53.684] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:53 [14:53:53.686] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:53 [14:53:53.689] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:53 [14:53:53.873] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:53:53 [14:53:53.887] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:53:53 [14:53:53.887] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:53 [14:53:53.892] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:53 [14:53:53.954] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:53 [14:53:53.964] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:53 [14:53:53.975] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:53:53 [14:53:53.976] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:53 [14:53:53.986] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:53 [14:53:53.986] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:54 [14:53:54.000] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:54 [14:53:54.003] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:54 [14:53:54.053] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:53:54 [14:53:54.059] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:53:54 [14:53:54.063] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data happy path 14:53:54 [14:53:54.105] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:54 [14:53:54.188] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:53:54 [14:53:54.209] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:53:54 [14:53:54.209] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:54 [14:53:54.212] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:54 [14:53:54.288] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:54 [14:53:54.306] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:54 [14:53:54.314] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:54 [14:53:54.323] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:53:54 [14:53:54.324] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:54 [14:53:54.336] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:54 [14:53:54.337] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:54 [14:53:54.341] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:54 [14:53:54.343] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:54 [14:53:54.355] VERBOSE: simulator Utility simulation for 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86.0xd191fb1a completed 14:53:54 [14:53:54.419] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:53:54 [14:53:54.448] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:53:54 [14:53:54.528] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:54 [14:53:54.713] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:54 [14:53:54.768] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:54 [14:53:54.769] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:54 [14:53:54.775] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:54 [14:53:54.860] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:54 [14:53:54.902] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:54 [14:53:54.914] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:54 [14:53:54.926] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:54 [14:53:54.927] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:54 [14:53:54.935] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:54 [14:53:54.935] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:54 [14:53:54.947] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:54 [14:53:54.949] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:54 [14:53:54.964] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 as fee payer 14:53:55 [14:53:55.015] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:55 [14:53:55.516] INFO: pxe:service Proving completed in 997.0502899999992ms {"timings":{"total":997.0502899999992,"sync":37.221019999997225,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":381.7452670000057,"oracles":{"debugLog":{"times":[0.6517550000062329,0.5451929999981076,0.5780329999979585,0.6499760000006063,0.43862999999691965,0.3906300000016927,0.3648990000001504,0.681166000002122]},"fetchTaggedLogs":{"times":[142.86313599999994]},"loadCapsule":{"times":[0.20478500000172062,0.24733500000002095,0.5218019999956596,0.24669600000197534,0.23594600000069477,0.20449400000507012]},"getSharedSecret":{"times":[4.145478999998886]},"aes128Decrypt":{"times":[0.3253370000020368,1.1082060000044294]},"getPublicKeysAndPartialAddress":{"times":[1.7739520000031916]},"getKeyValidationRequest":{"times":[1.661909000002197]},"deliverNote":{"times":[11.763681999997061]},"deleteCapsule":{"times":[0.30520699999760836]},"storeCapsule":{"times":[0.2448759999970207]},"getNotes":{"times":[2.4991099999970174]},"getAuthWitness":{"times":[0.20968499999435153]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.23217500000464497]},"notifyEnqueuedPublicFunctionCall":{"times":[0.47301100000186125]}}},{"functionName":"private_kernel_init","time":76.09926000000269},{"functionName":"private_kernel_reset","time":232.98346999999922},{"functionName":"private_kernel_tail","time":125.52246200000081}],"unaccounted":143.47881099999358}} 14:53:55 [14:53:55.567] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:55 [14:53:55.623] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","blockNumber":6,"slot":7} 14:53:55 [14:53:55.631] VERBOSE: p2p:tx_pool Adding tx 0x0e3a5bc72874202afc89fa415455d4bf11ec1bafc6a86449c05fd831582c66e8 to pool {"eventName":"tx-added-to-pool","txHash":"0x0e3a5bc72874202afc89fa415455d4bf11ec1bafc6a86449c05fd831582c66e8","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 14:53:55 [14:53:55.643] INFO: node Received tx 0x0e3a5bc72874202afc89fa415455d4bf11ec1bafc6a86449c05fd831582c66e8 {"txHash":"0x0e3a5bc72874202afc89fa415455d4bf11ec1bafc6a86449c05fd831582c66e8"} 14:53:55 [14:53:55.643] INFO: pxe:service Sent transaction 0x0e3a5bc72874202afc89fa415455d4bf11ec1bafc6a86449c05fd831582c66e8 14:53:55 [14:53:55.783] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:55 [14:53:55.990] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:56 [14:53:56.151] VERBOSE: sequencer Building block 6 for slot 7 {"slot":7,"blockNumber":6,"msgCount":0} 14:53:56 [14:53:56.170] VERBOSE: sequencer Processing pending txs {"slot":7,"slotStart":"2025-06-13T15:00:48.000Z","now":"2025-06-13T15:00:56.949Z"} 14:53:56 [14:53:56.196] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:56 [14:53:56.262] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":35.60427100000379} 14:53:56 [14:53:56.296] VERBOSE: simulator:public-processor Processed tx 0x0e3a5bc72874202afc89fa415455d4bf11ec1bafc6a86449c05fd831582c66e8 with 1 public calls in 85.90070299999934ms {"txHash":"0x0e3a5bc72874202afc89fa415455d4bf11ec1bafc6a86449c05fd831582c66e8","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":85.90070299999934} 14:53:56 [14:53:56.303] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1320328870000012s {"duration":0.1320328870000012,"rate":151810.66214207537,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 14:53:56 [14:53:56.416] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:56 [14:53:56.433] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 70569.27701321502 mana/s {"blockHash":"0x2fcd8507c4af7c97e0f0741d1cae41ab06d4deb709bb402e6678c9d9d2d71a7d","globalVariables":{"chainId":31337,"version":720795365,"blockNumber":6,"slotNumber":7,"timestamp":1749826848,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x0e3a5bc72874202afc89fa415455d4bf11ec1bafc6a86449c05fd831582c66e8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":283.14362000000256,"publicProcessDuration":132.78539399999863,"rollupCircuitsDuration":266.21416599999793,"txCount":1,"blockNumber":6,"blockTimestamp":1749826848,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:56 [14:53:56.436] VERBOSE: sequencer Attesting committee is empty 14:53:56 [14:53:56.624] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:56 [14:53:56.798] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x8ee8270101a31d48ab1826069a71380c6c632518705bd6035ba364c1c30afe80 14:53:56 [14:53:56.798] VERBOSE: sequencer-client Sent L1 transaction 0x8ee8270101a31d48ab1826069a71380c6c632518705bd6035ba364c1c30afe80 {"gasLimit":470248,"maxFeePerGas":"1.236063671","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:53:56 [14:53:56.813] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:53:56 [14:53:56.814] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x8ee8270101a31d48ab1826069a71380c6c632518705bd6035ba364c1c30afe80","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":6,"blockTimestamp":1749826848,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:56 [14:53:56.814] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:53:56 [14:53:56.820] INFO: blob-sink:server Received blob sidecar for block 0x555a2377042726c42c44831c9fda944b9154ad8dc5519ebe53cd2f33bc9445e5 14:53:56 [14:53:56.826] INFO: blob-sink:server Blob sidecar stored successfully for block 0x555a2377042726c42c44831c9fda944b9154ad8dc5519ebe53cd2f33bc9445e5 14:53:56 [14:53:56.827] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:56 [14:53:56.838] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000006"] on http://127.0.0.1:8545 14:53:56 [14:53:56.839] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 14:53:56 [14:53:56.841] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 14:53:57 [14:53:57.015] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749826884] on http://127.0.0.1:8545 14:53:57 [14:53:57.016] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:53:57 [14:53:57.018] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749826884 14:53:57 [14:53:57.018] WARN: foundation:test-date-provider Time set to 2025-06-13T15:01:24.000Z {"offset":446982,"timeMs":1749826884000} 14:53:57 [14:53:57.018] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 14:53:57 [14:53:57.033] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:57 [14:53:57.326] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:57 [14:53:57.369] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x2fcd8507c4af7c97e0f0741d1cae41ab06d4deb709bb402e6678c9d9d2d71a7d","blockNumber":6,"txCount":1,"globalVariables":{"chainId":31337,"version":720795365,"blockNumber":6,"slotNumber":7,"timestamp":1749826848,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x14daa531d0e5f2829e4aade84615107a03240fccb1161927885ac3c6909f459f","archiveNextLeafIndex":7} 14:53:57 [14:53:57.385] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 14:53:57 [14:53:57.481] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":8.722428000000946,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749826848,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:57 [14:53:57.490] VERBOSE: p2p Synched to latest block 6 14:53:57 [14:53:57.530] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:57 [14:53:57.660] VERBOSE: pxe:service Updated pxe last block to 6 {"blockHash":{},"archive":"0x14daa531d0e5f2829e4aade84615107a03240fccb1161927885ac3c6909f459f","header":{"contentCommitment":{"blobsHash":"0x00f0b81e51bf3209bcc4f29b8243b4bf486b77b6be1c9040b970b6f035857a54","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749826848,"version":720795365},"lastArchive":"0x12e958523f7c61e8272b178c4eedac4deed3cfd3d11997e4ec182ff096e86146","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21493a057b3ec8941ae01cae9e5e830f83118c1ac3fe88c1e9abdbce7f1da102","nullifierTree":"0x0e6e49589d3149bb0920396700823f634fc942ce25c4b1e93636d951427e8b42","publicDataTree":"0x3016be7d44e14e53aae5533e9a53d9fe3c00e93a26389764d9e89a2c2340ac5d"},"totalFees":2327130000,"totalManaUsed":45900}} 14:53:57 [14:53:57.744] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:57 [14:53:57.778] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:53:57 [14:53:57.808] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:53:57 [14:53:57.809] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:57 [14:53:57.872] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:53:57 [14:53:57.878] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:53:57 [14:53:57.888] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:53:57 [14:53:57.889] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:57 [14:53:57.958] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:57 [14:53:57.959] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:57 [14:53:57.964] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x14daa531d0e5f2829e4aade84615107a03240fccb1161927885ac3c6909f459f","blockNumber":7,"slot":8} 14:53:57 [14:53:57.967] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:53:57 [14:53:57.969] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:57 [14:53:57.976] VERBOSE: simulator Utility simulation for 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86.0xd191fb1a completed 14:53:58 [14:53:58.017] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:58 [14:53:58.031] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:53:58 [14:53:58.044] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:53:58 [14:53:58.218] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:58 [14:53:58.267] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:53:58 [14:53:58.268] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:58 [14:53:58.269] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:58 [14:53:58.335] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:53:58 [14:53:58.341] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x18b5d0f802875a1e2aac6f666b52a68aed67cb035dfe672214e762dfd008fcba 14:53:58 [14:53:58.349] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:53:58 [14:53:58.350] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:53:58 [14:53:58.356] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:53:58 [14:53:58.357] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:53:58 [14:53:58.360] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x00d7f36c90e1f085251b88f86ba4f4a7a14824b2e2acf7cb1076ba2d2dafdcf4","nullifier":"0x19cf976a055d616acced99ca7656a2b2e1cfa378a80915ff8a95fd4254f3dea2"} 14:53:58 [14:53:58.368] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:53:58 [14:53:58.389] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 as fee payer 14:53:58 [14:53:58.490] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:58 [14:53:58.932] INFO: pxe:service Proving completed in 812.5046700000021ms {"timings":{"total":812.5046700000021,"sync":8.350619999997434,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":249.448384000003,"oracles":{"debugLog":{"times":[0.573593000000983,0.34404799999902025,0.4175699999977951,0.4862820000053034,0.619765000003099,0.38257899999734946,0.875250999997661,0.7144569999945816]},"fetchTaggedLogs":{"times":[71.79615700000431]},"loadCapsule":{"times":[0.18075400000088848,0.16608399999677204,0.34959800000069663,4.475397000001976,1.4843049999981304,0.3938399999969988]},"getSharedSecret":{"times":[2.990970999999263]},"aes128Decrypt":{"times":[0.15303400000266265,0.6078839999972843]},"getPublicKeysAndPartialAddress":{"times":[1.558747000002768]},"getKeyValidationRequest":{"times":[1.86727499999688]},"deliverNote":{"times":[2.8121070000051986]},"deleteCapsule":{"times":[1.0946160000021337]},"storeCapsule":{"times":[0.37782899999729125]},"getNotes":{"times":[2.643723000001046]},"getAuthWitness":{"times":[0.3552789999957895]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.11885299999994459]},"notifyEnqueuedPublicFunctionCall":{"times":[0.08925199999794131]}}},{"functionName":"private_kernel_init","time":69.71003700000438},{"functionName":"private_kernel_reset","time":212.9069709999967},{"functionName":"private_kernel_tail","time":127.15501299999596}],"unaccounted":144.93364500000462}} 14:53:58 [14:53:58.974] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:58 [14:53:58.979] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x14daa531d0e5f2829e4aade84615107a03240fccb1161927885ac3c6909f459f","blockNumber":7,"slot":8} 14:53:59 [14:53:59.004] VERBOSE: p2p:tx_pool Adding tx 0x14b1698ef3e87e1164b2a19726d88b3b17ff0ea81e39978340730c7a7f94cce2 to pool {"eventName":"tx-added-to-pool","txHash":"0x14b1698ef3e87e1164b2a19726d88b3b17ff0ea81e39978340730c7a7f94cce2","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 14:53:59 [14:53:59.015] INFO: node Received tx 0x14b1698ef3e87e1164b2a19726d88b3b17ff0ea81e39978340730c7a7f94cce2 {"txHash":"0x14b1698ef3e87e1164b2a19726d88b3b17ff0ea81e39978340730c7a7f94cce2"} 14:53:59 [14:53:59.016] INFO: pxe:service Sent transaction 0x14b1698ef3e87e1164b2a19726d88b3b17ff0ea81e39978340730c7a7f94cce2 14:53:59 [14:53:59.180] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:59 [14:53:59.383] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:59 [14:53:59.501] VERBOSE: sequencer Building block 7 for slot 8 {"slot":8,"blockNumber":7,"msgCount":0} 14:53:59 [14:53:59.515] VERBOSE: sequencer Processing pending txs {"slot":8,"slotStart":"2025-06-13T15:01:24.000Z","now":"2025-06-13T15:01:26.497Z"} 14:53:59 [14:53:59.574] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":39.317307999997865} 14:53:59 [14:53:59.586] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:53:59 [14:53:59.596] VERBOSE: simulator:public-processor Processed tx 0x14b1698ef3e87e1164b2a19726d88b3b17ff0ea81e39978340730c7a7f94cce2 with 1 public calls in 69.79002400000172ms {"txHash":"0x14b1698ef3e87e1164b2a19726d88b3b17ff0ea81e39978340730c7a7f94cce2","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":69.79002400000172} 14:53:59 [14:53:59.600] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08470788099999481s {"duration":0.08470788099999481,"rate":624817.8962238855,"totalPublicGas":{"daGas":512,"l2Gas":52927},"totalBlockGas":{"daGas":1536,"l2Gas":78783},"totalSizeInBytes":320} 14:53:59 [14:53:59.730] INFO: sequencer Built block 7 for slot 8 with 1 txs and 0 messages. 231041.9357461422 mana/s {"blockHash":"0x1304a39e5e0726f6fb172db4766a690b81039538e01aee2c6f9daec5cbd3b60f","globalVariables":{"chainId":31337,"version":720795365,"blockNumber":7,"slotNumber":8,"timestamp":1749826884,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x14b1698ef3e87e1164b2a19726d88b3b17ff0ea81e39978340730c7a7f94cce2"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":228.54278200000408,"publicProcessDuration":85.0992999999944,"rollupCircuitsDuration":216.1030649999957,"txCount":1,"blockNumber":7,"blockTimestamp":1749826884,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:53:59 [14:53:59.731] VERBOSE: sequencer Attesting committee is empty 14:53:59 [14:53:59.805] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:00 [14:54:00.010] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x3f7fbd166c2b66d780ee75d7c60428a1cc40962d754cd740a9f216fc17fc182d 14:54:00 [14:54:00.011] VERBOSE: sequencer-client Sent L1 transaction 0x3f7fbd166c2b66d780ee75d7c60428a1cc40962d754cd740a9f216fc17fc182d {"gasLimit":489694,"maxFeePerGas":"1.227700377","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:54:00 [14:54:00.012] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:00 [14:54:00.028] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000007"] on http://127.0.0.1:8545 14:54:00 [14:54:00.032] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:54:00 [14:54:00.032] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x3f7fbd166c2b66d780ee75d7c60428a1cc40962d754cd740a9f216fc17fc182d","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":7,"blockTimestamp":1749826884,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:54:00 [14:54:00.033] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:54:00 [14:54:00.036] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7 14:54:00 [14:54:00.038] INFO: blob-sink:server Received blob sidecar for block 0x9b36707958b42b79d4144d20176ca8b0094f2993fbced0bc34d0df977dd534cd 14:54:00 [14:54:00.043] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 14:54:00 [14:54:00.046] INFO: blob-sink:server Blob sidecar stored successfully for block 0x9b36707958b42b79d4144d20176ca8b0094f2993fbced0bc34d0df977dd534cd 14:54:00 [14:54:00.222] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:00 [14:54:00.233] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749826920] on http://127.0.0.1:8545 14:54:00 [14:54:00.234] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:54:00 [14:54:00.236] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749826920 14:54:00 [14:54:00.236] WARN: foundation:test-date-provider Time set to 2025-06-13T15:02:00.000Z {"offset":479764,"timeMs":1749826920000} 14:54:00 [14:54:00.236] INFO: aztecjs:utils:watcher Slot 8 was filled, jumped to next slot 14:54:00 [14:54:00.428] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:00 [14:54:00.716] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:00 [14:54:00.731] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x1304a39e5e0726f6fb172db4766a690b81039538e01aee2c6f9daec5cbd3b60f","blockNumber":7,"txCount":1,"globalVariables":{"chainId":31337,"version":720795365,"blockNumber":7,"slotNumber":8,"timestamp":1749826884,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0fba5b301a72336e3a677e0b32d73ff6fea6b75ca7e4a0616b9892eb5b861365","archiveNextLeafIndex":8} 14:54:00 [14:54:00.734] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 14:54:00 [14:54:00.838] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":9.239439999997558,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1749826884,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:54:00 [14:54:00.845] VERBOSE: p2p Synched to latest block 7 14:54:00 [14:54:00.921] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:01 [14:54:01.037] VERBOSE: pxe:service Updated pxe last block to 7 {"blockHash":{},"archive":"0x0fba5b301a72336e3a677e0b32d73ff6fea6b75ca7e4a0616b9892eb5b861365","header":{"contentCommitment":{"blobsHash":"0x007448a56131ad325cb809515ad2fb4d290209706361fb86fca65617016457ec","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":8,"timestamp":1749826884,"version":720795365},"lastArchive":"0x14daa531d0e5f2829e4aade84615107a03240fccb1161927885ac3c6909f459f","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21493a057b3ec8941ae01cae9e5e830f83118c1ac3fe88c1e9abdbce7f1da102","nullifierTree":"0x0a3ee0acac6ddcd5d41e25919ee5ec8baee9d7962a17077b961f8facf2753447","publicDataTree":"0x0909dd298301c5fba8b31ece1bfca70db6fa71e17062e11c09b375462b906307"},"totalFees":3994298100,"totalManaUsed":78783}} 14:54:01 [14:54:01.109] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:54:01 [14:54:01.126] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:01 [14:54:01.128] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:54:01 [14:54:01.128] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:01 [14:54:01.134] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x0fba5b301a72336e3a677e0b32d73ff6fea6b75ca7e4a0616b9892eb5b861365","blockNumber":8,"slot":9} 14:54:01 [14:54:01.181] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:01 [14:54:01.186] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:54:01 [14:54:01.195] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:54:01 [14:54:01.196] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:54:01 [14:54:01.201] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:54:01 [14:54:01.202] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:54:01 [14:54:01.205] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:54:01 [14:54:01.206] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:54:01 [14:54:01.217] VERBOSE: simulator Utility simulation for 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86.0xd191fb1a completed 14:54:01 [14:54:01.256] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:54:01 [14:54:01.265] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:54:01 [14:54:01.267] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data failure case cancel before usage 14:54:01 [14:54:01.379] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:01 [14:54:01.479] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:54:01 [14:54:01.495] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:54:01 [14:54:01.495] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:01 [14:54:01.628] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:01 [14:54:01.648] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:54:01 [14:54:01.658] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x0fba5b301a72336e3a677e0b32d73ff6fea6b75ca7e4a0616b9892eb5b861365","blockNumber":8,"slot":9} 14:54:01 [14:54:01.664] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:54:01 [14:54:01.665] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:54:01 [14:54:01.672] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:54:01 [14:54:01.672] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:54:01 [14:54:01.676] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:54:01 [14:54:01.678] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:54:01 [14:54:01.686] VERBOSE: simulator Utility simulation for 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86.0xd191fb1a completed 14:54:01 [14:54:01.701] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:01 [14:54:01.732] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:54:01 [14:54:01.740] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:54:01 [14:54:01.851] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:01 [14:54:01.899] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:54:01 [14:54:01.900] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:01 [14:54:01.906] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:01 [14:54:01.987] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:01 [14:54:01.996] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:54:02 [14:54:02.006] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:54:02 [14:54:02.007] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:54:02 [14:54:02.014] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:54:02 [14:54:02.015] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:54:02 [14:54:02.017] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:54:02 [14:54:02.019] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:54:02 [14:54:02.030] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 as fee payer 14:54:02 [14:54:02.113] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:02 [14:54:02.465] INFO: pxe:service Proving completed in 712.3557639999999ms {"timings":{"total":712.3557639999999,"sync":2.8343480000039563,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":249.02930099999503,"oracles":{"debugLog":{"times":[0.5084519999945769,0.3806190000032075,0.44253099999332335,0.5069919999950798,0.4694309999977122,0.3801690000036615,0.21386500000517117,0.43013999999675434]},"fetchTaggedLogs":{"times":[91.68688700000348]},"loadCapsule":{"times":[2.50789999999688,0.23436499999661464,0.4296500000054948,0.20005500000115717,0.1612840000016149,0.206953999993857]},"getSharedSecret":{"times":[3.096634000001359]},"aes128Decrypt":{"times":[0.24229599999671336,0.9114410000038333]},"getPublicKeysAndPartialAddress":{"times":[3.0805340000006254]},"getKeyValidationRequest":{"times":[1.5646779999951832]},"deliverNote":{"times":[2.610272999998415]},"deleteCapsule":{"times":[0.26611599999887403]},"storeCapsule":{"times":[0.25154599999950733]},"getNotes":{"times":[1.3615820000050007]},"getAuthWitness":{"times":[0.15956299999379553]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05175099999905797]},"notifyEnqueuedPublicFunctionCall":{"times":[0.05264100000204053]}}},{"functionName":"private_kernel_init","time":64.36714499999653},{"functionName":"private_kernel_reset","time":187.30633799999487},{"functionName":"private_kernel_tail","time":85.22760299999936}],"unaccounted":123.59102900001017}} 14:54:02 [14:54:02.493] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:02 [14:54:02.518] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x0fba5b301a72336e3a677e0b32d73ff6fea6b75ca7e4a0616b9892eb5b861365","blockNumber":8,"slot":9} 14:54:02 [14:54:02.523] VERBOSE: p2p:tx_pool Adding tx 0x0afb7974c4a57446204ed8214e929236042e2a8e58ff622541244b6f6cd3b8ce to pool {"eventName":"tx-added-to-pool","txHash":"0x0afb7974c4a57446204ed8214e929236042e2a8e58ff622541244b6f6cd3b8ce","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 14:54:02 [14:54:02.531] INFO: node Received tx 0x0afb7974c4a57446204ed8214e929236042e2a8e58ff622541244b6f6cd3b8ce {"txHash":"0x0afb7974c4a57446204ed8214e929236042e2a8e58ff622541244b6f6cd3b8ce"} 14:54:02 [14:54:02.531] INFO: pxe:service Sent transaction 0x0afb7974c4a57446204ed8214e929236042e2a8e58ff622541244b6f6cd3b8ce 14:54:02 [14:54:02.700] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:02 [14:54:02.904] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:03 [14:54:03.044] VERBOSE: sequencer Building block 8 for slot 9 {"slot":9,"blockNumber":8,"msgCount":0} 14:54:03 [14:54:03.056] VERBOSE: sequencer Processing pending txs {"slot":9,"slotStart":"2025-06-13T15:02:00.000Z","now":"2025-06-13T15:02:02.820Z"} 14:54:03 [14:54:03.082] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":8.877811999998812} 14:54:03 [14:54:03.099] VERBOSE: simulator:public-processor Processed tx 0x0afb7974c4a57446204ed8214e929236042e2a8e58ff622541244b6f6cd3b8ce with 1 public calls in 33.28535399999964ms {"txHash":"0x0afb7974c4a57446204ed8214e929236042e2a8e58ff622541244b6f6cd3b8ce","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":33.28535399999964} 14:54:03 [14:54:03.101] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04396847900000284s {"duration":0.04396847900000284,"rate":455872.03505490156,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 14:54:03 [14:54:03.107] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:03 [14:54:03.248] INFO: sequencer Built block 8 for slot 9 with 1 txs and 0 messages. 97620.65577488819 mana/s {"blockHash":"0x25488a63061a9ff6dc0d7e8c761713f75f8779737f47e5091932129c1f2a87e2","globalVariables":{"chainId":31337,"version":720795365,"blockNumber":8,"slotNumber":9,"timestamp":1749826920,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x0afb7974c4a57446204ed8214e929236042e2a8e58ff622541244b6f6cd3b8ce"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":204.79507500000182,"publicProcessDuration":44.33774699999776,"rollupCircuitsDuration":193.40337299999373,"txCount":1,"blockNumber":8,"blockTimestamp":1749826920,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:54:03 [14:54:03.251] VERBOSE: sequencer Attesting committee is empty 14:54:03 [14:54:03.343] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:03 [14:54:03.540] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x4b7b38ad1c172cfa153e6fd3acdf72a9e3c7892e26982d49e220e3aba124ffbc 14:54:03 [14:54:03.540] VERBOSE: sequencer-client Sent L1 transaction 0x4b7b38ad1c172cfa153e6fd3acdf72a9e3c7892e26982d49e220e3aba124ffbc {"gasLimit":470234,"maxFeePerGas":"1.22127984","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:54:03 [14:54:03.547] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:03 [14:54:03.560] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:54:03 [14:54:03.561] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x4b7b38ad1c172cfa153e6fd3acdf72a9e3c7892e26982d49e220e3aba124ffbc","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":8,"blockTimestamp":1749826920,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:54:03 [14:54:03.561] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:54:03 [14:54:03.563] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000008"] on http://127.0.0.1:8545 14:54:03 [14:54:03.567] INFO: blob-sink:server Received blob sidecar for block 0xbb5ad25cb73978b7f633d46a3d0682b38f43f39785fd9e149932b25b65e897f2 14:54:03 [14:54:03.570] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 8 14:54:03 [14:54:03.571] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749826956] on http://127.0.0.1:8545 14:54:03 [14:54:03.574] INFO: aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8. 14:54:03 [14:54:03.575] INFO: blob-sink:server Blob sidecar stored successfully for block 0xbb5ad25cb73978b7f633d46a3d0682b38f43f39785fd9e149932b25b65e897f2 14:54:03 [14:54:03.576] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:54:03 [14:54:03.577] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749826956 14:54:03 [14:54:03.577] WARN: foundation:test-date-provider Time set to 2025-06-13T15:02:36.000Z {"offset":512423,"timeMs":1749826956000} 14:54:03 [14:54:03.577] INFO: aztecjs:utils:watcher Slot 9 was filled, jumped to next slot 14:54:03 [14:54:03.689] INFO: archiver Downloaded L2 block 8 {"blockHash":"0x25488a63061a9ff6dc0d7e8c761713f75f8779737f47e5091932129c1f2a87e2","blockNumber":8,"txCount":1,"globalVariables":{"chainId":31337,"version":720795365,"blockNumber":8,"slotNumber":9,"timestamp":1749826920,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x15db71ac2aa671301bcb7ab349b1191824fa540a10c5de6b13fa81f45e73dfb8","archiveNextLeafIndex":9} 14:54:03 [14:54:03.691] INFO: archiver Updated proven chain to block 8 {"provenBlockNumber":8} 14:54:03 [14:54:03.754] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:03 [14:54:03.803] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":8.855290999999852,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1749826920,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:54:03 [14:54:03.810] VERBOSE: p2p Synched to latest block 8 14:54:03 [14:54:03.956] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:04 [14:54:04.084] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x15db71ac2aa671301bcb7ab349b1191824fa540a10c5de6b13fa81f45e73dfb8","blockNumber":9,"slot":10} 14:54:04 [14:54:04.159] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:04 [14:54:04.363] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:04 [14:54:04.555] VERBOSE: pxe:service Updated pxe last block to 8 {"blockHash":{},"archive":"0x15db71ac2aa671301bcb7ab349b1191824fa540a10c5de6b13fa81f45e73dfb8","header":{"contentCommitment":{"blobsHash":"0x0084c80dc09d97b4ce397cef20d07f7664545ba6678e132f4dfcfc1a5fe4e46d","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1749826920,"version":720795365},"lastArchive":"0x0fba5b301a72336e3a677e0b32d73ff6fea6b75ca7e4a0616b9892eb5b861365","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21493a057b3ec8941ae01cae9e5e830f83118c1ac3fe88c1e9abdbce7f1da102","nullifierTree":"0x2688f763bb8e72f35e80d1a20d3b5ecb2828eaecd37032772b7cb6d3ee8d33e2","publicDataTree":"0x0ac6034f734d76c1eb0dc236d83014848c7b3d504d7af3ab8607a96bc4bbebe4"},"totalFees":2327130000,"totalManaUsed":45900}} 14:54:04 [14:54:04.581] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:04 [14:54:04.661] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:54:04 [14:54:04.681] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:54:04 [14:54:04.682] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:04 [14:54:04.688] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x15db71ac2aa671301bcb7ab349b1191824fa540a10c5de6b13fa81f45e73dfb8","blockNumber":9,"slot":10} 14:54:04 [14:54:04.748] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:04 [14:54:04.755] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:54:04 [14:54:04.766] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:54:04 [14:54:04.767] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:54:04 [14:54:04.773] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:54:04 [14:54:04.774] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:54:04 [14:54:04.777] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:54:04 [14:54:04.780] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:54:04 [14:54:04.787] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:04 [14:54:04.792] VERBOSE: simulator Utility simulation for 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86.0xd191fb1a completed 14:54:04 [14:54:04.832] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:54:04 [14:54:04.839] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:54:04 [14:54:04.914] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:04 [14:54:04.970] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:54:04 [14:54:04.970] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:05 [14:54:05.014] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:05 [14:54:05.054] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:05 [14:54:05.062] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:54:05 [14:54:05.075] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:54:05 [14:54:05.076] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:54:05 [14:54:05.090] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:54:05 [14:54:05.091] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:54:05 [14:54:05.094] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:54:05 [14:54:05.096] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:54:05 [14:54:05.111] VERBOSE: simulator:client_execution_context:debug_log Setting 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 as fee payer 14:54:05 [14:54:05.220] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:05 [14:54:05.677] INFO: pxe:service Proving completed in 826.3602230000033ms {"timings":{"total":826.3602230000033,"sync":2.5446809999994002,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":246.911841000001,"oracles":{"debugLog":{"times":[0.758228999999119,0.4480009999970207,0.5575429999953485,0.7063169999964884,0.4760009999954491,0.2814670000007027,0.3067469999950845,0.6310550000052899]},"fetchTaggedLogs":{"times":[89.32094099999813]},"loadCapsule":{"times":[0.22980500000267057,0.22427600000082748,0.4621210000041174,0.2847959999999148,0.26589700000477023,0.1855139999970561]},"getSharedSecret":{"times":[3.8145710000026156]},"aes128Decrypt":{"times":[0.22184500000003027,1.3096110000042245]},"getPublicKeysAndPartialAddress":{"times":[9.727902000005997]},"getKeyValidationRequest":{"times":[1.6455090000017663]},"deliverNote":{"times":[2.9552309999999125]},"deleteCapsule":{"times":[0.31775800000468735]},"storeCapsule":{"times":[0.3276479999985895]},"getNotes":{"times":[1.5311759999967762]},"getAuthWitness":{"times":[0.3072069999980158]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06425099999614758]},"notifyEnqueuedPublicFunctionCall":{"times":[0.09370299999864073]}}},{"functionName":"private_kernel_init","time":84.41778299999714},{"functionName":"private_kernel_reset","time":234.49904400000378},{"functionName":"private_kernel_tail","time":128.84198299999844}],"unaccounted":129.14489100000355}} 14:54:05 [14:54:05.711] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:05 [14:54:05.716] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x15db71ac2aa671301bcb7ab349b1191824fa540a10c5de6b13fa81f45e73dfb8","blockNumber":9,"slot":10} 14:54:05 [14:54:05.739] VERBOSE: p2p:tx_pool Adding tx 0x0c4bb3d42b9c08e055c1438449d30231c02c103a12d97c9ac14e63b453d867e1 to pool {"eventName":"tx-added-to-pool","txHash":"0x0c4bb3d42b9c08e055c1438449d30231c02c103a12d97c9ac14e63b453d867e1","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 14:54:05 [14:54:05.746] INFO: node Received tx 0x0c4bb3d42b9c08e055c1438449d30231c02c103a12d97c9ac14e63b453d867e1 {"txHash":"0x0c4bb3d42b9c08e055c1438449d30231c02c103a12d97c9ac14e63b453d867e1"} 14:54:05 [14:54:05.746] INFO: pxe:service Sent transaction 0x0c4bb3d42b9c08e055c1438449d30231c02c103a12d97c9ac14e63b453d867e1 14:54:05 [14:54:05.916] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:06 [14:54:06.119] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:06 [14:54:06.247] VERBOSE: sequencer Building block 9 for slot 10 {"slot":10,"blockNumber":9,"msgCount":0} 14:54:06 [14:54:06.259] VERBOSE: sequencer Processing pending txs {"slot":10,"slotStart":"2025-06-13T15:02:36.000Z","now":"2025-06-13T15:02:38.682Z"} 14:54:06 [14:54:06.288] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":8.854610999995202} 14:54:06 [14:54:06.310] VERBOSE: simulator:public-processor Processed tx 0x0c4bb3d42b9c08e055c1438449d30231c02c103a12d97c9ac14e63b453d867e1 with 1 public calls in 36.99875300000713ms {"txHash":"0x0c4bb3d42b9c08e055c1438449d30231c02c103a12d97c9ac14e63b453d867e1","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":36.99875300000713} 14:54:06 [14:54:06.312] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05141620699999476s {"duration":0.05141620699999476,"rate":389838.16912052734,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 14:54:06 [14:54:06.321] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:06 [14:54:06.440] INFO: sequencer Built block 9 for slot 10 with 1 txs and 0 messages. 103205.77240944923 mana/s {"blockHash":"0x16c8b0e3d2ecf66f5d3bee777b8427bf9a1fc7e8d396ecdeb5c384ffaa10bbb6","globalVariables":{"chainId":31337,"version":720795365,"blockNumber":9,"slotNumber":10,"timestamp":1749826956,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHashes":["0x0c4bb3d42b9c08e055c1438449d30231c02c103a12d97c9ac14e63b453d867e1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":193.4774960000068,"publicProcessDuration":51.749104999995325,"rollupCircuitsDuration":181.31890600000042,"txCount":1,"blockNumber":9,"blockTimestamp":1749826956,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:54:06 [14:54:06.442] VERBOSE: sequencer Attesting committee is empty 14:54:06 [14:54:06.539] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:06 [14:54:06.753] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:06 [14:54:06.766] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x0002934ebccf180406680193ac069550a3a676697e73f5f641efe5afb8f45fd1 14:54:06 [14:54:06.767] VERBOSE: sequencer-client Sent L1 transaction 0x0002934ebccf180406680193ac069550a3a676697e73f5f641efe5afb8f45fd1 {"gasLimit":470292,"maxFeePerGas":"1.21634497","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 14:54:06 [14:54:06.781] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749826992] on http://127.0.0.1:8545 14:54:06 [14:54:06.784] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:54:06 [14:54:06.784] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x0002934ebccf180406680193ac069550a3a676697e73f5f641efe5afb8f45fd1","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":9,"blockTimestamp":1749826956,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:54:06 [14:54:06.785] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 14:54:06 [14:54:06.788] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 14:54:06 [14:54:06.793] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749826992 14:54:06 [14:54:06.793] WARN: foundation:test-date-provider Time set to 2025-06-13T15:03:12.000Z {"offset":545207,"timeMs":1749826992000} 14:54:06 [14:54:06.793] INFO: aztecjs:utils:watcher Slot 10 was filled, jumped to next slot 14:54:06 [14:54:06.795] INFO: blob-sink:server Received blob sidecar for block 0x45d940db194a8d53150e74db7bc2920c50801ee38f2a197cccc8a07dd1b1c516 14:54:06 [14:54:06.800] INFO: blob-sink:server Blob sidecar stored successfully for block 0x45d940db194a8d53150e74db7bc2920c50801ee38f2a197cccc8a07dd1b1c516 14:54:06 [14:54:06.956] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:06 [14:54:06.960] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000009"] on http://127.0.0.1:8545 14:54:06 [14:54:06.962] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 9 14:54:06 [14:54:06.963] INFO: aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9. 14:54:07 [14:54:07.160] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:07 [14:54:07.449] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:07 [14:54:07.482] INFO: archiver Downloaded L2 block 9 {"blockHash":"0x16c8b0e3d2ecf66f5d3bee777b8427bf9a1fc7e8d396ecdeb5c384ffaa10bbb6","blockNumber":9,"txCount":1,"globalVariables":{"chainId":31337,"version":720795365,"blockNumber":9,"slotNumber":10,"timestamp":1749826956,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"archiveRoot":"0x12e4cfdb0390384dea29a45e93816190e87560b681762f766fcdbe93be5ea65f","archiveNextLeafIndex":10} 14:54:07 [14:54:07.486] INFO: archiver Updated proven chain to block 9 {"provenBlockNumber":9} 14:54:07 [14:54:07.577] INFO: world_state World state updated with L2 block 9 {"eventName":"l2-block-handled","duration":10.537030999999843,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1749826956,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:54:07 [14:54:07.620] VERBOSE: p2p Synched to latest block 9 14:54:07 [14:54:07.658] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:07 [14:54:07.775] VERBOSE: pxe:service Updated pxe last block to 9 {"blockHash":{},"archive":"0x12e4cfdb0390384dea29a45e93816190e87560b681762f766fcdbe93be5ea65f","header":{"contentCommitment":{"blobsHash":"0x00fa5506b1e1ca45435743bc2f6b626a536f06394890b3d9a24a885ee883c873","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1749826956,"version":720795365},"lastArchive":"0x15db71ac2aa671301bcb7ab349b1191824fa540a10c5de6b13fa81f45e73dfb8","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21493a057b3ec8941ae01cae9e5e830f83118c1ac3fe88c1e9abdbce7f1da102","nullifierTree":"0x169bb4e787375e2f3b7a24d3af92cc73b89c32ffe2dd5f82818c5910dce6096d","publicDataTree":"0x2210b1b1e52d8a815ce5f33dbdb93243f2dc64e25e336f0a108fc850c79399b4"},"totalFees":276318000,"totalManaUsed":45900}} 14:54:07 [14:54:07.891] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","selector":"0xd191fb1a"} 14:54:07 [14:54:07.907] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:07 [14:54:07.912] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 14:54:07 [14:54:07.912] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:07 [14:54:07.926] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x12e4cfdb0390384dea29a45e93816190e87560b681762f766fcdbe93be5ea65f","blockNumber":10,"slot":11} 14:54:08 [14:54:08.016] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86"} 14:54:08 [14:54:08.039] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x2870cd78ed51659a16359e56ded298b33c99dafa444014af06c0e8b2639f2ff3 14:54:08 [14:54:08.054] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 14:54:08 [14:54:08.055] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:54:08 [14:54:08.067] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:54:08 [14:54:08.067] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:54:08 [14:54:08.071] VERBOSE: pxe:service Added note {"index":0,"contract":"0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0b6ff6ebfbf42f5c3cacd448dee6297ba046e357c2a205b980e66321919e5122","nullifier":"0x2d29bfa00e027d042522f16c5c74b51a6217c5139f7c8b4833a70da7cf36db5d"} 14:54:08 [14:54:08.074] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:54:08 [14:54:08.086] VERBOSE: simulator Utility simulation for 0x05efedb4928317b0b1a10e280bcb62bf8eb45812caf9623f3dafab668b557e86.0xd191fb1a completed 14:54:08 [14:54:08.131] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 14:54:08 [14:54:08.144] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:08 [14:54:08.158] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 14:54:08 [14:54:08.206] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 {"origin":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000002af676e5","authWitnesses":["0x0bcba692d2d75c7d93509f2194bd1c51174f1bd1af6790242332f7696bcc88ff"]} 14:54:08 [14:54:08.311] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:54:08 [14:54:08.373] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 14:54:08 [14:54:08.373] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:54:08 [14:54:08.376] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:08 [14:54:08.473] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x12e4cfdb0390384dea29a45e93816190e87560b681762f766fcdbe93be5ea65f","blockNumber":10,"slot":11} 14:54:08 [14:54:08.496] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922"} 14:54:08 [14:54:08.539] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x18b5d0f802875a1e2aac6f666b52a68aed67cb035dfe672214e762dfd008fcba 14:54:08 [14:54:08.555] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 14:54:08 [14:54:08.556] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 14:54:08 [14:54:08.570] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 14:54:08 [14:54:08.574] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 14:54:08 [14:54:08.580] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:08 [14:54:08.587] VERBOSE: pxe:service Added note {"index":64,"contract":"0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x00d7f36c90e1f085251b88f86ba4f4a7a14824b2e2acf7cb1076ba2d2dafdcf4","nullifier":"0x19cf976a055d616acced99ca7656a2b2e1cfa378a80915ff8a95fd4254f3dea2"} 14:54:08 [14:54:08.590] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 14:54:08 [14:54:08.606] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1d986ef7e070e73a7ffa7fbdc3aa414df86009d959505cfb9a3d7fee02142922 as fee payer 14:54:08 [14:54:08.824] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:09 [14:54:09.231] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 14:54:09 [14:54:09.263] VERBOSE: node Simulating public calls for tx 0x13a45a750572e0ca1658118f52c1e9a2e049d5795c655ee572d5a0a5edafefc4 {"globalVariables":{"chainId":31337,"version":720795365,"blockNumber":10,"slotNumber":11,"timestamp":1749826992,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHash":"0x13a45a750572e0ca1658118f52c1e9a2e049d5795c655ee572d5a0a5edafefc4","blockNumber":10} 14:54:09 [14:54:09.275] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x12e4cfdb0390384dea29a45e93816190e87560b681762f766fcdbe93be5ea65f","blockNumber":10,"slot":11} 14:54:09 [14:54:09.317] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 reverted with reason Assertion failed: . {"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":29.594335000001593} 14:54:09 [14:54:09.318] WARN: simulator:public_tx_context APP_LOGIC phase reverted! 0x0000000000000000000000000000000000000000000000000000000000000001:0x2716b166 failed with reason: Assertion failed: 14:54:09 [14:54:09.352] VERBOSE: simulator:public-processor Processed tx 0x13a45a750572e0ca1658118f52c1e9a2e049d5795c655ee572d5a0a5edafefc4 with 1 public calls in 73.87966199999937ms {"txHash":"0x13a45a750572e0ca1658118f52c1e9a2e049d5795c655ee572d5a0a5edafefc4","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":73.87966199999937} 14:54:09 [14:54:09.353] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08472415099999489s {"duration":0.08472415099999489,"rate":418357.68882478547,"totalPublicGas":{"daGas":0,"l2Gas":35445},"totalBlockGas":{"daGas":1024,"l2Gas":61301},"totalSizeInBytes":256} 14:54:09 PASS src/e2e_authwit.test.ts 14:54:09 e2e_authwit_tests 14:54:09 Private 14:54:09 arbitrary data 14:54:09 ✓ happy path (8235 ms) 14:54:09 failure case 14:54:09 ✓ invalid chain id (1176 ms) 14:54:09 ✓ invalid version (1754 ms) 14:54:09 Public 14:54:09 arbitrary data 14:54:09 ✓ happy path (7204 ms) 14:54:09 failure case 14:54:09 ✓ cancel before usage (8115 ms) 14:54:09 14:54:09 Test Suites: 1 passed, 1 total 14:54:09 Tests: 5 passed, 5 total 14:54:09 Snapshots: 0 total 14:54:09 Time: 51.342 s 14:54:09 Ran all test suites matching /src\/e2e_authwit.test.ts/i. 14:54:09 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?