Parent Log: http://ci.aztec-labs.com/83b4d5049d814dc9 Command: 97e7ef9a556fd7e6:ISOLATE=1:NAME=e2e_offchain_note_delivery yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_offchain_note_delivery.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/86553a66d6e2c437b435016db7bedec6bd794ed7 Env: REF_NAME=gh-readonly-queue/master/pr-14912-015cb0cadef6a41094c3649f32a735392e1b9693 CURRENT_VERSION=0.87.9 CI_FULL=1 Date: Wed Jun 18 15:16:53 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14912_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_e9737a394094636f_master 15:16:53 +++ id -u 15:16:53 +++ id -g 15:16:53 ++ docker run -d --name e2e_offchain_note_delivery --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_offchain_note_delivery.test.ts'\''' 15:16:53 + cid=0648104fc7a9fd82cdc6c1b8cb772a89f21e31883e5db5b49776e774f3e4548c 15:16:53 + set +x 15:16:54 {"level":25,"time":1750259814214,"pid":12,"hostname":"0648104fc7a9","module":"logger","msg":"Logger initialized with level verbose"} 15:17:00 [15:17:00.107] INFO: e2e:e2e_offchain_note_delivery Running test: e2e_offchain_note_delivery can create a note that is not broadcast, deliver it offchain and read it 15:17:00 [15:17:00.214] INFO: e2e:e2e_offchain_note_delivery Logging metrics to log/e2e_offchain_note_delivery.jsonl 15:17:00 [15:17:00.459] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-99X1eW/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 15:17:00 [15:17:00.498] INFO: e2e:e2e_offchain_note_delivery Calling anvil_setBlockTimestampInterval with params: [12] 15:17:00 [15:17:00.521] WARN: e2e:e2e_offchain_note_delivery Set block interval to 12 15:17:00 [15:17:00.522] VERBOSE: e2e:e2e_offchain_note_delivery Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:17:00 [15:17:00.570] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:17:00 [15:17:00.580] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 15:17:00 [15:17:00.594] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:17:00 [15:17:00.599] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 15:17:00 [15:17:00.612] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 15:17:00 [15:17:00.619] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 15:17:00 [15:17:00.632] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 15:17:00 [15:17:00.637] VERBOSE: e2e:e2e_offchain_note_delivery Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 15:17:00 [15:17:00.669] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 15:17:00 [15:17:00.675] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 15:17:00 [15:17:00.687] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 15:17:00 [15:17:00.690] VERBOSE: e2e:e2e_offchain_note_delivery Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 15:17:00 [15:17:00.691] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for deployments to complete 15:17:00 [15:17:00.691] INFO: e2e:e2e_offchain_note_delivery Waiting for 6 transactions to be mined... 15:17:00 [15:17:00.709] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 15:17:00 [15:17:00.722] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 15:17:00 [15:17:00.722] VERBOSE: e2e:e2e_offchain_note_delivery Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 15:17:00 [15:17:00.732] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 15:17:00 [15:17:00.754] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 15:17:00 [15:17:00.758] VERBOSE: e2e:e2e_offchain_note_delivery Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 15:17:00 [15:17:00.775] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 15:17:00 [15:17:00.776] VERBOSE: e2e:e2e_offchain_note_delivery Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 15:17:00 [15:17:00.792] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 15:17:00 [15:17:00.797] VERBOSE: e2e:e2e_offchain_note_delivery Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 15:17:00 [15:17:00.809] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 15:17:00 [15:17:00.809] VERBOSE: e2e:e2e_offchain_note_delivery Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 15:17:00 [15:17:00.809] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for deployments to complete 15:17:00 [15:17:00.810] INFO: e2e:e2e_offchain_note_delivery Waiting for 8 transactions to be mined... 15:17:00 [15:17:00.830] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 15:17:00 [15:17:00.846] VERBOSE: e2e:e2e_offchain_note_delivery Deployed shared contracts 15:17:00 [15:17:00.868] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 15:17:00 [15:17:00.869] VERBOSE: e2e:e2e_offchain_note_delivery Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 15:17:00 [15:17:00.872] VERBOSE: e2e:e2e_offchain_note_delivery Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 15:17:00 [15:17:00.888] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 15:17:00 [15:17:00.912] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 15:17:00 [15:17:00.916] VERBOSE: e2e:e2e_offchain_note_delivery Awaiting for linked libraries to be deployed 15:17:00 [15:17:00.954] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xae96123ed0ade4ae7a83aacae4284a35c42918094ee4a83e491c3d9f8422b283 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 15:17:00 [15:17:00.961] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 15:17:00 [15:17:00.962] INFO: e2e:e2e_offchain_note_delivery Waiting for 9 transactions to be mined... 15:17:00 [15:17:00.993] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 15:17:00 [15:17:00.993] VERBOSE: e2e:e2e_offchain_note_delivery All core contracts have been deployed 15:17:01 [15:17:01.012] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 15:17:01 [15:17:01.012] VERBOSE: e2e:e2e_offchain_note_delivery Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 15:17:01 [15:17:01.025] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 15:17:01 [15:17:01.031] VERBOSE: e2e:e2e_offchain_note_delivery Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 15:17:01 [15:17:01.073] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 15:17:01 [15:17:01.074] VERBOSE: e2e:e2e_offchain_note_delivery Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 15:17:01 [15:17:01.074] INFO: e2e:e2e_offchain_note_delivery Waiting for 10 transactions to be mined... 15:17:01 [15:17:01.101] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 15:17:01 [15:17:01.108] VERBOSE: e2e:e2e_offchain_note_delivery Rollup deployed 15:17:01 [15:17:01.108] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for rollup and slash factory to be deployed 15:17:01 [15:17:01.108] INFO: e2e:e2e_offchain_note_delivery Waiting for 10 transactions to be mined... 15:17:01 [15:17:01.139] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 15:17:01 [15:17:01.140] VERBOSE: e2e:e2e_offchain_note_delivery All transactions for L1 deployment have been mined 15:17:01 [15:17:01.177] INFO: e2e:e2e_offchain_note_delivery 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"} 15:17:01 [15:17:01.182] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 15:17:01 [15:17:01.186] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:01 [15:17:01.187] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 15:17:01 [15:17:01.188] INFO: telemetry:client Using NoopTelemetryClient 15:17:01 [15:17:01.195] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/530a9ea846cd7865/blob-sink with map size 134217728 KB (LMDB v2) 15:17:01 [15:17:01.196] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 15:17:01 [15:17:01.196] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 15:17:01 [15:17:01.199] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:01 [15:17:01.201] INFO: aztecjs:utils:watcher New L1 time: 1750260060 15:17:01 [15:17:01.202] WARN: foundation:test-date-provider Time set to 2025-06-18T15:21:00.000Z {"offset":238799,"timeMs":1750260060000} 15:17:01 [15:17:01.203] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 15:17:01 [15:17:01.211] INFO: blob-sink:server Server is running on http://localhost:33545 15:17:01 [15:17:01.212] VERBOSE: e2e:e2e_offchain_note_delivery Creating and synching an aztec node... 15:17:01 [15:17:01.213] VERBOSE: e2e:e2e_offchain_note_delivery Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/802e1bda/acvm 15:17:01 [15:17:01.214] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:33545"} 15:17:01 [15:17:01.240] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 15:17:01 [15:17:01.241] INFO: archiver:lmdb Creating archiver data store at directory /tmp/530a9ea846cd7865/archiver with map size 134217728 KB (LMDB v2) 15:17:01 [15:17:01.248] INFO: archiver:lmdb Starting data store with maxReaders 16 15:17:01 [15:17:01.479] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:01 [15:17:01.612] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:33545"} 15:17:01 [15:17:01.631] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:33545"} 15:17:01 [15:17:01.632] WARN: node:blob-sink:client No L1 consensus host urls configured 15:17:01 [15:17:01.632] WARN: node:blob-sink:client No archive client configured 15:17:01 [15:17:01.636] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x0e471330a4eafee2292180f5ac8205b31e10365e68338f45e7625025e800c617 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xb307cdaee61569ca6ba29c5da48fb9bdf20e7e318e60b66f49a3d3d326e51f88","l1BlockNumber":16}} 15:17:01 [15:17:01.658] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:17:01 [15:17:01.671] INFO: world-state:database Creating world state data store at directory /tmp/530a9ea846cd7865/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:17:01 [15:17:01.704] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:01 [15:17:01.712] INFO: world_state Created world state synchroniser with block history of 64 15:17:01 [15:17:01.713] WARN: node Aztec node is accepting fake proofs 15:17:01 [15:17:01.727] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/530a9ea846cd7865/p2p with map size 134217728 KB (LMDB v2) 15:17:01 [15:17:01.733] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 15:17:01 [15:17:01.735] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/530a9ea846cd7865/p2p-archive with map size 134217728 KB (LMDB v2) 15:17:01 [15:17:01.737] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 15:17:01 [15:17:01.739] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/530a9ea846cd7865/p2p-peers with map size 134217728 KB (LMDB v2) 15:17:01 [15:17:01.741] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 15:17:01 [15:17:01.743] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:17:01 [15:17:01.744] VERBOSE: p2p P2P is disabled. Using dummy P2P service 15:17:01 [15:17:01.747] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:17:01 [15:17:01.748] INFO: world_state Started world state synchronizer from block 1 15:17:01 [15:17:01.751] VERBOSE: world-state:block_stream Starting sync from block number 0 15:17:01 [15:17:01.753] INFO: p2p Starting p2p client from block 0 with empty mempools 15:17:01 [15:17:01.753] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 15:17:01 [15:17:01.755] INFO: slasher Slasher client initialized 15:17:01 [15:17:01.756] INFO: slasher Starting Slasher client... 15:17:01 [15:17:01.801] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:17:01 [15:17:01.801] VERBOSE: node All Aztec Node subsystems synced 15:17:01 [15:17:01.810] INFO: sequencer-client Deploying forwarder contract 15:17:01 [15:17:01.817] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 15:17:01 [15:17:01.830] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 15:17:01 [15:17:01.830] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 15:17:01 [15:17:01.835] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:17:01 [15:17:01.851] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:17:01 [15:17:01.851] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 15:17:01 [15:17:01.852] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/802e1bda/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 15:17:02 [15:17:02.128] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 15:17:02 [15:17:02.131] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:17:02 [15:17:02.132] INFO: node Aztec Node version: 0.87.9 15:17:02 [15:17:02.132] 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"} 15:17:02 [15:17:02.134] VERBOSE: e2e:e2e_offchain_note_delivery Creating a pxe... 15:17:02 [15:17:02.137] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:02 [15:17:02.145] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/bcb7b72acf9992ac/pxe_data with map size 134217728 KB (LMDB v2) 15:17:02 [15:17:02.156] INFO: pxe:data:lmdb Starting data store with maxReaders 16 15:17:02 [15:17:02.158] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27ff966bebe20526c9ccaac0c3f51a3a750bef7a472258b6c605bedceca85bc8","blockNumber":1,"slot":2} 15:17:02 [15:17:02.386] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:02 [15:17:02.499] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 15:17:02 [15:17:02.500] INFO: pxe:service Started PXE connected to chain 31337 version 2616850191 15:17:02 [15:17:02.550] INFO: pxe:service Registered account 0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a 15:17:02 [15:17:02.612] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:02 [15:17:02.616] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 15:17:02 [15:17:02.621] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a 15:17:02 [15:17:02.786] INFO: pxe:service Added contract SchnorrAccount at 0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:17:02 [15:17:02.800] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27ff966bebe20526c9ccaac0c3f51a3a750bef7a472258b6c605bedceca85bc8","blockNumber":1,"slot":2} 15:17:02 [15:17:02.844] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:02 [15:17:02.854] VERBOSE: pxe:block_stream Starting sync from block number 0 15:17:02 [15:17:02.889] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 15:17:03 [15:17:03.002] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:17:03 [15:17:03.765] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 15:17:03 [15:17:03.875] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:17:03 [15:17:03.944] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:03 [15:17:03.996] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27ff966bebe20526c9ccaac0c3f51a3a750bef7a472258b6c605bedceca85bc8","blockNumber":1,"slot":2} 15:17:04 [15:17:04.101] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:04 [15:17:04.153] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:04 [15:17:04.155] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:04 [15:17:04.156] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:04 [15:17:04.227] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:04 [15:17:04.231] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:04 [15:17:04.359] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:04 [15:17:04.493] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:04 [15:17:04.558] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:04 [15:17:04.559] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:04 [15:17:04.568] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:04 [15:17:04.625] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27ff966bebe20526c9ccaac0c3f51a3a750bef7a472258b6c605bedceca85bc8","blockNumber":1,"slot":2} 15:17:04 [15:17:04.643] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:04 [15:17:04.648] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:04 [15:17:04.671] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a as fee payer 15:17:04 [15:17:04.894] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:05 [15:17:05.172] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:05 [15:17:05.396] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27ff966bebe20526c9ccaac0c3f51a3a750bef7a472258b6c605bedceca85bc8","blockNumber":1,"slot":2} 15:17:05 [15:17:05.533] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:06 [15:17:06.131] INFO: pxe:service Proving completed in 3287.9370440000002ms {"timings":{"total":3287.9370440000002,"sync":11.482888000000457,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":201.22303399999873,"oracles":{"callPrivateFunction":{"times":[994.126843,420.0142329999999,333.1831000000002]}}},{"functionName":"private_kernel_init","time":127.53405399999974},{"functionName":"ContractClassRegisterer:register","time":971.9442179999987,"oracles":{"loadCapsule":{"times":[54.30878499999926]},"notifyCreatedNullifier":{"times":[0.9223060000003898]},"debugLog":{"times":[1.0051100000000588]},"notifyCreatedContractClassLog":{"times":[7.843667999999525]}}},{"functionName":"private_kernel_inner","time":154.0065429999995},{"functionName":"SchnorrAccount:constructor","time":381.3594030000004,"oracles":{"getContractInstance":{"times":[1.2270900000003166]},"debugLog":{"times":[0.8047500000011496,0.5222959999991872]},"fetchTaggedLogs":{"times":[75.76024499999949]},"loadCapsule":{"times":[0.4321110000000772,0.24734200000057172,0.2589530000004743]},"notifyCreatedNullifier":{"times":[0.27874399999927846,0.41660999999839987]},"notifyCreatedNote":{"times":[0.5336260000003676]},"getRandomField":{"times":[0.564728000001196,0.25573200000144425,0.10676500000045053,0.11494499999935215,0.06965300000047137,0.07994400000097812,0.0626830000001064,0.053772000001117704,0.07004400000005262,0.10407499999928405,0.06708299999991141]},"getIndexedTaggingSecretAsSender":{"times":[44.96062300000085]},"incrementAppTaggingSecretIndexAsSender":{"times":[30.570260000000417]}}},{"functionName":"private_kernel_inner","time":128.60323699999935},{"functionName":"SchnorrAccount:entrypoint","time":283.0170710000002,"oracles":{"debugLog":{"times":[0.8048899999994319,0.5860599999996339,1.018460999999661]},"fetchTaggedLogs":{"times":[87.07919500000025]},"loadCapsule":{"times":[0.3320560000011028,0.2780640000000858,0.2833940000000439]},"getNotes":{"times":[3.96872600000097]},"getAuthWitness":{"times":[0.7168259999998554]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.5273059999999532]}}},{"functionName":"private_kernel_inner","time":163.3447950000009},{"functionName":"private_kernel_reset","time":230.64921200000026},{"functionName":"private_kernel_tail","time":93.77655600000071}],"unaccounted":540.9960330000013}} 15:17:06 [15:17:06.158] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:06 [15:17:06.257] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x27ff966bebe20526c9ccaac0c3f51a3a750bef7a472258b6c605bedceca85bc8","blockNumber":1,"slot":2} 15:17:06 [15:17:06.347] VERBOSE: p2p:tx_pool Adding tx 0x1a9d4b5269e86d7927035a673ba686acef3656ca3778b716a7d8f651734a8a62 to pool {"eventName":"tx-added-to-pool","txHash":"0x1a9d4b5269e86d7927035a673ba686acef3656ca3778b716a7d8f651734a8a62","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:17:06 [15:17:06.373] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:06 [15:17:06.377] INFO: node Received tx 0x1a9d4b5269e86d7927035a673ba686acef3656ca3778b716a7d8f651734a8a62 {"txHash":"0x1a9d4b5269e86d7927035a673ba686acef3656ca3778b716a7d8f651734a8a62"} 15:17:06 [15:17:06.378] INFO: pxe:service Sent transaction 0x1a9d4b5269e86d7927035a673ba686acef3656ca3778b716a7d8f651734a8a62 15:17:06 [15:17:06.581] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:06 [15:17:06.790] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:06 [15:17:06.823] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 15:17:06 [15:17:06.843] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T15:21:24.000Z","now":"2025-06-18T15:21:05.642Z"} 15:17:07 [15:17:07.077] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:07 [15:17:07.158] VERBOSE: simulator:public-processor Processed tx 0x1a9d4b5269e86d7927035a673ba686acef3656ca3778b716a7d8f651734a8a62 with no public calls in 213.6288199999999ms {"txHash":"0x1a9d4b5269e86d7927035a673ba686acef3656ca3778b716a7d8f651734a8a62","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":213.6288199999999} 15:17:07 [15:17:07.166] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.32064647100000004s {"duration":0.32064647100000004,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 15:17:07 [15:17:07.308] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:07 [15:17:07.330] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2fe9b3f5be872e8c18f278e370c8678d49f77cb7dbdad182a37867d855bc8ee3","globalVariables":{"chainId":31337,"version":2616850191,"blockNumber":1,"slotNumber":2,"timestamp":1750260084,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1a9d4b5269e86d7927035a673ba686acef3656ca3778b716a7d8f651734a8a62"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":511.8544929999989,"publicProcessDuration":322.0657309999988,"rollupCircuitsDuration":489.3278390000014,"txCount":1,"blockNumber":1,"blockTimestamp":1750260084,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:17:07 [15:17:07.335] VERBOSE: sequencer Attesting committee is empty 15:17:07 [15:17:07.516] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:07 [15:17:07.751] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:07 [15:17:07.758] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xa135ec9e0ead3e78bb61ee7c9b31eb6b6e00b0589601ea87eabfa0bff0671d7c 15:17:07 [15:17:07.758] VERBOSE: sequencer-client Sent L1 transaction 0xa135ec9e0ead3e78bb61ee7c9b31eb6b6e00b0589601ea87eabfa0bff0671d7c {"gasLimit":514567,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 15:17:07 [15:17:07.775] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:17:07 [15:17:07.777] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xa135ec9e0ead3e78bb61ee7c9b31eb6b6e00b0589601ea87eabfa0bff0671d7c","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1750260084,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:17:07 [15:17:07.778] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:17:07 [15:17:07.800] INFO: blob-sink:server Received blob sidecar for block 0x5bc1021d2a588801daa41d46e5564e8527bb664bc3ce5a56cfbcaabcea79c318 15:17:07 [15:17:07.808] INFO: blob-sink:server Blob sidecar stored successfully for block 0x5bc1021d2a588801daa41d46e5564e8527bb664bc3ce5a56cfbcaabcea79c318 15:17:07 [15:17:07.956] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:07 [15:17:07.967] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 15:17:07 [15:17:07.969] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 15:17:07 [15:17:07.972] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 15:17:07 [15:17:07.977] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750260120] on http://127.0.0.1:8545 15:17:07 [15:17:07.978] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:17:07 [15:17:07.980] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750260120 15:17:07 [15:17:07.980] WARN: foundation:test-date-provider Time set to 2025-06-18T15:22:00.000Z {"offset":292020,"timeMs":1750260120000} 15:17:07 [15:17:07.981] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 15:17:08 [15:17:08.162] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:08 [15:17:08.480] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:08 [15:17:08.501] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:17:08 [15:17:08.509] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2fe9b3f5be872e8c18f278e370c8678d49f77cb7dbdad182a37867d855bc8ee3","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2616850191,"blockNumber":1,"slotNumber":2,"timestamp":1750260084,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1104029cf93ed1f9497f4c89e888d106aa78334dd1f1abc9474f545ea3017171","archiveNextLeafIndex":2} 15:17:08 [15:17:08.515] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 15:17:09 [15:17:09.014] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:09 [15:17:09.022] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":416.4096669999999,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750260084,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:17:09 [15:17:09.024] WARN: pxe:service No artifact found for contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f when looking for its metadata 15:17:09 [15:17:09.030] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f as part of deployment for 0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb 15:17:09 [15:17:09.229] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:09 [15:17:09.297] VERBOSE: p2p Synched to latest block 1 15:17:09 [15:17:09.619] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:09 [15:17:09.633] INFO: pxe:service Added contract Test at 0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb with class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 15:17:09 [15:17:09.658] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x1104029cf93ed1f9497f4c89e888d106aa78334dd1f1abc9474f545ea3017171","header":{"contentCommitment":{"blobsHash":"0x00e73caa6f66e59f16e0e2e61f7c687ff19957d76762a8efd29c77bcc7fb51c1","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750260084,"version":2616850191},"lastArchive":"0x27ff966bebe20526c9ccaac0c3f51a3a750bef7a472258b6c605bedceca85bc8","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x09ec39f31650e8518b9e0e414a34395c6fa2e4a1aba575f5a124fc8cce188b91","nullifierTree":"0x0d293c7eaab454eca67a8946beb583c6eff22b6ee7fca1877e81c4b33878a614","publicDataTree":"0x0e5658c2ff593277d09f294ccc794b68409d7dafdfd04d39afeb59bc816d92ef"},"totalFees":6794052480,"totalManaUsed":20448}} 15:17:09 [15:17:09.771] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:09 [15:17:09.818] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:09 [15:17:09.819] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:09 [15:17:09.825] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:09 [15:17:09.894] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1104029cf93ed1f9497f4c89e888d106aa78334dd1f1abc9474f545ea3017171","blockNumber":2,"slot":3} 15:17:09 [15:17:09.952] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:09 [15:17:09.958] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x19343c3d08158cc0b15d8f7d01c06134b0e6999d7f3eeb53a6b9f82455258afe 15:17:09 [15:17:09.978] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:17:09 [15:17:09.980] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:17:09 [15:17:09.993] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:17:09 [15:17:09.994] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:17:09 [15:17:09.999] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1658f3285add4916139a4e2dab675685ef4b1634132294f5bbe5eaca559fde24","nullifier":"0x25dad3840677736619c906957290ca59009cdf1a6a19fcea524b85f37730af67"} 15:17:10 [15:17:10.002] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:10 [15:17:10.028] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a as fee payer 15:17:10 [15:17:10.035] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:10 [15:17:10.093] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:17:10 [15:17:10.621] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0231f367ddb29264182678ec70e69bd06340efa7dc780f1c7522d13c96eed157,0x08fed0d02dac97b0ce237807685976eba973a7f517fc0723c067c7b7b6e121cc,0x11714ee3dfbdb30a8b2975f186d75eb58f17897f0b8ce770a03c05432642725e 15:17:10 [15:17:10.765] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:17:10 [15:17:10.832] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:10 [15:17:10.942] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 15:17:10 [15:17:10.979] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1104029cf93ed1f9497f4c89e888d106aa78334dd1f1abc9474f545ea3017171","blockNumber":2,"slot":3} 15:17:11 [15:17:11.027] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:17:11 [15:17:11.044] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb,0x0000000000000000000000000000000000000000000000000000000000000001,0x0df97f43b8884ae0dd0f9c477c21d35623b431b992a2e6e90a2b5c1bfef52143,0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0eea76e1163ccfa69030e0733759dce0ccf602f045e7b4a3d9ec9b0864e70308,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a 15:17:11 [15:17:11.060] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:11 [15:17:11.300] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:11 [15:17:11.883] VERBOSE: simulator:private_execution Executing private function Test:initialize {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb"} 15:17:11 [15:17:11.976] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:12 [15:17:12.054] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:12 [15:17:12.054] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb"} 15:17:12 [15:17:12.265] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:12 [15:17:12.278] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1104029cf93ed1f9497f4c89e888d106aa78334dd1f1abc9474f545ea3017171","blockNumber":2,"slot":3} 15:17:12 [15:17:12.306] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb"} 15:17:12 [15:17:12.318] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:12 [15:17:12.490] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:12 [15:17:12.708] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:12 [15:17:12.955] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:12 [15:17:12.987] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1104029cf93ed1f9497f4c89e888d106aa78334dd1f1abc9474f545ea3017171","blockNumber":2,"slot":3} 15:17:13 [15:17:13.239] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:13 [15:17:13.459] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:13 [15:17:13.902] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:14 [15:17:14.372] INFO: pxe:service Proving completed in 4723.927431ms {"timings":{"total":4723.927431,"sync":13.628414000000703,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":712.7433249999976,"oracles":{"debugLog":{"times":[0.8141200000009121,0.5300370000004477,1.2292820000002393,1.0278919999982463,0.6295410000020638,0.5061150000001362,0.634012000002258,0.9327869999979157]},"fetchTaggedLogs":{"times":[136.65371200000118]},"loadCapsule":{"times":[0.2954650000028778,0.45451199999661185,0.6373320000020612,0.486575000002631,0.37795900000128313,0.3181159999985539]},"getSharedSecret":{"times":[8.551267999999254]},"aes128Decrypt":{"times":[1.5076349999981176,1.3430680000019493]},"getPublicKeysAndPartialAddress":{"times":[5.321907000001374]},"getKeyValidationRequest":{"times":[3.14083699999901]},"deliverNote":{"times":[5.572138999999879]},"deleteCapsule":{"times":[0.57944900000075]},"storeCapsule":{"times":[0.6448820000005071]},"getNotes":{"times":[5.7915199999988545]},"getAuthWitness":{"times":[0.2610430000022461]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07201400000121794]},"callPrivateFunction":{"times":[797.6017890000003,221.695165000001,1272.0479960000011]}}},{"functionName":"private_kernel_init","time":60.473902000001544},{"functionName":"ContractClassRegisterer:register","time":780.2415779999974,"oracles":{"loadCapsule":{"times":[3.2131809999991674]},"notifyCreatedNullifier":{"times":[0.5280370000000403]},"debugLog":{"times":[0.7148359999991953]},"notifyCreatedContractClassLog":{"times":[23.24519599999985]}}},{"functionName":"private_kernel_inner","time":119.96957499999917},{"functionName":"ContractInstanceDeployer:deploy","time":128.6761000000006,"oracles":{"storeInExecutionCache":{"times":[0.4324320000014268]},"callPrivateFunction":{"times":[88.42927399999826]},"notifyCreatedNullifier":{"times":[0.4003900000025169]},"debugLog":{"times":[0.6604430000006687]}}},{"functionName":"private_kernel_inner","time":118.80294599999979},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":71.21918100000039,"oracles":{}},{"functionName":"private_kernel_inner","time":114.9525730000023},{"functionName":"Test:initialize","time":937.1817580000024,"oracles":{"getContractInstance":{"times":[32.6283259999982]},"debugLog":{"times":[0.8386420000024373,0.5197560000015073]},"fetchTaggedLogs":{"times":[262.0013360000012]},"loadCapsule":{"times":[0.44941299999845796,0.27230300000155694,1.030031999998755]},"notifyCreatedNullifier":{"times":[0.28192399999898043]}}},{"functionName":"private_kernel_inner","time":144.03677199999947},{"functionName":"private_kernel_reset","time":163.7411200000024},{"functionName":"private_kernel_tail","time":105.59126400000241}],"unaccounted":1252.6689229999938}} 15:17:14 [15:17:14.393] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:14 [15:17:14.413] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1104029cf93ed1f9497f4c89e888d106aa78334dd1f1abc9474f545ea3017171","blockNumber":2,"slot":3} 15:17:14 [15:17:14.549] VERBOSE: p2p:tx_pool Adding tx 0x03127a78a2f44fbfd28da46caaa588c7be71422fa978f0b222c144db47ce3c05 to pool {"eventName":"tx-added-to-pool","txHash":"0x03127a78a2f44fbfd28da46caaa588c7be71422fa978f0b222c144db47ce3c05","noteHashCount":0,"nullifierCount":4,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":583,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:17:14 [15:17:14.562] INFO: node Received tx 0x03127a78a2f44fbfd28da46caaa588c7be71422fa978f0b222c144db47ce3c05 {"txHash":"0x03127a78a2f44fbfd28da46caaa588c7be71422fa978f0b222c144db47ce3c05"} 15:17:14 [15:17:14.563] INFO: pxe:service Sent transaction 0x03127a78a2f44fbfd28da46caaa588c7be71422fa978f0b222c144db47ce3c05 15:17:14 [15:17:14.604] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:14 [15:17:14.806] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:14 [15:17:14.939] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 15:17:14 [15:17:14.956] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T15:22:00.000Z","now":"2025-06-18T15:22:06.976Z"} 15:17:15 [15:17:15.039] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:15 [15:17:15.270] VERBOSE: simulator:public-processor Processed tx 0x03127a78a2f44fbfd28da46caaa588c7be71422fa978f0b222c144db47ce3c05 with no public calls in 219.5862390000002ms {"txHash":"0x03127a78a2f44fbfd28da46caaa588c7be71422fa978f0b222c144db47ce3c05","txFee":7272506880,"revertCode":0,"gasUsed":{"totalGas":{"daGas":310272,"l2Gas":21888},"billedGas":{"daGas":310272,"l2Gas":21888},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":4,"noteHashCount":0,"contractClassLogCount":1,"publicLogCount":0,"privateLogCount":1,"l2ToL1MessageCount":0,"durationMs":219.5862390000002} 15:17:15 [15:17:15.271] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:15 [15:17:15.274] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.31696673200000075s {"duration":0.31696673200000075,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":310272,"l2Gas":21888},"totalSizeInBytes":19648} 15:17:15 [15:17:15.446] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2b8563d0738ab56ec8f08c1538ef55dabce6d0965e5b3340c6844ec98220c484","globalVariables":{"chainId":31337,"version":2616850191,"blockNumber":2,"slotNumber":3,"timestamp":1750260120,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x03127a78a2f44fbfd28da46caaa588c7be71422fa978f0b222c144db47ce3c05"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":509.3401260000028,"publicProcessDuration":317.3972130000002,"rollupCircuitsDuration":493.2059879999979,"txCount":1,"blockNumber":2,"blockTimestamp":1750260120,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 15:17:15 [15:17:15.449] VERBOSE: sequencer Attesting committee is empty 15:17:15 [15:17:15.575] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:15 [15:17:15.791] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:15 [15:17:15.800] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xd05839397513ea50e5548f672d47b5d33d48e7b0bbc5775428194fdda9bf790f 15:17:15 [15:17:15.801] VERBOSE: sequencer-client Sent L1 transaction 0xd05839397513ea50e5548f672d47b5d33d48e7b0bbc5775428194fdda9bf790f {"gasLimit":470298,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:17:15 [15:17:15.817] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:17:15 [15:17:15.817] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xd05839397513ea50e5548f672d47b5d33d48e7b0bbc5775428194fdda9bf790f","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":2,"blockTimestamp":1750260120,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 15:17:15 [15:17:15.818] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:17:15 [15:17:15.822] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750260156] on http://127.0.0.1:8545 15:17:15 [15:17:15.825] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:17:15 [15:17:15.828] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750260156 15:17:15 [15:17:15.829] WARN: foundation:test-date-provider Time set to 2025-06-18T15:22:36.000Z {"offset":320171,"timeMs":1750260156000} 15:17:15 [15:17:15.829] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 15:17:15 [15:17:15.832] INFO: blob-sink:server Received blob sidecar for block 0xe6a157a246206df9a51aa56c154d9c0a0f649d13a08921c37e6c94599a76c537 15:17:15 [15:17:15.839] INFO: blob-sink:server Blob sidecar stored successfully for block 0xe6a157a246206df9a51aa56c154d9c0a0f649d13a08921c37e6c94599a76c537 15:17:15 [15:17:15.995] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:16 [15:17:16.004] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 15:17:16 [15:17:16.005] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 15:17:16 [15:17:16.007] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 15:17:16 [15:17:16.296] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:16 [15:17:16.321] VERBOSE: archiver:block-helper Store contract instance at 0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb 15:17:16 [15:17:16.341] VERBOSE: archiver:block-helper Store contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 15:17:16 [15:17:16.375] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x2b8563d0738ab56ec8f08c1538ef55dabce6d0965e5b3340c6844ec98220c484","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2616850191,"blockNumber":2,"slotNumber":3,"timestamp":1750260120,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x122034ab95bb1531a39efd701cbffaf060f61b015b9e75fa6621a9902a2c7307","archiveNextLeafIndex":3} 15:17:16 [15:17:16.391] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 15:17:16 [15:17:16.427] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.92769799999951,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750260120,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 15:17:16 [15:17:16.503] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:16 [15:17:16.504] VERBOSE: p2p Synched to latest block 2 15:17:16 [15:17:16.773] INFO: aztecjs:deploy_sent_tx Contract 0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb successfully deployed. 15:17:16 [15:17:16.783] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:16 [15:17:16.819] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x122034ab95bb1531a39efd701cbffaf060f61b015b9e75fa6621a9902a2c7307","header":{"contentCommitment":{"blobsHash":"0x00f6cc5e90eccbfd8899e13623540a2b8c72d4785e7d578ae5991e824cadd844","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750260120,"version":2616850191},"lastArchive":"0x1104029cf93ed1f9497f4c89e888d106aa78334dd1f1abc9474f545ea3017171","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x09ec39f31650e8518b9e0e414a34395c6fa2e4a1aba575f5a124fc8cce188b91","nullifierTree":"0x2e6cf9b98b0f971a78d49d3036a57b02dd605deed23181dcc04240455406ff40","publicDataTree":"0x173456f8a0412079a4c3c631d713d8135e380a935a535a87a175884dcacf9dfc"},"totalFees":7272506880,"totalManaUsed":21888}} 15:17:16 [15:17:16.897] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:16 [15:17:16.933] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:16 [15:17:16.934] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:16 [15:17:16.990] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:17 [15:17:17.007] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x122034ab95bb1531a39efd701cbffaf060f61b015b9e75fa6621a9902a2c7307","blockNumber":3,"slot":4} 15:17:17 [15:17:17.033] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a"} 15:17:17 [15:17:17.040] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x19343c3d08158cc0b15d8f7d01c06134b0e6999d7f3eeb53a6b9f82455258afe 15:17:17 [15:17:17.055] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:17:17 [15:17:17.056] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:17:17 [15:17:17.063] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:17:17 [15:17:17.064] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:17:17 [15:17:17.067] VERBOSE: pxe:service Added note {"index":0,"contract":"0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1658f3285add4916139a4e2dab675685ef4b1634132294f5bbe5eaca559fde24","nullifier":"0x25dad3840677736619c906957290ca59009cdf1a6a19fcea524b85f37730af67"} 15:17:17 [15:17:17.070] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:17 [15:17:17.088] VERBOSE: simulator:client_execution_context:debug_log Setting 0x1c4e71d2899ccab659b1a26a2f240182fc34c81dc09dafbfdd79cfa624ed3e2a as fee payer 15:17:17 [15:17:17.222] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:17 [15:17:17.686] VERBOSE: simulator:private_execution Executing private function Test:set_constant {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb"} 15:17:17 [15:17:17.698] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:17 [15:17:17.698] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb"} 15:17:17 [15:17:17.702] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:17 [15:17:17.897] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x122034ab95bb1531a39efd701cbffaf060f61b015b9e75fa6621a9902a2c7307","blockNumber":3,"slot":4} 15:17:17 [15:17:17.907] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:17 [15:17:17.916] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb"} 15:17:17 [15:17:17.921] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:18 [15:17:18.128] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:18 [15:17:18.663] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:18 [15:17:18.839] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x122034ab95bb1531a39efd701cbffaf060f61b015b9e75fa6621a9902a2c7307","blockNumber":3,"slot":4} 15:17:19 [15:17:19.061] INFO: pxe:service Proving completed in 2252.2386689999985ms {"timings":{"total":2252.2386689999985,"sync":12.227002999999968,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":595.9895300000026,"oracles":{"debugLog":{"times":[0.5844500000021071,0.4860339999977441,0.5066359999982524,0.5182559999993828,0.4314119999980903,0.4614929999988817,0.5295160000023316,0.599289999998291]},"fetchTaggedLogs":{"times":[103.50966999999946]},"loadCapsule":{"times":[0.2119009999987611,0.17815799999880255,0.47888400000010733,0.31437600000208477,0.3325970000005327,0.3197760000002745]},"getSharedSecret":{"times":[7.812941000000137]},"aes128Decrypt":{"times":[0.4804340000009688,0.7555279999978666]},"getPublicKeysAndPartialAddress":{"times":[1.9012450000009267]},"getKeyValidationRequest":{"times":[1.8335319999969215]},"deliverNote":{"times":[3.556717999999819]},"deleteCapsule":{"times":[0.7186259999980393]},"storeCapsule":{"times":[0.5010149999980058]},"getNotes":{"times":[1.9303669999972044]},"getAuthWitness":{"times":[0.2600529999981518]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0770940000002156]},"callPrivateFunction":{"times":[840.5850539999992]}}},{"functionName":"private_kernel_init","time":82.61590200000137},{"functionName":"Test:set_constant","time":499.8054889999985,"oracles":{"debugLog":{"times":[0.5852899999990768,0.4103109999996377]},"fetchTaggedLogs":{"times":[220.96678899999824]},"loadCapsule":{"times":[0.2233909999995376,1.4810840000027383,2.050632999998925]},"notifyCreatedNullifier":{"times":[0.253963000002841]},"notifyCreatedNote":{"times":[0.17100899999786634]}}},{"functionName":"private_kernel_inner","time":124.7843869999997},{"functionName":"private_kernel_reset","time":173.70474900000045},{"functionName":"private_kernel_tail","time":64.8006490000007}],"unaccounted":698.3109599999952}} 15:17:19 [15:17:19.072] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:19 [15:17:19.099] VERBOSE: p2p:tx_pool Adding tx 0x2bf8648840a23e3ac342c1faf1e775ff2db3765fa734960816671caba3566cf4 to pool {"eventName":"tx-added-to-pool","txHash":"0x2bf8648840a23e3ac342c1faf1e775ff2db3765fa734960816671caba3566cf4","noteHashCount":1,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 15:17:19 [15:17:19.104] INFO: node Received tx 0x2bf8648840a23e3ac342c1faf1e775ff2db3765fa734960816671caba3566cf4 {"txHash":"0x2bf8648840a23e3ac342c1faf1e775ff2db3765fa734960816671caba3566cf4"} 15:17:19 [15:17:19.104] INFO: pxe:service Sent transaction 0x2bf8648840a23e3ac342c1faf1e775ff2db3765fa734960816671caba3566cf4 15:17:19 [15:17:19.277] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:19 [15:17:19.369] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 15:17:19 [15:17:19.386] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T15:22:36.000Z","now":"2025-06-18T15:22:39.557Z"} 15:17:19 [15:17:19.410] VERBOSE: simulator:public-processor Processed tx 0x2bf8648840a23e3ac342c1faf1e775ff2db3765fa734960816671caba3566cf4 with no public calls in 12.612622000000556ms {"txHash":"0x2bf8648840a23e3ac342c1faf1e775ff2db3765fa734960816671caba3566cf4","txFee":5018455040,"revertCode":0,"gasUsed":{"totalGas":{"daGas":2048,"l2Gas":15104},"billedGas":{"daGas":2048,"l2Gas":15104},"teardownGas":{"daGas":0,"l2Gas":0},"publicGas":{"daGas":0,"l2Gas":0}},"publicDataWriteCount":1,"nullifierCount":2,"noteHashCount":1,"contractClassLogCount":0,"publicLogCount":0,"privateLogCount":0,"l2ToL1MessageCount":0,"durationMs":12.612622000000556} 15:17:19 [15:17:19.412] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.025108969000000796s {"duration":0.025108969000000796,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":2048,"l2Gas":15104},"totalSizeInBytes":352} 15:17:19 [15:17:19.522] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:19 [15:17:19.536] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1cdd18985914870ffc9acb710c3dffac9db9bc64f515b7bd1fb3ad2d0eba1c47","globalVariables":{"chainId":31337,"version":2616850191,"blockNumber":3,"slotNumber":4,"timestamp":1750260156,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2bf8648840a23e3ac342c1faf1e775ff2db3765fa734960816671caba3566cf4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":167.57990199999767,"publicProcessDuration":25.525760000000446,"rollupCircuitsDuration":151.62166199999774,"txCount":1,"blockNumber":3,"blockTimestamp":1750260156,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:17:19 [15:17:19.539] VERBOSE: sequencer Attesting committee is empty 15:17:19 [15:17:19.727] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:19 [15:17:19.824] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xac37e9d4ad72b6d38c33fdad813b38aaa8a957de9884b11b24e6f1c60c39a09e 15:17:19 [15:17:19.825] VERBOSE: sequencer-client Sent L1 transaction 0xac37e9d4ad72b6d38c33fdad813b38aaa8a957de9884b11b24e6f1c60c39a09e {"gasLimit":470220,"maxFeePerGas":"1.279583418","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:17:19 [15:17:19.838] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:17:19 [15:17:19.839] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xac37e9d4ad72b6d38c33fdad813b38aaa8a957de9884b11b24e6f1c60c39a09e","calldataSize":1444,"calldataGas":12268,"txCount":1,"blockNumber":3,"blockTimestamp":1750260156,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:17:19 [15:17:19.839] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:17:19 [15:17:19.847] INFO: blob-sink:server Received blob sidecar for block 0xcdd8d4ac0df8d361f86b4a0e35f8dfd7ab3651edf819c71ad720a9ff6cf848ec 15:17:19 [15:17:19.852] INFO: blob-sink:server Blob sidecar stored successfully for block 0xcdd8d4ac0df8d361f86b4a0e35f8dfd7ab3651edf819c71ad720a9ff6cf848ec 15:17:19 [15:17:19.929] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:19 [15:17:19.937] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 15:17:19 [15:17:19.938] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 15:17:19 [15:17:19.940] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 15:17:20 [15:17:20.041] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750260192] on http://127.0.0.1:8545 15:17:20 [15:17:20.042] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:17:20 [15:17:20.044] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750260192 15:17:20 [15:17:20.044] WARN: foundation:test-date-provider Time set to 2025-06-18T15:23:12.000Z {"offset":351956,"timeMs":1750260192000} 15:17:20 [15:17:20.044] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 15:17:20 [15:17:20.135] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:20 [15:17:20.314] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1cdd18985914870ffc9acb710c3dffac9db9bc64f515b7bd1fb3ad2d0eba1c47","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2616850191,"blockNumber":3,"slotNumber":4,"timestamp":1750260156,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x121524e2ddd3ee029410aa86cd1058857869d4881b532f420fd4587ffd84406e","archiveNextLeafIndex":4} 15:17:20 [15:17:20.317] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 15:17:20 [15:17:20.337] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:20 [15:17:20.424] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":10.400652000000264,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750260156,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:17:20 [15:17:20.431] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x121524e2ddd3ee029410aa86cd1058857869d4881b532f420fd4587ffd84406e","header":{"contentCommitment":{"blobsHash":"0x000c9d8d060b3b826b05cf8a0f6a79e2e9d6430032f943a3c470fc65f0ddcb51","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750260156,"version":2616850191},"lastArchive":"0x122034ab95bb1531a39efd701cbffaf060f61b015b9e75fa6621a9902a2c7307","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x11b605b5b758ab846c5df3ca21e9fefb6e92e8b9dca9411633f94633547d48c6","nullifierTree":"0x057c172999987e158ba654ef1651aa93cb8c4528491345e10c0552355f2b141c","publicDataTree":"0x255e69d0314913dd3cb901ac8aaedc34c2ebe6d90c86cea66d707bc15f6a5aa9"},"totalFees":5018455040,"totalManaUsed":15104}} 15:17:20 [15:17:20.435] VERBOSE: p2p Synched to latest block 3 15:17:20 [15:17:20.575] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:20 [15:17:20.869] VERBOSE: simulator Executing utility function deliver_note {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb","selector":"0x09d61d7b"} 15:17:20 [15:17:20.881] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:20 [15:17:20.885] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:17:20 [15:17:20.885] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb"} 15:17:21 [15:17:21.151] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:21 [15:17:21.257] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x121524e2ddd3ee029410aa86cd1058857869d4881b532f420fd4587ffd84406e","blockNumber":4,"slot":5} 15:17:21 [15:17:21.278] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb"} 15:17:21 [15:17:21.281] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:21 [15:17:21.282] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:17:21 [15:17:21.283] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:17:21 [15:17:21.283] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:17:21 [15:17:21.286] VERBOSE: pxe:service Added note {"index":128,"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08e500e73b7c9f20b0a0d01d9121e9f6deecdebdad166cc19bd8217d3e878f36","nullifier":"0x2260dee6f953dfb6dee997d679f57fe83b8169db1b81f5b6c072748706bd4fae"} 15:17:21 [15:17:21.287] VERBOSE: simulator Utility simulation for 0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb.0x09d61d7b completed 15:17:21 [15:17:21.458] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:21 [15:17:21.777] VERBOSE: simulator Executing utility function get_constant {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb","selector":"0xc2a89417"} 15:17:21 [15:17:21.789] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:21 [15:17:21.796] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:17:21 [15:17:21.796] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb"} 15:17:21 [15:17:21.997] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x121524e2ddd3ee029410aa86cd1058857869d4881b532f420fd4587ffd84406e","blockNumber":4,"slot":5} 15:17:22 [15:17:22.000] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:22 [15:17:22.012] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb"} 15:17:22 [15:17:22.017] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:22 [15:17:22.020] VERBOSE: simulator Utility simulation for 0x014b550a1305d871e94baca5d6a8937f037140f770c53796fdf4d876d6895cbb.0xc2a89417 completed 15:17:22 [15:17:22.025] INFO: node Stopping 15:17:22 [15:17:22.025] INFO: slasher Slasher client stopped. 15:17:22 [15:17:22.026] INFO: sequencer Stopped sequencer 15:17:22 [15:17:22.026] INFO: p2p P2P client stopped. 15:17:22 [15:17:22.028] INFO: world_state Stopped world state synchronizer 15:17:22 [15:17:22.028] INFO: archiver Stopped. 15:17:22 [15:17:22.029] INFO: node Stopped 15:17:22 [15:17:22.029] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up ACVM state 15:17:22 [15:17:22.029] INFO: e2e:e2e_offchain_note_delivery Cleaning up ACVM temp directory /tmp/802e1bda 15:17:22 [15:17:22.030] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up BB state 15:17:22 [15:17:22.042] INFO: blob-sink:server Stopping blob sink 15:17:22 [15:17:22.043] INFO: blob-sink:server Blob sink stopped 15:17:22 [15:17:22.044] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up data directory at /tmp/530a9ea846cd7865 15:17:22 PASS src/e2e_offchain_note_delivery.test.ts 15:17:22 e2e_offchain_note_delivery 15:17:22 ✓ can create a note that is not broadcast, deliver it offchain and read it (21942 ms) 15:17:22 15:17:22 Test Suites: 1 passed, 1 total 15:17:22 Tests: 1 passed, 1 total 15:17:22 Snapshots: 0 total 15:17:22 Time: 28.034 s 15:17:22 Ran all test suites matching /src\/e2e_offchain_note_delivery.test.ts/i. 15:17:22 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?