Parent Log: http://ci.aztec-labs.com/2de5c189ff06ed21 Command: 97e7ef9a556fd7e6:ISOLATE=1:NAME=e2e_offchain_note_delivery yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_offchain_note_delivery.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/86553a66d6e2c437b435016db7bedec6bd794ed7 Env: REF_NAME=gh-readonly-queue/master/pr-14912-015cb0cadef6a41094c3649f32a735392e1b9693 CURRENT_VERSION=0.87.9 CI_FULL=1 Date: Wed Jun 18 15:16:54 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14912_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_e9737a394094636f_master 15:16:54 +++ id -u 15:16:54 +++ id -g 15:16:54 ++ docker run -d --name e2e_offchain_note_delivery --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_offchain_note_delivery.test.ts'\''' 15:16:54 + cid=a41701d5a6714169eab8e31cf978f062218b815e4c5890535755cf597c9e267e 15:16:54 + set +x 15:16:55 {"level":25,"time":1750259815515,"pid":12,"hostname":"a41701d5a671","module":"logger","msg":"Logger initialized with level verbose"} 15:17:01 [15:17:01.541] INFO: e2e:e2e_offchain_note_delivery Running test: e2e_offchain_note_delivery can create a note that is not broadcast, deliver it offchain and read it 15:17:01 [15:17:01.682] INFO: e2e:e2e_offchain_note_delivery Logging metrics to log/e2e_offchain_note_delivery.jsonl 15:17:01 [15:17:01.966] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-Vhne0K/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 2 threads. 15:17:02 [15:17:02.010] INFO: e2e:e2e_offchain_note_delivery Calling anvil_setBlockTimestampInterval with params: [12] 15:17:02 [15:17:02.039] WARN: e2e:e2e_offchain_note_delivery Set block interval to 12 15:17:02 [15:17:02.040] VERBOSE: e2e:e2e_offchain_note_delivery Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:17:02 [15:17:02.094] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x277e4793f6e2cd181f412eadc8be0fb7610674abaaf8a99d92d51aa23eb36c84 {"gasLimit":854274,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:17:02 [15:17:02.108] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Fee Asset at 0x5fbdb2315678afecb367f032d93f642f64180aa3 15:17:02 [15:17:02.132] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xbbbc74469f1265d31106bb407903fbfedd04f24c46b16acf881c31ce633e2ccb {"gasLimit":854259,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:17:02 [15:17:02.139] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Staking Asset at 0xe7f1725e7734ce288f8367e1bb143e90bb3f0512 15:17:02 [15:17:02.154] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x994bc32fd6a609f011a10ac8bc6574d2fdfd26878b3b63e28e02f1494c2c9169 {"gasLimit":1014492,"maxFeePerGas":"3.139083461","maxPriorityFeePerGas":"1.728"} 15:17:02 [15:17:02.172] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Registry at 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 15:17:02 [15:17:02.209] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x60ebac4bd4e7add1c487878a45aee7180d0271a7181adcda1fb8aca89f4c701c {"gasLimit":767650,"maxFeePerGas":"3.316669081","maxPriorityFeePerGas":"2.0736"} 15:17:02 [15:17:02.217] VERBOSE: e2e:e2e_offchain_note_delivery Deployed GovernanceProposer at 0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9 15:17:02 [15:17:02.242] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x1fb91a334e8f826b09df475377c78a68728a14cc881cb74236c9d8bc4340f75e {"gasLimit":2851994,"maxFeePerGas":"3.584762973","maxPriorityFeePerGas":"2.48832"} 15:17:02 [15:17:02.248] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Governance at 0xdc64a140aa3e981100a9beca4e685f962f0cf6c9 15:17:02 [15:17:02.266] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xd5c8cc40f7a77f0dce3c4e4734f239a2e090a9349db5ef6c8c8dadf318cc8e64 {"gasLimit":391705,"maxFeePerGas":"3.951216637","maxPriorityFeePerGas":"2.985984"} 15:17:02 [15:17:02.272] VERBOSE: e2e:e2e_offchain_note_delivery Deployed CoinIssuer at 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 15:17:02 [15:17:02.273] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for deployments to complete 15:17:02 [15:17:02.273] INFO: e2e:e2e_offchain_note_delivery Waiting for 6 transactions to be mined... 15:17:02 [15:17:02.304] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 15:17:02 [15:17:02.323] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 {"gasLimit":56804,"maxFeePerGas":"4.446876289","maxPriorityFeePerGas":"3.5831808"} 15:17:02 [15:17:02.324] VERBOSE: e2e:e2e_offchain_note_delivery Added coin issuer 0x5fc8d32690cc91d4c39d9d3abcbd16989f875707 as minter on fee asset in 0x947e11059041976e5e859daa9c835bfce901b80599fe54edbf5d419b9934e4a8 15:17:02 [15:17:02.336] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xfda1306c79d34e7ae73d79bc52f140c9e61e3eacfd89cda21ed1a93f5bb66a63 {"gasLimit":56647,"maxFeePerGas":"5.057899916","maxPriorityFeePerGas":"4.29981696"} 15:17:02 [15:17:02.357] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x91b758c2f235d4663ef7939c8c84edb0be532e83a816d3b03efda2f5bd9b3abf {"gasLimit":339691,"maxFeePerGas":"5.823401983","maxPriorityFeePerGas":"5.159780352"} 15:17:02 [15:17:02.365] VERBOSE: e2e:e2e_offchain_note_delivery Deployed FeeAssetHandler at 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 15:17:02 [15:17:02.378] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 {"gasLimit":56804,"maxFeePerGas":"6.772666409","maxPriorityFeePerGas":"6.191736422"} 15:17:02 [15:17:02.379] VERBOSE: e2e:e2e_offchain_note_delivery Added fee asset handler 0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6 as minter on fee asset in 0x2097f635dea4f43e7c1e68fc38da10d242d42c5446d56e0f5b207d619a900fa2 15:17:02 [15:17:02.402] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x5d2a2997fcf062ce1a4301140243773d0dbf42f8ab0309a56838a672cda47af1 {"gasLimit":1115222,"maxFeePerGas":"7.93976784","maxPriorityFeePerGas":"7.430083706"} 15:17:02 [15:17:02.409] VERBOSE: e2e:e2e_offchain_note_delivery Deployed StakingAssetHandler at 0x610178da211fef7d417bc0e6fed39f05609ad788 15:17:02 [15:17:02.424] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a {"gasLimit":56804,"maxFeePerGas":"9.362275123","maxPriorityFeePerGas":"8.916100447"} 15:17:02 [15:17:02.425] VERBOSE: e2e:e2e_offchain_note_delivery Added staking asset handler 0x610178da211fef7d417bc0e6fed39f05609ad788 as minter on staking asset in 0xf186a1655129667b8d1dee1def30ffc0151a4963115adb1019bdc9485dd5454a 15:17:02 [15:17:02.425] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for deployments to complete 15:17:02 [15:17:02.425] INFO: e2e:e2e_offchain_note_delivery Waiting for 8 transactions to be mined... 15:17:02 [15:17:02.444] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 15:17:02 [15:17:02.455] VERBOSE: e2e:e2e_offchain_note_delivery Deployed shared contracts 15:17:02 [15:17:02.479] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 {"gasLimit":84837,"maxFeePerGas":"11.093178824","maxPriorityFeePerGas":"10.699320536"} 15:17:02 [15:17:02.480] VERBOSE: e2e:e2e_offchain_note_delivery Funded reward distributor with 10000000000000000000000000 fee asset in 0xdd080c6c58752ae31c39d6d0f1ca1a681d9e82caa8bae1d7dec322e872ca3034 15:17:02 [15:17:02.491] VERBOSE: e2e:e2e_offchain_note_delivery Rollup config args {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 15:17:02 [15:17:02.508] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xf8c00080a63c2a550ff510ae9f17cb81c0369449b7596ae7ecee321c9d8dfa1c {"gasLimit":86397,"maxFeePerGas":"13.183966014","maxPriorityFeePerGas":"12.839184643"} 15:17:02 [15:17:02.538] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xe94c52fea20b31aa94745e2f80aab275814e7f1afb67fe06fd0910437db7a19a {"gasLimit":4909800,"maxFeePerGas":"15.708908398","maxPriorityFeePerGas":"15.407021571"} 15:17:02 [15:17:02.545] VERBOSE: e2e:e2e_offchain_note_delivery Awaiting for linked libraries to be deployed 15:17:02 [15:17:02.586] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x6908687782805bb61eaded67dab0cac6bbba1cfb26052912b614a9f169af48de {"gasLimit":10407409,"maxFeePerGas":"18.752757986","maxPriorityFeePerGas":"18.488425885"} 15:17:02 [15:17:02.597] VERBOSE: e2e:e2e_offchain_note_delivery Deployed Rollup at 0x0b306bf915c4d645ff596e518faf3f9669b97016 {"aztecSlotDuration":36,"aztecEpochDuration":32,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"minimumStake":100000000000000000000,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100} 15:17:02 [15:17:02.598] INFO: e2e:e2e_offchain_note_delivery Waiting for 9 transactions to be mined... 15:17:02 [15:17:02.618] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 15:17:02 [15:17:02.619] VERBOSE: e2e:e2e_offchain_note_delivery All core contracts have been deployed 15:17:02 [15:17:02.635] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a {"gasLimit":64317,"maxFeePerGas":"22.426414275","maxPriorityFeePerGas":"22.186111062"} 15:17:02 [15:17:02.635] VERBOSE: e2e:e2e_offchain_note_delivery Funding fee juice portal with 10000000000000000000000 fee juice in 0xb50c2fdf6f888692e398188f4a5bc4b4790eacbc395d9bef962e6a188cb7cb7a (accelerated test deployments) 15:17:02 [15:17:02.647] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x3b438661f5338150c9883ff175549487ede9538bbe0ebd33b95928611e2884ab {"gasLimit":716194,"maxFeePerGas":"26.850966182","maxPriorityFeePerGas":"26.623333274"} 15:17:02 [15:17:02.653] VERBOSE: e2e:e2e_offchain_note_delivery Deployed SlashFactory at 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae 15:17:02 [15:17:02.695] VERBOSE: e2e:e2e_offchain_note_delivery Sent L1 transaction 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d {"gasLimit":116953,"maxFeePerGas":"32.147280396","maxPriorityFeePerGas":"31.947999928"} 15:17:02 [15:17:02.696] VERBOSE: e2e:e2e_offchain_note_delivery Adding rollup 0x0b306bf915c4d645ff596e518faf3f9669b97016 to registry 0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0 in tx 0x51a9e8244dbb479b288e781a8e685e0dd26d60c71a4efdd3f3ce617b2ea95e2d 15:17:02 [15:17:02.696] INFO: e2e:e2e_offchain_note_delivery Waiting for 10 transactions to be mined... 15:17:02 [15:17:02.720] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 15:17:02 [15:17:02.726] VERBOSE: e2e:e2e_offchain_note_delivery Rollup deployed 15:17:02 [15:17:02.727] VERBOSE: e2e:e2e_offchain_note_delivery Waiting for rollup and slash factory to be deployed 15:17:02 [15:17:02.727] INFO: e2e:e2e_offchain_note_delivery Waiting for 10 transactions to be mined... 15:17:02 [15:17:02.755] INFO: e2e:e2e_offchain_note_delivery All transactions mined successfully 15:17:02 [15:17:02.756] VERBOSE: e2e:e2e_offchain_note_delivery All transactions for L1 deployment have been mined 15:17:02 [15:17:02.779] INFO: e2e:e2e_offchain_note_delivery Aztec L1 contracts initialized {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 15:17:02 [15:17:02.784] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://127.0.0.1:8545 15:17:02 [15:17:02.787] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:02 [15:17:02.788] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x0B306BF915C4d645ff596e518fAf3F9669b97016 15:17:02 [15:17:02.789] INFO: telemetry:client Using NoopTelemetryClient 15:17:02 [15:17:02.796] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/bce034c470c6b824/blob-sink with map size 134217728 KB (LMDB v2) 15:17:02 [15:17:02.797] WARN: aztecjs:utils:watcher Wall time is more than 24 seconds away from L1 time, mining a block and syncing clocks 15:17:02 [15:17:02.797] INFO: ethereum:cheat_codes Calling evm_mine with params: [] on http://127.0.0.1:8545 15:17:02 [15:17:02.802] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:02 [15:17:02.804] INFO: aztecjs:utils:watcher New L1 time: 1750260061 15:17:02 [15:17:02.804] WARN: foundation:test-date-provider Time set to 2025-06-18T15:21:01.000Z {"offset":238196,"timeMs":1750260061000} 15:17:02 [15:17:02.806] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 15:17:02 [15:17:02.815] INFO: blob-sink:server Server is running on http://localhost:46117 15:17:02 [15:17:02.816] VERBOSE: e2e:e2e_offchain_note_delivery Creating and synching an aztec node... 15:17:02 [15:17:02.817] VERBOSE: e2e:e2e_offchain_note_delivery Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/209f1c39/acvm 15:17:02 [15:17:02.818] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:46117"} 15:17:02 [15:17:02.840] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 15:17:02 [15:17:02.841] INFO: archiver:lmdb Creating archiver data store at directory /tmp/bce034c470c6b824/archiver with map size 134217728 KB (LMDB v2) 15:17:02 [15:17:02.842] INFO: archiver:lmdb Starting data store with maxReaders 16 15:17:03 [15:17:03.071] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:03 [15:17:03.187] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:46117"} 15:17:03 [15:17:03.208] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:46117"} 15:17:03 [15:17:03.208] WARN: node:blob-sink:client No L1 consensus host urls configured 15:17:03 [15:17:03.208] WARN: node:blob-sink:client No archive client configured 15:17:03 [15:17:03.212] INFO: archiver Starting archiver sync to rollup contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 from L1 block 16 to current L1 block 20 with hash 0x9cafeaa69e053b53481773af13131a34fac8e162affd91dee5a2902f02293149 {"blocksSynchedTo":16,"messagesSynchedTo":{"l1BlockHash":"0xb59e1ee66d2425c5b021e2cb1429f8a474af116f00eff122f88cd4bbc0ea6e57","l1BlockNumber":16}} 15:17:03 [15:17:03.232] INFO: archiver Initial archiver sync to L1 block 20 complete. {"l1BlockNumber":20,"syncPoint":{"blocksSynchedTo":20},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:17:03 [15:17:03.244] INFO: world-state:database Creating world state data store at directory /tmp/bce034c470c6b824/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:17:03 [15:17:03.271] INFO: world_state Created world state synchroniser with block history of 64 15:17:03 [15:17:03.272] WARN: node Aztec node is accepting fake proofs 15:17:03 [15:17:03.279] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:03 [15:17:03.292] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/bce034c470c6b824/p2p with map size 134217728 KB (LMDB v2) 15:17:03 [15:17:03.298] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 15:17:03 [15:17:03.300] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/bce034c470c6b824/p2p-archive with map size 134217728 KB (LMDB v2) 15:17:03 [15:17:03.302] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 15:17:03 [15:17:03.303] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/bce034c470c6b824/p2p-peers with map size 134217728 KB (LMDB v2) 15:17:03 [15:17:03.305] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 15:17:03 [15:17:03.306] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:17:03 [15:17:03.307] VERBOSE: p2p P2P is disabled. Using dummy P2P service 15:17:03 [15:17:03.311] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:17:03 [15:17:03.312] INFO: world_state Started world state synchronizer from block 1 15:17:03 [15:17:03.315] VERBOSE: world-state:block_stream Starting sync from block number 0 15:17:03 [15:17:03.317] INFO: p2p Starting p2p client from block 0 with empty mempools 15:17:03 [15:17:03.317] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 15:17:03 [15:17:03.319] INFO: slasher Slasher client initialized 15:17:03 [15:17:03.319] INFO: slasher Starting Slasher client... 15:17:03 [15:17:03.352] VERBOSE: validator Initialized validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:17:03 [15:17:03.353] VERBOSE: node All Aztec Node subsystems synced 15:17:03 [15:17:03.366] INFO: sequencer-client Deploying forwarder contract 15:17:03 [15:17:03.378] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 15:17:03 [15:17:03.396] VERBOSE: sequencer-client Sent L1 transaction 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918 {"gasLimit":436981,"maxFeePerGas":"1.353583777","maxPriorityFeePerGas":"1.2"} 15:17:03 [15:17:03.396] VERBOSE: sequencer-client Deployed contract with salt 0x000000000000000000000000f39Fd6e51aad88F6F4ce6aB8827279cffFb92266 to address 0x5075Ec8e7b5B34c80CE1041bd7988a537d858E4A in tx 0xa852e9420ee3d2b2162627e15a554cf55020e4cf63a143914c2fe05d25120918. 15:17:03 [15:17:03.406] INFO: sequencer-client Forwarder contract deployed at 0x5075ec8e7b5b34c80ce1041bd7988a537d858e4a with owner 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:17:03 [15:17:03.424] INFO: validator Started validator with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:17:03 [15:17:03.424] VERBOSE: validator Validator 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 not on the validator committee for epoch 0 15:17:03 [15:17:03.425] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/209f1c39/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":false} 15:17:03 [15:17:03.675] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 15:17:03 [15:17:03.680] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:17:03 [15:17:03.682] INFO: node Aztec Node version: 0.87.9 15:17:03 [15:17:03.683] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","governanceAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceProposerAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","rollupAddress":"0x0b306bf915c4d645ff596e518faf3f9669b97016","inboxAddress":"0xde46dabb403afc77dd67b6c69bbd44b9347ae0e7","outboxAddress":"0xd1c0400e4d1cb3e9b5b8b7571814729e72bf7061","feeJuicePortalAddress":"0x828357aaec783ab8368becae52781ff73a6dbb35","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0x75537828f2ce51be7289709686a69cbfdbb714f1","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","feeAssetHandlerAddress":"0x2279b7a0a67db372996a5fab50d91eaa73d2ebe6","stakingAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788"} 15:17:03 [15:17:03.685] VERBOSE: e2e:e2e_offchain_note_delivery Creating a pxe... 15:17:03 [15:17:03.697] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:03 [15:17:03.710] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/2daf78c8b11a8f58/pxe_data with map size 134217728 KB (LMDB v2) 15:17:03 [15:17:03.723] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29a2f93bbb4453d3944747daec5f85a7ed723efa19c9ecfad7e1d21ea0bdf404","blockNumber":1,"slot":2} 15:17:03 [15:17:03.724] INFO: pxe:data:lmdb Starting data store with maxReaders 16 15:17:03 [15:17:03.951] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:04 [15:17:04.062] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 15:17:04 [15:17:04.064] INFO: pxe:service Started PXE connected to chain 31337 version 2235602435 15:17:04 [15:17:04.130] INFO: pxe:service Registered account 0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9 15:17:04 [15:17:04.222] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:04 [15:17:04.224] WARN: pxe:service No artifact found for contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a when looking for its metadata 15:17:04 [15:17:04.228] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a as part of deployment for 0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9 15:17:04 [15:17:04.380] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29a2f93bbb4453d3944747daec5f85a7ed723efa19c9ecfad7e1d21ea0bdf404","blockNumber":1,"slot":2} 15:17:04 [15:17:04.382] INFO: pxe:service Added contract SchnorrAccount at 0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9 with class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:17:04 [15:17:04.420] VERBOSE: pxe:block_stream Starting sync from block number 0 15:17:04 [15:17:04.447] VERBOSE: simulator:private_execution Executing private function MultiCallEntrypoint:entrypoint {"contract":"0x0000000000000000000000000000000000000000000000000000000000000004"} 15:17:04 [15:17:04.489] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:04 [15:17:04.543] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:17:05 [15:17:05.339] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a,0x09c9af7c05966ce886fc47ad78b12b911fae2aa99b888dc6175a3c214b956f0e,0x0c05463206ae0d0995c03525c6103b2ea543e6d7bbdbf5b3197928455d75a9e5,0x136df56b2c789090458197f8589ee9a9215579138440b4fe7cd9d33e8d88151c 15:17:05 [15:17:05.441] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:17:05 [15:17:05.516] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:05 [15:17:05.548] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29a2f93bbb4453d3944747daec5f85a7ed723efa19c9ecfad7e1d21ea0bdf404","blockNumber":1,"slot":2} 15:17:05 [15:17:05.681] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:constructor {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:05 [15:17:05.727] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:05 [15:17:05.735] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:05 [15:17:05.736] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:05 [15:17:05.815] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:05 [15:17:05.822] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:05 [15:17:05.955] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:06 [15:17:06.127] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:06 [15:17:06.176] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:06 [15:17:06.177] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:06 [15:17:06.182] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:06 [15:17:06.249] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29a2f93bbb4453d3944747daec5f85a7ed723efa19c9ecfad7e1d21ea0bdf404","blockNumber":1,"slot":2} 15:17:06 [15:17:06.269] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:06 [15:17:06.282] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:06 [15:17:06.303] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9 as fee payer 15:17:06 [15:17:06.392] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:06 [15:17:06.681] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:06 [15:17:06.957] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:07 [15:17:07.136] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29a2f93bbb4453d3944747daec5f85a7ed723efa19c9ecfad7e1d21ea0bdf404","blockNumber":1,"slot":2} 15:17:07 [15:17:07.328] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:07 [15:17:07.971] INFO: pxe:service Proving completed in 3553.3264259999996ms {"timings":{"total":3553.3264259999996,"sync":2.7218700000012177,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":186.24535500000093,"oracles":{"callPrivateFunction":{"times":[1018.6595539999998,471.7292099999995,337.0715619999992]}}},{"functionName":"private_kernel_init","time":132.4697329999999},{"functionName":"ContractClassRegisterer:register","time":997.3877719999982,"oracles":{"loadCapsule":{"times":[27.78399200000058]},"notifyCreatedNullifier":{"times":[1.019838999998683]},"debugLog":{"times":[0.9601480000001175]},"notifyCreatedContractClassLog":{"times":[8.742991000000984]}}},{"functionName":"private_kernel_inner","time":222.36430500000097},{"functionName":"SchnorrAccount:constructor","time":422.2223300000005,"oracles":{"getContractInstance":{"times":[4.1722069999996165]},"debugLog":{"times":[0.7519940000001952,0.6054210000002058]},"fetchTaggedLogs":{"times":[84.47142499999973]},"loadCapsule":{"times":[0.6253620000006777,0.30721600000106264,0.3195049999994808]},"notifyCreatedNullifier":{"times":[0.2854850000003353,0.5647109999990789]},"notifyCreatedNote":{"times":[0.48006900000109454]},"getRandomField":{"times":[0.49776899999960733,0.3882080000003043,0.114211999998588,0.07353100000000268,0.0767519999990327,0.07066100000156439,0.06512099999963539,0.0670719999998255,0.06387100000029022,0.10607200000049488,0.0742210000007617]},"getIndexedTaggingSecretAsSender":{"times":[65.48950500000137]},"incrementAppTaggingSecretIndexAsSender":{"times":[42.375348999999915]}}},{"functionName":"private_kernel_inner","time":181.49254400000063},{"functionName":"SchnorrAccount:entrypoint","time":291.1258570000009,"oracles":{"debugLog":{"times":[0.653282000001127,0.7393030000002909,0.6424210000004678]},"fetchTaggedLogs":{"times":[100.94456799999898]},"loadCapsule":{"times":[1.821353999999701,1.424486000001707,0.7764640000004874]},"getNotes":{"times":[2.7319709999992483]},"getAuthWitness":{"times":[0.4521889999996347]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.059839000001375]}}},{"functionName":"private_kernel_inner","time":155.454796},{"functionName":"private_kernel_reset","time":224.9427220000016},{"functionName":"private_kernel_tail","time":106.7768619999988}],"unaccounted":630.122279999996}} 15:17:07 [15:17:07.997] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:08 [15:17:08.190] VERBOSE: sequencer Not enough txs to build block 1 at slot 2 (got 0 txs, need 1) {"chainTipArchive":"0x29a2f93bbb4453d3944747daec5f85a7ed723efa19c9ecfad7e1d21ea0bdf404","blockNumber":1,"slot":2} 15:17:08 [15:17:08.212] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:08 [15:17:08.215] VERBOSE: p2p:tx_pool Adding tx 0x2d41c599d50804831ad8022f8c66d12739bfd6df3d01a4ee19e91fc91ae5bae1 to pool {"eventName":"tx-added-to-pool","txHash":"0x2d41c599d50804831ad8022f8c66d12739bfd6df3d01a4ee19e91fc91ae5bae1","noteHashCount":1,"nullifierCount":3,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":7,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:17:08 [15:17:08.262] INFO: node Received tx 0x2d41c599d50804831ad8022f8c66d12739bfd6df3d01a4ee19e91fc91ae5bae1 {"txHash":"0x2d41c599d50804831ad8022f8c66d12739bfd6df3d01a4ee19e91fc91ae5bae1"} 15:17:08 [15:17:08.263] INFO: pxe:service Sent transaction 0x2d41c599d50804831ad8022f8c66d12739bfd6df3d01a4ee19e91fc91ae5bae1 15:17:08 [15:17:08.435] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:08 [15:17:08.639] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:08 [15:17:08.721] VERBOSE: sequencer Building block 1 for slot 2 {"slot":2,"blockNumber":1,"msgCount":0} 15:17:08 [15:17:08.734] VERBOSE: sequencer Processing pending txs {"slot":2,"slotStart":"2025-06-18T15:21:25.000Z","now":"2025-06-18T15:21:06.930Z"} 15:17:08 [15:17:08.913] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:09 [15:17:09.010] VERBOSE: simulator:public-processor Processed tx 0x2d41c599d50804831ad8022f8c66d12739bfd6df3d01a4ee19e91fc91ae5bae1 with no public calls in 204.6914909999996ms {"txHash":"0x2d41c599d50804831ad8022f8c66d12739bfd6df3d01a4ee19e91fc91ae5bae1","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":204.6914909999996} 15:17:09 [15:17:09.017] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.28173199600000043s {"duration":0.28173199600000043,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":20448},"totalSizeInBytes":1344} 15:17:09 [15:17:09.167] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:09 [15:17:09.178] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x266aaff796a95a849531d4b2a9c7ef0d2e8316eed8419e84013f03415186e7ab","globalVariables":{"chainId":31337,"version":2235602435,"blockNumber":1,"slotNumber":2,"timestamp":1750260085,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2d41c599d50804831ad8022f8c66d12739bfd6df3d01a4ee19e91fc91ae5bae1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":457.21914000000106,"publicProcessDuration":283.05983000000015,"rollupCircuitsDuration":445.0545259999999,"txCount":1,"blockNumber":1,"blockTimestamp":1750260085,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:17:09 [15:17:09.181] VERBOSE: sequencer Attesting committee is empty 15:17:09 [15:17:09.409] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:09 [15:17:09.652] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:09 [15:17:09.660] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x276cbfb91d639e855fb5336419a1d940ce952b60ef807a9ad47219825588df82 15:17:09 [15:17:09.660] VERBOSE: sequencer-client Sent L1 transaction 0x276cbfb91d639e855fb5336419a1d940ce952b60ef807a9ad47219825588df82 {"gasLimit":514570,"maxFeePerGas":"1.574385805","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 15:17:09 [15:17:09.674] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:17:09 [15:17:09.675] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x276cbfb91d639e855fb5336419a1d940ce952b60ef807a9ad47219825588df82","calldataSize":1444,"calldataGas":12280,"txCount":1,"blockNumber":1,"blockTimestamp":1750260085,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:17:09 [15:17:09.675] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:17:09 [15:17:09.693] INFO: blob-sink:server Received blob sidecar for block 0x440cd73ab6235c5b880211799dfc89a232f879188ad864d636a529748ecbbd27 15:17:09 [15:17:09.699] INFO: blob-sink:server Blob sidecar stored successfully for block 0x440cd73ab6235c5b880211799dfc89a232f879188ad864d636a529748ecbbd27 15:17:09 [15:17:09.727] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750260121] on http://127.0.0.1:8545 15:17:09 [15:17:09.728] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:17:09 [15:17:09.729] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750260121 15:17:09 [15:17:09.730] WARN: foundation:test-date-provider Time set to 2025-06-18T15:22:01.000Z {"offset":291270,"timeMs":1750260121000} 15:17:09 [15:17:09.730] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 15:17:09 [15:17:09.858] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:09 [15:17:09.891] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://127.0.0.1:8545 15:17:09 [15:17:09.901] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 15:17:09 [15:17:09.912] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 15:17:10 [15:17:10.068] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:10 [15:17:10.332] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:10 [15:17:10.354] VERBOSE: archiver:block-helper Store contract class 0x0729afe6a2795df3ffa50d1ebbb6f439dc372d317f0aa72e2df96bb66218286a 15:17:10 [15:17:10.360] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x266aaff796a95a849531d4b2a9c7ef0d2e8316eed8419e84013f03415186e7ab","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2235602435,"blockNumber":1,"slotNumber":2,"timestamp":1750260085,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x23c76d3c2149bc3fca0ad0a6f00f2633cb43ad874f3f1c4d05c037eb6ac705d3","archiveNextLeafIndex":2} 15:17:10 [15:17:10.378] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 15:17:10 [15:17:10.890] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:10 [15:17:10.902] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":446.27206900000056,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750260085,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 15:17:10 [15:17:10.903] WARN: pxe:service No artifact found for contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f when looking for its metadata 15:17:10 [15:17:10.909] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f as part of deployment for 0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6 15:17:11 [15:17:11.124] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:11 [15:17:11.149] VERBOSE: p2p Synched to latest block 1 15:17:11 [15:17:11.503] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:11 [15:17:11.522] INFO: pxe:service Added contract Test at 0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6 with class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 15:17:11 [15:17:11.568] VERBOSE: pxe:service Updated pxe last block to 1 {"blockHash":{},"archive":"0x23c76d3c2149bc3fca0ad0a6f00f2633cb43ad874f3f1c4d05c037eb6ac705d3","header":{"contentCommitment":{"blobsHash":"0x00cbe7d314f600fd07d9d972b756b49d38b1a8fecbe9de29b9197f0d3f19fa30","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750260085,"version":2235602435},"lastArchive":"0x29a2f93bbb4453d3944747daec5f85a7ed723efa19c9ecfad7e1d21ea0bdf404","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x196d895803d10ddb6dac60558ea6bf6f27dd127fbd2a32d85d320cb00172b3f6","nullifierTree":"0x10d4f1a8a8d411018e70e2055d0ce53d283bbcca636f80440bcdfd791276fcee","publicDataTree":"0x283aff5a197f6b8be3ce771f387d16c781c0c7df0096c04cba78b4023be7b3fb"},"totalFees":6794052480,"totalManaUsed":20448}} 15:17:11 [15:17:11.715] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:11 [15:17:11.764] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:11 [15:17:11.765] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:11 [15:17:11.768] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:11 [15:17:11.827] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x23c76d3c2149bc3fca0ad0a6f00f2633cb43ad874f3f1c4d05c037eb6ac705d3","blockNumber":2,"slot":3} 15:17:11 [15:17:11.876] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:11 [15:17:11.881] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2497f085c1262825f8dfdde9661f2057f79c272467cd065ed248397cb9183d45 15:17:11 [15:17:11.905] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:17:11 [15:17:11.906] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:17:11 [15:17:11.915] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:17:11 [15:17:11.916] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:17:11 [15:17:11.925] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0be86d0bf0a758c770beb3bcf918e965f2d08a4ac543d59041b20eeac5f961d8","nullifier":"0x030c965054a3e2e76c4e6be0007805cee3591c4e1b1d6b843f381a499e624c89"} 15:17:11 [15:17:11.933] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:11 [15:17:11.951] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9 as fee payer 15:17:11 [15:17:11.975] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:12 [15:17:12.015] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:register {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:17:12 [15:17:12.445] VERBOSE: simulator:client_execution_context:debug_log ContractClassRegistered: 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0231f367ddb29264182678ec70e69bd06340efa7dc780f1c7522d13c96eed157,0x08fed0d02dac97b0ce237807685976eba973a7f517fc0723c067c7b7b6e121cc,0x11714ee3dfbdb30a8b2975f186d75eb58f17897f0b8ce770a03c05432642725e 15:17:12 [15:17:12.546] VERBOSE: simulator:client_execution_context Emitted log from ContractClassRegisterer: "0000000000000000000000000000000000000000000000000000000000000003000000006999d1e02b08a447a463563453cb..." 15:17:12 [15:17:12.607] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:12 [15:17:12.685] VERBOSE: simulator:private_execution Executing private function ContractInstanceDeployer:deploy {"contract":"0x0000000000000000000000000000000000000000000000000000000000000002"} 15:17:12 [15:17:12.696] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x23c76d3c2149bc3fca0ad0a6f00f2633cb43ad874f3f1c4d05c037eb6ac705d3","blockNumber":2,"slot":3} 15:17:12 [15:17:12.737] VERBOSE: simulator:private_execution Executing private function ContractClassRegisterer:assert_class_id_is_registered {"contract":"0x0000000000000000000000000000000000000000000000000000000000000003"} 15:17:12 [15:17:12.750] VERBOSE: simulator:client_execution_context:debug_log ContractInstanceDeployed: 0x0000000085864497636cf755ae7bde03f267ce01a520981c21c3682aaf82a631,0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6,0x0000000000000000000000000000000000000000000000000000000000000001,0x0903a1c73e8795ebeddd8433a31eb7da3dc0ae6e65be3e1589265f6a0b4ad9a2,0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f,0x0eea76e1163ccfa69030e0733759dce0ccf602f045e7b4a3d9ec9b0864e70308,0x01498945581e0eb9f8427ad6021184c700ef091d570892c437d12c7d90364bbd,0x170ae506787c5c43d6ca9255d571c10fa9ffa9d141666e290c347c5c9ab7e344,0x00c044b05b6ca83b9c2dbae79cc1135155956a64e136819136e9947fe5e5866c,0x1c1f0ca244c7cd46b682552bff8ae77dea40b966a71de076ec3b7678f2bdb151,0x1b00316144359e9a3ec8e49c1cdb7eeb0cedd190dfd9dc90eea5115aa779e287,0x080ffc74d7a8b0bccb88ac11f45874172f3847eb8b92654aaa58a3d2b8dc7833,0x019c111f36ad3fc1d9b7a7a14344314d2864b94f030594cd67f753ef774a1efb,0x2039907fe37f08d10739255141bb066c506a12f7d1e8dfec21abc58494705b6f,0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9 15:17:12 [15:17:12.909] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:13 [15:17:13.359] VERBOSE: simulator:private_execution Executing private function Test:initialize {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6"} 15:17:13 [15:17:13.383] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:13 [15:17:13.388] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:13 [15:17:13.388] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6"} 15:17:13 [15:17:13.584] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x23c76d3c2149bc3fca0ad0a6f00f2633cb43ad874f3f1c4d05c037eb6ac705d3","blockNumber":2,"slot":3} 15:17:13 [15:17:13.598] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:13 [15:17:13.608] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6"} 15:17:13 [15:17:13.613] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:13 [15:17:13.822] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:14 [15:17:14.114] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:14 [15:17:14.374] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x23c76d3c2149bc3fca0ad0a6f00f2633cb43ad874f3f1c4d05c037eb6ac705d3","blockNumber":2,"slot":3} 15:17:14 [15:17:14.379] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:14 [15:17:14.747] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:15 [15:17:15.212] VERBOSE: sequencer Not enough txs to build block 2 at slot 3 (got 0 txs, need 1) {"chainTipArchive":"0x23c76d3c2149bc3fca0ad0a6f00f2633cb43ad874f3f1c4d05c037eb6ac705d3","blockNumber":2,"slot":3} 15:17:15 [15:17:15.433] INFO: pxe:service Proving completed in 3883.152151000002ms {"timings":{"total":3883.152151000002,"sync":20.16656999999759,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":679.8725320000012,"oracles":{"debugLog":{"times":[1.272173000001203,0.416428000000451,0.4726779999982682,0.6109319999995932,0.7639240000025893,0.3509559999984049,0.6416019999996934,1.1015509999997448]},"fetchTaggedLogs":{"times":[113.78796100000181]},"loadCapsule":{"times":[0.3086650000004738,0.3629370000016934,0.4942379999993136,3.862370999999257,0.3774669999984326,0.3408960000015213]},"getSharedSecret":{"times":[13.774812999999995]},"aes128Decrypt":{"times":[3.1497380000000703,1.3488439999964612]},"getPublicKeysAndPartialAddress":{"times":[2.9645739999978105]},"getKeyValidationRequest":{"times":[2.227300999998988]},"deliverNote":{"times":[10.081805000001623]},"deleteCapsule":{"times":[0.936106999997719]},"storeCapsule":{"times":[0.7176140000010491]},"getNotes":{"times":[2.7647410000026866]},"getAuthWitness":{"times":[0.29955600000175764]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.20056399999884889]},"callPrivateFunction":{"times":[645.9161859999986,157.7448080000031,857.452742999998]}}},{"functionName":"private_kernel_init","time":58.22388000000137},{"functionName":"ContractClassRegisterer:register","time":630.1125759999959,"oracles":{"loadCapsule":{"times":[7.210752000002685]},"notifyCreatedNullifier":{"times":[1.1991719999969064]},"debugLog":{"times":[0.9951780000010331]},"notifyCreatedContractClassLog":{"times":[9.56823599999916]}}},{"functionName":"private_kernel_inner","time":113.62603699999818},{"functionName":"ContractInstanceDeployer:deploy","time":95.51551699999982,"oracles":{"storeInExecutionCache":{"times":[0.25940500000069733]},"callPrivateFunction":{"times":[53.624885000001086]},"notifyCreatedNullifier":{"times":[0.3077659999980824]},"debugLog":{"times":[0.580019999997603]}}},{"functionName":"private_kernel_inner","time":102.0456239999985},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.52479500000118,"oracles":{}},{"functionName":"private_kernel_inner","time":174.98877500000162},{"functionName":"Test:initialize","time":533.8062360000004,"oracles":{"getContractInstance":{"times":[13.889315000000352]},"debugLog":{"times":[0.6177219999990484,0.30897600000025705]},"fetchTaggedLogs":{"times":[223.7106100000019]},"loadCapsule":{"times":[0.22551400000156718,0.11465200000020559,0.1396020000029239]},"notifyCreatedNullifier":{"times":[0.17059299999891664]}}},{"functionName":"private_kernel_inner","time":119.77520000000004},{"functionName":"private_kernel_reset","time":150.66257799999948},{"functionName":"private_kernel_tail","time":72.73792600000161}],"unaccounted":1092.0939050000052}} 15:17:15 [15:17:15.448] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:15 [15:17:15.579] VERBOSE: p2p:tx_pool Adding tx 0x050d5842444f13e9edde8a4af97f1f56d3c649f065260c2f4e72dbf8a5777dfa to pool {"eventName":"tx-added-to-pool","txHash":"0x050d5842444f13e9edde8a4af97f1f56d3c649f065260c2f4e72dbf8a5777dfa","noteHashCount":0,"nullifierCount":4,"privateLogCount":1,"classRegisteredCount":1,"contractClassLogSize":583,"proofSize":172052,"size":293088,"feePaymentMethod":"fee_juice"} 15:17:15 [15:17:15.597] INFO: node Received tx 0x050d5842444f13e9edde8a4af97f1f56d3c649f065260c2f4e72dbf8a5777dfa {"txHash":"0x050d5842444f13e9edde8a4af97f1f56d3c649f065260c2f4e72dbf8a5777dfa"} 15:17:15 [15:17:15.598] INFO: pxe:service Sent transaction 0x050d5842444f13e9edde8a4af97f1f56d3c649f065260c2f4e72dbf8a5777dfa 15:17:15 [15:17:15.652] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:15 [15:17:15.730] VERBOSE: sequencer Building block 2 for slot 3 {"slot":3,"blockNumber":2,"msgCount":0} 15:17:15 [15:17:15.746] VERBOSE: sequencer Processing pending txs {"slot":3,"slotStart":"2025-06-18T15:22:01.000Z","now":"2025-06-18T15:22:07.016Z"} 15:17:15 [15:17:15.857] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:16 [15:17:16.076] VERBOSE: simulator:public-processor Processed tx 0x050d5842444f13e9edde8a4af97f1f56d3c649f065260c2f4e72dbf8a5777dfa with no public calls in 212.9808329999978ms {"txHash":"0x050d5842444f13e9edde8a4af97f1f56d3c649f065260c2f4e72dbf8a5777dfa","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":212.9808329999978} 15:17:16 [15:17:16.079] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:16 [15:17:16.080] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.33295982700000243s {"duration":0.33295982700000243,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":310272,"l2Gas":21888},"totalSizeInBytes":19648} 15:17:16 [15:17:16.253] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0e9e6c356d7c138d98c0791ac15875d0922df40c5b63360dc733d2cd7fafa927","globalVariables":{"chainId":31337,"version":2235602435,"blockNumber":2,"slotNumber":3,"timestamp":1750260121,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x050d5842444f13e9edde8a4af97f1f56d3c649f065260c2f4e72dbf8a5777dfa"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":522.1194719999985,"publicProcessDuration":333.41760499999873,"rollupCircuitsDuration":507.44395299999815,"txCount":1,"blockNumber":2,"blockTimestamp":1750260121,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 15:17:16 [15:17:16.257] VERBOSE: sequencer Attesting committee is empty 15:17:16 [15:17:16.359] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:16 [15:17:16.582] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:16 [15:17:16.586] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x47ca3f7670a6f2c32ed041c1ca38cbfb78b1c18f24124489d9b19e99fb307638 15:17:16 [15:17:16.587] VERBOSE: sequencer-client Sent L1 transaction 0x47ca3f7670a6f2c32ed041c1ca38cbfb78b1c18f24124489d9b19e99fb307638 {"gasLimit":470188,"maxFeePerGas":"1.303611197","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:17:16 [15:17:16.604] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750260157] on http://127.0.0.1:8545 15:17:16 [15:17:16.606] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:17:16 [15:17:16.606] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x47ca3f7670a6f2c32ed041c1ca38cbfb78b1c18f24124489d9b19e99fb307638","calldataSize":1444,"calldataGas":12256,"txCount":1,"blockNumber":2,"blockTimestamp":1750260121,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 15:17:16 [15:17:16.607] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:17:16 [15:17:16.611] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:17:16 [15:17:16.614] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750260157 15:17:16 [15:17:16.614] WARN: foundation:test-date-provider Time set to 2025-06-18T15:22:37.000Z {"offset":320386,"timeMs":1750260157000} 15:17:16 [15:17:16.615] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 15:17:16 [15:17:16.618] INFO: blob-sink:server Received blob sidecar for block 0xb4fbbddcd3124ba7d2a5a5a14100a2da8d97730f3968f32b141a3eb64425a5a5 15:17:16 [15:17:16.624] INFO: blob-sink:server Blob sidecar stored successfully for block 0xb4fbbddcd3124ba7d2a5a5a14100a2da8d97730f3968f32b141a3eb64425a5a5 15:17:16 [15:17:16.786] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:16 [15:17:16.790] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://127.0.0.1:8545 15:17:16 [15:17:16.792] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 15:17:16 [15:17:16.794] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 15:17:17 [15:17:17.015] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:17 [15:17:17.036] VERBOSE: archiver:block-helper Store contract instance at 0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6 15:17:17 [15:17:17.060] VERBOSE: archiver:block-helper Store contract class 0x0cd6e6e7b5b2a59ff6e9f185228de43b82c3ec609c26a6e21bb33fa5d38bc08f 15:17:17 [15:17:17.099] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0e9e6c356d7c138d98c0791ac15875d0922df40c5b63360dc733d2cd7fafa927","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2235602435,"blockNumber":2,"slotNumber":3,"timestamp":1750260121,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1a2ae751e7a3bdf936fdfffb3b6b2c003afa43b4bfab0ee55aefd97506bd4e51","archiveNextLeafIndex":3} 15:17:17 [15:17:17.114] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 15:17:17 [15:17:17.143] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":8.186570999998366,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750260121,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":583} 15:17:17 [15:17:17.216] VERBOSE: p2p Synched to latest block 2 15:17:17 [15:17:17.221] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:17 [15:17:17.425] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:17 [15:17:17.630] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:17 [15:17:17.858] INFO: aztecjs:deploy_sent_tx Contract 0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6 successfully deployed. 15:17:17 [15:17:17.868] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:17 [15:17:17.903] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1a2ae751e7a3bdf936fdfffb3b6b2c003afa43b4bfab0ee55aefd97506bd4e51","blockNumber":3,"slot":4} 15:17:17 [15:17:17.928] VERBOSE: pxe:service Updated pxe last block to 2 {"blockHash":{},"archive":"0x1a2ae751e7a3bdf936fdfffb3b6b2c003afa43b4bfab0ee55aefd97506bd4e51","header":{"contentCommitment":{"blobsHash":"0x00de371f324cddde615b79337d1f2f34ecf83470f4be0584665448d15587396d","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750260121,"version":2235602435},"lastArchive":"0x23c76d3c2149bc3fca0ad0a6f00f2633cb43ad874f3f1c4d05c037eb6ac705d3","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x196d895803d10ddb6dac60558ea6bf6f27dd127fbd2a32d85d320cb00172b3f6","nullifierTree":"0x046066de90468fba4eaf84d39c1c09c940af54e88a2a7197ed35ca2c84e56910","publicDataTree":"0x169ed1b3b7d0f15a7afddf95816190d2687bfef3a9a8769a5bb8b9b7ab5e7b47"},"totalFees":7272506880,"totalManaUsed":21888}} 15:17:18 [15:17:18.009] VERBOSE: simulator:private_execution Executing private function SchnorrAccount:entrypoint {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:18 [15:17:18.051] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:18 [15:17:18.051] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:18 [15:17:18.083] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:18 [15:17:18.123] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9"} 15:17:18 [15:17:18.129] VERBOSE: simulator:client_execution_context:debug_log Processing log with tag 0x2497f085c1262825f8dfdde9661f2057f79c272467cd065ed248397cb9183d45 15:17:18 [15:17:18.142] VERBOSE: simulator:client_execution_context:debug_log Processing private note msg 15:17:18 [15:17:18.144] VERBOSE: simulator:client_execution_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:17:18 [15:17:18.153] VERBOSE: simulator:client_execution_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:17:18 [15:17:18.154] VERBOSE: simulator:client_execution_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:17:18 [15:17:18.161] VERBOSE: pxe:service Added note {"index":0,"contract":"0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x0be86d0bf0a758c770beb3bcf918e965f2d08a4ac543d59041b20eeac5f961d8","nullifier":"0x030c965054a3e2e76c4e6be0007805cee3591c4e1b1d6b843f381a499e624c89"} 15:17:18 [15:17:18.163] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:18 [15:17:18.181] VERBOSE: simulator:client_execution_context:debug_log Setting 0x2b8bf9be65e348aa5885c4bf3fccaf813c92f4a0282b22208feefa42cab687c9 as fee payer 15:17:18 [15:17:18.338] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:18 [15:17:18.889] VERBOSE: simulator:private_execution Executing private function Test:set_constant {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6"} 15:17:18 [15:17:18.900] VERBOSE: simulator:client_execution_context:debug_log Performing message discovery 15:17:18 [15:17:18.901] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6"} 15:17:18 [15:17:18.904] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:19 [15:17:19.065] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1a2ae751e7a3bdf936fdfffb3b6b2c003afa43b4bfab0ee55aefd97506bd4e51","blockNumber":3,"slot":4} 15:17:19 [15:17:19.086] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6"} 15:17:19 [15:17:19.089] VERBOSE: simulator:client_execution_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:19 [15:17:19.129] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:19 [15:17:19.455] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:19 [15:17:19.855] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:20 [15:17:20.006] VERBOSE: sequencer Not enough txs to build block 3 at slot 4 (got 0 txs, need 1) {"chainTipArchive":"0x1a2ae751e7a3bdf936fdfffb3b6b2c003afa43b4bfab0ee55aefd97506bd4e51","blockNumber":3,"slot":4} 15:17:20 [15:17:20.238] INFO: pxe:service Proving completed in 2322.2845049999996ms {"timings":{"total":2322.2845049999996,"sync":14.893373999999312,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":632.6725350000052,"oracles":{"debugLog":{"times":[0.650632000000769,0.5360289999989618,0.577370000002702,1.1828710000008869,0.4680479999988165,0.40083700000104727,0.4284570000017993,0.5865310000008321]},"fetchTaggedLogs":{"times":[75.93926500000089]},"loadCapsule":{"times":[0.2914550000023155,0.24291400000220165,0.5017189999998664,0.3210259999978007,0.23649500000101398,0.20332399999824702]},"getSharedSecret":{"times":[4.5099520000003395]},"aes128Decrypt":{"times":[0.3406570000006468,0.9943180000009306]},"getPublicKeysAndPartialAddress":{"times":[2.423743999999715]},"getKeyValidationRequest":{"times":[2.1862399999990885]},"deliverNote":{"times":[7.767932999999175]},"deleteCapsule":{"times":[0.25041499999861117]},"storeCapsule":{"times":[0.315945999998803]},"getNotes":{"times":[1.914955000000191]},"getAuthWitness":{"times":[0.28498599999875296]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0649809999995341]},"callPrivateFunction":{"times":[912.1263480000016]}}},{"functionName":"private_kernel_init","time":84.7963579999996},{"functionName":"Test:set_constant","time":517.0098079999989,"oracles":{"debugLog":{"times":[0.4956789999996545,0.31555500000104075]},"fetchTaggedLogs":{"times":[187.27992000000086]},"loadCapsule":{"times":[0.20003400000132388,0.1218829999997979,0.15112199999930453]},"notifyCreatedNullifier":{"times":[0.15308200000072247]},"notifyCreatedNote":{"times":[0.10270200000013574]}}},{"functionName":"private_kernel_inner","time":102.57752400000027},{"functionName":"private_kernel_reset","time":175.54962499999965},{"functionName":"private_kernel_tail","time":70.74189000000115}],"unaccounted":724.0433909999956}} 15:17:20 [15:17:20.251] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:20 [15:17:20.269] VERBOSE: p2p:tx_pool Adding tx 0x2eab14c9180cebb3713152a882bb8497a4d27388cb83ad2ebd7627d460bad291 to pool {"eventName":"tx-added-to-pool","txHash":"0x2eab14c9180cebb3713152a882bb8497a4d27388cb83ad2ebd7627d460bad291","noteHashCount":1,"nullifierCount":2,"privateLogCount":0,"classRegisteredCount":0,"contractClassLogSize":0,"proofSize":172052,"size":196480,"feePaymentMethod":"fee_juice"} 15:17:20 [15:17:20.274] INFO: node Received tx 0x2eab14c9180cebb3713152a882bb8497a4d27388cb83ad2ebd7627d460bad291 {"txHash":"0x2eab14c9180cebb3713152a882bb8497a4d27388cb83ad2ebd7627d460bad291"} 15:17:20 [15:17:20.274] INFO: pxe:service Sent transaction 0x2eab14c9180cebb3713152a882bb8497a4d27388cb83ad2ebd7627d460bad291 15:17:20 [15:17:20.454] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:20 [15:17:20.521] VERBOSE: sequencer Building block 3 for slot 4 {"slot":4,"blockNumber":3,"msgCount":0} 15:17:20 [15:17:20.535] VERBOSE: sequencer Processing pending txs {"slot":4,"slotStart":"2025-06-18T15:22:37.000Z","now":"2025-06-18T15:22:40.921Z"} 15:17:20 [15:17:20.552] VERBOSE: simulator:public-processor Processed tx 0x2eab14c9180cebb3713152a882bb8497a4d27388cb83ad2ebd7627d460bad291 with no public calls in 10.842209000002185ms {"txHash":"0x2eab14c9180cebb3713152a882bb8497a4d27388cb83ad2ebd7627d460bad291","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":10.842209000002185} 15:17:20 [15:17:20.553] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.016871369999997114s {"duration":0.016871369999997114,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":2048,"l2Gas":15104},"totalSizeInBytes":352} 15:17:20 [15:17:20.648] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0337b3d97927eb2c762dc4b007db2fb73a8ea4484301065d592ee89973f65ad3","globalVariables":{"chainId":31337,"version":2235602435,"blockNumber":3,"slotNumber":4,"timestamp":1750260157,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2eab14c9180cebb3713152a882bb8497a4d27388cb83ad2ebd7627d460bad291"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":126.65647700000045,"publicProcessDuration":17.135354999998526,"rollupCircuitsDuration":112.94466499999908,"txCount":1,"blockNumber":3,"blockTimestamp":1750260157,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:17:20 [15:17:20.649] VERBOSE: sequencer Attesting committee is empty 15:17:20 [15:17:20.725] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:20 [15:17:20.905] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xab6c325d178e02b2aaf6a6421aee0c03f77e0e22e36ac9e1d62e171bef90be49 15:17:20 [15:17:20.905] VERBOSE: sequencer-client Sent L1 transaction 0xab6c325d178e02b2aaf6a6421aee0c03f77e0e22e36ac9e1d62e171bef90be49 {"gasLimit":470160,"maxFeePerGas":"1.279583373","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:17:20 [15:17:20.917] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:17:20 [15:17:20.917] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xab6c325d178e02b2aaf6a6421aee0c03f77e0e22e36ac9e1d62e171bef90be49","calldataSize":1444,"calldataGas":12232,"txCount":1,"blockNumber":3,"blockTimestamp":1750260157,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:17:20 [15:17:20.918] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:17:20 [15:17:20.922] INFO: blob-sink:server Received blob sidecar for block 0x918e6a1371737c2cf7e92aadaf710a64f622f8fb052c65c3565f304e62dd70d0 15:17:20 [15:17:20.927] INFO: blob-sink:server Blob sidecar stored successfully for block 0x918e6a1371737c2cf7e92aadaf710a64f622f8fb052c65c3565f304e62dd70d0 15:17:20 [15:17:20.928] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:20 [15:17:20.935] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x0b306bf915c4d645ff596e518faf3f9669b97016","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://127.0.0.1:8545 15:17:20 [15:17:20.937] WARN: ethereum:cheat_codes Set L1 storage for contract 0x0b306bf915c4d645ff596e518faf3f9669b97016 at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 15:17:20 [15:17:20.938] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 15:17:20 [15:17:20.943] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1750260193] on http://127.0.0.1:8545 15:17:20 [15:17:20.944] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://127.0.0.1:8545 15:17:20 [15:17:20.945] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750260193 15:17:20 [15:17:20.946] WARN: foundation:test-date-provider Time set to 2025-06-18T15:23:13.000Z {"offset":352055,"timeMs":1750260193000} 15:17:20 [15:17:20.946] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 15:17:21 [15:17:21.133] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:21 [15:17:21.447] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:21 [15:17:21.471] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x0337b3d97927eb2c762dc4b007db2fb73a8ea4484301065d592ee89973f65ad3","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2235602435,"blockNumber":3,"slotNumber":4,"timestamp":1750260157,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x06377762f35348ed4de020f8db7dadc3a5cbb4aa7cd97d325f81b40c9f034ea4","archiveNextLeafIndex":4} 15:17:21 [15:17:21.478] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 15:17:21 [15:17:21.573] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":8.871413000000757,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750260157,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:17:21 [15:17:21.579] VERBOSE: pxe:service Updated pxe last block to 3 {"blockHash":{},"archive":"0x06377762f35348ed4de020f8db7dadc3a5cbb4aa7cd97d325f81b40c9f034ea4","header":{"contentCommitment":{"blobsHash":"0x00800d44b24e3ceff7a27bc3294e7affe1d65e23684f8e16c9d74651ebc0b28c","inHash":"0x00089a9d421a82c4a25f7acbebe69e638d5b064fa8a60e018793dcb0be53752c","numTxs":1,"outHash":"0x0000000000000000000000000000000000000000000000000000000000000000"},"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0x0000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750260157,"version":2235602435},"lastArchive":"0x1a2ae751e7a3bdf936fdfffb3b6b2c003afa43b4bfab0ee55aefd97506bd4e51","state":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1cee9d79cb327f027bb59e386c53f52806df4da2e9acc6e221e4e3ab735ec089","nullifierTree":"0x243c052bd2c54727152ddcccec8d00bd16a3e81e9694de121f6500b0af9b0dca","publicDataTree":"0x047ccd1461245c78c77c6744b26785a407817c80ef327de9dc02fd4903361166"},"totalFees":5018455040,"totalManaUsed":15104}} 15:17:21 [15:17:21.694] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:21 [15:17:21.708] VERBOSE: p2p Synched to latest block 3 15:17:21 [15:17:21.945] VERBOSE: simulator Executing utility function deliver_note {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6","selector":"0x09d61d7b"} 15:17:21 [15:17:21.954] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:21 [15:17:21.958] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:17:21 [15:17:21.958] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6"} 15:17:22 [15:17:22.119] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6"} 15:17:22 [15:17:22.120] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x06377762f35348ed4de020f8db7dadc3a5cbb4aa7cd97d325f81b40c9f034ea4","blockNumber":4,"slot":5} 15:17:22 [15:17:22.127] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:22 [15:17:22.129] VERBOSE: simulator:client_view_context:debug_log Attempting nonce discovery on 0x0000000000000000000000000000000000000000000000000000000000000001 potential notes on contract 0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6 for storage slot 0x0000000000000000000000000000000000000000000000000000000000000001 15:17:22 [15:17:22.130] VERBOSE: simulator:client_view_context:debug_log Discovered a total of 0x0000000000000000000000000000000000000000000000000000000000000001 notes 15:17:22 [15:17:22.131] VERBOSE: simulator:client_view_context:debug_log Discovered 0x0000000000000000000000000000000000000000000000000000000000000001 notes from a private message 15:17:22 [15:17:22.176] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:22 [15:17:22.186] VERBOSE: pxe:service Added note {"index":128,"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6","slot":"0x0000000000000000000000000000000000000000000000000000000000000001","noteHash":"0x08e500e73b7c9f20b0a0d01d9121e9f6deecdebdad166cc19bd8217d3e878f36","nullifier":"0x2b61d7d7bc9b38643d8269faac9ea9fd393e8c4019be84598ec6faf20d87fe74"} 15:17:22 [15:17:22.187] VERBOSE: simulator Utility simulation for 0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6.0x09d61d7b completed 15:17:22 [15:17:22.422] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:22 [15:17:22.643] VERBOSE: simulator Executing utility function get_constant {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6","selector":"0xc2a89417"} 15:17:22 [15:17:22.651] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://127.0.0.1:8545 15:17:22 [15:17:22.654] VERBOSE: simulator:client_view_context:debug_log Performing message discovery 15:17:22 [15:17:22.655] VERBOSE: pxe:service Searching for tagged logs {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6"} 15:17:22 [15:17:22.774] VERBOSE: sequencer Not enough txs to build block 4 at slot 5 (got 0 txs, need 1) {"chainTipArchive":"0x06377762f35348ed4de020f8db7dadc3a5cbb4aa7cd97d325f81b40c9f034ea4","blockNumber":4,"slot":5} 15:17:22 [15:17:22.792] VERBOSE: pxe:service Searching for nullifiers of known notes {"contract":"0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6"} 15:17:22 [15:17:22.796] VERBOSE: simulator:client_view_context:debug_log 0x0000000000000000000000000000000000000000000000000000000000000000 pending partial notes 15:17:22 [15:17:22.799] VERBOSE: simulator Utility simulation for 0x0386a9ba340aba9f727b34bf7dd893c8f12075dbaf9b2cce16c3f3fbe9244bd6.0xc2a89417 completed 15:17:22 [15:17:22.802] INFO: node Stopping 15:17:22 [15:17:22.803] INFO: slasher Slasher client stopped. 15:17:22 [15:17:22.803] INFO: sequencer Stopped sequencer 15:17:22 [15:17:22.804] INFO: p2p P2P client stopped. 15:17:22 [15:17:22.805] INFO: world_state Stopped world state synchronizer 15:17:22 [15:17:22.806] INFO: archiver Stopped. 15:17:22 [15:17:22.806] INFO: node Stopped 15:17:22 [15:17:22.806] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up ACVM state 15:17:22 [15:17:22.806] INFO: e2e:e2e_offchain_note_delivery Cleaning up ACVM temp directory /tmp/209f1c39 15:17:22 [15:17:22.807] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up BB state 15:17:22 [15:17:22.817] INFO: blob-sink:server Stopping blob sink 15:17:22 [15:17:22.817] INFO: blob-sink:server Blob sink stopped 15:17:22 [15:17:22.817] VERBOSE: e2e:e2e_offchain_note_delivery Cleaning up data directory at /tmp/bce034c470c6b824 15:17:22 PASS src/e2e_offchain_note_delivery.test.ts 15:17:22 e2e_offchain_note_delivery 15:17:22 ✓ can create a note that is not broadcast, deliver it offchain and read it (21281 ms) 15:17:22 15:17:22 Test Suites: 1 passed, 1 total 15:17:22 Tests: 1 passed, 1 total 15:17:22 Snapshots: 0 total 15:17:22 Time: 27.498 s 15:17:22 Ran all test suites matching /src\/e2e_offchain_note_delivery.test.ts/i. 15:17:22 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?