Parent Log: http://ci.aztec-labs.com/e1f72f729648c9e9 Command: 090f4700861c2841: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/14cf4d3d103c5f816297929a93306c74eec40f14 Env: REF_NAME=gh-readonly-queue/master/pr-15027-f4ac84d7ac4041d505399edd8819840bb14d6c9d CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Fri Jun 13 17:48:00 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15027_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_e9737a394094636f_master 17:48:00 +++ id -u 17:48:00 +++ id -g 17:48:00 ++ 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'\''' 17:48:00 + cid=822ef580010ddc913554c36a32494d5f31e904498c5d46d4419fce71dde48e52 17:48:00 + set +x 17:48:01 {"level":25,"time":1749836881642,"pid":12,"hostname":"822ef580010d","module":"logger","msg":"Logger initialized with level verbose"} 17:48:07 [17:48:07.883] 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 17:48:07 [17:48:07.984] INFO: e2e:e2e_offchain_note_delivery Logging metrics to log/e2e_offchain_note_delivery.jsonl 17:48:08 [17:48:08.223] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-FchPIf/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 17:48:08 [17:48:08.270] INFO: e2e:e2e_offchain_note_delivery Calling anvil_setBlockTimestampInterval with params: [12] 17:48:08 [17:48:08.297] WARN: e2e:e2e_offchain_note_delivery Set block interval to 12 17:48:08 [17:48:08.298] VERBOSE: e2e:e2e_offchain_note_delivery Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:48:08 [17:48:08.347] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:48:08 [17:48:08.356] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 17:48:08 [17:48:08.379] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:48:08 [17:48:08.385] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 17:48:08 [17:48:08.403] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 17:48:08 [17:48:08.408] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 17:48:08 [17:48:08.432] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 17:48:08 [17:48:08.439] VERBOSE: e2e:e2e_offchain_note_delivery Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 17:48:08 [17:48:08.462] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 17:48:08 [17:48:08.469] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 17:48:08 [17:48:08.486] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 17:48:08 [17:48:08.491] VERBOSE: e2e:e2e_offchain_note_delivery Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 17:48:08 [17:48:08.492] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for deployments to complete 17:48:08 [17:48:08.492] INFO: e2e:e2e_offchain_note_delivery Waiting for 6 transactions to be mined... 17:48:08 [17:48:08.516] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 17:48:08 [17:48:08.536] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 17:48:08 [17:48:08.536] VERBOSE: e2e:e2e_offchain_note_delivery Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 17:48:08 [17:48:08.550] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 17:48:08 [17:48:08.569] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 17:48:08 [17:48:08.577] VERBOSE: e2e:e2e_offchain_note_delivery Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 17:48:08 [17:48:08.593] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 17:48:08 [17:48:08.593] VERBOSE: e2e:e2e_offchain_note_delivery Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 17:48:08 [17:48:08.614] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 17:48:08 [17:48:08.619] VERBOSE: e2e:e2e_offchain_note_delivery Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 17:48:08 [17:48:08.635] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 17:48:08 [17:48:08.635] VERBOSE: e2e:e2e_offchain_note_delivery Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 17:48:08 [17:48:08.636] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for deployments to complete 17:48:08 [17:48:08.636] INFO: e2e:e2e_offchain_note_delivery Waiting for 8 transactions to be mined... 17:48:08 [17:48:08.662] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 17:48:08 [17:48:08.676] VERBOSE: e2e:e2e_offchain_note_delivery Deployed shared contracts 17:48:08 [17:48:08.695] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 17:48:08 [17:48:08.696] VERBOSE: e2e:e2e_offchain_note_delivery Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 17:48:08 [17:48:08.699] 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} 17:48:08 [17:48:08.713] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 17:48:08 [17:48:08.744] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 17:48:08 [17:48:08.751] VERBOSE: e2e:e2e_offchain_note_delivery Awaiting for linked libraries to be deployed 17:48:08 [17:48:08.796] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x8c67cb46612983c1d4359254783117dd0709348170d0bead06043345cb0946a4 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 17:48:08 [17:48:08.804] 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} 17:48:08 [17:48:08.805] INFO: e2e:e2e_offchain_note_delivery Waiting for 9 transactions to be mined... 17:48:08 [17:48:08.833] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 17:48:08 [17:48:08.833] VERBOSE: e2e:e2e_offchain_note_delivery All core contracts have been deployed 17:48:08 [17:48:08.852] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 17:48:08 [17:48:08.853] VERBOSE: e2e:e2e_offchain_note_delivery Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 17:48:08 [17:48:08.866] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 17:48:08 [17:48:08.871] VERBOSE: e2e:e2e_offchain_note_delivery Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 17:48:08 [17:48:08.895] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 17:48:08 [17:48:08.895] VERBOSE: e2e:e2e_offchain_note_delivery Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 17:48:08 [17:48:08.895] INFO: e2e:e2e_offchain_note_delivery Waiting for 10 transactions to be mined... 17:48:08 [17:48:08.915] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 17:48:08 [17:48:08.925] VERBOSE: e2e:e2e_offchain_note_delivery Rollup deployed 17:48:08 [17:48:08.925] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for rollup and slash factory to be deployed 17:48:08 [17:48:08.925] INFO: e2e:e2e_offchain_note_delivery Waiting for 10 transactions to be mined... 17:48:08 [17:48:08.958] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 17:48:08 [17:48:08.959] VERBOSE: e2e:e2e_offchain_note_delivery All transactions for L1 deployment have been mined 17:48:08 [17:48:08.981] 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"} 17:48:08 [17:48:08.988] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 17:48:08 [17:48:08.991] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:08 [17:48:08.993] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 17:48:08 [17:48:08.994] INFO: telemetry:client Using NoopTelemetryClient 17:48:09 [17:48:09.000] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 17:48:09 [17:48:09.001] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 17:48:09 [17:48:09.002] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/4c6473e3b48df008/blob-sink with map size 134217728 KB (LMDB v2) 17:48:09 [17:48:09.005] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:09 [17:48:09.010] INFO: aztecjs:utils:watcher New L1 time: 1749837127 17:48:09 [17:48:09.011] WARN: foundation:test-date-provider Time set to 2025-06-13T17:52:07.000Z {"offset":237989,"timeMs":1749837127000} 17:48:09 [17:48:09.015] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:48:09 [17:48:09.023] INFO: blob-sink:server Server is running on http://localhost:34301 17:48:09 [17:48:09.024] VERBOSE: e2e:e2e_offchain_note_delivery Creating and synching an aztec node... 17:48:09 [17:48:09.025] VERBOSE: e2e:e2e_offchain_note_delivery Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/98bd470b/acvm 17:48:09 [17:48:09.026] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:34301"} 17:48:09 [17:48:09.044] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:48:09 [17:48:09.045] INFO: archiver:lmdb Creating archiver data store at directory /tmp/4c6473e3b48df008/archiver with map size 134217728 KB (LMDB v2) 17:48:09 [17:48:09.046] INFO: archiver:lmdb Starting data store with maxReaders 16 17:48:09 [17:48:09.246] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:09 [17:48:09.355] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:34301"} 17:48:09 [17:48:09.374] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:34301"} 17:48:09 [17:48:09.374] WARN: node:blob-sink:client No L1 consensus host urls configured 17:48:09 [17:48:09.374] WARN: node:blob-sink:client No archive client configured 17:48:09 [17:48:09.377] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x1039b10bdd2c1820edd74bcb541657f93029c14915669c437ef0bbde0475653b {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0x9d435fcd81b02f600cb9f19b7674466fb9f91f094b82f65f192075267e7f95f9","l1BlockNumber":16}} 17:48:09 [17:48:09.393] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x1039b10bdd2c1820edd74bcb541657f93029c14915669c437ef0bbde0475653b","l1BlockNumber":20}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:48:09 [17:48:09.402] INFO: world-state:database Creating world state data store at directory /tmp/4c6473e3b48df008/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:48:09 [17:48:09.430] INFO: world_state Created world state synchroniser with block history of 64 17:48:09 [17:48:09.430] WARN: node Aztec node is accepting fake proofs 17:48:09 [17:48:09.442] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/4c6473e3b48df008/p2p with map size 134217728 KB (LMDB v2) 17:48:09 [17:48:09.444] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:48:09 [17:48:09.446] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/4c6473e3b48df008/p2p-archive with map size 134217728 KB (LMDB v2) 17:48:09 [17:48:09.448] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:48:09 [17:48:09.449] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/4c6473e3b48df008/p2p-peers with map size 134217728 KB (LMDB v2) 17:48:09 [17:48:09.451] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:09 [17:48:09.455] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:48:09 [17:48:09.458] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:48:09 [17:48:09.459] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:48:09 [17:48:09.462] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:48:09 [17:48:09.462] INFO: world_state Started world state synchronizer from block 1 17:48:09 [17:48:09.465] VERBOSE: world-state:block_stream Starting sync from block number 0 17:48:09 [17:48:09.467] INFO: p2p Starting p2p client from block 0 with empty mempools 17:48:09 [17:48:09.467] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:48:09 [17:48:09.469] INFO: slasher Slasher client initialized 17:48:09 [17:48:09.469] INFO: slasher Starting Slasher client... 17:48:09 [17:48:09.501] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:48:09 [17:48:09.502] VERBOSE: node All Aztec Node subsystems synced 17:48:09 [17:48:09.514] INFO: sequencer-client Deploying forwarder contract 17:48:09 [17:48:09.525] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:48:09 [17:48:09.551] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 17:48:09 [17:48:09.552] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 17:48:09 [17:48:09.559] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:48:09 [17:48:09.581] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:48:09 [17:48:09.582] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 17:48:09 [17:48:09.582] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/98bd470b/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 17:48:09 [17:48:09.798] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:48:09 [17:48:09.800] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:48:09 [17:48:09.802] INFO: node Aztec Node version: 0.87.8 17:48:09 [17:48:09.802] 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:48:09 [17:48:09.804] VERBOSE: e2e:e2e_offchain_note_delivery Creating a pxe... 17:48:09 [17:48:09.808] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:09 [17:48:09.819] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/b9d752d736ee75b0/pxe_data with map size 134217728 KB (LMDB v2) 17:48:09 [17:48:09.842] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:48:09 [17:48:09.844] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d338d241dc91bdd36a8e92627ba542b8f96ca1f3ef939e45828425a32f40e89","blockNumber":1,"slot":2} 17:48:10 [17:48:10.043] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:10 [17:48:10.129] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:48:10 [17:48:10.130] INFO: pxe:service Started PXE connected to chain 31337 version 3761205123 17:48:10 [17:48:10.175] INFO: pxe:service Registered account 0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba 17:48:10 [17:48:10.238] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 17:48:10 [17:48:10.239] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba 17:48:10 [17:48:10.273] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:10 [17:48:10.380] INFO: pxe:service Added contract SchnorrAccount at 0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:48:10 [17:48:10.397] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d338d241dc91bdd36a8e92627ba542b8f96ca1f3ef939e45828425a32f40e89","blockNumber":1,"slot":2} 17:48:10 [17:48:10.426] VERBOSE: pxe:block_stream Starting sync from block number 0 17:48:10 [17:48:10.453] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 17:48:10 [17:48:10.502] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:10 [17:48:10.557] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:48:11 [17:48:11.196] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 17:48:11 [17:48:11.328] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:48:11 [17:48:11.410] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:11 [17:48:11.486] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d338d241dc91bdd36a8e92627ba542b8f96ca1f3ef939e45828425a32f40e89","blockNumber":1,"slot":2} 17:48:11 [17:48:11.548] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:11 [17:48:11.608] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:11 [17:48:11.609] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:11 [17:48:11.635] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:11 [17:48:11.673] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:11 [17:48:11.678] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:11 [17:48:11.861] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:11 [17:48:11.900] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:11 [17:48:11.900] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:11 [17:48:11.906] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:11 [17:48:11.950] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:11 [17:48:11.954] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:11 [17:48:11.970] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba as fee payer 17:48:12 [17:48:12.034] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d338d241dc91bdd36a8e92627ba542b8f96ca1f3ef939e45828425a32f40e89","blockNumber":1,"slot":2} 17:48:12 [17:48:12.143] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:12 [17:48:12.394] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:12 [17:48:12.715] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:12 [17:48:12.837] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1d338d241dc91bdd36a8e92627ba542b8f96ca1f3ef939e45828425a32f40e89","blockNumber":1,"slot":2} 17:48:13 [17:48:13.284] INFO: pxe:service Proving completed in 2860.6378409999998ms {"timings":{"total":2860.6378409999998,"sync":2.9746630000008736,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":171.7505429999983,"oracles":{"callPrivateFunction":{"times":[900.3884600000001,369.3158289999992,213.6725150000002]}}},{"functionName":"private_kernel_init","time":99.33584599999995},{"functionName":"ContractClassRegisterer:register","time":882.3786719999989,"oracles":{"loadCapsule":{"times":[21.76332000000002]},"notifyCreatedNullifier":{"times":[2.5600219999996625]},"debugLog":{"times":[1.4458940000004077]},"notifyCreatedContractClassLog":{"times":[12.544932999999219]}}},{"functionName":"private_kernel_inner","time":140.03743799999938},{"functionName":"SchnorrAccount:constructor","time":327.7920370000011,"oracles":{"getContractInstance":{"times":[4.385306000000128]},"debugLog":{"times":[0.6729560000003403,0.49587199999950826]},"fetchTaggedLogs":{"times":[67.78729500000009]},"loadCapsule":{"times":[0.440230000000156,0.2781460000005609,0.2862960000002204]},"notifyCreatedNullifier":{"times":[0.24805600000036065,0.22055600000021514]},"notifyCreatedNote":{"times":[0.5206529999995837]},"getRandomField":{"times":[0.35037799999918207,0.2219150000000809,0.05623100000047998,0.0632210000003397,0.06832199999917066,0.08912299999974493,0.051502000000255066,0.04119100000025355,0.07171200000084355,0.06414199999926495,0.048770999999760534]},"getIndexedTaggingSecretAsSender":{"times":[31.937589999999545]},"incrementAppTaggingSecretIndexAsSender":{"times":[27.387181000000055]}}},{"functionName":"private_kernel_inner","time":178.98886799999855},{"functionName":"SchnorrAccount:entrypoint","time":174.1668520000021,"oracles":{"debugLog":{"times":[0.5948939999998402,0.5093329999999696,0.8998019999999087]},"fetchTaggedLogs":{"times":[51.95878300000004]},"loadCapsule":{"times":[0.2924270000003162,0.26819700000123703,0.30512699999962933]},"getNotes":{"times":[2.7317760000005364]},"getAuthWitness":{"times":[0.32309799999893585]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.2049889999998413]}}},{"functionName":"private_kernel_inner","time":159.2952120000009},{"functionName":"private_kernel_reset","time":188.68260200000077},{"functionName":"private_kernel_tail","time":88.42526299999918}],"unaccounted":446.80984499999977}} 17:48:13 [17:48:13.306] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:13 [17:48:13.441] VERBOSE: p2p:tx_pool Adding tx 0x0d86cddf50e1dfbf65310048575c7bc9f5bd257acb47c95e67064eb8755114b4 to pool {"eventName":"tx-added-to-pool","txHash":"0x0d86cddf50e1dfbf65310048575c7bc9f5bd257acb47c95e67064eb8755114b4","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:48:13 [17:48:13.484] INFO: node Received tx 0x0d86cddf50e1dfbf65310048575c7bc9f5bd257acb47c95e67064eb8755114b4 {"txHash":"0x0d86cddf50e1dfbf65310048575c7bc9f5bd257acb47c95e67064eb8755114b4"} 17:48:13 [17:48:13.486] INFO: pxe:service Sent transaction 0x0d86cddf50e1dfbf65310048575c7bc9f5bd257acb47c95e67064eb8755114b4 17:48:13 [17:48:13.502] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 17:48:13 [17:48:13.511] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:13 [17:48:13.515] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-13T17:52:31.000Z","now":"2025-06-13T17:52:11.504Z"} 17:48:13 [17:48:13.717] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:13 [17:48:13.779] VERBOSE: simulator:public-processor Processed tx 0x0d86cddf50e1dfbf65310048575c7bc9f5bd257acb47c95e67064eb8755114b4 with no public calls in 169.42071700000088ms {"txHash":"0x0d86cddf50e1dfbf65310048575c7bc9f5bd257acb47c95e67064eb8755114b4","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":169.42071700000088} 17:48:13 [17:48:13.783] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.26612195000000066s {"duration":0.26612195000000066,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 17:48:13 [17:48:13.931] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x211a2da170df838b3e46cb4107083d3e876df4e827d71fa9429bc4ba40dc782d","globalVariables":{"chainId":31337,"version":3761205123,"blockNumber":1,"slotNumber":2,"timestamp":1749837151,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0d86cddf50e1dfbf65310048575c7bc9f5bd257acb47c95e67064eb8755114b4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":428.47844599999917,"publicProcessDuration":267.4021309999989,"rollupCircuitsDuration":415.6326969999991,"txCount":1,"blockNumber":1,"blockTimestamp":1749837151,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:48:13 [17:48:13.936] VERBOSE: sequencer Attesting committee is empty 17:48:14 [17:48:14.023] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:14 [17:48:14.316] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:14 [17:48:14.322] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x7d3d29195cea90b3e1908c371a56696bab3546b706cff251502753ad1e57e6ab 17:48:14 [17:48:14.323] VERBOSE: sequencer-client Sent L1 transaction 0x7d3d29195cea90b3e1908c371a56696bab3546b706cff251502753ad1e57e6ab {"gasLimit":514507,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:48:14 [17:48:14.340] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 17:48:14 [17:48:14.344] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 17:48:14 [17:48:14.348] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:48:14 [17:48:14.349] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x7d3d29195cea90b3e1908c371a56696bab3546b706cff251502753ad1e57e6ab","calldataSize":1444,"calldataGas":12256,"txCount":1,"blockNumber":1,"blockTimestamp":1749837151,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:48:14 [17:48:14.350] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:48:14 [17:48:14.354] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 17:48:14 [17:48:14.375] INFO: blob-sink:server Received blob sidecar for block 0x96b7165a53e2ec61cadccdf647d744662b37457f6797726642ec815e5fc6ee0b 17:48:14 [17:48:14.390] INFO: blob-sink:server Blob sidecar stored successfully for block 0x96b7165a53e2ec61cadccdf647d744662b37457f6797726642ec815e5fc6ee0b 17:48:14 [17:48:14.557] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:14 [17:48:14.583] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 17:48:14 [17:48:14.598] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x211a2da170df838b3e46cb4107083d3e876df4e827d71fa9429bc4ba40dc782d","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3761205123,"blockNumber":1,"slotNumber":2,"timestamp":1749837151,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x02547d791f0062b8e0f64a2e3bb7cb80092a0e746e9f72748dd22fe01ae90e6d","archiveNextLeafIndex":2} 17:48:14 [17:48:14.600] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749837187] on http://127.0.0.1:8545 17:48:14 [17:48:14.604] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:48:14 [17:48:14.613] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749837187 17:48:14 [17:48:14.614] WARN: foundation:test-date-provider Time set to 2025-06-13T17:53:07.000Z {"offset":292386,"timeMs":1749837187000} 17:48:14 [17:48:14.614] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 17:48:14 [17:48:14.616] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 17:48:14 [17:48:14.682] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":9.253192999998646,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749837151,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 17:48:15 [17:48:15.101] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:15 [17:48:15.105] WARN: pxe:service No artifact found for contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f when looking for its metadata 17:48:15 [17:48:15.108] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f as part of deployment for 0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330 17:48:15 [17:48:15.303] VERBOSE: p2p Synched to latest block 1 17:48:15 [17:48:15.307] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:15 [17:48:15.728] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:15 [17:48:15.747] INFO: pxe:service Added contract Test at 0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330 with class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 17:48:15 [17:48:15.878] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x02547d791f0062b8e0f64a2e3bb7cb80092a0e746e9f72748dd22fe01ae90e6d","header":{"contentCommitment":{"blobsHash":"0x00896e6287c1ebd08dcbbcd0a157ed9a0c9934839596b9e2dd190168317fb396","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749837151,"version":3761205123},"lastArchive":"0x1d338d241dc91bdd36a8e92627ba542b8f96ca1f3ef939e45828425a32f40e89","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0f77f199780797182880ff6be06cc0a97261b052d78516562f40c58264e4dc15","nullifierTree":"0x2b46304e0bdb48a4b774037b6acc6eba37302c66192d4844b52bf959deabf057","publicDataTree":"0x0134428280e56c9aacf43d84859dae0866ba3c92cc79a90debd27addd7e77838"},"totalFees":6794052480,"totalManaUsed":20448}} 17:48:15 [17:48:15.887] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x02547d791f0062b8e0f64a2e3bb7cb80092a0e746e9f72748dd22fe01ae90e6d","blockNumber":2,"slot":3} 17:48:15 [17:48:15.969] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:16 [17:48:16.009] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:16 [17:48:16.056] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:16 [17:48:16.057] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:16 [17:48:16.177] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:16 [17:48:16.182] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x06740622b3fbfd0e3da3ae7a66e33e12a4b1484a17e8f6394ca92793beb83363 17:48:16 [17:48:16.198] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:48:16 [17:48:16.199] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:48:16 [17:48:16.211] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:48:16 [17:48:16.212] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:48:16 [17:48:16.255] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2741a2ad3dc8214cbad1913cef761c00014de9aea6bbf3188bd728b41e370caf","nullifier":"0x1a44487c1b460fc509e3f597adc563f42f2e35c25897c179fed7cd38a2ba0b46"} 17:48:16 [17:48:16.264] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:16 [17:48:16.265] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:16 [17:48:16.307] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba as fee payer 17:48:16 [17:48:16.365] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:48:16 [17:48:16.829] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0231f367ddb29264182678ec70e69bd06340efa7dc780f1c7522d13c96eed157,0x08fed0d02dac97b0ce237807685976eba973a7f517fc0723c067c7b7b6e121cc,0x11714ee3dfbdb30a8b2975f186d75eb58f17897f0b8ce770a03c05432642725e 17:48:16 [17:48:16.938] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 17:48:17 [17:48:17.035] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:17 [17:48:17.140] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 17:48:17 [17:48:17.157] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x02547d791f0062b8e0f64a2e3bb7cb80092a0e746e9f72748dd22fe01ae90e6d","blockNumber":2,"slot":3} 17:48:17 [17:48:17.198] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 17:48:17 [17:48:17.214] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330,0x0000000000000000000000000000000000000000000000000000000000000001,0x2dcd449ee05b3303c06b91c07ad34f0ad2691e1e2b3b809c1f4127c18f52d078,0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0eea76e1163ccfa69030e0733759dce0ccf602f045e7b4a3d9ec9b0864e70308,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba 17:48:17 [17:48:17.251] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:17 [17:48:17.968] VERBOSE: simulator:private_execution Executing private function Test:initialize {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330"} 17:48:17 [17:48:17.988] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:17 [17:48:17.997] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:17 [17:48:17.998] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330"} 17:48:18 [17:48:18.182] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x02547d791f0062b8e0f64a2e3bb7cb80092a0e746e9f72748dd22fe01ae90e6d","blockNumber":2,"slot":3} 17:48:18 [17:48:18.195] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330"} 17:48:18 [17:48:18.198] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:18 [17:48:18.215] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:18 [17:48:18.456] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:18 [17:48:18.684] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:18 [17:48:18.946] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:18 [17:48:18.949] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x02547d791f0062b8e0f64a2e3bb7cb80092a0e746e9f72748dd22fe01ae90e6d","blockNumber":2,"slot":3} 17:48:19 [17:48:19.208] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:19 [17:48:19.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:20 [17:48:20.376] INFO: pxe:service Proving completed in 4555.316871999999ms {"timings":{"total":4555.316871999999,"sync":62.73900400000093,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":835.4746370000012,"oracles":{"debugLog":{"times":[0.9228519999996934,0.518101999999999,0.6795860000001994,0.6028750000004948,0.9584940000004281,0.9913839999990159,0.6146150000004127,0.8273499999995693]},"fetchTaggedLogs":{"times":[122.2346890000008]},"loadCapsule":{"times":[0.5834830000003421,0.47615200000109326,0.5533039999991161,0.6991959999995743,2.258764999998675,2.818317000001116]},"getSharedSecret":{"times":[6.341943000001265]},"aes128Decrypt":{"times":[1.4992660000007163,1.2425610000009328]},"getPublicKeysAndPartialAddress":{"times":[2.412797999999384]},"getKeyValidationRequest":{"times":[5.596154999999271]},"deliverNote":{"times":[42.24528900000041]},"deleteCapsule":{"times":[2.5433720000000903]},"storeCapsule":{"times":[1.8072030000002997]},"getNotes":{"times":[20.79732200000035]},"getAuthWitness":{"times":[0.35800899999958347]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.10030200000073819]},"callPrivateFunction":{"times":[708.8097699999998,211.56974400000036,970.1125129999982]}}},{"functionName":"private_kernel_init","time":103.05242599999838},{"functionName":"ContractClassRegisterer:register","time":690.744362999998,"oracles":{"loadCapsule":{"times":[4.188410999999178]},"notifyCreatedNullifier":{"times":[0.7404380000007222]},"debugLog":{"times":[0.7542979999998352]},"notifyCreatedContractClassLog":{"times":[9.802986000000601]}}},{"functionName":"private_kernel_inner","time":151.830922000001},{"functionName":"ContractInstanceDeployer:deploy","time":126.25541499999781,"oracles":{"storeInExecutionCache":{"times":[0.23180599999977858]},"callPrivateFunction":{"times":[63.171064000000115]},"notifyCreatedNullifier":{"times":[0.41879100000005565]},"debugLog":{"times":[0.6020750000006956]}}},{"functionName":"private_kernel_inner","time":156.65751899999668},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":38.3220450000008,"oracles":{}},{"functionName":"private_kernel_inner","time":178.8366939999978},{"functionName":"Test:initialize","time":596.4898090000024,"oracles":{"getContractInstance":{"times":[7.616044000002148]},"debugLog":{"times":[0.6740769999996701,0.3730890000006184]},"fetchTaggedLogs":{"times":[198.96514899999966]},"loadCapsule":{"times":[0.22966599999926984,0.2600370000000112,0.1933339999995951]},"notifyCreatedNullifier":{"times":[0.17847400000027847]}}},{"functionName":"private_kernel_inner","time":142.89486699999907},{"functionName":"private_kernel_reset","time":195.3609030000007},{"functionName":"private_kernel_tail","time":70.34190700000181}],"unaccounted":1206.3163610000029}} 17:48:20 [17:48:20.398] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:20 [17:48:20.403] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x02547d791f0062b8e0f64a2e3bb7cb80092a0e746e9f72748dd22fe01ae90e6d","blockNumber":2,"slot":3} 17:48:20 [17:48:20.550] VERBOSE: p2p:tx_pool Adding tx 0x27c97f3ee3291cfc0210830405c288b52aae81784b579dcd6cbe200199871305 to pool {"eventName":"tx-added-to-pool","txHash":"0x27c97f3ee3291cfc0210830405c288b52aae81784b579dcd6cbe200199871305","noteHashCount":0,"nullifierCount":4,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":583,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 17:48:20 [17:48:20.588] INFO: node Received tx 0x27c97f3ee3291cfc0210830405c288b52aae81784b579dcd6cbe200199871305 {"txHash":"0x27c97f3ee3291cfc0210830405c288b52aae81784b579dcd6cbe200199871305"} 17:48:20 [17:48:20.589] INFO: pxe:service Sent transaction 0x27c97f3ee3291cfc0210830405c288b52aae81784b579dcd6cbe200199871305 17:48:20 [17:48:20.607] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:20 [17:48:20.811] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:20 [17:48:20.959] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 17:48:20 [17:48:20.978] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-13T17:53:07.000Z","now":"2025-06-13T17:53:13.364Z"} 17:48:21 [17:48:21.061] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:21 [17:48:21.291] VERBOSE: simulator:public-processor Processed tx 0x27c97f3ee3291cfc0210830405c288b52aae81784b579dcd6cbe200199871305 with no public calls in 211.56052400000044ms {"txHash":"0x27c97f3ee3291cfc0210830405c288b52aae81784b579dcd6cbe200199871305","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":211.56052400000044} 17:48:21 [17:48:21.293] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:21 [17:48:21.299] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3198703060000007s {"duration":0.3198703060000007,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":310272,"l2Gas":21888},"totalSizeInBytes":19648} 17:48:21 [17:48:21.484] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x252234387d7a62e3161b03eea99ac26a8efafb42a64dfd417927db1f335d1d74","globalVariables":{"chainId":31337,"version":3761205123,"blockNumber":2,"slotNumber":3,"timestamp":1749837187,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x27c97f3ee3291cfc0210830405c288b52aae81784b579dcd6cbe200199871305"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":524.1450039999982,"publicProcessDuration":320.42493000000104,"rollupCircuitsDuration":506.8729770000027,"txCount":1,"blockNumber":2,"blockTimestamp":1749837187,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 17:48:21 [17:48:21.488] VERBOSE: sequencer Attesting committee is empty 17:48:21 [17:48:21.583] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:21 [17:48:21.781] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x011a51962dca23b7b7e8b0a6d61999d7b2bd9b7ae6bcc2db0872c264b18af814 17:48:21 [17:48:21.781] VERBOSE: sequencer-client Sent L1 transaction 0x011a51962dca23b7b7e8b0a6d61999d7b2bd9b7ae6bcc2db0872c264b18af814 {"gasLimit":470269,"maxFeePerGas":"1.303611172","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:48:21 [17:48:21.788] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:21 [17:48:21.798] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:48:21 [17:48:21.799] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x011a51962dca23b7b7e8b0a6d61999d7b2bd9b7ae6bcc2db0872c264b18af814","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":2,"blockTimestamp":1749837187,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 17:48:21 [17:48:21.799] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:48:21 [17:48:21.803] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 17:48:21 [17:48:21.806] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 17:48:21 [17:48:21.810] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 17:48:21 [17:48:21.814] INFO: blob-sink:server Received blob sidecar for block 0xadb40ca0232489a3df1a3b3ff3d54ddef35ba4d37707e352ebe4928c6ff30115 17:48:21 [17:48:21.825] INFO: blob-sink:server Blob sidecar stored successfully for block 0xadb40ca0232489a3df1a3b3ff3d54ddef35ba4d37707e352ebe4928c6ff30115 17:48:21 [17:48:21.827] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749837223] on http://127.0.0.1:8545 17:48:21 [17:48:21.829] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:48:21 [17:48:21.830] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749837223 17:48:21 [17:48:21.831] WARN: foundation:test-date-provider Time set to 2025-06-13T17:53:43.000Z {"offset":321169,"timeMs":1749837223000} 17:48:21 [17:48:21.831] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 17:48:21 [17:48:21.993] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:22 [17:48:22.267] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:22 [17:48:22.282] VERBOSE: archiver:block-helper Store contract instance at 0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330 17:48:22 [17:48:22.301] VERBOSE: archiver:block-helper Store contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 17:48:22 [17:48:22.342] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x252234387d7a62e3161b03eea99ac26a8efafb42a64dfd417927db1f335d1d74","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3761205123,"blockNumber":2,"slotNumber":3,"timestamp":1749837187,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x29cfb846e74c12e3702e5621ed6a8d91354af55d9ae391b454745b0593b0545c","archiveNextLeafIndex":3} 17:48:22 [17:48:22.360] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 17:48:22 [17:48:22.390] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.126035999997839,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749837187,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 17:48:22 [17:48:22.468] VERBOSE: p2p Synched to latest block 2 17:48:22 [17:48:22.471] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:22 [17:48:22.783] INFO: aztecjs:deploy_sent_tx Contract 0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330 successfully deployed. 17:48:22 [17:48:22.786] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:22 [17:48:22.815] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x29cfb846e74c12e3702e5621ed6a8d91354af55d9ae391b454745b0593b0545c","header":{"contentCommitment":{"blobsHash":"0x001b00f2960c2939892c9da0e4fb4fe34f7135bf1215ab22a9b43c13851dc04a","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749837187,"version":3761205123},"lastArchive":"0x02547d791f0062b8e0f64a2e3bb7cb80092a0e746e9f72748dd22fe01ae90e6d","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0f77f199780797182880ff6be06cc0a97261b052d78516562f40c58264e4dc15","nullifierTree":"0x0b7c774aa538403d1fea8bfa901fd66a9aafb71a8583ba76edbb83343e89b016","publicDataTree":"0x2091228d457cb5a78ce4a09dd1eb261fd0a0f40d1ad65412fa49ab757f70ce19"},"totalFees":7272506880,"totalManaUsed":21888}} 17:48:22 [17:48:22.900] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:22 [17:48:22.938] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:22 [17:48:22.939] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:22 [17:48:22.985] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x29cfb846e74c12e3702e5621ed6a8d91354af55d9ae391b454745b0593b0545c","blockNumber":3,"slot":4} 17:48:22 [17:48:22.994] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:23 [17:48:23.017] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba"} 17:48:23 [17:48:23.023] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x06740622b3fbfd0e3da3ae7a66e33e12a4b1484a17e8f6394ca92793beb83363 17:48:23 [17:48:23.034] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 17:48:23 [17:48:23.035] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:48:23 [17:48:23.040] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:48:23 [17:48:23.040] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:48:23 [17:48:23.043] VERBOSE: pxe:service Added note {"index":0,"contract":"0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x2741a2ad3dc8214cbad1913cef761c00014de9aea6bbf3188bd728b41e370caf","nullifier":"0x1a44487c1b460fc509e3f597adc563f42f2e35c25897c179fed7cd38a2ba0b46"} 17:48:23 [17:48:23.045] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:23 [17:48:23.062] VERBOSE: simulator:client_execution_context:debug_log Setting 0x0c4fe60d88065ff32b90556c73e20e51d794fd7eecb3d074d1cb374e53dfe6ba as fee payer 17:48:23 [17:48:23.300] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:23 [17:48:23.675] VERBOSE: simulator:private_execution Executing private function Test:set_constant {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330"} 17:48:23 [17:48:23.692] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 17:48:23 [17:48:23.693] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330"} 17:48:23 [17:48:23.696] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:23 [17:48:23.904] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:23 [17:48:23.916] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x29cfb846e74c12e3702e5621ed6a8d91354af55d9ae391b454745b0593b0545c","blockNumber":3,"slot":4} 17:48:23 [17:48:23.936] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330"} 17:48:23 [17:48:23.942] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:24 [17:48:24.131] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:24 [17:48:24.563] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:24 [17:48:24.771] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:24 [17:48:24.781] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x29cfb846e74c12e3702e5621ed6a8d91354af55d9ae391b454745b0593b0545c","blockNumber":3,"slot":4} 17:48:25 [17:48:25.061] INFO: pxe:service Proving completed in 2254.2008800000003ms {"timings":{"total":2254.2008800000003,"sync":10.822581000000355,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":608.2878939999973,"oracles":{"debugLog":{"times":[0.5838149999981397,0.33079799999904935,0.35588799999823095,0.4198099999994156,0.33186799999748473,0.26250599999912083,0.822359999998298,0.5285829999993439]},"fetchTaggedLogs":{"times":[82.21005399999922]},"loadCapsule":{"times":[0.21458499999789638,0.3671380000014324,0.3767489999991085,0.2401160000008531,0.5005520000013348,0.4099499999974796]},"getSharedSecret":{"times":[3.9467050000021118]},"aes128Decrypt":{"times":[0.2931570000000647,1.0964160000003176]},"getPublicKeysAndPartialAddress":{"times":[1.3603629999997793]},"getKeyValidationRequest":{"times":[1.4555450000007113]},"deliverNote":{"times":[2.763236999999208]},"deleteCapsule":{"times":[0.27911699999822304]},"storeCapsule":{"times":[0.45928099999946426]},"getNotes":{"times":[3.717900000003283]},"getAuthWitness":{"times":[0.2115849999972852]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0569020000002638]},"callPrivateFunction":{"times":[883.6582879999987]}}},{"functionName":"private_kernel_init","time":79.93890800000008},{"functionName":"Test:set_constant","time":505.989837000001,"oracles":{"debugLog":{"times":[0.694006999998237,0.3049879999998666]},"fetchTaggedLogs":{"times":[248.1523269999998]},"loadCapsule":{"times":[0.22543600000062725,0.17201399999976275,0.1964250000019092]},"notifyCreatedNullifier":{"times":[0.1586440000028233]},"notifyCreatedNote":{"times":[0.1056429999989632]}}},{"functionName":"private_kernel_inner","time":165.24133599999914},{"functionName":"private_kernel_reset","time":231.56864599999972},{"functionName":"private_kernel_tail","time":66.46297300000151}],"unaccounted":585.8887050000012}} 17:48:25 [17:48:25.079] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:25 [17:48:25.098] VERBOSE: p2p:tx_pool Adding tx 0x0cc71d53c8962148235263e37919a1dea0b3f40df9a64a97258ef9097630365c to pool {"eventName":"tx-added-to-pool","txHash":"0x0cc71d53c8962148235263e37919a1dea0b3f40df9a64a97258ef9097630365c","noteHashCount":1,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 17:48:25 [17:48:25.104] INFO: node Received tx 0x0cc71d53c8962148235263e37919a1dea0b3f40df9a64a97258ef9097630365c {"txHash":"0x0cc71d53c8962148235263e37919a1dea0b3f40df9a64a97258ef9097630365c"} 17:48:25 [17:48:25.105] INFO: pxe:service Sent transaction 0x0cc71d53c8962148235263e37919a1dea0b3f40df9a64a97258ef9097630365c 17:48:25 [17:48:25.283] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:25 [17:48:25.312] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 17:48:25 [17:48:25.327] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-13T17:53:43.000Z","now":"2025-06-13T17:53:46.496Z"} 17:48:25 [17:48:25.349] VERBOSE: simulator:public-processor Processed tx 0x0cc71d53c8962148235263e37919a1dea0b3f40df9a64a97258ef9097630365c with no public calls in 13.253709999997227ms {"txHash":"0x0cc71d53c8962148235263e37919a1dea0b3f40df9a64a97258ef9097630365c","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":13.253709999997227} 17:48:25 [17:48:25.350] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02232884800000102s {"duration":0.02232884800000102,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":2048,"l2Gas":15104},"totalSizeInBytes":352} 17:48:25 [17:48:25.451] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x27cffcd8fe6d7d49ff2982bcebaa67a415a5d0e520f2f4cce54f206240e08d02","globalVariables":{"chainId":31337,"version":3761205123,"blockNumber":3,"slotNumber":4,"timestamp":1749837223,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0cc71d53c8962148235263e37919a1dea0b3f40df9a64a97258ef9097630365c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":139.28974000000017,"publicProcessDuration":22.710738000001584,"rollupCircuitsDuration":125.16078899999775,"txCount":1,"blockNumber":3,"blockTimestamp":1749837223,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:48:25 [17:48:25.454] VERBOSE: sequencer Attesting committee is empty 17:48:25 [17:48:25.545] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:25 [17:48:25.786] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:25 [17:48:25.798] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x1161d62ddff90a671d0c72f3d33941259fb918bc9850fb2477dd37b0f9da9e38 17:48:25 [17:48:25.798] VERBOSE: sequencer-client Sent L1 transaction 0x1161d62ddff90a671d0c72f3d33941259fb918bc9850fb2477dd37b0f9da9e38 {"gasLimit":470234,"maxFeePerGas":"1.279583373","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:48:25 [17:48:25.809] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749837259] on http://127.0.0.1:8545 17:48:25 [17:48:25.811] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 17:48:25 [17:48:25.814] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:48:25 [17:48:25.814] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x1161d62ddff90a671d0c72f3d33941259fb918bc9850fb2477dd37b0f9da9e38","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":3,"blockTimestamp":1749837223,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:48:25 [17:48:25.815] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:48:25 [17:48:25.818] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749837259 17:48:25 [17:48:25.818] WARN: foundation:test-date-provider Time set to 2025-06-13T17:54:19.000Z {"offset":353182,"timeMs":1749837259000} 17:48:25 [17:48:25.818] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 17:48:25 [17:48:25.822] INFO: blob-sink:server Received blob sidecar for block 0x145ac15050ed9f8baa4208c0b5f7fca990d2e49d79b5b0713cecbf2758a3d582 17:48:25 [17:48:25.826] INFO: blob-sink:server Blob sidecar stored successfully for block 0x145ac15050ed9f8baa4208c0b5f7fca990d2e49d79b5b0713cecbf2758a3d582 17:48:25 [17:48:25.991] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:25 [17:48:25.997] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 17:48:26 [17:48:25.999] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 17:48:26 [17:48:26.002] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 17:48:26 [17:48:26.255] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:26 [17:48:26.272] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x27cffcd8fe6d7d49ff2982bcebaa67a415a5d0e520f2f4cce54f206240e08d02","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":3761205123,"blockNumber":3,"slotNumber":4,"timestamp":1749837223,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x24d88deacb68f140f25a9166fa8550bdacb2f0697a9be7ca4c6ba159f18e8c96","archiveNextLeafIndex":4} 17:48:26 [17:48:26.274] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 17:48:26 [17:48:26.378] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":8.037825999999768,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749837223,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:48:26 [17:48:26.383] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x24d88deacb68f140f25a9166fa8550bdacb2f0697a9be7ca4c6ba159f18e8c96","header":{"contentCommitment":{"blobsHash":"0x001e80c77eefdd541716b773023293b501766551c5846dab826de68edbd8e6c5","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749837223,"version":3761205123},"lastArchive":"0x29cfb846e74c12e3702e5621ed6a8d91354af55d9ae391b454745b0593b0545c","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x02565eacdd444e2e682edeb2983b9112b578eeb5599c8d287f2d572ceb4c1d74","nullifierTree":"0x15fc04647c97800ec195f6e47ffddb3583bf82d552091230caa19047a2068649","publicDataTree":"0x11d1e1bd774d90d051cd4fbb14d2b0f4662e21b0cf4a4e789ba7f0f82219b8a9"},"totalFees":5018455040,"totalManaUsed":15104}} 17:48:26 [17:48:26.389] VERBOSE: p2p Synched to latest block 3 17:48:26 [17:48:26.524] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:26 [17:48:26.858] VERBOSE: simulator Executing utility function deliver_note {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330","selector":"0x09d61d7b"} 17:48:26 [17:48:26.872] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:26 [17:48:26.878] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:48:26 [17:48:26.878] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330"} 17:48:27 [17:48:27.087] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:27 [17:48:27.096] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x24d88deacb68f140f25a9166fa8550bdacb2f0697a9be7ca4c6ba159f18e8c96","blockNumber":4,"slot":5} 17:48:27 [17:48:27.187] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330"} 17:48:27 [17:48:27.191] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:27 [17:48:27.191] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 17:48:27 [17:48:27.193] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 17:48:27 [17:48:27.193] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 17:48:27 [17:48:27.196] VERBOSE: pxe:service Added note {"index":128,"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08e500e73b7c9f20b0a0d01d9121e9f6deecdebdad166cc19bd8217d3e878f36","nullifier":"0x1c637b48912da5f2efc2cc0a3077491003f38ed8b26d5a0504cd1ec11c4cf3a3"} 17:48:27 [17:48:27.197] VERBOSE: simulator Utility simulation for 0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330.0x09d61d7b completed 17:48:27 [17:48:27.337] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:27 [17:48:27.592] VERBOSE: simulator Executing utility function get_constant {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330","selector":"0xc2a89417"} 17:48:27 [17:48:27.601] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 17:48:27 [17:48:27.605] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 17:48:27 [17:48:27.605] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330"} 17:48:27 [17:48:27.760] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x24d88deacb68f140f25a9166fa8550bdacb2f0697a9be7ca4c6ba159f18e8c96","blockNumber":4,"slot":5} 17:48:27 [17:48:27.762] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330"} 17:48:27 [17:48:27.766] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 17:48:27 [17:48:27.768] VERBOSE: simulator Utility simulation for 0x077c6784b3ed8874cce38f9f1d5ebce17a9f605c7d362b535154f145cda43330.0xc2a89417 completed 17:48:27 [17:48:27.772] INFO: node Stopping 17:48:27 [17:48:27.773] INFO: slasher Slasher client stopped. 17:48:27 [17:48:27.773] INFO: sequencer Stopped sequencer 17:48:27 [17:48:27.773] INFO: p2p P2P client stopped. 17:48:27 [17:48:27.775] INFO: world_state Stopped world state synchronizer 17:48:27 [17:48:27.775] INFO: archiver Stopped. 17:48:27 [17:48:27.776] INFO: node Stopped 17:48:27 [17:48:27.776] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up ACVM state 17:48:27 [17:48:27.776] INFO: e2e:e2e_offchain_note_delivery Cleaning up ACVM temp directory /tmp/98bd470b 17:48:27 [17:48:27.777] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up BB state 17:48:27 [17:48:27.787] INFO: blob-sink:server Stopping blob sink 17:48:27 [17:48:27.787] INFO: blob-sink:server Blob sink stopped 17:48:27 [17:48:27.788] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up data directory at /tmp/4c6473e3b48df008 17:48:27 PASS src/e2e_offchain_note_delivery.test.ts 17:48:27 e2e_offchain_note_delivery 17:48:27 can create a note that is not broadcast, deliver it offchain and read it (19909 ms) 17:48:27 17:48:27 Test Suites: 1 passed, 1 total 17:48:27 Tests: 1 passed, 1 total 17:48:27 Snapshots: 0 total 17:48:27 Time: 26.363 s 17:48:27 Ran all test suites matching /src\/e2e_offchain_note_delivery.test.ts/i. 17:48:27 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?