Parent Log: http://ci.aztec-labs.com/5b033f030d6cee54 Command: 53e9b8d3e8ba3411:ISOLATE=1:NAME=e2e_authwit yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_authwit.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/f4ac84d7ac4041d505399edd8819840bb14d6c9d Env: REF_NAME=gh-readonly-queue/master/pr-15005-b1b65bcdbd44a49fbebe5d2265256dc9466e92be CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Fri Jun 13 17:07:54 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15005_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_06a902b1832ee6d0_master 17:07:55 +++ id -u 17:07:55 +++ id -g 17:07:55 ++ docker run -d --name e2e_authwit --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_authwit.test.ts'\''' 17:07:55 + cid=d08d6b278459d0c597fa01aff6298b103f32a40f8546c2a8748778e4560f7b29 17:07:55 + set +x 17:07:55 {"level":25,"time":1749834475964,"pid":12,"hostname":"d08d6b278459","module":"logger","msg":"Logger initialized with level verbose"} 17:08:01 [17:08:01.727] INFO: e2e:e2e_authwit Logging metrics to log/unknown.jsonl 17:08:02 [17:08:02.059] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-OKFMZm/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:08:02 [17:08:02.093] INFO: e2e:e2e_authwit Calling anvil_setBlockTimestampInterval with params: [12] 17:08:02 [17:08:02.122] WARN: e2e:e2e_authwit Set block interval to 12 17:08:02 [17:08:02.123] VERBOSE: e2e:e2e_authwit Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:08:02 [17:08:02.166] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:08:02 [17:08:02.173] VERBOSE: e2e:e2e_authwit Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:08:02 [17:08:02.186] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:08:02 [17:08:02.190] VERBOSE: e2e:e2e_authwit Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:08:02 [17:08:02.211] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:08:02 [17:08:02.215] VERBOSE: e2e:e2e_authwit Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:08:02 [17:08:02.230] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:08:02 [17:08:02.253] VERBOSE: e2e:e2e_authwit Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:08:02 [17:08:02.282] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:08:02 [17:08:02.287] VERBOSE: e2e:e2e_authwit Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:08:02 [17:08:02.299] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:08:02 [17:08:02.304] VERBOSE: e2e:e2e_authwit Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:08:02 [17:08:02.305] VERBOSE: e2e:e2e_authwit Waiting for deployments to complete 17:08:02 [17:08:02.305] INFO: e2e:e2e_authwit Waiting for 6 transactions to be mined... 17:08:02 [17:08:02.326] INFO: e2e:e2e_authwit All transactions mined successfully 17:08:02 [17:08:02.340] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:08:02 [17:08:02.341] VERBOSE: e2e:e2e_authwit Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:08:02 [17:08:02.358] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:08:02 [17:08:02.368] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:08:02 [17:08:02.372] VERBOSE: e2e:e2e_authwit Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:08:02 [17:08:02.385] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:08:02 [17:08:02.385] VERBOSE: e2e:e2e_authwit Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:08:02 [17:08:02.402] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:08:02 [17:08:02.406] VERBOSE: e2e:e2e_authwit Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:08:02 [17:08:02.416] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:08:02 [17:08:02.416] VERBOSE: e2e:e2e_authwit Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:08:02 [17:08:02.416] VERBOSE: e2e:e2e_authwit Waiting for deployments to complete 17:08:02 [17:08:02.416] INFO: e2e:e2e_authwit Waiting for 8 transactions to be mined... 17:08:02 [17:08:02.432] INFO: e2e:e2e_authwit All transactions mined successfully 17:08:02 [17:08:02.440] VERBOSE: e2e:e2e_authwit Deployed shared contracts 17:08:02 [17:08:02.460] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:08:02 [17:08:02.460] VERBOSE: e2e:e2e_authwit Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:08:02 [17:08:02.462] VERBOSE: e2e:e2e_authwit Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:08:02 [17:08:02.472] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:08:02 [17:08:02.495] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:08:02 [17:08:02.500] VERBOSE: e2e:e2e_authwit Awaiting for linked libraries to be deployed 17:08:02 [17:08:02.543] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x0e1b44e0e6988334ddca9415381d9a353105390287402ba14ec719aa42d424c7 {"gasLimit":10407394,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:08:02 [17:08:02.548] VERBOSE: e2e:e2e_authwit Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 17:08:02 [17:08:02.548] INFO: e2e:e2e_authwit Waiting for 9 transactions to be mined... 17:08:02 [17:08:02.564] INFO: e2e:e2e_authwit All transactions mined successfully 17:08:02 [17:08:02.564] VERBOSE: e2e:e2e_authwit All core contracts have been deployed 17:08:02 [17:08:02.575] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:08:02 [17:08:02.575] VERBOSE: e2e:e2e_authwit Funding fee juice portal with 20000000000000000000000 fee juice in 0x87752e6d1988a4ae568647f8d87c596d1b69935ee30a33c51605875f496d2e9b (accelerated test deployments) 17:08:02 [17:08:02.585] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0x3076e8ed3c707fd6d82a919b677cf7a63a9c4828413a41044e3272f6f71e410a {"gasLimit":716194,"maxFeePerGas":"26.850966158","maxPriorityFeePerGas":"26.623333274"} 17:08:02 [17:08:02.588] VERBOSE: e2e:e2e_authwit Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:08:02 [17:08:02.607] VERBOSE: e2e:e2e_authwit Sent L1 transaction 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 {"gasLimit":116953,"maxFeePerGas":"32.147280374","maxPriorityFeePerGas":"31.947999928"} 17:08:02 [17:08:02.607] VERBOSE: e2e:e2e_authwit Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0xcd2cca55b67399deb9b7db167c38dc1d22e6d4d796fedc3ba097570542992776 17:08:02 [17:08:02.607] INFO: e2e:e2e_authwit Waiting for 10 transactions to be mined... 17:08:02 [17:08:02.631] INFO: e2e:e2e_authwit All transactions mined successfully 17:08:02 [17:08:02.640] VERBOSE: e2e:e2e_authwit Rollup deployed 17:08:02 [17:08:02.640] VERBOSE: e2e:e2e_authwit Waiting for rollup and slash factory to be deployed 17:08:02 [17:08:02.640] INFO: e2e:e2e_authwit Waiting for 10 transactions to be mined... 17:08:02 [17:08:02.659] INFO: e2e:e2e_authwit All transactions mined successfully 17:08:02 [17:08:02.659] VERBOSE: e2e:e2e_authwit All transactions for L1 deployment have been mined 17:08:02 [17:08:02.678] INFO: e2e:e2e_authwit Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 17:08:02 [17:08:02.681] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:08:02 [17:08:02.684] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:02 [17:08:02.685] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:08:02 [17:08:02.686] INFO: telemetry:client Using NoopTelemetryClient 17:08:02 [17:08:02.691] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/89d99b30165f72c5/blob-sink with map size 134217728 KB (LMDB v2) 17:08:02 [17:08:02.692] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:08:02 [17:08:02.692] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:08:02 [17:08:02.695] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:02 [17:08:02.697] INFO: aztecjs:utils:watcher New L1 time: 1749834721 17:08:02 [17:08:02.698] WARN: foundation:test-date-provider Time set to 2025-06-13T17:12:01.000Z {"offset":238303,"timeMs":1749834721000} 17:08:02 [17:08:02.699] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:08:02 [17:08:02.708] INFO: blob-sink:server Server is running on http://localhost:34211 17:08:02 [17:08:02.709] VERBOSE: e2e:e2e_authwit Creating and synching an aztec node... 17:08:02 [17:08:02.709] VERBOSE: e2e:e2e_authwit Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/bfce0d3b/acvm 17:08:02 [17:08:02.711] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34211"} 17:08:02 [17:08:02.725] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:08:02 [17:08:02.726] INFO: archiver:lmdb Creating archiver data store at directory /tmp/89d99b30165f72c5/archiver with map size 134217728 KB (LMDB v2) 17:08:02 [17:08:02.731] INFO: archiver:lmdb Starting data store with maxReaders 16 17:08:02 [17:08:02.920] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:03 [17:08:03.013] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:34211"} 17:08:03 [17:08:03.031] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:34211"} 17:08:03 [17:08:03.032] WARN: node:blob-sink:client No L1 consensus host urls configured 17:08:03 [17:08:03.032] WARN: node:blob-sink:client No archive client configured 17:08:03 [17:08:03.034] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0xc7175f929821085db81aa82f5f11a146889938a8dabc06601fa25d6d9a4402bf {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x66b07648e3e384afaff37d171879257c59308262b6ad9fe6bfbd0aadb9095ac2","l1BlockNumber":16}} 17:08:03 [17:08:03.047] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xc7175f929821085db81aa82f5f11a146889938a8dabc06601fa25d6d9a4402bf","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:08:03 [17:08:03.054] INFO: world-state:database Creating world state data store at directory /tmp/89d99b30165f72c5/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:08:03 [17:08:03.077] INFO: world_state Created world state synchroniser with block history of 64 17:08:03 [17:08:03.077] WARN: node Aztec node is accepting fake proofs 17:08:03 [17:08:03.086] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/89d99b30165f72c5/p2p with map size 134217728 KB (LMDB v2) 17:08:03 [17:08:03.087] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:08:03 [17:08:03.088] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/89d99b30165f72c5/p2p-archive with map size 134217728 KB (LMDB v2) 17:08:03 [17:08:03.089] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:08:03 [17:08:03.090] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/89d99b30165f72c5/p2p-peers with map size 134217728 KB (LMDB v2) 17:08:03 [17:08:03.091] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:08:03 [17:08:03.092] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:08:03 [17:08:03.093] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:08:03 [17:08:03.095] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:08:03 [17:08:03.096] INFO: world_state Started world state synchronizer from block 1 17:08:03 [17:08:03.098] VERBOSE: world-state:block_stream Starting sync from block number 0 17:08:03 [17:08:03.099] INFO: p2p Starting p2p client from block 0 with empty mempools 17:08:03 [17:08:03.099] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:08:03 [17:08:03.100] INFO: slasher Slasher client initialized 17:08:03 [17:08:03.101] INFO: slasher Starting Slasher client... 17:08:03 [17:08:03.132] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:03 [17:08:03.133] VERBOSE: node All Aztec Node subsystems synced 17:08:03 [17:08:03.141] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:03 [17:08:03.143] INFO: sequencer-client Deploying forwarder contract 17:08:03 [17:08:03.152] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:08:03 [17:08:03.169] VERBOSE: sequencer-client Sent L1 transaction 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968 {"gasLimit":436981,"maxFeePerGas":"1.353583762","maxPriorityFeePerGas":"1.2"} 17:08:03 [17:08:03.170] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xb1f3df2017e7ba07c13a74da934c53780ad6675aaaf877e947cca2001f9da968. 17:08:03 [17:08:03.175] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:08:03 [17:08:03.198] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:03 [17:08:03.198] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:08:03 [17:08:03.199] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/bfce0d3b/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:08:03 [17:08:03.449] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:08:03 [17:08:03.451] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:08:03 [17:08:03.452] INFO: node Aztec Node version: 0.87.8 17:08:03 [17:08:03.452] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 17:08:03 [17:08:03.453] VERBOSE: e2e:e2e_authwit Creating a pxe... 17:08:03 [17:08:03.457] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:03 [17:08:03.465] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/03d71bced254d33b/pxe_data with map size 134217728 KB (LMDB v2) 17:08:03 [17:08:03.477] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:08:03 [17:08:03.479] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2} 17:08:03 [17:08:03.674] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:03 [17:08:03.786] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:08:03 [17:08:03.787] INFO: pxe:service Started PXE connected to chain 31337 version 2254972989 17:08:03 [17:08:03.836] INFO: pxe:service Registered account 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c 17:08:03 [17:08:03.894] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:03 [17:08:03.898] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:08:03 [17:08:03.902] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c 17:08:04 [17:08:04.029] INFO: pxe:service Added contract SchnorrAccount at 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:04 [17:08:04.038] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2} 17:08:04 [17:08:04.068] VERBOSE: pxe:block_stream Starting sync from block number 0 17:08:04 [17:08:04.091] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:08:04 [17:08:04.135] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:04 [17:08:04.178] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:04 [17:08:04.802] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:08:04 [17:08:04.912] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:05 [17:08:05.013] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:05 [17:08:05.090] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2} 17:08:05 [17:08:05.160] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:05 [17:08:05.218] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:05 [17:08:05.220] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:05 [17:08:05.224] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:05 [17:08:05.277] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:05 [17:08:05.280] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:05 [17:08:05.458] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:05 [17:08:05.502] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:05 [17:08:05.503] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:05 [17:08:05.507] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:05 [17:08:05.556] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:05 [17:08:05.559] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:05 [17:08:05.576] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer 17:08:05 [17:08:05.667] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2} 17:08:05 [17:08:05.777] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:06 [17:08:06.041] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:06 [17:08:06.211] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2} 17:08:06 [17:08:06.375] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:06 [17:08:06.906] INFO: pxe:service Proving completed in 2840.9801929999994ms {"timings":{"total":2840.9801929999994,"sync":3.735893999999462,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":186.45423800000208,"oracles":{"callPrivateFunction":{"times":[866.554924,377.5141279999989,218.4610819999998]}}},{"functionName":"private_kernel_init","time":103.0472060000011},{"functionName":"ContractClassRegisterer:register","time":848.582316,"oracles":{"loadCapsule":{"times":[22.686713999999483]},"notifyCreatedNullifier":{"times":[2.492315999999846]},"debugLog":{"times":[2.9492970000010246]},"notifyCreatedContractClassLog":{"times":[8.176085000000967]}}},{"functionName":"private_kernel_inner","time":162.18285699999979},{"functionName":"SchnorrAccount:constructor","time":327.47725399999945,"oracles":{"getContractInstance":{"times":[5.775150999999823]},"debugLog":{"times":[0.7089759999998932,0.26523599999927683]},"fetchTaggedLogs":{"times":[60.02204999999958]},"loadCapsule":{"times":[0.31760700000086217,0.190454999999929,0.16581399999995483]},"notifyCreatedNullifier":{"times":[0.12643299999945157,0.3862390000012965]},"notifyCreatedNote":{"times":[0.40137899999899673]},"getRandomField":{"times":[0.25550599999951373,0.16387399999985064,0.0827819999994972,0.05171200000040699,0.044841000000815256,0.049651000001176726,0.04937100000097416,0.04299100000025646,0.046741000000110944,0.0637910000004922,0.04010100000050443]},"getIndexedTaggingSecretAsSender":{"times":[35.999556000000666]},"incrementAppTaggingSecretIndexAsSender":{"times":[34.9105610000006]}}},{"functionName":"private_kernel_inner","time":161.35349799999858},{"functionName":"SchnorrAccount:entrypoint","time":170.78574099999787,"oracles":{"debugLog":{"times":[0.6436949999988428,0.5031920000001264,0.8474990000013349]},"fetchTaggedLogs":{"times":[55.189220999998724]},"loadCapsule":{"times":[0.27424599999903876,0.284497000000556,0.24439600000005157]},"getNotes":{"times":[2.166659000000436]},"getAuthWitness":{"times":[0.3062370000006922]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.027953000000707]}}},{"functionName":"private_kernel_inner","time":118.13505799999984},{"functionName":"private_kernel_reset","time":203.12566499999957},{"functionName":"private_kernel_tail","time":108.48747000000003}],"unaccounted":447.61299600000166}} 17:08:06 [17:08:06.930] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:07 [17:08:07.024] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","blockNumber":1,"slot":2} 17:08:07 [17:08:07.104] VERBOSE: p2p:tx_pool Adding tx 0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15 to pool {"eventName":"tx-added-to-pool","txHash":"0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:08:07 [17:08:07.135] INFO: node Received tx 0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15 {"txHash":"0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15"} 17:08:07 [17:08:07.138] INFO: pxe:service Sent transaction 0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15 17:08:07 [17:08:07.149] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:07 [17:08:07.354] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:07 [17:08:07.553] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:08:07 [17:08:07.557] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:07 [17:08:07.567] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T17:12:25.000Z","now":"2025-06-13T17:12:05.870Z"} 17:08:07 [17:08:07.794] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:07 [17:08:07.878] VERBOSE: simulator:public-processor Processed tx 0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15 with no public calls in 232.99843099999998ms {"txHash":"0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15","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":232.99843099999998} 17:08:07 [17:08:07.881] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.31269078900000025s {"duration":0.31269078900000025,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:08:08 [17:08:08.039] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:08 [17:08:08.053] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x03d9f32061835bbb1f4d7f759d911b8892e382368fa0acff703813b37e2578a0","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":1,"slotNumber":2,"timestamp":1749834745,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2288bddbc1b4f19df2ef864ff2a0f5c6014bbe012bac1747e9590e21a953ef15"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":499.77094899999975,"publicProcessDuration":313.5923989999992,"rollupCircuitsDuration":486.3638949999986,"txCount":1,"blockNumber":1,"blockTimestamp":1749834745,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:08 [17:08:08.055] VERBOSE: sequencer Attesting committee is empty 17:08:08 [17:08:08.246] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:08 [17:08:08.467] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:08 [17:08:08.475] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xfe5373be6ba59c0a8ad3a7de7f4d13dc45bd7fbff02c615ee290a0c24481e8b0 17:08:08 [17:08:08.475] VERBOSE: sequencer-client Sent L1 transaction 0xfe5373be6ba59c0a8ad3a7de7f4d13dc45bd7fbff02c615ee290a0c24481e8b0 {"gasLimit":514570,"maxFeePerGas":"1.574385791","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:08:08 [17:08:08.490] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:08 [17:08:08.491] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xfe5373be6ba59c0a8ad3a7de7f4d13dc45bd7fbff02c615ee290a0c24481e8b0","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1749834745,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:08 [17:08:08.492] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:08 [17:08:08.512] INFO: blob-sink:server Received blob sidecar for block 0x99bffb560909bd233a276cf0cfd8cb36f9310c027b0ec83e887705f7c5462e4f 17:08:08 [17:08:08.519] INFO: blob-sink:server Blob sidecar stored successfully for block 0x99bffb560909bd233a276cf0cfd8cb36f9310c027b0ec83e887705f7c5462e4f 17:08:08 [17:08:08.746] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:08 [17:08:08.778] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:08 [17:08:08.780] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:08:08 [17:08:08.786] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:08:08 [17:08:08.790] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x03d9f32061835bbb1f4d7f759d911b8892e382368fa0acff703813b37e2578a0","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":1,"slotNumber":2,"timestamp":1749834745,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","archiveNextLeafIndex":2} 17:08:08 [17:08:08.791] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:08:08 [17:08:08.792] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834781] on http://127.0.0.1:8545 17:08:08 [17:08:08.794] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:08 [17:08:08.796] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834781 17:08:08 [17:08:08.797] WARN: foundation:test-date-provider Time set to 2025-06-13T17:13:01.000Z {"offset":292204,"timeMs":1749834781000} 17:08:08 [17:08:08.797] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:08:08 [17:08:08.908] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":44.94971900000019,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749834745,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:08:08 [17:08:08.955] INFO: pxe:service Registered account 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 17:08:08 [17:08:08.956] VERBOSE: p2p Synched to latest block 1 17:08:09 [17:08:09.059] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:09 [17:08:09.069] INFO: pxe:service Added contract SchnorrAccount at 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:08:09 [17:08:09.108] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","blockNumber":2,"slot":3} 17:08:09 [17:08:09.115] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","header":{"contentCommitment":{"blobsHash":"0x00625e41bfa5829ece7b54b2037f957f2f99896a83bfe69bf1237f54d599a1fc","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749834745,"version":2254972989},"lastArchive":"0x24fa16e0c307ed822b0707d7fb06110eb520581133840574b890767f894200a6","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x21963c0f5c7085b3bbe383480ee20e2347925f703de1ffaa2db720b37ab2d05b","nullifierTree":"0x15f9c15e1a2ec733b07283f849600ece2d37dbdfa4a594a6e5af105f11cd390d","publicDataTree":"0x10bbdb7ab2e7708501154cb9a2afd3ad5c72970cbce87ab0d6c20f26c3bb5829"},"totalFees":6794052480,"totalManaUsed":20448}} 17:08:09 [17:08:09.137] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:08:09 [17:08:09.232] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:09 [17:08:09.270] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:09 [17:08:09.276] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:09 [17:08:09.276] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:09 [17:08:09.348] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:08:09 [17:08:09.373] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:09 [17:08:09.379] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:09 [17:08:09.483] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:09 [17:08:09.590] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:09 [17:08:09.648] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:09 [17:08:09.649] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:09 [17:08:09.690] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:09 [17:08:09.698] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","blockNumber":2,"slot":3} 17:08:09 [17:08:09.732] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:09 [17:08:09.753] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:09 [17:08:09.805] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer 17:08:09 [17:08:09.895] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:10 [17:08:10.251] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:10 [17:08:10.874] INFO: pxe:service Proving completed in 1769.0076719999997ms {"timings":{"total":1769.0076719999997,"sync":11.961370999999417,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":107.09870799999408,"oracles":{"callPrivateFunction":{"times":[344.6452420000005,339.11765699999887]}}},{"functionName":"private_kernel_init","time":82.09861099999944},{"functionName":"SchnorrAccount:constructor","time":310.26749400000153,"oracles":{"getContractInstance":{"times":[3.3941370000011375]},"debugLog":{"times":[0.47195099999953527,0.40466899999955785]},"fetchTaggedLogs":{"times":[101.85303999999996]},"loadCapsule":{"times":[0.26187600000048405,0.2555849999989732,0.47447100000135833]},"notifyCreatedNullifier":{"times":[0.21667499999966822,0.2703160000000935]},"notifyCreatedNote":{"times":[0.08558200000152283]},"getRandomField":{"times":[0.1041029999996681,0.16361400000096182,0.04506100000071456,0.034959999999045976,0.042140999999901396,0.039521000000604545,0.03482100000110222,0.03858100000070408,0.05976100000043516,0.11272300000018731,0.0680609999999433]},"getIndexedTaggingSecretAsSender":{"times":[55.01361700000052]},"incrementAppTaggingSecretIndexAsSender":{"times":[36.098047999999835]}}},{"functionName":"private_kernel_inner","time":144.9641759999995},{"functionName":"SchnorrAccount:entrypoint","time":304.385970000003,"oracles":{"debugLog":{"times":[0.7186970000002475,1.3487409999997908,3.020478999998886]},"fetchTaggedLogs":{"times":[97.36801699999887]},"loadCapsule":{"times":[0.46985099999983504,4.560712999998941,0.6586449999995239]},"getNotes":{"times":[26.480160999999498]},"getAuthWitness":{"times":[0.34021800000118674]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6730959999986226]}}},{"functionName":"private_kernel_inner","time":177.94758300000103},{"functionName":"private_kernel_reset","time":201.7038219999995},{"functionName":"private_kernel_tail","time":104.43446799999947}],"unaccounted":324.1454690000028}} 17:08:10 [17:08:10.890] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:10 [17:08:10.895] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","blockNumber":2,"slot":3} 17:08:10 [17:08:10.930] VERBOSE: p2p:tx_pool Adding tx 0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e to pool {"eventName":"tx-added-to-pool","txHash":"0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e","noteHashCount":1,"nullifierCount":2,"privateLogCount":1,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 17:08:10 [17:08:10.936] INFO: node Received tx 0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e {"txHash":"0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e"} 17:08:10 [17:08:10.936] INFO: pxe:service Sent transaction 0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e 17:08:11 [17:08:11.097] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:11 [17:08:11.301] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:11 [17:08:11.443] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:08:11 [17:08:11.468] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T17:13:01.000Z","now":"2025-06-13T17:13:03.672Z"} 17:08:11 [17:08:11.505] VERBOSE: simulator:public-processor Processed tx 0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e with no public calls in 19.14374400000088ms {"txHash":"0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e","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":19.14374400000088} 17:08:11 [17:08:11.507] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03862291499999992s {"duration":0.03862291499999992,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":15104},"totalSizeInBytes":992} 17:08:11 [17:08:11.513] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:11 [17:08:11.649] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x16232118a04f9b5e35d965c379b57c4381d93bef4783b4c6fb5f44c5e5edf7bd","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":2,"slotNumber":3,"timestamp":1749834781,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x06cb615ba190f72f52cac9ab9d91863463788a1f89701642867d5d730e56362e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":206.7776670000003,"publicProcessDuration":39.03234499999962,"rollupCircuitsDuration":182.75790299999971,"txCount":1,"blockNumber":2,"blockTimestamp":1749834781,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:11 [17:08:11.652] VERBOSE: sequencer Attesting committee is empty 17:08:11 [17:08:11.732] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:11 [17:08:11.960] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:11 [17:08:11.969] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xdc383b451b66c764b0b957156a78156cb4d3139c984f01299577ba9c8a5c5571 17:08:11 [17:08:11.969] VERBOSE: sequencer-client Sent L1 transaction 0xdc383b451b66c764b0b957156a78156cb4d3139c984f01299577ba9c8a5c5571 {"gasLimit":470254,"maxFeePerGas":"1.303611187","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:11 [17:08:11.989] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 17:08:11 [17:08:11.994] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 17:08:11 [17:08:11.997] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834817] on http://127.0.0.1:8545 17:08:12 [17:08:12.006] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 17:08:12 [17:08:12.012] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:12 [17:08:12.018] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834817 17:08:12 [17:08:12.018] WARN: foundation:test-date-provider Time set to 2025-06-13T17:13:37.000Z {"offset":324982,"timeMs":1749834817000} 17:08:12 [17:08:12.018] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:08:12 [17:08:12.022] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:12 [17:08:12.022] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xdc383b451b66c764b0b957156a78156cb4d3139c984f01299577ba9c8a5c5571","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":2,"blockTimestamp":1749834781,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:12 [17:08:12.023] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:12 [17:08:12.034] INFO: blob-sink:server Received blob sidecar for block 0x36b87784b29c4441480494890fe2cade4eb2abcf5593b9bed4c485b91046b1d7 17:08:12 [17:08:12.077] INFO: blob-sink:server Blob sidecar stored successfully for block 0x36b87784b29c4441480494890fe2cade4eb2abcf5593b9bed4c485b91046b1d7 17:08:12 [17:08:12.223] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:12 [17:08:12.248] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x16232118a04f9b5e35d965c379b57c4381d93bef4783b4c6fb5f44c5e5edf7bd","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":2,"slotNumber":3,"timestamp":1749834781,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","archiveNextLeafIndex":3} 17:08:12 [17:08:12.260] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 17:08:12 [17:08:12.373] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":11.557010999997146,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749834781,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:12 [17:08:12.393] VERBOSE: p2p Synched to latest block 2 17:08:12 [17:08:12.499] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:12 [17:08:12.643] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","blockNumber":3,"slot":4} 17:08:12 [17:08:12.648] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","header":{"contentCommitment":{"blobsHash":"0x00bae807c9e4ee120e990b524d014fef26020df986bdf19143e3c27f64f63a22","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749834781,"version":2254972989},"lastArchive":"0x1b5a4c0b74781fd38783233be129956ae804afb146f83700e984f3bb5c375259","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x14ffbb4e8d5ecfff878dfdb071d465a0d346acf01608d11ada6e77ea1e2adc5a","publicDataTree":"0x2d5546ec5a702a66520fb9d5e88ae41bb686711c018d7de10b005be2a35dd093"},"totalFees":5018455040,"totalManaUsed":15104}} 17:08:12 [17:08:12.721] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:12 [17:08:12.808] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:12 [17:08:12.864] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:12 [17:08:12.865] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:12 [17:08:12.978] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:13 [17:08:13.040] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:13 [17:08:13.049] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:13 [17:08:13.065] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:13 [17:08:13.066] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:13 [17:08:13.079] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:13 [17:08:13.080] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:13 [17:08:13.100] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:13 [17:08:13.106] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:13 [17:08:13.122] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer 17:08:13 [17:08:13.207] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:13 [17:08:13.221] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:08:13 [17:08:13.243] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","blockNumber":3,"slot":4} 17:08:13 [17:08:13.279] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:13 [17:08:13.297] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c,0x0000000000000000000000000000000000000000000000000000000000000001,0x0e1a4386eb74933caafd688212a2bb990799b853c2ea9475cbd869df074b3a86,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x1feef5cc227695ba4101ff856ef512ce4e18bd4430a801c3d3ea2ce6b447a2c1,0x2eb092b9d7fcb1a074f76f4d690af3b86218b7eadc74008cd9905cdde6e864aa,0x12da8d3426c400f00507beac996cbed0288544d18b43ccf702bafbe584909eea,0x1a88c976e8dd9460d30456f08ae85fc9c80db976189b2d94cac1ac0d6cbf789d,0x2e13719748bacbd7f85c22358a712518c65d5afdcc602b74a6d709fd8a582354,0x1a7bca87bbf1a1b4e2b88f21776479fa18db2aeae855684236aba805252bcb99,0x1eb6a26604d77934282c3556192e5bd45ff74275028d261f76816878ffde4ed6,0x16fa338f8513608eb346513d8c4206f8f30bf5732519533b8aafbda32ca3c3e5,0x1bd09f27dc6e0e4cfa9c00968c16fbb89bac6ac475ad9fc2fd9fc96788cd98aa,0x0000000000000000000000000000000000000000000000000000000000000000 17:08:13 [17:08:13.349] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:08:13 [17:08:13.387] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:13 [17:08:13.398] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4,0x0000000000000000000000000000000000000000000000000000000000000001,0x1ec75b29ff4729aead2690e887680c20561bc1cfc428078191c79effa0e0eccf,0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x1a05a8678a12830d640e51980a4568bc0569adbb131f9b8f8aadf143d712c42c,0x0d0d70b29b941e93bfc0c959325ba2bb72866ffd5bf2ff1d8e751a68ec6e4c1f,0x282f8eeca5b139d1aa67809b06d236c838a2154f5ec330b3b99913576077e0fd,0x151a531cbd849436bdd57fdd4ba259e9dca7d30768a8804a4587f58d1d810b10,0x1c8b35245d2a210d1e738b39b55a27331d8cf516a829a30f508807d7d72776f6,0x14b916204245f6d4f9362c7ca08397bba74d80dea2cfbd326db8bf16fc80c25b,0x204a6ee0deb8673ce383f25957634d8c2e80517ddaa0cbce83379f84d699718b,0x138e203f141076914a9a8a9164f9b6bdd9d0791421286ffeba151951cb22c9b9,0x047cede245186ae4c2ceacdd881006614f38c0a112badcc5f8e857f74f36dfff,0x0000000000000000000000000000000000000000000000000000000000000000 17:08:13 [17:08:13.445] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:13 [17:08:13.663] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:13 [17:08:13.949] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:14 [17:08:13.996] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","blockNumber":3,"slot":4} 17:08:14 [17:08:14.244] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:14 [17:08:14.515] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:14 [17:08:14.773] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:14 [17:08:14.775] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","blockNumber":3,"slot":4} 17:08:15 [17:08:15.120] INFO: pxe:service Proving completed in 2492.5361669999984ms {"timings":{"total":2492.5361669999984,"sync":27.113184000001638,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":482.1855199999991,"oracles":{"debugLog":{"times":[0.7758580000008806,0.5254520000016782,0.6249040000002424,0.5600330000015674,1.3723009999994247,1.0635640000000421,0.3957200000004377,0.5374719999999797]},"fetchTaggedLogs":{"times":[180.25534699999844]},"loadCapsule":{"times":[0.26508599999942817,1.2012869999998657,0.9902620000029856,0.4486789999973553,1.199096999996982,1.464034000000538]},"getSharedSecret":{"times":[5.476653999998234]},"aes128Decrypt":{"times":[1.344409999997879,1.3959409999988566]},"getPublicKeysAndPartialAddress":{"times":[2.370443999996496]},"getKeyValidationRequest":{"times":[4.802619000001869]},"deliverNote":{"times":[19.150345000001835]},"deleteCapsule":{"times":[0.8378889999985404]},"storeCapsule":{"times":[2.9475169999968784]},"getNotes":{"times":[2.2529410000024654]},"getAuthWitness":{"times":[0.33403700000053504]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.11838300000090385]},"callPrivateFunction":{"times":[178.1457279999995,96.38178499999776]}}},{"functionName":"private_kernel_init","time":105.27387600000293},{"functionName":"ContractInstanceDeployer:deploy","time":106.52440699999715,"oracles":{"storeInExecutionCache":{"times":[0.2511159999994561]},"callPrivateFunction":{"times":[62.81331399999908]},"notifyCreatedNullifier":{"times":[0.37705799999821465]},"debugLog":{"times":[0.7349370000010822]}}},{"functionName":"private_kernel_inner","time":140.6008780000011},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":44.534958000003826,"oracles":{}},{"functionName":"private_kernel_inner","time":158.33984899999996},{"functionName":"ContractInstanceDeployer:deploy","time":55.07694900000206,"oracles":{"storeInExecutionCache":{"times":[0.06250200000067707]},"callPrivateFunction":{"times":[39.85417300000336]},"notifyCreatedNullifier":{"times":[0.3018969999975525]},"debugLog":{"times":[0.5054110000019136]}}},{"functionName":"private_kernel_inner","time":164.687751999998},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":30.161803999999393,"oracles":{}},{"functionName":"private_kernel_inner","time":164.52975900000092},{"functionName":"private_kernel_reset","time":237.83106899999984},{"functionName":"private_kernel_tail","time":108.1439509999982}],"unaccounted":667.5322109999943}} 17:08:15 [17:08:15.139] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:15 [17:08:15.186] VERBOSE: p2p:tx_pool Adding tx 0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b to pool {"eventName":"tx-added-to-pool","txHash":"0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b","noteHashCount":0,"nullifierCount":3,"privateLogCount":2,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 17:08:15 [17:08:15.192] INFO: node Received tx 0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b {"txHash":"0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b"} 17:08:15 [17:08:15.192] INFO: pxe:service Sent transaction 0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b 17:08:15 [17:08:15.295] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:08:15 [17:08:15.307] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T17:13:37.000Z","now":"2025-06-13T17:13:40.289Z"} 17:08:15 [17:08:15.333] VERBOSE: simulator:public-processor Processed tx 0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b with no public calls in 17.049197000000277ms {"txHash":"0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b","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":17.049197000000277} 17:08:15 [17:08:15.336] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.028188139000001684s {"duration":0.028188139000001684,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":18432,"l2Gas":16544},"totalSizeInBytes":1376} 17:08:15 [17:08:15.345] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:15 [17:08:15.474] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0399e362418571e3d233e974b1a16dc6553f0a08a9e062b4c47e6f602056c633","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":3,"slotNumber":4,"timestamp":1749834817,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1d464110b1e171034eef6e3fa845574a984dd8d2d76808cfa767bfa452652e2b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":179.01717599999756,"publicProcessDuration":28.651160000001255,"rollupCircuitsDuration":167.40032399999836,"txCount":1,"blockNumber":3,"blockTimestamp":1749834817,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:15 [17:08:15.476] VERBOSE: sequencer Attesting committee is empty 17:08:15 [17:08:15.564] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:15 [17:08:15.758] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x0566976d1b40ebf48cd93046f37c9c9121787ca90074efe99cf8e083b51d9b24 17:08:15 [17:08:15.759] VERBOSE: sequencer-client Sent L1 transaction 0x0566976d1b40ebf48cd93046f37c9c9121787ca90074efe99cf8e083b51d9b24 {"gasLimit":470280,"maxFeePerGas":"1.279583375","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:15 [17:08:15.767] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:15 [17:08:15.775] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:15 [17:08:15.775] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x0566976d1b40ebf48cd93046f37c9c9121787ca90074efe99cf8e083b51d9b24","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":3,"blockTimestamp":1749834817,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:15 [17:08:15.776] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:15 [17:08:15.783] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:08:15 [17:08:15.786] INFO: blob-sink:server Received blob sidecar for block 0xf10e9bcf8effdb1bd4eeab1f74b69bdee392d21dd2da1a0c0ed64461c143a29d 17:08:15 [17:08:15.789] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:08:15 [17:08:15.793] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 17:08:15 [17:08:15.794] INFO: blob-sink:server Blob sidecar stored successfully for block 0xf10e9bcf8effdb1bd4eeab1f74b69bdee392d21dd2da1a0c0ed64461c143a29d 17:08:15 [17:08:15.803] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834853] on http://127.0.0.1:8545 17:08:15 [17:08:15.804] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:15 [17:08:15.806] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834853 17:08:15 [17:08:15.806] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:13.000Z {"offset":357194,"timeMs":1749834853000} 17:08:15 [17:08:15.806] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:08:15 [17:08:15.972] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:16 [17:08:16.178] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:16 [17:08:16.477] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:16 [17:08:16.496] VERBOSE: archiver:block-helper Store contract instance at 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c 17:08:16 [17:08:16.497] VERBOSE: archiver:block-helper Store contract instance at 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 17:08:16 [17:08:16.500] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x0399e362418571e3d233e974b1a16dc6553f0a08a9e062b4c47e6f602056c633","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":3,"slotNumber":4,"timestamp":1749834817,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","archiveNextLeafIndex":4} 17:08:16 [17:08:16.506] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 17:08:16 [17:08:16.620] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":14.768625000000611,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749834817,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:16 [17:08:16.634] VERBOSE: p2p Synched to latest block 3 17:08:16 [17:08:16.685] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:16 [17:08:16.818] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","blockNumber":4,"slot":5} 17:08:16 [17:08:16.890] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.099] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.249] WARN: pxe:service No artifact found for contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c when looking for its metadata 17:08:17 [17:08:17.250] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c as part of deployment for 0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd 17:08:17 [17:08:17.383] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.477] INFO: pxe:service Added contract AuthWitTest at 0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd with class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c 17:08:17 [17:08:17.480] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","blockNumber":4,"slot":5} 17:08:17 [17:08:17.501] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","header":{"contentCommitment":{"blobsHash":"0x00b154a9556a893a03b83cab901a26e3b329d764a2e94dfa14212595bd918192","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749834817,"version":2254972989},"lastArchive":"0x2875048cde4af0b237b287bbe33973ee030f0b335fd9a10dcc9d81fb9e398bf1","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x1daabb6ca70c12cc95d3d6e771dc43e3fcdc6069066a3c519b072b4e232e789b","publicDataTree":"0x21821fefa1e445cf79db672afbdaeb33311078f94e612247d8f68302d56be457"},"totalFees":5496909440,"totalManaUsed":16544}} 17:08:17 [17:08:17.620] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:17 [17:08:17.684] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:17 [17:08:17.684] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:17 [17:08:17.685] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.828] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:17 [17:08:17.836] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:17 [17:08:17.850] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:17 [17:08:17.851] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:17 [17:08:17.864] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:17 [17:08:17.864] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:17 [17:08:17.868] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:17 [17:08:17.869] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:17 [17:08:17.883] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer 17:08:17 [17:08:17.897] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:17 [17:08:17.924] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:18 [17:08:18.592] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0b531072c192262f69310be602c8bfeb8f4e36acff72ed861afd4f76ee50de56,0x2054c0397fca7702b6f9252401dd1f653f4e20cff98e2eb5395de9bbdc250278,0x2b6ecadb0b2de2c700fc27a25c15b4c8eb590b62f353cdd047a57ce195071418 17:08:18 [17:08:18.756] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:08:18 [17:08:18.860] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:18 [17:08:18.952] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:08:18 [17:08:18.969] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","blockNumber":4,"slot":5} 17:08:19 [17:08:19.011] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:08:19 [17:08:19.021] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd,0x0000000000000000000000000000000000000000000000000000000000000001,0x0fb28a0148a05dac53a7c04241a34b5a9c133fbed3aae2af7a321610120c0b23,0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c,0x0000000000000000000000000000000000000000000000000000000000000000,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c 17:08:19 [17:08:19.082] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.349] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.630] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.938] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:19 [17:08:19.941] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","blockNumber":4,"slot":5} 17:08:20 [17:08:20.251] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.612] INFO: pxe:service Proving completed in 3119.941818000003ms {"timings":{"total":3119.941818000003,"sync":17.629328999999416,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":429.55044199999975,"oracles":{"debugLog":{"times":[0.8001179999992019,0.5443820000000414,0.6251840000004449,0.6528350000007777,0.42205900000044494,0.25425600000016857,0.33672800000204006,0.4709709999988263]},"fetchTaggedLogs":{"times":[149.28109299999778]},"loadCapsule":{"times":[0.23699500000293483,0.35354800000277464,0.49063200000091456,0.21334500000011758,0.2848470000026282,0.25063500000032946]},"getSharedSecret":{"times":[3.9186790000021574]},"aes128Decrypt":{"times":[0.3310480000000098,1.4261520000000019]},"getPublicKeysAndPartialAddress":{"times":[1.7927700000000186]},"getKeyValidationRequest":{"times":[3.7342940000016824]},"deliverNote":{"times":[3.198311999996804]},"deleteCapsule":{"times":[0.23899600000004284]},"storeCapsule":{"times":[0.3190570000006119]},"getNotes":{"times":[1.6007960000024468]},"getAuthWitness":{"times":[0.1653440000009141]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05805099999997765]},"callPrivateFunction":{"times":[953.5484770000003,191.62687300000107]}}},{"functionName":"private_kernel_init","time":115.98632799999905},{"functionName":"ContractClassRegisterer:register","time":934.9013350000023,"oracles":{"loadCapsule":{"times":[6.271892000000662]},"notifyCreatedNullifier":{"times":[0.473149999997986]},"debugLog":{"times":[0.5824529999990773]},"notifyCreatedContractClassLog":{"times":[22.198773000000074]}}},{"functionName":"private_kernel_inner","time":179.17886},{"functionName":"ContractInstanceDeployer:deploy","time":113.45376000000033,"oracles":{"storeInExecutionCache":{"times":[0.1607140000014624]},"callPrivateFunction":{"times":[55.946836999999505]},"notifyCreatedNullifier":{"times":[0.233234999999695]},"debugLog":{"times":[0.45234999999956926]}}},{"functionName":"private_kernel_inner","time":195.5605719999985},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":35.96962599999824,"oracles":{}},{"functionName":"private_kernel_inner","time":199.01864899999782},{"functionName":"private_kernel_reset","time":242.98023499999908},{"functionName":"private_kernel_tail","time":115.70051199999943}],"unaccounted":540.0121700000091}} 17:08:20 [17:08:20.638] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.766] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","blockNumber":4,"slot":5} 17:08:20 [17:08:20.858] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:20 [17:08:20.872] VERBOSE: p2p:tx_pool Adding tx 0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb to pool {"eventName":"tx-added-to-pool","txHash":"0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb","noteHashCount":0,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":55,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:08:20 [17:08:20.898] INFO: node Received tx 0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb {"txHash":"0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb"} 17:08:20 [17:08:20.899] INFO: pxe:service Sent transaction 0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb 17:08:21 [17:08:21.071] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.278] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.317] VERBOSE: sequencer Building block 4 for slot 5 {"slot":5,"blockNumber":4,"msgCount":0} 17:08:21 [17:08:21.332] VERBOSE: sequencer Processing pending txs {"slot":5,"slotStart":"2025-06-13T17:14:13.000Z","now":"2025-06-13T17:14:18.526Z"} 17:08:21 [17:08:21.606] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.703] VERBOSE: simulator:public-processor Processed tx 0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb with no public calls in 252.76381800000308ms {"txHash":"0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb","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":252.76381800000308} 17:08:21 [17:08:21.710] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3768353490000009s {"duration":0.3768353490000009,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":39424,"l2Gas":16544},"totalSizeInBytes":2720} 17:08:21 [17:08:21.879] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:21 [17:08:21.907] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2afe1842cccc5246fb7faf1d99c79dd75f7162280ab81f22e63e2c2b6f428e3b","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":4,"slotNumber":5,"timestamp":1749834853,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x226a920efade99679b7204ecf71a4456315441161fe10e1482c772119b6ef8fb"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":591.9254729999993,"publicProcessDuration":377.3022400000009,"rollupCircuitsDuration":575.2767759999988,"txCount":1,"blockNumber":4,"blockTimestamp":1749834853,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 17:08:21 [17:08:21.915] VERBOSE: sequencer Attesting committee is empty 17:08:22 [17:08:22.094] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.337] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.350] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x9cdd3c9c6d04672b5c465701d8dbc751b0230c0e81290893b60fcd0f4fff39d8 17:08:22 [17:08:22.351] VERBOSE: sequencer-client Sent L1 transaction 0x9cdd3c9c6d04672b5c465701d8dbc751b0230c0e81290893b60fcd0f4fff39d8 {"gasLimit":470277,"maxFeePerGas":"1.261127724","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:22 [17:08:22.371] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://127.0.0.1:8545 17:08:22 [17:08:22.376] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 17:08:22 [17:08:22.380] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 17:08:22 [17:08:22.384] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:22 [17:08:22.384] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x9cdd3c9c6d04672b5c465701d8dbc751b0230c0e81290893b60fcd0f4fff39d8","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":4,"blockTimestamp":1749834853,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 17:08:22 [17:08:22.385] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:22 [17:08:22.392] INFO: blob-sink:server Received blob sidecar for block 0xddd347e7cbd173c8eafa9d3245901f4eac33cd9f8e7f23555ee57892ec901ce0 17:08:22 [17:08:22.403] INFO: blob-sink:server Blob sidecar stored successfully for block 0xddd347e7cbd173c8eafa9d3245901f4eac33cd9f8e7f23555ee57892ec901ce0 17:08:22 [17:08:22.550] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.587] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834889] on http://127.0.0.1:8545 17:08:22 [17:08:22.588] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:22 [17:08:22.590] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834889 17:08:22 [17:08:22.591] WARN: foundation:test-date-provider Time set to 2025-06-13T17:14:49.000Z {"offset":386410,"timeMs":1749834889000} 17:08:22 [17:08:22.591] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 17:08:22 [17:08:22.793] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:22 [17:08:22.817] VERBOSE: archiver:block-helper Store contract instance at 0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd 17:08:22 [17:08:22.820] VERBOSE: archiver:block-helper Store contract class 0x038b262e87e934bf659e3671d93334275ac8f36996d6c559351d89ccb742fa7c 17:08:22 [17:08:22.839] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x2afe1842cccc5246fb7faf1d99c79dd75f7162280ab81f22e63e2c2b6f428e3b","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":4,"slotNumber":5,"timestamp":1749834853,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","archiveNextLeafIndex":5} 17:08:22 [17:08:22.847] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 17:08:22 [17:08:22.925] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":10.914237000000867,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749834853,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":55} 17:08:22 [17:08:22.942] INFO: aztecjs:deploy_sent_tx Contract 0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd successfully deployed. 17:08:22 [17:08:22.948] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data happy path 17:08:23 [17:08:23.002] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.006] VERBOSE: pxe:service Updated pxe last block to 4 {"blockHash":{},"archive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","header":{"contentCommitment":{"blobsHash":"0x00c831c25b17da50de285068d0c5799ab3d8c014f7f521da7cdd93b43abed1d8","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749834853,"version":2254972989},"lastArchive":"0x1acccf7c169b9e4a89fde069044f5ae17f36694f6a19568350a8eb549c8505af","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x18208fb86b767a64e97ca0e36772afa32779894c443f41e235888e2520162cd3","publicDataTree":"0x0352097dd1a1baf6de0e1c62f9e36c9052a0c9148f22cd7472431f7f2dc4f39b"},"totalFees":838780800,"totalManaUsed":16544}} 17:08:23 [17:08:23.015] VERBOSE: p2p Synched to latest block 4 17:08:23 [17:08:23.127] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:23 [17:08:23.143] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:23 [17:08:23.144] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:23 [17:08:23.210] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.227] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:23 [17:08:23.235] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:23 [17:08:23.249] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:23 [17:08:23.250] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:23 [17:08:23.258] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:23 [17:08:23.258] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:23 [17:08:23.262] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:23 [17:08:23.264] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:23 [17:08:23.283] VERBOSE: simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed 17:08:23 [17:08:23.339] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:23 [17:08:23.352] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:23 [17:08:23.414] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.465] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","blockNumber":5,"slot":6} 17:08:23 [17:08:23.483] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","selector":"0xd191fb1a"} 17:08:23 [17:08:23.499] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:23 [17:08:23.500] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:23 [17:08:23.559] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:23 [17:08:23.569] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e 17:08:23 [17:08:23.584] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:23 [17:08:23.585] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:23 [17:08:23.592] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:23 [17:08:23.592] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:23 [17:08:23.595] VERBOSE: pxe:service Added note {"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"} 17:08:23 [17:08:23.597] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:23 [17:08:23.604] VERBOSE: simulator Utility simulation for 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4.0xd191fb1a completed 17:08:23 [17:08:23.636] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.652] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:23 [17:08:23.661] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:23 [17:08:23.766] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:23 [17:08:23.810] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:23 [17:08:23.810] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:23 [17:08:23.855] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:23 [17:08:23.890] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:23 [17:08:23.898] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e 17:08:23 [17:08:23.912] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:23 [17:08:23.913] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:23 [17:08:23.938] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:23 [17:08:23.939] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:23 [17:08:23.951] VERBOSE: pxe:service Added note {"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"} 17:08:23 [17:08:23.956] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:23 [17:08:23.971] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer 17:08:24 [17:08:24.008] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd"} 17:08:24 [17:08:24.018] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","blockNumber":5,"slot":6} 17:08:24 [17:08:24.063] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:24 [17:08:24.145] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:24 [17:08:24.174] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:24 [17:08:24.175] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:24 [17:08:24.280] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:24 [17:08:24.289] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:24 [17:08:24.301] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:24 [17:08:24.302] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:24 [17:08:24.310] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:24 [17:08:24.311] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:24 [17:08:24.313] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:24 [17:08:24.317] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:24 [17:08:24.320] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:24 [17:08:24.579] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:24 [17:08:24.806] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","blockNumber":5,"slot":6} 17:08:24 [17:08:24.823] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.065] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.293] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.660] INFO: pxe:service Proving completed in 1980.390636ms {"timings":{"total":1980.390636,"sync":4.377049999999144,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":274.16154200000165,"oracles":{"debugLog":{"times":[0.7851580000024114,0.9484819999997853,0.6020140000000538,0.4978110000010929,0.7002559999964433,0.6990860000005341,0.7601070000018808,0.783806999999797]},"fetchTaggedLogs":{"times":[85.82374500000151]},"loadCapsule":{"times":[0.35765799999717274,0.23917500000243308,0.40077900000324007,0.34892799999943236,0.3593189999992319,0.3809580000015558]},"getSharedSecret":{"times":[5.599196999999549]},"aes128Decrypt":{"times":[0.6390250000004016,1.0115729999997711]},"getPublicKeysAndPartialAddress":{"times":[8.774059000003035]},"getKeyValidationRequest":{"times":[12.653146000000561]},"deliverNote":{"times":[12.808899999999994]},"deleteCapsule":{"times":[1.3426910000016505]},"storeCapsule":{"times":[0.45261000000027707]},"getNotes":{"times":[1.8348020000012184]},"getAuthWitness":{"times":[0.20404499999858672]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08517200000278535]},"callPrivateFunction":{"times":[369.69060700000045]}}},{"functionName":"private_kernel_init","time":97.57459100000051},{"functionName":"AuthWitTest:consume","time":80.13195699999415,"oracles":{"storeInExecutionCache":{"times":[0.13122300000031828]},"callPrivateFunction":{"times":[322.6577410000027]},"loadFromExecutionCache":{"times":[0.18016400000124122]},"notifyCreatedNullifier":{"times":[0.2672759999986738]}}},{"functionName":"private_kernel_inner","time":185.29175800000303},{"functionName":"SchnorrAccount:verify_private_authwit","time":282.722526000005,"oracles":{"debugLog":{"times":[0.8049080000018876,0.46875100000033854,0.6018230000008771,0.5935829999980342,0.41535899999871617,0.2801660000004631,0.3838889999969979]},"fetchTaggedLogs":{"times":[111.38994399999865]},"loadCapsule":{"times":[0.3014369999982591,0.22537499999816646,0.41624900000169873,0.9534319999984291,0.3352779999986524,0.2935169999982463]},"getSharedSecret":{"times":[5.278889000001072]},"aes128Decrypt":{"times":[0.42481000000043423,0.794157999996969]},"getPublicKeysAndPartialAddress":{"times":[1.945424000001367]},"getKeyValidationRequest":{"times":[2.004884999998467]},"deliverNote":{"times":[6.634290999998484]},"deleteCapsule":{"times":[0.38890900000114925]},"storeCapsule":{"times":[0.3235469999999623]},"getNotes":{"times":[2.012166000000434]},"getAuthWitness":{"times":[0.10757300000113901]},"storeInExecutionCache":{"times":[0.20955500000127358]}}},{"functionName":"private_kernel_inner","time":151.7104380000019},{"functionName":"private_kernel_reset","time":260.3828100000028},{"functionName":"private_kernel_tail","time":104.56400000000212}],"unaccounted":539.4739639999898}} 17:08:25 [17:08:25.689] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:25 [17:08:25.766] VERBOSE: sequencer Not enough txs to build block 5 at slot 6 (got 0 txs, need 1) {"chainTipArchive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","blockNumber":5,"slot":6} 17:08:25 [17:08:25.787] VERBOSE: p2p:tx_pool Adding tx 0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47 to pool {"eventName":"tx-added-to-pool","txHash":"0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47","noteHashCount":0,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 17:08:25 [17:08:25.797] INFO: node Received tx 0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47 {"txHash":"0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47"} 17:08:25 [17:08:25.799] INFO: pxe:service Sent transaction 0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47 17:08:25 [17:08:25.910] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.114] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.320] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.356] VERBOSE: sequencer Building block 5 for slot 6 {"slot":6,"blockNumber":5,"msgCount":0} 17:08:26 [17:08:26.381] VERBOSE: sequencer Processing pending txs {"slot":6,"slotStart":"2025-06-13T17:14:49.000Z","now":"2025-06-13T17:14:52.791Z"} 17:08:26 [17:08:26.414] VERBOSE: simulator:public-processor Processed tx 0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47 with no public calls in 19.2015250000004ms {"txHash":"0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47","txFee":567840000,"revertCode":0,"gasUsed":{"totalGas":{"daGas":1536,"l2Gas":11200},"billedGas":{"daGas":1536,"l2Gas":11200},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":0,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":19.2015250000004} 17:08:26 [17:08:26.415] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.032159039000001936s {"duration":0.032159039000001936,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":1536,"l2Gas":11200},"totalSizeInBytes":288} 17:08:26 [17:08:26.549] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.572] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1edea935100dce20a534e24ca41bcaaf8eb5b935de19d3aaf048f104abbd56eb","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":5,"slotNumber":6,"timestamp":1749834889,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x154a3a62d189c2bf898513b8fe98d4d7c49106d315b6bb4f6d18ae65f6897d47"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":238.48935399999755,"publicProcessDuration":32.56073800000013,"rollupCircuitsDuration":193.4061529999999,"txCount":1,"blockNumber":5,"blockTimestamp":1749834889,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:26 [17:08:26.587] VERBOSE: sequencer Attesting committee is empty 17:08:26 [17:08:26.762] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.968] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:26 [17:08:26.982] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x31b97788eadfe66a11d742a52a55631baf6012e58bbcdf6fbf73ccbf99126cd6 17:08:26 [17:08:26.982] VERBOSE: sequencer-client Sent L1 transaction 0x31b97788eadfe66a11d742a52a55631baf6012e58bbcdf6fbf73ccbf99126cd6 {"gasLimit":470246,"maxFeePerGas":"1.246951997","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:27 [17:08:27.016] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://127.0.0.1:8545 17:08:27 [17:08:27.019] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834925] on http://127.0.0.1:8545 17:08:27 [17:08:27.021] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 17:08:27 [17:08:27.025] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:27 [17:08:27.026] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 17:08:27 [17:08:27.028] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:27 [17:08:27.029] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x31b97788eadfe66a11d742a52a55631baf6012e58bbcdf6fbf73ccbf99126cd6","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":5,"blockTimestamp":1749834889,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:27 [17:08:27.030] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:27 [17:08:27.034] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834925 17:08:27 [17:08:27.035] WARN: foundation:test-date-provider Time set to 2025-06-13T17:15:25.000Z {"offset":417965,"timeMs":1749834925000} 17:08:27 [17:08:27.035] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 17:08:27 [17:08:27.046] INFO: blob-sink:server Received blob sidecar for block 0x76cf2f45b5b2dc2d2d8ce4b3013e8b3a47be71e5535e50f30a30871517ae5194 17:08:27 [17:08:27.057] INFO: blob-sink:server Blob sidecar stored successfully for block 0x76cf2f45b5b2dc2d2d8ce4b3013e8b3a47be71e5535e50f30a30871517ae5194 17:08:27 [17:08:27.181] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:27 [17:08:27.386] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:27 [17:08:27.588] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:27 [17:08:27.782] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x1edea935100dce20a534e24ca41bcaaf8eb5b935de19d3aaf048f104abbd56eb","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":5,"slotNumber":6,"timestamp":1749834889,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","archiveNextLeafIndex":6} 17:08:27 [17:08:27.784] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 17:08:27 [17:08:27.793] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:27 [17:08:27.818] VERBOSE: pxe:service Updated pxe last block to 5 {"blockHash":{},"archive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","header":{"contentCommitment":{"blobsHash":"0x003703749dfadc7c5db6aaec0b8c946c8e691ea37c6f85c56e644a574f0db92c","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749834889,"version":2254972989},"lastArchive":"0x07ce7ec1d4a0a78eeaed86203be6cc397a40e02977a35fa6aff09b14332dcff8","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x20bf42cbee17300737bd33bc1f6353ee9b746f2cc35b21e266f7a94c0bcd24b4","publicDataTree":"0x2da1d92f39c8e6a1d2b7eb113fd48086b3320a6d46d5620478bbebc39a0741be"},"totalFees":567840000,"totalManaUsed":11200}} 17:08:27 [17:08:27.938] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":9.567427000001771,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749834889,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:28 [17:08:28.001] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.011] VERBOSE: p2p Synched to latest block 5 17:08:28 [17:08:28.176] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:28 [17:08:28.198] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:28 [17:08:28.199] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:28 [17:08:28.206] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.252] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7} 17:08:28 [17:08:28.300] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:28 [17:08:28.322] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:28 [17:08:28.341] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:28 [17:08:28.342] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:28 [17:08:28.351] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:28 [17:08:28.352] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:28 [17:08:28.357] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:28 [17:08:28.360] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:28 [17:08:28.371] WARN: node Nullifier 1412136670559030468905179444353797816480882328436364701199225603777842628352 already exists in the tree 17:08:28 [17:08:28.374] VERBOSE: simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed 17:08:28 [17:08:28.415] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.436] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:28 [17:08:28.456] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:28 [17:08:28.641] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:28 [17:08:28.700] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:28 [17:08:28.700] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:28 [17:08:28.704] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.798] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7} 17:08:28 [17:08:28.830] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:28 [17:08:28.843] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e 17:08:28 [17:08:28.858] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:28 [17:08:28.859] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:28 [17:08:28.891] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:28 [17:08:28.892] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:28 [17:08:28.899] VERBOSE: pxe:service Added note {"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"} 17:08:28 [17:08:28.901] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:28 [17:08:28.922] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer 17:08:28 [17:08:28.927] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:28 [17:08:28.961] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd"} 17:08:29 [17:08:29.106] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:29 [17:08:29.142] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:29 [17:08:29.143] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:29 [17:08:29.147] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:29 [17:08:29.291] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:29 [17:08:29.325] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:29 [17:08:29.339] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:29 [17:08:29.341] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:29 [17:08:29.342] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7} 17:08:29 [17:08:29.355] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:29 [17:08:29.356] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:29 [17:08:29.360] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:29 [17:08:29.372] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:29 [17:08:29.377] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:29 [17:08:29.647] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:29 [17:08:29.901] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.028] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7} 17:08:30 [17:08:30.193] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.462] INFO: pxe:service Proving completed in 1981.917340999993ms {"timings":{"total":1981.917340999993,"sync":12.571704999994836,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":418.9723159999994,"oracles":{"debugLog":{"times":[0.7411570000040228,0.5483820000008564,0.6999849999992875,0.6647949999969569,0.6883559999987483,0.3811790000036126,0.47650099999736995,0.8680499999973108]},"fetchTaggedLogs":{"times":[140.24124799999845]},"loadCapsule":{"times":[0.23893499999394407,0.22684499999741092,0.4869010000038543,0.3057859999971697,0.28225599999859696,0.4411289999989094]},"getSharedSecret":{"times":[5.053765000004205]},"aes128Decrypt":{"times":[0.7386570000016945,1.5366349999967497]},"getPublicKeysAndPartialAddress":{"times":[18.639311999999336]},"getKeyValidationRequest":{"times":[8.472222000003967]},"deliverNote":{"times":[7.046790000000328]},"deleteCapsule":{"times":[0.32317699999839533]},"storeCapsule":{"times":[0.3221080000002985]},"getNotes":{"times":[2.5594879999989644]},"getAuthWitness":{"times":[0.3083370000022114]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0659109999978682]},"callPrivateFunction":{"times":[493.6821770000024]}}},{"functionName":"private_kernel_init","time":75.05586100000073},{"functionName":"AuthWitTest:consume","time":104.96093699999619,"oracles":{"storeInExecutionCache":{"times":[0.13543299999582814]},"callPrivateFunction":{"times":[439.4147870000015]},"loadFromExecutionCache":{"times":[0.0892729999977746]},"notifyCreatedNullifier":{"times":[0.4396500000002561]}}},{"functionName":"private_kernel_inner","time":202.4075559999983},{"functionName":"SchnorrAccount:verify_private_authwit","time":378.46457600000576,"oracles":{"debugLog":{"times":[0.8208190000004834,0.5864730000030249,0.4426900000034948,0.7473769999996875,0.7014760000020033,0.4917510000013863,0.590213000003132]},"fetchTaggedLogs":{"times":[174.62099699999817]},"loadCapsule":{"times":[1.8270019999981741,2.0003450000003795,2.621649000000616,0.5886429999954998,0.24826600000233157,0.5615620000025956]},"getSharedSecret":{"times":[7.359416999999667]},"aes128Decrypt":{"times":[0.3120169999965583,0.8955400000049849]},"getPublicKeysAndPartialAddress":{"times":[3.8445080000019516]},"getKeyValidationRequest":{"times":[6.300703000000794]},"deliverNote":{"times":[16.960485000003246]},"deleteCapsule":{"times":[0.4436790000036126]},"storeCapsule":{"times":[0.7070449999955599]},"getNotes":{"times":[4.5117819999941275]},"getAuthWitness":{"times":[0.2346449999968172]},"storeInExecutionCache":{"times":[0.1677739999940968]}}},{"functionName":"private_kernel_inner","time":154.28758599999856},{"functionName":"private_kernel_reset","time":196.15082500000426},{"functionName":"private_kernel_tail","time":74.95400900000095}],"unaccounted":364.09196999999403}} 17:08:30 [17:08:30.485] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.506] VERBOSE: p2p:tx_validator:tx_double_spend Rejecting tx 0x1b7adfbe82c18a0e0a32dc0b4a6c21719f11167d9c5ef11b95b7584cd5878d96 for repeating a nullifier 17:08:30 [17:08:30.509] WARN: node Received invalid tx 0x1b7adfbe82c18a0e0a32dc0b4a6c21719f11167d9c5ef11b95b7584cd5878d96: Existing nullifier {"txHash":"0x1b7adfbe82c18a0e0a32dc0b4a6c21719f11167d9c5ef11b95b7584cd5878d96"} 17:08:30 [17:08:30.515] ERROR: pxe:service Error: Error: Invalid tx: Existing nullifier 17:08:30 at AztecNodeService.#sendTx (/home/aztec-dev/aztec-packages/yarn-project/aztec-node/dest/aztec-node/server.js:339:19) 17:08:30 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 17:08:30 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) 17:08:30 [17:08:30.517] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid chain id 17:08:30 [17:08:30.588] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7} 17:08:30 [17:08:30.624] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:30 [17:08:30.638] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:30 [17:08:30.638] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:30 [17:08:30.695] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.722] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:30 [17:08:30.728] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:30 [17:08:30.737] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:30 [17:08:30.738] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:30 [17:08:30.746] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:30 [17:08:30.746] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:30 [17:08:30.750] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:30 [17:08:30.751] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:30 [17:08:30.800] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:30 [17:08:30.805] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:30 [17:08:30.817] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 {"origin":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000008668283d","authWitnesses":["0x0b1b0dc7d086bbf4a5918c566dff9e6f520a95e2f3e3290435c9a2ab6c3c2d13"]} 17:08:30 [17:08:30.892] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:30 [17:08:30.931] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:30 [17:08:30.932] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:30 [17:08:30.936] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:30 [17:08:30.990] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:30 [17:08:30.996] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e 17:08:31 [17:08:31.006] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:31 [17:08:31.006] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:31 [17:08:31.012] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:31 [17:08:31.012] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:31 [17:08:31.015] VERBOSE: pxe:service Added note {"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"} 17:08:31 [17:08:31.016] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:31 [17:08:31.030] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer 17:08:31 [17:08:31.044] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd"} 17:08:31 [17:08:31.122] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:31 [17:08:31.149] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:31 [17:08:31.149] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:31 [17:08:31.154] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.201] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7} 17:08:31 [17:08:31.238] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:31 [17:08:31.248] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:31 [17:08:31.260] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:31 [17:08:31.261] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:31 [17:08:31.272] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:31 [17:08:31.272] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:31 [17:08:31.275] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:31 [17:08:31.277] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:31 [17:08:31.346] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Private arbitrary data failure case invalid version 17:08:31 [17:08:31.379] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.425] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:31 [17:08:31.438] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:31 [17:08:31.439] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:31 [17:08:31.489] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:31 [17:08:31.495] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:31 [17:08:31.503] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:31 [17:08:31.504] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:31 [17:08:31.510] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:31 [17:08:31.510] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:31 [17:08:31.512] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:31 [17:08:31.514] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:31 [17:08:31.555] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:31 [17:08:31.568] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:31 [17:08:31.583] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 {"origin":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000008668283d","authWitnesses":["0x2a8d07491cb93dac93f4c290d6385585e9df2a5ad77e0924e5a9aa79a74d507d"]} 17:08:31 [17:08:31.585] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.710] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:31 [17:08:31.766] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:31 [17:08:31.766] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:31 [17:08:31.794] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:31 [17:08:31.843] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7} 17:08:31 [17:08:31.872] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:31 [17:08:31.882] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e 17:08:31 [17:08:31.896] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:31 [17:08:31.897] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:31 [17:08:31.909] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:31 [17:08:31.910] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:31 [17:08:31.913] VERBOSE: pxe:service Added note {"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"} 17:08:31 [17:08:31.915] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:31 [17:08:31.933] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer 17:08:31 [17:08:31.956] VERBOSE: simulator:private_execution Executing private function AuthWitTest:consume {"contract":"0x081597a20f8b6b4396bd3290804b5648c18f1ce671345b4bf03e14d3b3add5cd"} 17:08:32 [17:08:32.042] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:verify_private_authwit {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:32 [17:08:32.068] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:32 [17:08:32.069] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:32 [17:08:32.071] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.145] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:32 [17:08:32.155] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:32 [17:08:32.169] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:32 [17:08:32.170] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:32 [17:08:32.186] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:32 [17:08:32.186] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:32 [17:08:32.190] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:32 [17:08:32.192] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:32 [17:08:32.294] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.355] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:32 [17:08:32.367] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:32 [17:08:32.368] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:32 [17:08:32.425] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7} 17:08:32 [17:08:32.457] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:32 [17:08:32.463] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:32 [17:08:32.473] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:32 [17:08:32.474] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:32 [17:08:32.480] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:32 [17:08:32.481] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:32 [17:08:32.483] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:32 [17:08:32.485] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:32 [17:08:32.498] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.528] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:32 [17:08:32.538] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:32 [17:08:32.540] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data happy path 17:08:32 [17:08:32.644] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:32 [17:08:32.657] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:32 [17:08:32.658] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:32 [17:08:32.704] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.717] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:32 [17:08:32.723] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:32 [17:08:32.734] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:32 [17:08:32.735] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:32 [17:08:32.740] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:32 [17:08:32.741] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:32 [17:08:32.744] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:32 [17:08:32.745] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:32 [17:08:32.758] VERBOSE: simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed 17:08:32 [17:08:32.803] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:32 [17:08:32.809] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:32 [17:08:32.907] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:32 [17:08:32.949] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:32 [17:08:32.949] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:32 [17:08:32.954] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:32 [17:08:32.999] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7} 17:08:33 [17:08:33.025] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:33 [17:08:33.031] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:33 [17:08:33.042] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:33 [17:08:33.043] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:33 [17:08:33.049] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:33 [17:08:33.049] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:33 [17:08:33.055] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:33 [17:08:33.057] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:33 [17:08:33.074] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer 17:08:33 [17:08:33.190] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.655] INFO: pxe:service Proving completed in 829.4188079999949ms {"timings":{"total":829.4188079999949,"sync":3.259964000004402,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":221.72049100000004,"oracles":{"debugLog":{"times":[0.5122620000038296,0.5771430000022519,0.47080100000312086,0.40380899999581743,0.5867339999967953,0.2851860000009765,0.3004769999970449,0.5393820000026608]},"fetchTaggedLogs":{"times":[79.96550800000114]},"loadCapsule":{"times":[0.20331399999849964,0.20447499999863794,0.5201919999963138,0.19071400000393623,0.1757930000021588,0.20356500000343658]},"getSharedSecret":{"times":[3.915238000001409]},"aes128Decrypt":{"times":[0.24110499999369495,0.6120440000013332]},"getPublicKeysAndPartialAddress":{"times":[1.3724610000062967]},"getKeyValidationRequest":{"times":[1.420653000001039]},"deliverNote":{"times":[6.090228000000934]},"deleteCapsule":{"times":[0.24937599999975646]},"storeCapsule":{"times":[0.2694859999974142]},"getNotes":{"times":[1.6500280000036582]},"getAuthWitness":{"times":[0.26595599999564]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1779549999992014]},"notifyEnqueuedPublicFunctionCall":{"times":[0.36307799999485724]}}},{"functionName":"private_kernel_init","time":93.64675700000225},{"functionName":"private_kernel_reset","time":242.01710099999764},{"functionName":"private_kernel_tail","time":110.81064500000502}],"unaccounted":157.96384999998554}} 17:08:33 [17:08:33.690] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:33 [17:08:33.731] VERBOSE: sequencer Not enough txs to build block 6 at slot 7 (got 0 txs, need 1) {"chainTipArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","blockNumber":6,"slot":7} 17:08:33 [17:08:33.739] VERBOSE: p2p:tx_pool Adding tx 0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783 to pool {"eventName":"tx-added-to-pool","txHash":"0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 17:08:33 [17:08:33.750] INFO: node Received tx 0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783 {"txHash":"0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783"} 17:08:33 [17:08:33.750] INFO: pxe:service Sent transaction 0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783 17:08:33 [17:08:33.897] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.100] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.258] VERBOSE: sequencer Building block 6 for slot 7 {"slot":7,"blockNumber":6,"msgCount":0} 17:08:34 [17:08:34.272] VERBOSE: sequencer Processing pending txs {"slot":7,"slotStart":"2025-06-13T17:15:25.000Z","now":"2025-06-13T17:15:32.237Z"} 17:08:34 [17:08:34.305] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.348] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":43.975234000005} 17:08:34 [17:08:34.382] VERBOSE: simulator:public-processor Processed tx 0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783 with 1 public calls in 93.29388900000049ms {"txHash":"0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783","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":93.29388900000049} 17:08:34 [17:08:34.384] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.11048098700000264s {"duration":0.11048098700000264,"rate":181424.88173100338,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 17:08:34 [17:08:34.511] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.522] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 75796.0471915172 mana/s {"blockHash":"0x20ccc2c198962d6a17a3ed9c4cfd4966b99d02bab80831747406e0020d847566","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":6,"slotNumber":7,"timestamp":1749834925,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x07b2f1e4b7f9d840facffca120e046b8774bcacf818251e7796dc202ffbc2783"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":263.76293300000543,"publicProcessDuration":111.06633099999453,"rollupCircuitsDuration":250.51923299999908,"txCount":1,"blockNumber":6,"blockTimestamp":1749834925,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:34 [17:08:34.525] VERBOSE: sequencer Attesting committee is empty 17:08:34 [17:08:34.797] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:34 [17:08:34.806] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x97a07ed74b58cae29be1089ac0dda9ed797b48a0238f316a6f24dfe5a922f362 17:08:34 [17:08:34.806] VERBOSE: sequencer-client Sent L1 transaction 0x97a07ed74b58cae29be1089ac0dda9ed797b48a0238f316a6f24dfe5a922f362 {"gasLimit":470295,"maxFeePerGas":"1.236063667","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:34 [17:08:34.823] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:34 [17:08:34.824] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x97a07ed74b58cae29be1089ac0dda9ed797b48a0238f316a6f24dfe5a922f362","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":6,"blockTimestamp":1749834925,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:34 [17:08:34.824] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:34 [17:08:34.833] INFO: blob-sink:server Received blob sidecar for block 0xae266447b9be450594c8368fb6cf7192a2531b155e5cd82b131ac63ea61f2ade 17:08:34 [17:08:34.841] INFO: blob-sink:server Blob sidecar stored successfully for block 0xae266447b9be450594c8368fb6cf7192a2531b155e5cd82b131ac63ea61f2ade 17:08:34 [17:08:34.846] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834961] on http://127.0.0.1:8545 17:08:34 [17:08:34.847] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:34 [17:08:34.849] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834961 17:08:34 [17:08:34.849] WARN: foundation:test-date-provider Time set to 2025-06-13T17:16:01.000Z {"offset":446151,"timeMs":1749834961000} 17:08:34 [17:08:34.850] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 17:08:35 [17:08:35.000] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.005] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000006"] on http://127.0.0.1:8545 17:08:35 [17:08:35.006] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 17:08:35 [17:08:35.008] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 17:08:35 [17:08:35.203] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.498] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.516] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x20ccc2c198962d6a17a3ed9c4cfd4966b99d02bab80831747406e0020d847566","blockNumber":6,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":6,"slotNumber":7,"timestamp":1749834925,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x0149654888ad0821df9fa16495f2867d1fb93f43673addb8ed52ede01a31591b","archiveNextLeafIndex":7} 17:08:35 [17:08:35.521] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 17:08:35 [17:08:35.625] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":10.9119370000044,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749834925,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:35 [17:08:35.637] VERBOSE: p2p Synched to latest block 6 17:08:35 [17:08:35.703] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.823] VERBOSE: pxe:service Updated pxe last block to 6 {"blockHash":{},"archive":"0x0149654888ad0821df9fa16495f2867d1fb93f43673addb8ed52ede01a31591b","header":{"contentCommitment":{"blobsHash":"0x00420bd79da1ee21928d4bbfa1c3f237a526cc9d1d8fd7a0280daff3fda75b11","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749834925,"version":2254972989},"lastArchive":"0x0e00628042432f02857042f10aad0fac23eff773cd9e586906b5d8c5029a91de","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x0510b38d01e3452658be0ad382eec29fb089af1fe74d808ea13e18a7475d9163","publicDataTree":"0x07357b706e738e1ffa38c9024afdaf7d1b35aa46f0b473eea3ceb75fe8c1320e"},"totalFees":2327130000,"totalManaUsed":45900}} 17:08:35 [17:08:35.915] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:35 [17:08:35.957] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:35 [17:08:35.978] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:35 [17:08:35.979] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:35 [17:08:35.985] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x0149654888ad0821df9fa16495f2867d1fb93f43673addb8ed52ede01a31591b","blockNumber":7,"slot":8} 17:08:36 [17:08:36.072] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:36 [17:08:36.080] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:36 [17:08:36.096] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:36 [17:08:36.097] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:36 [17:08:36.106] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:36 [17:08:36.107] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:36 [17:08:36.110] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:36 [17:08:36.112] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:36 [17:08:36.122] VERBOSE: simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed 17:08:36 [17:08:36.167] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:36 [17:08:36.172] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:36 [17:08:36.175] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.296] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:36 [17:08:36.342] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:36 [17:08:36.343] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:36 [17:08:36.405] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.416] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:36 [17:08:36.423] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e 17:08:36 [17:08:36.436] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:36 [17:08:36.437] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:36 [17:08:36.447] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:36 [17:08:36.447] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:36 [17:08:36.453] VERBOSE: pxe:service Added note {"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"} 17:08:36 [17:08:36.456] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:36 [17:08:36.473] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer 17:08:36 [17:08:36.593] VERBOSE: sequencer Not enough txs to build block 7 at slot 8 (got 0 txs, need 1) {"chainTipArchive":"0x0149654888ad0821df9fa16495f2867d1fb93f43673addb8ed52ede01a31591b","blockNumber":7,"slot":8} 17:08:36 [17:08:36.676] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:36 [17:08:36.966] INFO: pxe:service Proving completed in 750.371100999997ms {"timings":{"total":750.371100999997,"sync":3.4189470000055735,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":237.59195100000215,"oracles":{"debugLog":{"times":[0.8984210000053281,0.49149100000067847,0.5622730000031879,0.599794000001566,0.5449220000009518,0.3422279999940656,0.36151799999788636,0.5913929999951506]},"fetchTaggedLogs":{"times":[78.01534299999912]},"loadCapsule":{"times":[0.26177499999903375,0.24779499999567633,0.5289220000049681,0.4762209999971674,0.3299470000056317,0.4652810000043246]},"getSharedSecret":{"times":[4.0310110000064014]},"aes128Decrypt":{"times":[0.21846499999810476,1.113115000000107]},"getPublicKeysAndPartialAddress":{"times":[1.8640620000005583]},"getKeyValidationRequest":{"times":[2.9350869999980205]},"deliverNote":{"times":[5.847822000003362]},"deleteCapsule":{"times":[1.388000999999349]},"storeCapsule":{"times":[0.2404259999966598]},"getNotes":{"times":[3.1267510000034235]},"getAuthWitness":{"times":[0.2165949999980512]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09688299999834271]},"notifyEnqueuedPublicFunctionCall":{"times":[0.08345199999894248]}}},{"functionName":"private_kernel_init","time":78.74233999999706},{"functionName":"private_kernel_reset","time":203.73493499999313},{"functionName":"private_kernel_tail","time":85.05107300000236}],"unaccounted":141.83185499999672}} 17:08:37 [17:08:37.019] VERBOSE: p2p:tx_pool Adding tx 0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89 to pool {"eventName":"tx-added-to-pool","txHash":"0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 17:08:37 [17:08:37.028] INFO: node Received tx 0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89 {"txHash":"0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89"} 17:08:37 [17:08:37.028] INFO: pxe:service Sent transaction 0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89 17:08:37 [17:08:37.116] VERBOSE: sequencer Building block 7 for slot 8 {"slot":8,"blockNumber":7,"msgCount":0} 17:08:37 [17:08:37.131] VERBOSE: sequencer Processing pending txs {"slot":8,"slotStart":"2025-06-13T17:16:01.000Z","now":"2025-06-13T17:16:03.282Z"} 17:08:37 [17:08:37.198] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.200] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":49.19647199999599} 17:08:37 [17:08:37.228] VERBOSE: simulator:public-processor Processed tx 0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89 with 1 public calls in 85.20107600000483ms {"txHash":"0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89","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":85.20107600000483} 17:08:37 [17:08:37.232] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.09976361499999621s {"duration":0.09976361499999621,"rate":530524.0793449797,"totalPublicGas":{"daGas":512,"l2Gas":52927},"totalBlockGas":{"daGas":1536,"l2Gas":78783},"totalSizeInBytes":320} 17:08:37 [17:08:37.342] INFO: sequencer Built block 7 for slot 8 with 1 txs and 0 messages. 233763.814091214 mana/s {"blockHash":"0x1d202ea4525597dc0e609c8122d827d1ea5a986ee8766c6ca6c8ced92157bc9f","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":7,"slotNumber":8,"timestamp":1749834961,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x10bd2c35e0fa3682f9a6aba95d3840ea904a93323f6a911353dd27aec5d61a89"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":225.75184300000547,"publicProcessDuration":100.34308900000178,"rollupCircuitsDuration":211.81211800000165,"txCount":1,"blockNumber":7,"blockTimestamp":1749834961,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:37 [17:08:37.344] VERBOSE: sequencer Attesting committee is empty 17:08:37 [17:08:37.434] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.656] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.666] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x97f66885fa137d4defe0fbaf12eba528352d80aadb303de3bc16c00c5c539e73 17:08:37 [17:08:37.666] VERBOSE: sequencer-client Sent L1 transaction 0x97f66885fa137d4defe0fbaf12eba528352d80aadb303de3bc16c00c5c539e73 {"gasLimit":489789,"maxFeePerGas":"1.227700382","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:37 [17:08:37.675] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749834997] on http://127.0.0.1:8545 17:08:37 [17:08:37.677] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:37 [17:08:37.681] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:37 [17:08:37.681] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x97f66885fa137d4defe0fbaf12eba528352d80aadb303de3bc16c00c5c539e73","calldataSize":1444,"calldataGas":12328,"txCount":1,"blockNumber":7,"blockTimestamp":1749834961,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:37 [17:08:37.681] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:37 [17:08:37.684] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749834997 17:08:37 [17:08:37.684] WARN: foundation:test-date-provider Time set to 2025-06-13T17:16:37.000Z {"offset":479316,"timeMs":1749834997000} 17:08:37 [17:08:37.684] INFO: aztecjs:utils:watcher Slot 8 was filled, jumped to next slot 17:08:37 [17:08:37.686] INFO: blob-sink:server Received blob sidecar for block 0xf2c808667811940f6268cb93f257a8e1dfc6b2637e9420fccbac197a71854e12 17:08:37 [17:08:37.691] INFO: blob-sink:server Blob sidecar stored successfully for block 0xf2c808667811940f6268cb93f257a8e1dfc6b2637e9420fccbac197a71854e12 17:08:37 [17:08:37.859] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:37 [17:08:37.870] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000007"] on http://127.0.0.1:8545 17:08:37 [17:08:37.871] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7 17:08:37 [17:08:37.873] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 17:08:38 [17:08:38.172] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.193] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x1d202ea4525597dc0e609c8122d827d1ea5a986ee8766c6ca6c8ced92157bc9f","blockNumber":7,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":7,"slotNumber":8,"timestamp":1749834961,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","archiveNextLeafIndex":8} 17:08:38 [17:08:38.204] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 17:08:38 [17:08:38.297] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":8.905181999994966,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1749834961,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:38 [17:08:38.317] VERBOSE: p2p Synched to latest block 7 17:08:38 [17:08:38.378] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.583] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.735] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","blockNumber":8,"slot":9} 17:08:38 [17:08:38.786] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:38 [17:08:38.990] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:39 [17:08:39.047] VERBOSE: pxe:service Updated pxe last block to 7 {"blockHash":{},"archive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","header":{"contentCommitment":{"blobsHash":"0x00d67e5103ec3366dea1cc748c4a3bf0bb88f45da70858cf2e21393ec994afc4","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":7,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":8,"timestamp":1749834961,"version":2254972989},"lastArchive":"0x0149654888ad0821df9fa16495f2867d1fb93f43673addb8ed52ede01a31591b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x07cb15bc1a4dd2733b56a609596f6621e22f1118fd75c4fcb5b60676d8a9c47c","publicDataTree":"0x2a0fba3674e46b72c7275c94fd46553a0d1c2679d66cf4f125f1af36ae3a41ee"},"totalFees":3994298100,"totalManaUsed":78783}} 17:08:39 [17:08:39.140] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:39 [17:08:39.153] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:39 [17:08:39.153] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:39 [17:08:39.199] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:39 [17:08:39.234] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:39 [17:08:39.265] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","blockNumber":8,"slot":9} 17:08:39 [17:08:39.274] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:39 [17:08:39.283] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:39 [17:08:39.284] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:39 [17:08:39.290] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:39 [17:08:39.291] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:39 [17:08:39.295] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:39 [17:08:39.298] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:39 [17:08:39.306] VERBOSE: simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed 17:08:39 [17:08:39.339] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:39 [17:08:39.344] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:39 [17:08:39.347] INFO: e2e:e2e_authwit Running test: e2e_authwit_tests Public arbitrary data failure case cancel before usage 17:08:39 [17:08:39.412] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:39 [17:08:39.438] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:39 [17:08:39.455] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:39 [17:08:39.455] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:39 [17:08:39.519] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:39 [17:08:39.526] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:39 [17:08:39.535] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:39 [17:08:39.536] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:39 [17:08:39.543] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:39 [17:08:39.544] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:39 [17:08:39.547] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:39 [17:08:39.548] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:39 [17:08:39.558] VERBOSE: simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed 17:08:39 [17:08:39.598] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:39 [17:08:39.603] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:39 [17:08:39.675] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:39 [17:08:39.701] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:39 [17:08:39.743] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:39 [17:08:39.743] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:39 [17:08:39.817] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","blockNumber":8,"slot":9} 17:08:39 [17:08:39.845] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:39 [17:08:39.884] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:39 [17:08:39.902] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:39 [17:08:39.902] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:39 [17:08:39.915] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:39 [17:08:39.916] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:39 [17:08:39.919] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:39 [17:08:39.921] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:39 [17:08:39.939] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer 17:08:39 [17:08:39.957] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.218] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.559] INFO: pxe:service Proving completed in 943.8864850000027ms {"timings":{"total":943.8864850000027,"sync":3.5673600000009174,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":307.13065300000017,"oracles":{"debugLog":{"times":[0.7321569999985513,3.6611620000039693,0.4168089999948279,0.3371670000051381,0.6329439999972237,0.3973390000028303,0.3509879999983241,0.8562000000019907]},"fetchTaggedLogs":{"times":[133.52201799999602]},"loadCapsule":{"times":[0.18918399999529356,5.328620000000228,0.6199339999948279,0.2366660000043339,0.23210500000277534,0.22582500000135042]},"getSharedSecret":{"times":[5.5065449999965494]},"aes128Decrypt":{"times":[0.24993600000016158,0.6627840000001015]},"getPublicKeysAndPartialAddress":{"times":[2.0159960000019055]},"getKeyValidationRequest":{"times":[3.8267160000032163]},"deliverNote":{"times":[3.5713409999953]},"deleteCapsule":{"times":[0.2790160000004107]},"storeCapsule":{"times":[0.278625999999349]},"getNotes":{"times":[1.704967999998189]},"getAuthWitness":{"times":[0.29892600000312086]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0815020000009099]},"notifyEnqueuedPublicFunctionCall":{"times":[0.09205199999996694]}}},{"functionName":"private_kernel_init","time":102.20779000000039},{"functionName":"private_kernel_reset","time":244.23760000000038},{"functionName":"private_kernel_tail","time":95.90381799999886}],"unaccounted":190.839264000002}} 17:08:40 [17:08:40.587] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.681] VERBOSE: sequencer Not enough txs to build block 8 at slot 9 (got 0 txs, need 1) {"chainTipArchive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","blockNumber":8,"slot":9} 17:08:40 [17:08:40.692] VERBOSE: p2p:tx_pool Adding tx 0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78 to pool {"eventName":"tx-added-to-pool","txHash":"0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 17:08:40 [17:08:40.704] INFO: node Received tx 0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78 {"txHash":"0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78"} 17:08:40 [17:08:40.704] INFO: pxe:service Sent transaction 0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78 17:08:40 [17:08:40.791] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:40 [17:08:40.993] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.205] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.210] VERBOSE: sequencer Building block 8 for slot 9 {"slot":9,"blockNumber":8,"msgCount":0} 17:08:41 [17:08:41.228] VERBOSE: sequencer Processing pending txs {"slot":9,"slotStart":"2025-06-13T17:16:37.000Z","now":"2025-06-13T17:16:40.544Z"} 17:08:41 [17:08:41.296] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":25.48124600000301} 17:08:41 [17:08:41.326] VERBOSE: simulator:public-processor Processed tx 0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78 with 1 public calls in 78.1144359999962ms {"txHash":"0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78","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":78.1144359999962} 17:08:41 [17:08:41.328] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.09885574400000041s {"duration":0.09885574400000041,"rate":202760.0945474642,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 17:08:41 [17:08:41.471] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.484] INFO: sequencer Built block 8 for slot 9 with 1 txs and 0 messages. 73108.87849882603 mana/s {"blockHash":"0x0613b56461818c9efd552fb3fd8bd1fe7f065465f2854bc82f42148b6151f8cb","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":8,"slotNumber":9,"timestamp":1749834997,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"txHashes":["0x0cbff2d276b38f18de0065eca067f723545ff6213ac5928a0e24e13001bd6a78"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":273.53436299999885,"publicProcessDuration":99.27490399999806,"rollupCircuitsDuration":258.89331200000015,"txCount":1,"blockNumber":8,"blockTimestamp":1749834997,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:41 [17:08:41.486] VERBOSE: sequencer Attesting committee is empty 17:08:41 [17:08:41.680] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.814] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x8bad49d2b2b02f7b262a4222736f48595d6000e5987ca364129d5af20c12605f 17:08:41 [17:08:41.814] VERBOSE: sequencer-client Sent L1 transaction 0x8bad49d2b2b02f7b262a4222736f48595d6000e5987ca364129d5af20c12605f {"gasLimit":470220,"maxFeePerGas":"1.22127985","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:41 [17:08:41.830] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749835033] on http://127.0.0.1:8545 17:08:41 [17:08:41.832] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:41 [17:08:41.833] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x8bad49d2b2b02f7b262a4222736f48595d6000e5987ca364129d5af20c12605f","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":8,"blockTimestamp":1749834997,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:41 [17:08:41.833] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:41 [17:08:41.835] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:41 [17:08:41.839] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749835033 17:08:41 [17:08:41.840] WARN: foundation:test-date-provider Time set to 2025-06-13T17:17:13.000Z {"offset":511161,"timeMs":1749835033000} 17:08:41 [17:08:41.840] INFO: aztecjs:utils:watcher Slot 9 was filled, jumped to next slot 17:08:41 [17:08:41.843] INFO: blob-sink:server Received blob sidecar for block 0x42200659368445d07f10f298b385a92ca0746075eb2cb027fae338084d5b9db4 17:08:41 [17:08:41.849] INFO: blob-sink:server Blob sidecar stored successfully for block 0x42200659368445d07f10f298b385a92ca0746075eb2cb027fae338084d5b9db4 17:08:41 [17:08:41.883] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:41 [17:08:41.896] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000008"] on http://127.0.0.1:8545 17:08:41 [17:08:41.898] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 8 17:08:41 [17:08:41.903] INFO: aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8. 17:08:42 [17:08:42.085] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.302] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.611] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.630] INFO: archiver Downloaded L2 block 8 {"blockHash":"0x0613b56461818c9efd552fb3fd8bd1fe7f065465f2854bc82f42148b6151f8cb","blockNumber":8,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":8,"slotNumber":9,"timestamp":1749834997,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700},"archiveRoot":"0x2f0dd45016d38d1518f6944c469d7340a29752de91be6bb52d7f4de7e6ac3d6e","archiveNextLeafIndex":9} 17:08:42 [17:08:42.633] INFO: archiver Updated proven chain to block 8 {"provenBlockNumber":8} 17:08:42 [17:08:42.736] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":8.307838000000629,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1749834997,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:42 [17:08:42.747] VERBOSE: p2p Synched to latest block 8 17:08:42 [17:08:42.819] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:42 [17:08:42.834] VERBOSE: pxe:service Updated pxe last block to 8 {"blockHash":{},"archive":"0x2f0dd45016d38d1518f6944c469d7340a29752de91be6bb52d7f4de7e6ac3d6e","header":{"contentCommitment":{"blobsHash":"0x0095e1518dfafcc1e1d046b0952d2f833cb18bbad5cb544a688e6bbdf1d22ece","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":8,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":50700,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":9,"timestamp":1749834997,"version":2254972989},"lastArchive":"0x20caa0cc37a12263e8627b66486ecdf7d88bde75b523f3f88be29fc2a0d52ce2","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x1e70d768909f9e32d70476e725c07b73b017a84c5378b2b10c8a11684e5429fd","publicDataTree":"0x2d1130d82dc7b33310598e9fd34f3b67e0b75831560295e4ead2330a47fdd975"},"totalFees":2327130000,"totalManaUsed":45900}} 17:08:42 [17:08:42.955] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:42 [17:08:42.971] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:42 [17:08:42.971] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:43 [17:08:43.020] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x2f0dd45016d38d1518f6944c469d7340a29752de91be6bb52d7f4de7e6ac3d6e","blockNumber":9,"slot":10} 17:08:43 [17:08:43.024] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:43 [17:08:43.066] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:43 [17:08:43.074] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:43 [17:08:43.089] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:43 [17:08:43.090] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:43 [17:08:43.096] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:43 [17:08:43.096] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:43 [17:08:43.099] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:43 [17:08:43.101] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:43 [17:08:43.111] VERBOSE: simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed 17:08:43 [17:08:43.151] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:43 [17:08:43.161] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:43 [17:08:43.233] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:43 [17:08:43.263] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:43 [17:08:43.310] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:43 [17:08:43.310] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:43 [17:08:43.391] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:43 [17:08:43.398] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:43 [17:08:43.413] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:43 [17:08:43.414] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:43 [17:08:43.422] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:43 [17:08:43.423] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:43 [17:08:43.426] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:43 [17:08:43.428] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:43 [17:08:43.441] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c as fee payer 17:08:43 [17:08:43.542] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:44 [17:08:44.011] INFO: pxe:service Proving completed in 839.3453420000005ms {"timings":{"total":839.3453420000005,"sync":4.449619999999413,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":239.85967200000596,"oracles":{"debugLog":{"times":[0.666135999999824,0.6373149999999441,0.6234340000009979,0.6093439999967813,0.5426930000030552,0.49331099999835715,0.36799799999425886,0.5416820000027656]},"fetchTaggedLogs":{"times":[86.00854500000423]},"loadCapsule":{"times":[0.30139699999563163,0.16017399999691406,0.4825510000009672,0.20374400000582682,0.25856600000406615,0.2467160000014701]},"getSharedSecret":{"times":[4.571812999995018]},"aes128Decrypt":{"times":[0.2919670000046608,1.13639599999442]},"getPublicKeysAndPartialAddress":{"times":[2.01942599999893]},"getKeyValidationRequest":{"times":[1.9325240000034682]},"deliverNote":{"times":[3.127270999997563]},"deleteCapsule":{"times":[0.4111689999990631]},"storeCapsule":{"times":[0.35610799999994924]},"getNotes":{"times":[1.792951000003086]},"getAuthWitness":{"times":[0.188984000000346]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07294199999887496]},"notifyEnqueuedPublicFunctionCall":{"times":[0.11653300000034506]}}},{"functionName":"private_kernel_init","time":121.19917900000291},{"functionName":"private_kernel_reset","time":218.36778600000252},{"functionName":"private_kernel_tail","time":109.296190999994}],"unaccounted":146.17289399999572}} 17:08:44 [17:08:44.040] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:44 [17:08:44.046] VERBOSE: sequencer Not enough txs to build block 9 at slot 10 (got 0 txs, need 1) {"chainTipArchive":"0x2f0dd45016d38d1518f6944c469d7340a29752de91be6bb52d7f4de7e6ac3d6e","blockNumber":9,"slot":10} 17:08:44 [17:08:44.065] VERBOSE: p2p:tx_pool Adding tx 0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9 to pool {"eventName":"tx-added-to-pool","txHash":"0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9","noteHashCount":0,"nullifierCount":1,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":226345,"feePaymentMethod":"fee_juice"} 17:08:44 [17:08:44.074] INFO: node Received tx 0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9 {"txHash":"0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9"} 17:08:44 [17:08:44.074] INFO: pxe:service Sent transaction 0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9 17:08:44 [17:08:44.253] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:44 [17:08:44.461] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:44 [17:08:44.579] VERBOSE: sequencer Building block 9 for slot 10 {"slot":10,"blockNumber":9,"msgCount":0} 17:08:44 [17:08:44.591] VERBOSE: sequencer Processing pending txs {"slot":10,"slotStart":"2025-06-13T17:17:13.000Z","now":"2025-06-13T17:17:15.752Z"} 17:08:44 [17:08:44.627] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0xb839de91 completed successfully. {"eventName":"avm-simulation","appCircuitName":"0xb839de91","duration":12.731937999997172} 17:08:44 [17:08:44.649] VERBOSE: simulator:public-processor Processed tx 0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9 with 1 public calls in 42.96564099999523ms {"txHash":"0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9","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":42.96564099999523} 17:08:44 [17:08:44.650] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05862859600000229s {"duration":0.05862859600000229,"rate":341880.948334482,"totalPublicGas":{"daGas":512,"l2Gas":20044},"totalBlockGas":{"daGas":1536,"l2Gas":45900},"totalSizeInBytes":320} 17:08:44 [17:08:44.674] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:44 [17:08:44.781] INFO: sequencer Built block 9 for slot 10 with 1 txs and 0 messages. 98443.89880431049 mana/s {"blockHash":"0x08f552cb2880b42d8567a1ad726a0bf2bbdc7031aaa448ab3f91b0baa323ef32","globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":9,"slotNumber":10,"timestamp":1749835033,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHashes":["0x23117d218528840e87a6456862983e5fb922a1235503dd437a4ff9b3835d6fd9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":203.03862899999513,"publicProcessDuration":59.09041499999876,"rollupCircuitsDuration":190.8262229999964,"txCount":1,"blockNumber":9,"blockTimestamp":1749835033,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:44 [17:08:44.799] VERBOSE: sequencer Attesting committee is empty 17:08:44 [17:08:44.882] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:45 [17:08:45.098] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:45 [17:08:45.105] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xaa288634ddc234298f5717fdc00a016907b9992f3aac0261bdf429fd599f9261 17:08:45 [17:08:45.105] VERBOSE: sequencer-client Sent L1 transaction 0xaa288634ddc234298f5717fdc00a016907b9992f3aac0261bdf429fd599f9261 {"gasLimit":470260,"maxFeePerGas":"1.216344976","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:08:45 [17:08:45.118] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000009"] on http://127.0.0.1:8545 17:08:45 [17:08:45.123] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749835069] on http://127.0.0.1:8545 17:08:45 [17:08:45.125] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 9 17:08:45 [17:08:45.129] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:08:45 [17:08:45.132] INFO: aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9. 17:08:45 [17:08:45.136] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:08:45 [17:08:45.137] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xaa288634ddc234298f5717fdc00a016907b9992f3aac0261bdf429fd599f9261","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":9,"blockTimestamp":1749835033,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:45 [17:08:45.138] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:08:45 [17:08:45.144] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749835069 17:08:45 [17:08:45.144] WARN: foundation:test-date-provider Time set to 2025-06-13T17:17:49.000Z {"offset":543856,"timeMs":1749835069000} 17:08:45 [17:08:45.145] INFO: aztecjs:utils:watcher Slot 10 was filled, jumped to next slot 17:08:45 [17:08:45.147] INFO: blob-sink:server Received blob sidecar for block 0x525ac5f1a4ccff4caf726e6123bad783b4beda1b8b1064cbd0fd1b10a3294ee1 17:08:45 [17:08:45.157] INFO: blob-sink:server Blob sidecar stored successfully for block 0x525ac5f1a4ccff4caf726e6123bad783b4beda1b8b1064cbd0fd1b10a3294ee1 17:08:45 [17:08:45.301] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:45 [17:08:45.505] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:45 [17:08:45.784] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:45 [17:08:45.811] INFO: archiver Downloaded L2 block 9 {"blockHash":"0x08f552cb2880b42d8567a1ad726a0bf2bbdc7031aaa448ab3f91b0baa323ef32","blockNumber":9,"txCount":1,"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":9,"slotNumber":10,"timestamp":1749835033,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"archiveRoot":"0x1334d6cf8f7140464667807e73fc3428a951101ee8e63dd6cdb6f290e7c4bcae","archiveNextLeafIndex":10} 17:08:45 [17:08:45.815] INFO: archiver Updated proven chain to block 9 {"provenBlockNumber":9} 17:08:45 [17:08:45.920] INFO: world_state World state updated with L2 block 9 {"eventName":"l2-block-handled","duration":10.438935999998648,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1749835033,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:08:45 [17:08:45.932] VERBOSE: p2p Synched to latest block 9 17:08:46 [17:08:45.999] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:46 [17:08:46.115] VERBOSE: pxe:service Updated pxe last block to 9 {"blockHash":{},"archive":"0x1334d6cf8f7140464667807e73fc3428a951101ee8e63dd6cdb6f290e7c4bcae","header":{"contentCommitment":{"blobsHash":"0x003ddf6b3bd1f78b0f56ff133f4212434155d85075cd3a09b1019d05c8ce7c56","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":9,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":10,"timestamp":1749835033,"version":2254972989},"lastArchive":"0x2f0dd45016d38d1518f6944c469d7340a29752de91be6bb52d7f4de7e6ac3d6e","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1aa47af463139f602e903957841a32ded8bf982552f6c9112c7633a711d20188","nullifierTree":"0x246789739844737f77be1bc0c18fc048cefa06d4f1e3b23ee66d594ab82fc3fb","publicDataTree":"0x09d081ef5a04ad28760f44b97bb0d51c77dfaa56657c769d0a76c2b55d470163"},"totalFees":276318000,"totalManaUsed":45900}} 17:08:46 [17:08:46.209] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:46 [17:08:46.258] VERBOSE: simulator Executing utility function lookup_validity {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","selector":"0xd191fb1a"} 17:08:46 [17:08:46.275] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:08:46 [17:08:46.276] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:46 [17:08:46.289] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x1334d6cf8f7140464667807e73fc3428a951101ee8e63dd6cdb6f290e7c4bcae","blockNumber":10,"slot":11} 17:08:46 [17:08:46.374] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c"} 17:08:46 [17:08:46.382] VERBOSE: simulator:client_view_context:debug_log Processing log with tag 0x0b8c14948e8ea3088d158b4b5d7d650cf747c87da7b795d2a154de1d7a56974c 17:08:46 [17:08:46.394] VERBOSE: simulator:client_view_context:debug_log Processing private note msg 17:08:46 [17:08:46.396] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:46 [17:08:46.410] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:46 [17:08:46.410] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:46 [17:08:46.417] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0cb17177c9c332116b0771049d815a00b79db49b129b72f3f319a2147cef258d","nullifier":"0x1a9046eeefa27e4cf71374831031222c4f63ebe35ca97012dc38a1f7b727a18e"} 17:08:46 [17:08:46.417] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:46 [17:08:46.420] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:46 [17:08:46.435] VERBOSE: simulator Utility simulation for 0x0f49ce4096fee1e1885deda434f218798559742858066677fa8cd67ec205b94c.0xd191fb1a completed 17:08:46 [17:08:46.469] VERBOSE: simulator Executing utility function utility_is_consumable {"contract":"0x0000000000000000000000000000000000000000000000000000000000000001","selector":"0x75f967ce"} 17:08:46 [17:08:46.474] VERBOSE: simulator Utility simulation for 0x0000000000000000000000000000000000000000000000000000000000000001.0x75f967ce completed 17:08:46 [17:08:46.520] INFO: pxe:service Simulating transaction execution request to 0x27e740b2 at 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 {"origin":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","functionSelector":"0x27e740b2","simulatePublic":true,"chainId":"0x0000000000000000000000000000000000000000000000000000000000007a69","version":"0x000000000000000000000000000000000000000000000000000000008668283d","authWitnesses":["0x1f608cf6419f331ae78905db2c3dbb6c52c75644232b8ed0597e31ef9078108d"]} 17:08:46 [17:08:46.611] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:46 [17:08:46.661] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:08:46 [17:08:46.661] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:46 [17:08:46.662] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:46 [17:08:46.749] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4"} 17:08:46 [17:08:46.760] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x07d6874994c88a33d1198952118e8a8114a2a1a4f22462bfc6cd707ff7f5764e 17:08:46 [17:08:46.773] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:08:46 [17:08:46.775] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:08:46 [17:08:46.783] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:08:46 [17:08:46.783] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:08:46 [17:08:46.786] VERBOSE: pxe:service Added note {"index":64,"contract":"0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2c7fdeb2b873adefd1d9a0e405c18f95692487433d6ad86f31bdc595c495c09f","nullifier":"0x0e93d8ac112c20de4b93ac7972b232103a7a34c1f8a18f5f6d98732ef6c87070"} 17:08:46 [17:08:46.788] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:08:46 [17:08:46.815] VERBOSE: simulator:client_execution_context:debug_log Setting 0x24e4f823e02b58bbe2a981b3bd0ad41962a50f358b79a748780771e824b634a4 as fee payer 17:08:46 [17:08:46.868] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:46 [17:08:46.937] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x1334d6cf8f7140464667807e73fc3428a951101ee8e63dd6cdb6f290e7c4bcae","blockNumber":10,"slot":11} 17:08:47 [17:08:47.392] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:08:47 [17:08:47.411] VERBOSE: node Simulating public calls for tx 0x23c4f5415721f328c7f2374784e0ebb5be4448cbd73f0ebbff2784bba78d8b29 {"globalVariables":{"chainId":31337,"version":2254972989,"blockNumber":10,"slotNumber":11,"timestamp":1749835069,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":6020},"txHash":"0x23c4f5415721f328c7f2374784e0ebb5be4448cbd73f0ebbff2784bba78d8b29","blockNumber":10} 17:08:47 [17:08:47.468] VERBOSE: sequencer Not enough txs to build block 10 at slot 11 (got 0 txs, need 1) {"chainTipArchive":"0x1334d6cf8f7140464667807e73fc3428a951101ee8e63dd6cdb6f290e7c4bcae","blockNumber":10,"slot":11} 17:08:47 [17:08:47.470] VERBOSE: simulator:public_tx_simulator Simulation of enqueued public call 0x2716b166 reverted with reason Assertion failed: . {"eventName":"avm-simulation","appCircuitName":"0x2716b166","duration":39.23046000000613} 17:08:47 [17:08:47.471] WARN: simulator:public_tx_context APP_LOGIC phase reverted! 0x0000000000000000000000000000000000000000000000000000000000000001:0x2716b166 failed with reason: Assertion failed: 17:08:47 [17:08:47.497] VERBOSE: simulator:public-processor Processed tx 0x23c4f5415721f328c7f2374784e0ebb5be4448cbd73f0ebbff2784bba78d8b29 with 1 public calls in 74.0139909999998ms {"txHash":"0x23c4f5415721f328c7f2374784e0ebb5be4448cbd73f0ebbff2784bba78d8b29","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":74.0139909999998} 17:08:47 [17:08:47.500] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.08377955199999997s {"duration":0.08377955199999997,"rate":423074.59462184773,"totalPublicGas":{"daGas":0,"l2Gas":35445},"totalBlockGas":{"daGas":1024,"l2Gas":61301},"totalSizeInBytes":256} 17:08:47 PASS src/e2e_authwit.test.ts 17:08:47 e2e_authwit_tests 17:08:47 Private 17:08:47 arbitrary data 17:08:47 happy path (7572 ms) 17:08:47 failure case 17:08:47 invalid chain id (828 ms) 17:08:47 invalid version (1194 ms) 17:08:47 Public 17:08:47 arbitrary data 17:08:47 happy path (6806 ms) 17:08:47 failure case 17:08:47 cancel before usage (8186 ms) 17:08:47 17:08:47 Test Suites: 1 passed, 1 total 17:08:47 Tests: 5 passed, 5 total 17:08:47 Snapshots: 0 total 17:08:47 Time: 51.761 s 17:08:47 Ran all test suites matching /src\/e2e_authwit.test.ts/i. 17:08:47 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?