Parent Log: http://ci.aztec-labs.com/08c315a53e9a1c87 Command: d2a1f586812a792c: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/71fe6b444df8fafa5531226cf458dbd22d2f3ab7 Env: REF_NAME=gh-readonly-queue/master/pr-15117-c06f30929f18b85bcea93c0926a8d640a3819f00 CURRENT_VERSION=0.87.8 CI_FULL=1 Date: Tue Jun 17 19:25:37 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15117_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_e9737a394094636f_master 19:25:37 +++ id -u 19:25:37 +++ id -g 19:25:37 ++ 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'\''' 19:25:37 + cid=29893bc8751107665c628bda57c3d0bbf8440021756c3fd0e07a0cb95dc496a7 19:25:37 + set +x 19:25:38 {"level":25,"time":1750188338246,"pid":12,"hostname":"29893bc87511","module":"logger","msg":"Logger initialized with level verbose"} 19:25:44 [19:25:44.149] 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 19:25:44 [19:25:44.256] INFO: e2e:e2e_offchain_note_delivery Logging metrics to log/e2e_offchain_note_delivery.jsonl 19:25:44 [19:25:44.532] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-CAwmJ6/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 19:25:44 [19:25:44.568] INFO: e2e:e2e_offchain_note_delivery Calling anvil_setBlockTimestampInterval with params: [12] 19:25:44 [19:25:44.593] WARN: e2e:e2e_offchain_note_delivery Set block interval to 12 19:25:44 [19:25:44.594] VERBOSE: e2e:e2e_offchain_note_delivery Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:25:44 [19:25:44.644] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 19:25:44 [19:25:44.653] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 19:25:44 [19:25:44.670] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 19:25:44 [19:25:44.675] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 19:25:44 [19:25:44.693] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 19:25:44 [19:25:44.725] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 19:25:44 [19:25:44.747] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 19:25:44 [19:25:44.753] VERBOSE: e2e:e2e_offchain_note_delivery Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 19:25:44 [19:25:44.770] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 19:25:44 [19:25:44.775] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 19:25:44 [19:25:44.790] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 19:25:44 [19:25:44.797] VERBOSE: e2e:e2e_offchain_note_delivery Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 19:25:44 [19:25:44.798] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for deployments to complete 19:25:44 [19:25:44.799] INFO: e2e:e2e_offchain_note_delivery Waiting for 6 transactions to be mined... 19:25:44 [19:25:44.822] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 19:25:44 [19:25:44.841] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 19:25:44 [19:25:44.842] VERBOSE: e2e:e2e_offchain_note_delivery Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 19:25:44 [19:25:44.854] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 19:25:44 [19:25:44.878] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 19:25:44 [19:25:44.883] VERBOSE: e2e:e2e_offchain_note_delivery Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 19:25:44 [19:25:44.901] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 19:25:44 [19:25:44.901] VERBOSE: e2e:e2e_offchain_note_delivery Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 19:25:44 [19:25:44.930] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 19:25:44 [19:25:44.937] VERBOSE: e2e:e2e_offchain_note_delivery Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 19:25:44 [19:25:44.955] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 19:25:44 [19:25:44.955] VERBOSE: e2e:e2e_offchain_note_delivery Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 19:25:44 [19:25:44.956] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for deployments to complete 19:25:44 [19:25:44.956] INFO: e2e:e2e_offchain_note_delivery Waiting for 8 transactions to be mined... 19:25:44 [19:25:44.982] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 19:25:44 [19:25:44.995] VERBOSE: e2e:e2e_offchain_note_delivery Deployed shared contracts 19:25:45 [19:25:45.017] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 19:25:45 [19:25:45.018] VERBOSE: e2e:e2e_offchain_note_delivery Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 19:25:45 [19:25:45.029] 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} 19:25:45 [19:25:45.048] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 19:25:45 [19:25:45.077] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 19:25:45 [19:25:45.083] VERBOSE: e2e:e2e_offchain_note_delivery Awaiting for linked libraries to be deployed 19:25:45 [19:25:45.130] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x2a4d92171de9db6f0e03d57f05db3b0a2c0fa747d46fe5a5fd44df8b7bef91c4 {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 19:25:45 [19:25:45.150] 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} 19:25:45 [19:25:45.151] INFO: e2e:e2e_offchain_note_delivery Waiting for 9 transactions to be mined... 19:25:45 [19:25:45.187] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 19:25:45 [19:25:45.188] VERBOSE: e2e:e2e_offchain_note_delivery All core contracts have been deployed 19:25:45 [19:25:45.206] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 19:25:45 [19:25:45.206] VERBOSE: e2e:e2e_offchain_note_delivery Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 19:25:45 [19:25:45.217] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 19:25:45 [19:25:45.220] VERBOSE: e2e:e2e_offchain_note_delivery Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 19:25:45 [19:25:45.245] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 19:25:45 [19:25:45.245] VERBOSE: e2e:e2e_offchain_note_delivery Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 19:25:45 [19:25:45.246] INFO: e2e:e2e_offchain_note_delivery Waiting for 10 transactions to be mined... 19:25:45 [19:25:45.266] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 19:25:45 [19:25:45.271] VERBOSE: e2e:e2e_offchain_note_delivery Rollup deployed 19:25:45 [19:25:45.272] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for rollup and slash factory to be deployed 19:25:45 [19:25:45.272] INFO: e2e:e2e_offchain_note_delivery Waiting for 10 transactions to be mined... 19:25:45 [19:25:45.296] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 19:25:45 [19:25:45.296] VERBOSE: e2e:e2e_offchain_note_delivery All transactions for L1 deployment have been mined 19:25:45 [19:25:45.317] 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"} 19:25:45 [19:25:45.320] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 19:25:45 [19:25:45.322] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:45 [19:25:45.323] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 19:25:45 [19:25:45.323] INFO: telemetry:client Using NoopTelemetryClient 19:25:45 [19:25:45.329] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/9d25624a47c970c7/blob-sink with map size 134217728 KB (LMDB v2) 19:25:45 [19:25:45.330] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 19:25:45 [19:25:45.330] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 19:25:45 [19:25:45.333] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:45 [19:25:45.335] INFO: aztecjs:utils:watcher New L1 time: 1750188584 19:25:45 [19:25:45.336] WARN: foundation:test-date-provider Time set to 2025-06-17T19:29:44.000Z {"offset":238665,"timeMs":1750188584000} 19:25:45 [19:25:45.337] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 19:25:45 [19:25:45.346] INFO: blob-sink:server Server is running on http://localhost:33689 19:25:45 [19:25:45.346] VERBOSE: e2e:e2e_offchain_note_delivery Creating and synching an aztec node... 19:25:45 [19:25:45.347] VERBOSE: e2e:e2e_offchain_note_delivery Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/26df5e18/acvm 19:25:45 [19:25:45.348] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:33689"} 19:25:45 [19:25:45.363] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 19:25:45 [19:25:45.364] INFO: archiver:lmdb Creating archiver data store at directory /tmp/9d25624a47c970c7/archiver with map size 134217728 KB (LMDB v2) 19:25:45 [19:25:45.365] INFO: archiver:lmdb Starting data store with maxReaders 16 19:25:45 [19:25:45.604] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:45 [19:25:45.751] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:33689"} 19:25:45 [19:25:45.777] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:33689"} 19:25:45 [19:25:45.778] WARN: node:blob-sink:client No L1 consensus host urls configured 19:25:45 [19:25:45.778] WARN: node:blob-sink:client No archive client configured 19:25:45 [19:25:45.783] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x8dad7feb16041395ce353044f2949a437732f722c9270aa4b02c361018046b53 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xfeef3a3192de05ab9b8962ee420d333fc6f5bc23722f46e5a23a12079313846e","l1BlockNumber":16}} 19:25:45 [19:25:45.807] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 19:25:45 [19:25:45.813] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:45 [19:25:45.827] INFO: world-state:database Creating world state data store at directory /tmp/9d25624a47c970c7/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 19:25:45 [19:25:45.868] INFO: world_state Created world state synchroniser with block history of 64 19:25:45 [19:25:45.868] WARN: node Aztec node is accepting fake proofs 19:25:45 [19:25:45.882] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/9d25624a47c970c7/p2p with map size 134217728 KB (LMDB v2) 19:25:45 [19:25:45.884] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 19:25:45 [19:25:45.885] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/9d25624a47c970c7/p2p-archive with map size 134217728 KB (LMDB v2) 19:25:45 [19:25:45.886] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 19:25:45 [19:25:45.887] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/9d25624a47c970c7/p2p-peers with map size 134217728 KB (LMDB v2) 19:25:45 [19:25:45.888] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 19:25:45 [19:25:45.890] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 19:25:45 [19:25:45.891] VERBOSE: p2p P2P is disabled. Using dummy P2P service 19:25:45 [19:25:45.894] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 19:25:45 [19:25:45.895] INFO: world_state Started world state synchronizer from block 1 19:25:45 [19:25:45.898] VERBOSE: world-state:block_stream Starting sync from block number 0 19:25:45 [19:25:45.901] INFO: p2p Starting p2p client from block 0 with empty mempools 19:25:45 [19:25:45.902] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 19:25:45 [19:25:45.904] INFO: slasher Slasher client initialized 19:25:45 [19:25:45.904] INFO: slasher Starting Slasher client... 19:25:45 [19:25:45.951] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:25:45 [19:25:45.952] VERBOSE: node All Aztec Node subsystems synced 19:25:45 [19:25:45.966] INFO: sequencer-client Deploying forwarder contract 19:25:45 [19:25:45.976] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 19:25:45 [19:25:45.997] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 19:25:45 [19:25:45.998] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 19:25:46 [19:25:46.006] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 19:25:46 [19:25:46.025] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:46 [19:25:46.045] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:25:46 [19:25:46.045] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 19:25:46 [19:25:46.046] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/26df5e18/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 19:25:46 [19:25:46.248] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 19:25:46 [19:25:46.251] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 19:25:46 [19:25:46.253] INFO: node Aztec Node version: 0.87.8 19:25:46 [19:25:46.253] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 19:25:46 [19:25:46.255] VERBOSE: e2e:e2e_offchain_note_delivery Creating a pxe... 19:25:46 [19:25:46.261] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:46 [19:25:46.268] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/0355681db0cdf9ed/pxe_data with map size 134217728 KB (LMDB v2) 19:25:46 [19:25:46.281] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1806f68eac227340ca44d88c5a9422b168a9a9148a039f9ddc102559719f5a9b","blockNumber":1,"slot":2} 19:25:46 [19:25:46.282] INFO: pxe:data:lmdb Starting data store with maxReaders 16 19:25:46 [19:25:46.484] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:46 [19:25:46.597] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 19:25:46 [19:25:46.597] INFO: pxe:service Started PXE connected to chain 31337 version 1965661658 19:25:46 [19:25:46.661] INFO: pxe:service Registered account 0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64 19:25:46 [19:25:46.730] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:46 [19:25:46.733] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 19:25:46 [19:25:46.737] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64 19:25:46 [19:25:46.901] INFO: pxe:service Added contract SchnorrAccount at 0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 19:25:46 [19:25:46.914] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1806f68eac227340ca44d88c5a9422b168a9a9148a039f9ddc102559719f5a9b","blockNumber":1,"slot":2} 19:25:46 [19:25:46.957] VERBOSE: pxe:block_stream Starting sync from block number 0 19:25:46 [19:25:46.969] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:46 [19:25:46.998] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 19:25:47 [19:25:47.113] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:25:47 [19:25:47.954] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 19:25:48 [19:25:48.089] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:25:48 [19:25:48.223] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:48 [19:25:48.281] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1806f68eac227340ca44d88c5a9422b168a9a9148a039f9ddc102559719f5a9b","blockNumber":1,"slot":2} 19:25:48 [19:25:48.434] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:25:48 [19:25:48.522] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:48 [19:25:48.536] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:25:48 [19:25:48.538] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:25:48 [19:25:48.620] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:25:48 [19:25:48.624] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:25:48 [19:25:48.745] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:48 [19:25:48.932] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:25:48 [19:25:48.982] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:25:48 [19:25:48.983] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:25:49 [19:25:49.000] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:49 [19:25:49.012] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1806f68eac227340ca44d88c5a9422b168a9a9148a039f9ddc102559719f5a9b","blockNumber":1,"slot":2} 19:25:49 [19:25:49.062] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:25:49 [19:25:49.068] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:25:49 [19:25:49.091] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64 as fee payer 19:25:49 [19:25:49.373] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:49 [19:25:49.697] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:49 [19:25:49.771] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1806f68eac227340ca44d88c5a9422b168a9a9148a039f9ddc102559719f5a9b","blockNumber":1,"slot":2} 19:25:50 [19:25:50.048] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:50 [19:25:50.632] INFO: pxe:service Proving completed in 3680.5973240000003ms {"timings":{"total":3680.5973240000003,"sync":6.518464999999196,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":235.4807269999983,"oracles":{"callPrivateFunction":{"times":[1137.8114430000005,566.2308099999991,346.5468149999997]}}},{"functionName":"private_kernel_init","time":180.904364},{"functionName":"ContractClassRegisterer:register","time":1101.428167,"oracles":{"loadCapsule":{"times":[109.59102799999891]},"notifyCreatedNullifier":{"times":[1.1910029999999097]},"debugLog":{"times":[0.9444279999988794]},"notifyCreatedContractClassLog":{"times":[10.458779999999024]}}},{"functionName":"private_kernel_inner","time":161.3114880000012},{"functionName":"SchnorrAccount:constructor","time":516.0380700000005,"oracles":{"getContractInstance":{"times":[34.53386200000023]},"debugLog":{"times":[1.019640000000436,0.38901799999985087]},"fetchTaggedLogs":{"times":[85.97252599999956]},"loadCapsule":{"times":[0.39196799999990617,0.23727400000097987,0.28841599999941536]},"notifyCreatedNullifier":{"times":[0.22235399999954097,0.4250580000007176]},"notifyCreatedNote":{"times":[0.47135899999921094]},"getRandomField":{"times":[0.5137999999988097,0.45524900000054913,0.2500949999994191,0.16256299999986368,0.16452300000128162,0.09554199999911361,0.10086199999932433,0.08631100000093284,0.09963199999947392,0.12635299999965355,0.07474199999887787]},"getIndexedTaggingSecretAsSender":{"times":[58.47545999999966]},"incrementAppTaggingSecretIndexAsSender":{"times":[39.9910660000005]}}},{"functionName":"private_kernel_inner","time":189.5174879999995},{"functionName":"SchnorrAccount:entrypoint","time":301.1998560000011,"oracles":{"debugLog":{"times":[1.7438839999995253,0.6112220000013622,1.1061909999989439]},"fetchTaggedLogs":{"times":[82.16670299999896]},"loadCapsule":{"times":[1.1773620000003575,0.8041659999998956,0.48081899999851885]},"getNotes":{"times":[4.008227000000261]},"getAuthWitness":{"times":[0.5974820000010368]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.5711100000007718]}}},{"functionName":"private_kernel_inner","time":182.14359700000023},{"functionName":"private_kernel_reset","time":187.54968999999983},{"functionName":"private_kernel_tail","time":97.23065200000019}],"unaccounted":521.2747600000002}} 19:25:50 [19:25:50.656] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:50 [19:25:50.720] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x1806f68eac227340ca44d88c5a9422b168a9a9148a039f9ddc102559719f5a9b","blockNumber":1,"slot":2} 19:25:50 [19:25:50.779] VERBOSE: p2p:tx_pool Adding tx 0x263753c06ef3d5f34eed4c28871636c76cfa08f84e2f028436c1a0e19e2e0052 to pool {"eventName":"tx-added-to-pool","txHash":"0x263753c06ef3d5f34eed4c28871636c76cfa08f84e2f028436c1a0e19e2e0052","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 19:25:50 [19:25:50.798] INFO: node Received tx 0x263753c06ef3d5f34eed4c28871636c76cfa08f84e2f028436c1a0e19e2e0052 {"txHash":"0x263753c06ef3d5f34eed4c28871636c76cfa08f84e2f028436c1a0e19e2e0052"} 19:25:50 [19:25:50.799] INFO: pxe:service Sent transaction 0x263753c06ef3d5f34eed4c28871636c76cfa08f84e2f028436c1a0e19e2e0052 19:25:50 [19:25:50.864] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:51 [19:25:51.069] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:51 [19:25:51.241] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 19:25:51 [19:25:51.258] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-17T19:30:08.000Z","now":"2025-06-17T19:29:49.923Z"} 19:25:51 [19:25:51.280] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:51 [19:25:51.586] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:51 [19:25:51.676] VERBOSE: simulator:public-processor Processed tx 0x263753c06ef3d5f34eed4c28871636c76cfa08f84e2f028436c1a0e19e2e0052 with no public calls in 291.3505670000013ms {"txHash":"0x263753c06ef3d5f34eed4c28871636c76cfa08f84e2f028436c1a0e19e2e0052","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":291.3505670000013} 19:25:51 [19:25:51.679] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.41933123799999883s {"duration":0.41933123799999883,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 19:25:51 [19:25:51.853] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:51 [19:25:51.865] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0656445bbe73eb713117cd7fb79dc25f88aa995f1135b85d228f7c5a381b1c30","globalVariables":{"chainId":31337,"version":1965661658,"blockNumber":1,"slotNumber":2,"timestamp":1750188608,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x263753c06ef3d5f34eed4c28871636c76cfa08f84e2f028436c1a0e19e2e0052"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":623.4846670000006,"publicProcessDuration":420.585701,"rollupCircuitsDuration":608.2594649999992,"txCount":1,"blockNumber":1,"blockTimestamp":1750188608,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:25:51 [19:25:51.872] VERBOSE: sequencer Attesting committee is empty 19:25:52 [19:25:52.061] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:52 [19:25:52.296] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:52 [19:25:52.305] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xfd7ede16182f9565e3a549991634a4def2c7393b59d75fb545fd9906d5d3a607 19:25:52 [19:25:52.305] VERBOSE: sequencer-client Sent L1 transaction 0xfd7ede16182f9565e3a549991634a4def2c7393b59d75fb545fd9906d5d3a607 {"gasLimit":514585,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 19:25:52 [19:25:52.322] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:25:52 [19:25:52.323] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xfd7ede16182f9565e3a549991634a4def2c7393b59d75fb545fd9906d5d3a607","calldataSize":1444,"calldataGas":12292,"txCount":1,"blockNumber":1,"blockTimestamp":1750188608,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:25:52 [19:25:52.324] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:25:52 [19:25:52.345] INFO: blob-sink:server Received blob sidecar for block 0xf20dc517c03e1fb4c9de8aff3628115593b18e9f641c042e1af9b0d732714402 19:25:52 [19:25:52.351] INFO: blob-sink:server Blob sidecar stored successfully for block 0xf20dc517c03e1fb4c9de8aff3628115593b18e9f641c042e1af9b0d732714402 19:25:52 [19:25:52.505] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 19:25:52 [19:25:52.507] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:52 [19:25:52.508] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 19:25:52 [19:25:52.513] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 19:25:52 [19:25:52.527] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188644] on http://127.0.0.1:8545 19:25:52 [19:25:52.529] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:25:52 [19:25:52.532] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188644 19:25:52 [19:25:52.532] WARN: foundation:test-date-provider Time set to 2025-06-17T19:30:44.000Z {"offset":291468,"timeMs":1750188644000} 19:25:52 [19:25:52.533] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 19:25:52 [19:25:52.713] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:52 [19:25:52.976] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:52 [19:25:52.996] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 19:25:53 [19:25:53.006] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x0656445bbe73eb713117cd7fb79dc25f88aa995f1135b85d228f7c5a381b1c30","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":1965661658,"blockNumber":1,"slotNumber":2,"timestamp":1750188608,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1a37945290c69f829aa1a60b47c0e85402ae61c0df49f739239b43f953a5628c","archiveNextLeafIndex":2} 19:25:53 [19:25:53.013] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 19:25:53 [19:25:53.480] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:53 [19:25:53.487] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":398.13297299999977,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750188608,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 19:25:53 [19:25:53.489] WARN: pxe:service No artifact found for contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f when looking for its metadata 19:25:53 [19:25:53.499] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f as part of deployment for 0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747 19:25:53 [19:25:53.704] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:53 [19:25:53.794] VERBOSE: p2p Synched to latest block 1 19:25:54 [19:25:54.113] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:54 [19:25:54.137] INFO: pxe:service Added contract Test at 0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747 with class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 19:25:54 [19:25:54.165] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x1a37945290c69f829aa1a60b47c0e85402ae61c0df49f739239b43f953a5628c","header":{"contentCommitment":{"blobsHash":"0x00598fbc63eaa61e183fffe6918998d2fc071a33f185f67529208648975f8270","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750188608,"version":1965661658},"lastArchive":"0x1806f68eac227340ca44d88c5a9422b168a9a9148a039f9ddc102559719f5a9b","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x256a620813f9ad76b6bfafbac6d0c676db3336a73af2e696e366cac139bcdcee","nullifierTree":"0x1a63bf1d6c93b56ab69b39a12044d906d1e8c0737132fd46c15cd8816b4d7820","publicDataTree":"0x1995cd61d6dfec01427b8ea5b854019a72ab625b08cd5d31d8d97c60fa996d4d"},"totalFees":6794052480,"totalManaUsed":20448}} 19:25:54 [19:25:54.281] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:25:54 [19:25:54.331] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:25:54 [19:25:54.332] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:25:54 [19:25:54.333] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:54 [19:25:54.400] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1a37945290c69f829aa1a60b47c0e85402ae61c0df49f739239b43f953a5628c","blockNumber":2,"slot":3} 19:25:54 [19:25:54.436] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:25:54 [19:25:54.441] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x189ca279bded6a584e13e0450e85297899169001248ba7b1a641a88400ff1392 19:25:54 [19:25:54.452] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:25:54 [19:25:54.452] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:25:54 [19:25:54.468] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:25:54 [19:25:54.469] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:25:54 [19:25:54.475] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1725ec629dffe310d35679076912d6bbd2f2539e7d6e7c21817abbb13dcd2cbb","nullifier":"0x29cd11af74f5f78f76fd47823a7bfb45e68f664ae418a8ff722c7e95c014bccd"} 19:25:54 [19:25:54.477] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:25:54 [19:25:54.497] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64 as fee payer 19:25:54 [19:25:54.545] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:25:55 [19:25:55.191] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0231f367ddb29264182678ec70e69bd06340efa7dc780f1c7522d13c96eed157,0x08fed0d02dac97b0ce237807685976eba973a7f517fc0723c067c7b7b6e121cc,0x11714ee3dfbdb30a8b2975f186d75eb58f17897f0b8ce770a03c05432642725e 19:25:55 [19:25:55.290] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 19:25:55 [19:25:55.355] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:55 [19:25:55.447] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 19:25:55 [19:25:55.465] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1a37945290c69f829aa1a60b47c0e85402ae61c0df49f739239b43f953a5628c","blockNumber":2,"slot":3} 19:25:55 [19:25:55.499] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 19:25:55 [19:25:55.516] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747,0x0000000000000000000000000000000000000000000000000000000000000001,0x213aac18d63c8b19a428bc3bc9baa8f5043d46fdb3151720e3e4f6d16a74738f,0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0eea76e1163ccfa69030e0733759dce0ccf602f045e7b4a3d9ec9b0864e70308,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64 19:25:55 [19:25:55.691] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:56 [19:25:56.286] VERBOSE: simulator:private_execution Executing private function Test:initialize {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747"} 19:25:56 [19:25:56.312] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:56 [19:25:56.318] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:25:56 [19:25:56.318] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747"} 19:25:56 [19:25:56.534] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:56 [19:25:56.562] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1a37945290c69f829aa1a60b47c0e85402ae61c0df49f739239b43f953a5628c","blockNumber":2,"slot":3} 19:25:56 [19:25:56.581] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747"} 19:25:56 [19:25:56.585] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:25:56 [19:25:56.798] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:57 [19:25:57.018] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:57 [19:25:57.234] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:57 [19:25:57.305] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1a37945290c69f829aa1a60b47c0e85402ae61c0df49f739239b43f953a5628c","blockNumber":2,"slot":3} 19:25:57 [19:25:57.579] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:57 [19:25:57.849] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:58 [19:25:58.359] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x1a37945290c69f829aa1a60b47c0e85402ae61c0df49f739239b43f953a5628c","blockNumber":2,"slot":3} 19:25:58 [19:25:58.638] INFO: pxe:service Proving completed in 4482.67022ms {"timings":{"total":4482.67022,"sync":11.734745000001567,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":803.4554519999874,"oracles":{"debugLog":{"times":[0.9527790000029199,0.49462900000071386,0.4890090000008058,0.4808200000006764,0.7247239999996964,0.4766989999989164,0.5136899999997695,0.7185939999981201]},"fetchTaggedLogs":{"times":[106.24173399999927]},"loadCapsule":{"times":[0.44466800000009243,0.6875729999992473,0.5777710000002116,0.27212499999950523,0.30999599999995553,0.25622500000099535]},"getSharedSecret":{"times":[3.8781439999984286]},"aes128Decrypt":{"times":[1.061839999998483,0.8212659999990137]},"getPublicKeysAndPartialAddress":{"times":[8.841808999997738]},"getKeyValidationRequest":{"times":[2.872145000001183]},"deliverNote":{"times":[5.489755000002333]},"deleteCapsule":{"times":[0.4824689999986731]},"storeCapsule":{"times":[0.4002470000014]},"getNotes":{"times":[3.0190180000026885]},"getAuthWitness":{"times":[0.3303059999998368]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.1027219999996305]},"callPrivateFunction":{"times":[854.018079999998,168.1858800000009,1069.398193000001]}}},{"functionName":"private_kernel_init","time":80.99361999999746},{"functionName":"ContractClassRegisterer:register","time":836.2767600000043,"oracles":{"loadCapsule":{"times":[5.491455999999744]},"notifyCreatedNullifier":{"times":[0.45923899999979767]},"debugLog":{"times":[0.6487429999979213]},"notifyCreatedContractClassLog":{"times":[7.703736999999819]}}},{"functionName":"private_kernel_inner","time":131.03432899999825},{"functionName":"ContractInstanceDeployer:deploy","time":102.23931699999957,"oracles":{"storeInExecutionCache":{"times":[0.3862169999993057]},"callPrivateFunction":{"times":[53.26922000000195]},"notifyCreatedNullifier":{"times":[0.30977599999823724]},"debugLog":{"times":[3.6674499999971886]}}},{"functionName":"private_kernel_inner","time":120.66402999999991},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":42.670897000003606,"oracles":{}},{"functionName":"private_kernel_inner","time":124.14985700000034},{"functionName":"Test:initialize","time":616.8918909999993,"oracles":{"getContractInstance":{"times":[10.134824999997363]},"debugLog":{"times":[0.7487639999999374,0.5036889999973937]},"fetchTaggedLogs":{"times":[265.09616500000266]},"loadCapsule":{"times":[0.2531139999991865,0.2496050000008836,0.2726650000004156]},"notifyCreatedNullifier":{"times":[0.30668599999989965]}}},{"functionName":"private_kernel_inner","time":127.74607599999945},{"functionName":"private_kernel_reset","time":211.82774600000266},{"functionName":"private_kernel_tail","time":68.4748099999997}],"unaccounted":1204.5106900000064}} 19:25:58 [19:25:58.655] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:58 [19:25:58.791] VERBOSE: p2p:tx_pool Adding tx 0x22c7f571c1c395c7b6f565115914e234649b863694cfcb8b4e4cbfa85d8fee21 to pool {"eventName":"tx-added-to-pool","txHash":"0x22c7f571c1c395c7b6f565115914e234649b863694cfcb8b4e4cbfa85d8fee21","noteHashCount":0,"nullifierCount":4,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":583,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 19:25:58 [19:25:58.809] INFO: node Received tx 0x22c7f571c1c395c7b6f565115914e234649b863694cfcb8b4e4cbfa85d8fee21 {"txHash":"0x22c7f571c1c395c7b6f565115914e234649b863694cfcb8b4e4cbfa85d8fee21"} 19:25:58 [19:25:58.810] INFO: pxe:service Sent transaction 0x22c7f571c1c395c7b6f565115914e234649b863694cfcb8b4e4cbfa85d8fee21 19:25:58 [19:25:58.860] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:58 [19:25:58.882] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 19:25:58 [19:25:58.898] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-17T19:30:44.000Z","now":"2025-06-17T19:30:50.366Z"} 19:25:59 [19:25:59.069] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:59 [19:25:59.145] VERBOSE: simulator:public-processor Processed tx 0x22c7f571c1c395c7b6f565115914e234649b863694cfcb8b4e4cbfa85d8fee21 with no public calls in 163.85245700000087ms {"txHash":"0x22c7f571c1c395c7b6f565115914e234649b863694cfcb8b4e4cbfa85d8fee21","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":163.85245700000087} 19:25:59 [19:25:59.148] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.24840809599999922s {"duration":0.24840809599999922,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":310272,"l2Gas":21888},"totalSizeInBytes":19648} 19:25:59 [19:25:59.313] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:59 [19:25:59.331] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1a5ff24af62d59fc5be011a96809c51598dd7376534eb429af3a47190605c024","globalVariables":{"chainId":31337,"version":1965661658,"blockNumber":2,"slotNumber":3,"timestamp":1750188644,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x22c7f571c1c395c7b6f565115914e234649b863694cfcb8b4e4cbfa85d8fee21"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":448.2192009999999,"publicProcessDuration":248.889185,"rollupCircuitsDuration":433.06638100000055,"txCount":1,"blockNumber":2,"blockTimestamp":1750188644,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 19:25:59 [19:25:59.334] VERBOSE: sequencer Attesting committee is empty 19:25:59 [19:25:59.520] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:59 [19:25:59.652] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x248db38ec75a811f25ac81dfa5c0e7a3ea33af504693a72a97652d9e116ffc15 19:25:59 [19:25:59.652] VERBOSE: sequencer-client Sent L1 transaction 0x248db38ec75a811f25ac81dfa5c0e7a3ea33af504693a72a97652d9e116ffc15 {"gasLimit":470298,"maxFeePerGas":"1.303611208","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:25:59 [19:25:59.663] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:25:59 [19:25:59.664] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x248db38ec75a811f25ac81dfa5c0e7a3ea33af504693a72a97652d9e116ffc15","calldataSize":1444,"calldataGas":12304,"txCount":1,"blockNumber":2,"blockTimestamp":1750188644,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 19:25:59 [19:25:59.664] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:25:59 [19:25:59.674] INFO: blob-sink:server Received blob sidecar for block 0xd177cabf49ec28c47ec2cfe698f7a92a56c213ae505c42de89649263b85166ea 19:25:59 [19:25:59.679] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188680] on http://127.0.0.1:8545 19:25:59 [19:25:59.682] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:25:59 [19:25:59.683] INFO: blob-sink:server Blob sidecar stored successfully for block 0xd177cabf49ec28c47ec2cfe698f7a92a56c213ae505c42de89649263b85166ea 19:25:59 [19:25:59.684] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188680 19:25:59 [19:25:59.685] WARN: foundation:test-date-provider Time set to 2025-06-17T19:31:20.000Z {"offset":320315,"timeMs":1750188680000} 19:25:59 [19:25:59.685] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 19:25:59 [19:25:59.723] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:25:59 [19:25:59.730] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 19:25:59 [19:25:59.731] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 19:25:59 [19:25:59.733] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 19:25:59 [19:25:59.926] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:00 [19:26:00.113] VERBOSE: archiver:block-helper Store contract instance at 0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747 19:26:00 [19:26:00.132] VERBOSE: archiver:block-helper Store contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 19:26:00 [19:26:00.155] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:00 [19:26:00.164] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x1a5ff24af62d59fc5be011a96809c51598dd7376534eb429af3a47190605c024","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":1965661658,"blockNumber":2,"slotNumber":3,"timestamp":1750188644,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x023c28e45748159d08a39c12621c64116deecc7629ed0167f28a988e584134c9","archiveNextLeafIndex":3} 19:26:00 [19:26:00.169] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 19:26:00 [19:26:00.218] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":7.5496449999991455,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750188644,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 19:26:00 [19:26:00.284] VERBOSE: p2p Synched to latest block 2 19:26:00 [19:26:00.361] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:00 [19:26:00.563] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:00 [19:26:00.704] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x023c28e45748159d08a39c12621c64116deecc7629ed0167f28a988e584134c9","blockNumber":3,"slot":4} 19:26:00 [19:26:00.765] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:00 [19:26:00.985] INFO: aztecjs:deploy_sent_tx Contract 0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747 successfully deployed. 19:26:00 [19:26:00.991] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:01 [19:26:01.022] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x023c28e45748159d08a39c12621c64116deecc7629ed0167f28a988e584134c9","header":{"contentCommitment":{"blobsHash":"0x0002e4c8aba74286d5439e59f48b8186fe954a859285e84fc6282fbb34bc9251","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750188644,"version":1965661658},"lastArchive":"0x1a37945290c69f829aa1a60b47c0e85402ae61c0df49f739239b43f953a5628c","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x256a620813f9ad76b6bfafbac6d0c676db3336a73af2e696e366cac139bcdcee","nullifierTree":"0x2cb599efd386173ad0059ed6686830a11919b48af99db027027da2560ce35011","publicDataTree":"0x139ca6921f36b53876236e66dda1da22c41c26c84e58e2aa190a355eccef9da5"},"totalFees":7272506880,"totalManaUsed":21888}} 19:26:01 [19:26:01.110] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:26:01 [19:26:01.147] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:01 [19:26:01.147] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:26:01 [19:26:01.198] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:01 [19:26:01.228] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64"} 19:26:01 [19:26:01.239] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x023c28e45748159d08a39c12621c64116deecc7629ed0167f28a988e584134c9","blockNumber":3,"slot":4} 19:26:01 [19:26:01.256] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x189ca279bded6a584e13e0450e85297899169001248ba7b1a641a88400ff1392 19:26:01 [19:26:01.268] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 19:26:01 [19:26:01.269] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:01 [19:26:01.276] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:01 [19:26:01.277] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:01 [19:26:01.280] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x1725ec629dffe310d35679076912d6bbd2f2539e7d6e7c21817abbb13dcd2cbb","nullifier":"0x29cd11af74f5f78f76fd47823a7bfb45e68f664ae418a8ff722c7e95c014bccd"} 19:26:01 [19:26:01.281] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:01 [19:26:01.294] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2006d6f0b2a03474a3aca860e674f39f5a176871bddbac0702fad5bc2f674c64 as fee payer 19:26:01 [19:26:01.423] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:01 [19:26:01.947] VERBOSE: simulator:private_execution Executing private function Test:set_constant {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747"} 19:26:01 [19:26:01.964] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 19:26:01 [19:26:01.965] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747"} 19:26:01 [19:26:01.969] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:02 [19:26:02.176] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x023c28e45748159d08a39c12621c64116deecc7629ed0167f28a988e584134c9","blockNumber":3,"slot":4} 19:26:02 [19:26:02.182] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:02 [19:26:02.194] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747"} 19:26:02 [19:26:02.198] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:02 [19:26:02.495] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:02 [19:26:02.812] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:02 [19:26:02.994] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x023c28e45748159d08a39c12621c64116deecc7629ed0167f28a988e584134c9","blockNumber":3,"slot":4} 19:26:03 [19:26:03.224] INFO: pxe:service Proving completed in 2210.0375700000004ms {"timings":{"total":2210.0375700000004,"sync":10.442580000002636,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":653.6846349999978,"oracles":{"debugLog":{"times":[0.631652000000031,0.4146980000004987,0.7357740000006743,0.7448540000004868,0.4755590000022494,0.3509459999986575,0.28475600000092527,0.5315410000002885]},"fetchTaggedLogs":{"times":[96.19324199999755]},"loadCapsule":{"times":[8.002203000000009,1.7563739999968675,1.8162850000007893,0.1727729999984149,0.18142299999817624,0.21521500000017113]},"getSharedSecret":{"times":[4.130348999999114]},"aes128Decrypt":{"times":[0.31122599999798695,1.4742780000015046]},"getPublicKeysAndPartialAddress":{"times":[2.091649999998481]},"getKeyValidationRequest":{"times":[1.82157499999812]},"deliverNote":{"times":[2.9927170000009937]},"deleteCapsule":{"times":[0.2664550000008603]},"storeCapsule":{"times":[0.23183399999834364]},"getNotes":{"times":[1.4353080000000773]},"getAuthWitness":{"times":[0.23654499999975087]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05442100000072969]},"callPrivateFunction":{"times":[908.2084270000014]}}},{"functionName":"private_kernel_init","time":62.52060699999856},{"functionName":"Test:set_constant","time":505.57336999999825,"oracles":{"debugLog":{"times":[0.7020740000007208,0.344636999998329]},"fetchTaggedLogs":{"times":[231.89055000000008]},"loadCapsule":{"times":[0.23478500000055647,0.16830299999855924,0.177203000002919]},"notifyCreatedNullifier":{"times":[0.20981400000164285]},"notifyCreatedNote":{"times":[0.11550200000056066]}}},{"functionName":"private_kernel_inner","time":134.15216900000087},{"functionName":"private_kernel_reset","time":173.86342800000057},{"functionName":"private_kernel_tail","time":71.21811399999933}],"unaccounted":598.5826670000024}} 19:26:03 [19:26:03.238] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:03 [19:26:03.257] VERBOSE: p2p:tx_pool Adding tx 0x21584d944e329b27cd826c9bcaff7ad9cb841e7347040bec27b14cf9bdf7eeb1 to pool {"eventName":"tx-added-to-pool","txHash":"0x21584d944e329b27cd826c9bcaff7ad9cb841e7347040bec27b14cf9bdf7eeb1","noteHashCount":1,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 19:26:03 [19:26:03.260] INFO: node Received tx 0x21584d944e329b27cd826c9bcaff7ad9cb841e7347040bec27b14cf9bdf7eeb1 {"txHash":"0x21584d944e329b27cd826c9bcaff7ad9cb841e7347040bec27b14cf9bdf7eeb1"} 19:26:03 [19:26:03.261] INFO: pxe:service Sent transaction 0x21584d944e329b27cd826c9bcaff7ad9cb841e7347040bec27b14cf9bdf7eeb1 19:26:03 [19:26:03.445] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:03 [19:26:03.519] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 19:26:03 [19:26:03.532] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-17T19:31:20.000Z","now":"2025-06-17T19:31:23.847Z"} 19:26:03 [19:26:03.554] VERBOSE: simulator:public-processor Processed tx 0x21584d944e329b27cd826c9bcaff7ad9cb841e7347040bec27b14cf9bdf7eeb1 with no public calls in 12.663062999999966ms {"txHash":"0x21584d944e329b27cd826c9bcaff7ad9cb841e7347040bec27b14cf9bdf7eeb1","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.663062999999966} 19:26:03 [19:26:03.555] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02198830100000123s {"duration":0.02198830100000123,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":2048,"l2Gas":15104},"totalSizeInBytes":352} 19:26:03 [19:26:03.652] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:03 [19:26:03.662] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x268a2c45f4be9421436b06cc2e641281c70af1aa94362474aad4822b210cae1f","globalVariables":{"chainId":31337,"version":1965661658,"blockNumber":3,"slotNumber":4,"timestamp":1750188680,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x21584d944e329b27cd826c9bcaff7ad9cb841e7347040bec27b14cf9bdf7eeb1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":143.53862799999843,"publicProcessDuration":22.349197999999888,"rollupCircuitsDuration":130.8711660000008,"txCount":1,"blockNumber":3,"blockTimestamp":1750188680,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:03 [19:26:03.664] VERBOSE: sequencer Attesting committee is empty 19:26:03 [19:26:03.907] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:03 [19:26:03.912] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x32a06222d70b65127953e588fe6d2d7c32636a63c4bd58befee99e5381fc1ff3 19:26:03 [19:26:03.912] VERBOSE: sequencer-client Sent L1 transaction 0x32a06222d70b65127953e588fe6d2d7c32636a63c4bd58befee99e5381fc1ff3 {"gasLimit":470269,"maxFeePerGas":"1.279583418","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 19:26:03 [19:26:03.921] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 19:26:03 [19:26:03.922] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x32a06222d70b65127953e588fe6d2d7c32636a63c4bd58befee99e5381fc1ff3","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":3,"blockTimestamp":1750188680,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:03 [19:26:03.922] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 19:26:03 [19:26:03.926] INFO: blob-sink:server Received blob sidecar for block 0x98e2005cfc4d28bf691ed3e07df7182d8ab939d64cbd751e17ca92e97f1b5fd2 19:26:03 [19:26:03.929] INFO: blob-sink:server Blob sidecar stored successfully for block 0x98e2005cfc4d28bf691ed3e07df7182d8ab939d64cbd751e17ca92e97f1b5fd2 19:26:03 [19:26:03.963] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750188716] on http://127.0.0.1:8545 19:26:03 [19:26:03.965] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 19:26:03 [19:26:03.967] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750188716 19:26:03 [19:26:03.968] WARN: foundation:test-date-provider Time set to 2025-06-17T19:31:56.000Z {"offset":352032,"timeMs":1750188716000} 19:26:03 [19:26:03.968] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 19:26:04 [19:26:04.112] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:04 [19:26:04.114] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 19:26:04 [19:26:04.117] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 19:26:04 [19:26:04.119] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 19:26:04 [19:26:04.314] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:04 [19:26:04.420] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x268a2c45f4be9421436b06cc2e641281c70af1aa94362474aad4822b210cae1f","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":1965661658,"blockNumber":3,"slotNumber":4,"timestamp":1750188680,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x14d813db9ad43e4d19394e65478656531b4f35bb5fcfe83855f926d5ba35cfc0","archiveNextLeafIndex":4} 19:26:04 [19:26:04.429] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 19:26:04 [19:26:04.516] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:04 [19:26:04.522] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":10.166043999997783,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750188680,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 19:26:04 [19:26:04.537] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x14d813db9ad43e4d19394e65478656531b4f35bb5fcfe83855f926d5ba35cfc0","header":{"contentCommitment":{"blobsHash":"0x001a39481a50cb8aa50d9f753c065b65a86f3675b8003c23318128041c570d39","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750188680,"version":1965661658},"lastArchive":"0x023c28e45748159d08a39c12621c64116deecc7629ed0167f28a988e584134c9","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x0ae3ab3d431a72c985961e8d55fa3b1df9604e6199a8f9cf42d32a4905ff5de7","nullifierTree":"0x04be1ed705c7486776dd5eade933ee9285e67c4bc0d2b2156e651d20226b761c","publicDataTree":"0x0c3c1924e0fdac945f13aabaec24950098ee201a21eaecd2f9680aac5f909f84"},"totalFees":5018455040,"totalManaUsed":15104}} 19:26:04 [19:26:04.542] VERBOSE: p2p Synched to latest block 3 19:26:04 [19:26:04.811] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:04 [19:26:04.921] VERBOSE: simulator Executing utility function deliver_note {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747","selector":"0x09d61d7b"} 19:26:04 [19:26:04.941] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:04 [19:26:04.941] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747"} 19:26:05 [19:26:05.139] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:05 [19:26:05.216] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x14d813db9ad43e4d19394e65478656531b4f35bb5fcfe83855f926d5ba35cfc0","blockNumber":4,"slot":5} 19:26:05 [19:26:05.263] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747"} 19:26:05 [19:26:05.270] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:05 [19:26:05.271] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 19:26:05 [19:26:05.273] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 19:26:05 [19:26:05.273] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 19:26:05 [19:26:05.277] VERBOSE: pxe:service Added note {"index":128,"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08e500e73b7c9f20b0a0d01d9121e9f6deecdebdad166cc19bd8217d3e878f36","nullifier":"0x2feabbcadd63b8e007e433a00e05eaead213004aa07827d7c3a4784d1fcef962"} 19:26:05 [19:26:05.278] VERBOSE: simulator Utility simulation for 0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747.0x09d61d7b completed 19:26:05 [19:26:05.467] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:05 [19:26:05.751] VERBOSE: simulator Executing utility function get_constant {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747","selector":"0xc2a89417"} 19:26:05 [19:26:05.764] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 19:26:05 [19:26:05.769] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 19:26:05 [19:26:05.769] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747"} 19:26:05 [19:26:05.926] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x14d813db9ad43e4d19394e65478656531b4f35bb5fcfe83855f926d5ba35cfc0","blockNumber":4,"slot":5} 19:26:05 [19:26:05.934] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747"} 19:26:05 [19:26:05.939] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 19:26:05 [19:26:05.942] VERBOSE: simulator Utility simulation for 0x240ed05d1df344a9f28fa16e726ca0349233971e6bc979325f2c98aa3e52d747.0xc2a89417 completed 19:26:05 [19:26:05.945] INFO: node Stopping 19:26:05 [19:26:05.945] INFO: slasher Slasher client stopped. 19:26:05 [19:26:05.945] INFO: sequencer Stopped sequencer 19:26:05 [19:26:05.946] INFO: p2p P2P client stopped. 19:26:05 [19:26:05.947] INFO: world_state Stopped world state synchronizer 19:26:05 [19:26:05.948] INFO: archiver Stopped. 19:26:05 [19:26:05.948] INFO: node Stopped 19:26:05 [19:26:05.948] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up ACVM state 19:26:05 [19:26:05.948] INFO: e2e:e2e_offchain_note_delivery Cleaning up ACVM temp directory /tmp/26df5e18 19:26:05 [19:26:05.949] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up BB state 19:26:05 [19:26:05.957] INFO: blob-sink:server Stopping blob sink 19:26:05 [19:26:05.958] INFO: blob-sink:server Blob sink stopped 19:26:05 [19:26:05.958] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up data directory at /tmp/9d25624a47c970c7 19:26:05 PASS src/e2e_offchain_note_delivery.test.ts 19:26:05 e2e_offchain_note_delivery 19:26:05 ✓ can create a note that is not broadcast, deliver it offchain and read it (21813 ms) 19:26:05 19:26:05 Test Suites: 1 passed, 1 total 19:26:05 Tests: 1 passed, 1 total 19:26:05 Snapshots: 0 total 19:26:05 Time: 27.919 s 19:26:05 Ran all test suites matching /src\/e2e_offchain_note_delivery.test.ts/i. 19:26:05 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?