Parent Log: http://ci.aztec-labs.com/f7f41d385a4341ce Command: 0652eea69439df6d playground/scripts/run_test.sh firefox Commit: https://github.com/AztecProtocol/aztec-packages/commit/721a41c449eb0c4538a26180f6061f326128cf78 Env: REF_NAME=gh-readonly-queue/next/pr-14963-60e60f99f2634ad75a76b6e103858ff9ccd041d5 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 18:44:59 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14963_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_23123200780498f7_next 18:44:59 Network playground-firefox_default Creating 18:44:59 Network playground-firefox_default Created 18:44:59 Container playground-firefox-ethereum-1 Creating 18:45:01 Container playground-firefox-ethereum-1 Created 18:45:01 Container playground-firefox-aztec-1 Creating 18:45:01 Container playground-firefox-aztec-1 Created 18:45:01 Container playground-firefox-playground-1 Creating 18:45:01 Container playground-firefox-playground-1 Created 18:45:01 Attaching to aztec-1, ethereum-1, playground-1 18:45:07 aztec-1 | 18:45:07 aztec-1 | _ 18:45:07 aztec-1 | /\ | | 18:45:07 aztec-1 | / \ ___| |_ ___ ___ 18:45:07 aztec-1 | / /\ \ |_ / __/ _ \/ __| 18:45:07 aztec-1 | / ____ \ / /| || __/ (__ 18:45:07 aztec-1 | /_/___ \_\/___|\__\___|\___| 18:45:07 aztec-1 | 18:45:07 aztec-1 | https://github.com/AztecProtocol 18:45:07 aztec-1 | 18:45:07 aztec-1 | 18:45:07 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by... 18:45:07 aztec-1 | Setting up test accounts 18:45:08 aztec-1 | [18:45:08.073] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-dkqpVV/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 18:45:08 aztec-1 | [18:45:08.330] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 18:45:08 aztec-1 | [18:45:08.335] WARN: sandbox Set block interval to 12 18:45:08 aztec-1 | [18:45:08.543] INFO: sandbox Waiting for 7 transactions to be mined... 18:45:08 aztec-1 | [18:45:08.565] INFO: sandbox All transactions mined successfully 18:45:08 aztec-1 | [18:45:08.653] INFO: sandbox Waiting for 9 transactions to be mined... 18:45:08 aztec-1 | [18:45:08.681] INFO: sandbox All transactions mined successfully 18:45:08 aztec-1 | [18:45:08.856] INFO: sandbox Waiting for 11 transactions to be mined... 18:45:08 aztec-1 | [18:45:08.879] INFO: sandbox All transactions mined successfully 18:45:08 aztec-1 | [18:45:08.942] INFO: sandbox Waiting for 12 transactions to be mined... 18:45:09 aztec-1 | [18:45:08.975] INFO: sandbox All transactions mined successfully 18:45:09 aztec-1 | [18:45:08.984] INFO: sandbox Waiting for 12 transactions to be mined... 18:45:09 aztec-1 | [18:45:09.008] INFO: sandbox All transactions mined successfully 18:45:09 aztec-1 | [18:45:09.029] INFO: sandbox Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 18:45:09 aztec-1 | [18:45:09.029] INFO: sandbox Handing over to governance 18:45:09 aztec-1 | [18:45:09.039] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 18:45:09 aztec-1 | [18:45:09.040] INFO: telemetry:client Using NoopTelemetryClient 18:45:09 aztec-1 | [18:45:09.040] INFO: blob-sink:client Creating local blob sink client. 18:45:09 aztec-1 | [18:45:09.046] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:45:09 aztec-1 | [18:45:09.046] WARN: foundation:test-date-provider Time set to 2025-06-16T18:49:50.000Z {"offset":280954,"timeMs":1750099790000} 18:45:09 aztec-1 | [18:45:09.077] INFO: archiver:lmdb Starting data store with maxReaders 16 18:45:09 aztec-1 | [18:45:09.542] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xcef744745d503787498664c49a645e4dd3bd71a162f0ee922cfbc80eaed82a98 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x166aae8d6f4d6ebbc3284a3d518486b7c048b7ace3bfc0b4263758ce80a341b3","l1BlockNumber":20}} 18:45:09 aztec-1 | [18:45:09.567] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xcef744745d503787498664c49a645e4dd3bd71a162f0ee922cfbc80eaed82a98","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 18:45:09 aztec-1 | [18:45:09.576] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-KX0nXS/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 18:45:09 aztec-1 | [18:45:09.778] INFO: world_state Created world state synchroniser with block history of 64 18:45:09 aztec-1 | [18:45:09.778] WARN: node Aztec node is accepting fake proofs 18:45:09 aztec-1 | [18:45:09.793] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 18:45:09 aztec-1 | [18:45:09.804] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 18:45:09 aztec-1 | [18:45:09.815] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 18:45:09 aztec-1 | [18:45:09.829] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 18:45:09 aztec-1 | [18:45:09.834] INFO: world_state Started world state synchronizer from block 1 18:45:10 aztec-1 | [18:45:09.838] INFO: p2p Starting p2p client from block 0 with empty mempools 18:45:10 aztec-1 | [18:45:10.143] INFO: epoch-prune-watcher EpochPruneWatcher initialized 18:45:10 aztec-1 | [18:45:10.206] INFO: slasher Starting Slasher client... 18:45:10 aztec-1 | [18:45:10.216] INFO: sequencer-client Deploying forwarder contract 18:45:10 aztec-1 | [18:45:10.247] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 18:45:10 aztec-1 | [18:45:10.260] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 18:45:10 aztec-1 | [18:45:10.261] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":50,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":true} 18:45:10 aztec-1 | [18:45:10.263] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 18:45:10 aztec-1 | [18:45:10.264] INFO: node Aztec Node version: 0.87.6 18:45:10 aztec-1 | [18:45:10.264] INFO: node Aztec Node started on chain 0x7a69 {"rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","slashFactoryAddress":"0x59b670e9fa9d0a427751af201d676719a970857b","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 18:45:10 aztec-1 | [18:45:10.269] INFO: pxe:data:lmdb Starting data store with maxReaders 16 18:45:10 aztec-1 | [18:45:10.281] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"now":1750099791,"syncedToL1Ts":1750099790,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750099778,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750099814},"newBlockNumber":1,"expectedSlot":1} 18:45:10 aztec-1 | [18:45:10.337] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"now":1750099791,"syncedToL1Ts":1750099790,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750099778,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750099814},"newBlockNumber":1,"expectedSlot":1} 18:45:10 aztec-1 | [18:45:10.493] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"now":1750099791,"syncedToL1Ts":1750099802,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750099778,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750099814},"newBlockNumber":1,"expectedSlot":1} 18:45:10 aztec-1 | [18:45:10.500] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:45:10 aztec-1 | [18:45:10.501] WARN: foundation:test-date-provider Time set to 2025-06-16T18:50:02.000Z {"offset":291500,"timeMs":1750099802000} 18:45:10 aztec-1 | Setting up funded test accounts... 18:45:10 aztec-1 | [18:45:10.625] INFO: pxe:service Started PXE connected to chain 31337 version 3676816240 18:45:10 aztec-1 | [18:45:10.711] INFO: pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 18:45:10 aztec-1 | [18:45:10.795] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 18:45:10 aztec-1 | [18:45:10.799] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 18:45:10 aztec-1 | [18:45:10.990] INFO: pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 18:45:14 aztec-1 | [18:45:13.883] INFO: pxe:service Proving completed in 2837.3738900000008ms {"timings":{"total":2837.3738900000008,"sync":17.90328700000009,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":180.14769799999976,"oracles":{"callPrivateFunction":{"times":[911.4691220000004,342.93839800000023,270.9564100000007]}}},{"functionName":"private_kernel_init","time":93.78146399999969},{"functionName":"ContractClassRegisterer:register","time":890.7750560000013,"oracles":{"loadCapsule":{"times":[37.280305000000226]},"notifyCreatedNullifier":{"times":[1.0072289999989152]},"debugLog":{"times":[0.6495890000005602]},"notifyCreatedContractClassLog":{"times":[5.925228000000061]}}},{"functionName":"private_kernel_inner","time":149.12204200000087},{"functionName":"SchnorrAccount:constructor","time":309.0309490000018,"oracles":{"getContractInstance":{"times":[2.957763000000341]},"debugLog":{"times":[0.1342740000000049,0.13909400000011374]},"fetchTaggedLogs":{"times":[73.02148699999998]},"loadCapsule":{"times":[0.9136259999995673,0.28361799999947834,0.19322600000123202]},"validateEnqueuedNotesAndEvents":{"times":[8.810918999999558]},"notifyCreatedNullifier":{"times":[0.22311599999920873,0.2973490000003949]},"notifyCreatedNote":{"times":[0.5851670000010927]},"getRandomField":{"times":[0.23088600000119186,0.3298400000003312,0.06339200000002165,0.06977199999892036,0.20238599999902362,0.07176200000139943,0.052210999998351326,0.08409199999914563,0.05863099999987753,0.08805299999949057,0.04638100000011036]},"getIndexedTaggingSecretAsSender":{"times":[44.16613099999995]},"incrementAppTaggingSecretIndexAsSender":{"times":[27.912249999999403]}}},{"functionName":"private_kernel_inner","time":112.82790299999942},{"functionName":"SchnorrAccount:entrypoint","time":242.49015399999735,"oracles":{"debugLog":{"times":[0.26481799999965006,0.0941530000000057,0.42034199999943667]},"fetchTaggedLogs":{"times":[69.71953400000166]},"loadCapsule":{"times":[0.32878899999923306,0.1840649999994639,0.22346599999946193]},"validateEnqueuedNotesAndEvents":{"times":[5.688962000000174]},"getNotes":{"times":[2.6687259999998787]},"getAuthWitness":{"times":[0.43476300000111223]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.3146670000005543]}}},{"functionName":"private_kernel_inner","time":103.27098399999886},{"functionName":"private_kernel_reset","time":165.26610900000014},{"functionName":"private_kernel_tail","time":64.67924099999982}],"unaccounted":508.07900300000165}} 18:45:14 aztec-1 | [18:45:13.978] INFO: node Received tx 0x0ab481114d63a8ac59804fc6a9ce413120f210734cfb653d56dcf52d46d71e71 {"txHash":"0x0ab481114d63a8ac59804fc6a9ce413120f210734cfb653d56dcf52d46d71e71"} 18:45:14 aztec-1 | [18:45:13.978] INFO: pxe:service Sent transaction 0x0ab481114d63a8ac59804fc6a9ce413120f210734cfb653d56dcf52d46d71e71 18:45:14 aztec-1 | [18:45:14.082] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.042979526999999504s {"duration":0.042979526999999504,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 18:45:14 aztec-1 | [18:45:14.124] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x02f541403d1e993ad7ae56c3d8fa75e36d557bdff86d3e25e2d69b6c03b96142","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750099814,"version":3676816240},"txHashes":["0x0ab481114d63a8ac59804fc6a9ce413120f210734cfb653d56dcf52d46d71e71"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":95.52355399999942,"publicProcessDuration":43.70310699999936,"rollupCircuitsDuration":87.7518540000001,"txCount":1,"blockNumber":1,"blockTimestamp":1750099814,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:45:17 aztec-1 | [18:45:16.838] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 18:45:17 aztec-1 | [18:45:16.840] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 18:45:17 aztec-1 | [18:45:16.841] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:17 aztec-1 | [18:45:16.950] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x02f541403d1e993ad7ae56c3d8fa75e36d557bdff86d3e25e2d69b6c03b96142","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750099814,"version":3676816240},"archiveRoot":"0x28c1a25c8639c0779185529c2bf28e0cd52d6529f86368ed94d8af3e7c93b5a9","archiveNextLeafIndex":2} 18:45:17 aztec-1 | [18:45:16.957] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 18:45:17 aztec-1 | [18:45:16.989] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":17.154146000000765,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750099814,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:45:17 aztec-1 | [18:45:17.060] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:45:17 aztec-1 | [18:45:17.061] WARN: foundation:test-date-provider Time set to 2025-06-16T18:50:14.000Z {"offset":296940,"timeMs":1750099814000} 18:45:17 aztec-1 | [18:45:17.083] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750099850 18:45:17 aztec-1 | [18:45:17.083] WARN: foundation:test-date-provider Time set to 2025-06-16T18:50:50.000Z {"offset":332917,"timeMs":1750099850000} 18:45:17 aztec-1 | [18:45:17.083] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 18:45:17 aztec-1 | [18:45:17.106] INFO: pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f 18:45:17 aztec-1 | [18:45:17.227] INFO: pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 18:45:19 aztec-1 | [18:45:18.709] INFO: pxe:service Proving completed in 1465.5159860000003ms {"timings":{"total":1465.5159860000003,"sync":18.81814300000042,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":93.18985799999791,"oracles":{"callPrivateFunction":{"times":[335.5087370000001,261.40909099999953]}}},{"functionName":"private_kernel_init","time":54.74359000000004},{"functionName":"SchnorrAccount:constructor","time":316.3541549999991,"oracles":{"getContractInstance":{"times":[9.008765000000494]},"debugLog":{"times":[0.26050799999939045,0.10161300000072515]},"fetchTaggedLogs":{"times":[89.05909099999917]},"loadCapsule":{"times":[0.21259599999939383,0.2694979999996576,0.19845600000007835]},"validateEnqueuedNotesAndEvents":{"times":[5.467124999999214]},"notifyCreatedNullifier":{"times":[0.5695249999989755,0.3659299999999348]},"notifyCreatedNote":{"times":[0.17441499999949883]},"getRandomField":{"times":[0.11637399999926856,0.164864000000307,0.1265530000000581,0.06341199999951641,0.03905100000156381,0.06254199999966659,0.036880999999993946,0.039531000000351924,0.04210100000091188,0.04354099999909522,0.02936000000045169]},"getIndexedTaggingSecretAsSender":{"times":[49.554943000001]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.713407999999617]}}},{"functionName":"private_kernel_inner","time":106.69408000000112},{"functionName":"SchnorrAccount:entrypoint","time":229.8728970000011,"oracles":{"debugLog":{"times":[0.27817700000014156,0.09741199999916716,0.1787850000000617]},"fetchTaggedLogs":{"times":[84.84162199999992]},"loadCapsule":{"times":[0.166864999999234,0.19283499999983178,0.15373499999986961]},"validateEnqueuedNotesAndEvents":{"times":[5.779773000000205]},"getNotes":{"times":[1.374189000000115]},"getAuthWitness":{"times":[0.13998399999945832]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4652430000005552]}}},{"functionName":"private_kernel_inner","time":131.74841000000015},{"functionName":"private_kernel_reset","time":193.4848379999985},{"functionName":"private_kernel_tail","time":59.32401899999968}],"unaccounted":261.28599600000234}} 18:45:19 aztec-1 | [18:45:18.763] INFO: node Received tx 0x2702e5839922e7a4e63dbc44f256f5197c3f86ee99a216c57890544b6331f50c {"txHash":"0x2702e5839922e7a4e63dbc44f256f5197c3f86ee99a216c57890544b6331f50c"} 18:45:19 aztec-1 | [18:45:18.763] INFO: pxe:service Sent transaction 0x2702e5839922e7a4e63dbc44f256f5197c3f86ee99a216c57890544b6331f50c 18:45:19 aztec-1 | [18:45:18.861] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.027492048000000067s {"duration":0.027492048000000067,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 18:45:19 aztec-1 | [18:45:18.886] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x112e4266bea1c6e195aec079afb08f41c594ef4e7cd42d0118f77804ef02c754","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750099850,"version":3676816240},"txHashes":["0x2702e5839922e7a4e63dbc44f256f5197c3f86ee99a216c57890544b6331f50c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":60.6347769999993,"publicProcessDuration":27.6138409999985,"rollupCircuitsDuration":54.5805849999997,"txCount":1,"blockNumber":2,"blockTimestamp":1750099850,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:45:19 aztec-1 | [18:45:19.120] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:19 aztec-1 | [18:45:19.143] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:45:19 aztec-1 | [18:45:19.143] WARN: foundation:test-date-provider Time set to 2025-06-16T18:51:02.000Z {"offset":342857,"timeMs":1750099862000} 18:45:19 aztec-1 | [18:45:19.146] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 18:45:19 aztec-1 | [18:45:19.147] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 18:45:19 aztec-1 | [18:45:19.170] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750099886 18:45:19 aztec-1 | [18:45:19.170] WARN: foundation:test-date-provider Time set to 2025-06-16T18:51:26.000Z {"offset":366830,"timeMs":1750099886000} 18:45:19 aztec-1 | [18:45:19.170] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 18:45:19 aztec-1 | [18:45:19.226] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x112e4266bea1c6e195aec079afb08f41c594ef4e7cd42d0118f77804ef02c754","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750099850,"version":3676816240},"archiveRoot":"0x1ddffcfd970c1d26091571579448b1d514d7c51c42595e4eec910007b3788861","archiveNextLeafIndex":3} 18:45:19 aztec-1 | [18:45:19.233] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 18:45:19 aztec-1 | [18:45:19.289] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":16.503297000001112,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750099850,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:45:19 aztec-1 | [18:45:19.427] INFO: pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 18:45:19 aztec-1 | [18:45:19.558] INFO: pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 18:45:21 aztec-1 | [18:45:21.128] INFO: pxe:service Proving completed in 1559.0337830000026ms {"timings":{"total":1559.0337830000026,"sync":32.001485999997385,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":95.1541950000028,"oracles":{"callPrivateFunction":{"times":[415.0125279999993,243.87943399999858]}}},{"functionName":"private_kernel_init","time":51.85710800000015},{"functionName":"SchnorrAccount:constructor","time":385.40178000000014,"oracles":{"getContractInstance":{"times":[7.568074000002525]},"debugLog":{"times":[0.1554340000002412,0.10696299999835901]},"fetchTaggedLogs":{"times":[119.31695699999909]},"loadCapsule":{"times":[0.20950599999923725,0.1532340000012482,0.18047500000102445]},"validateEnqueuedNotesAndEvents":{"times":[5.603509000000486]},"notifyCreatedNullifier":{"times":[0.23834699999861186,0.3756009999997332]},"notifyCreatedNote":{"times":[0.12447299999985262]},"getRandomField":{"times":[0.1528650000000198,0.2593779999988328,0.10730300000068382,0.07693199999994249,0.07054199999765842,0.06111199999941164,0.0423609999998007,0.05811099999846192,0.03890099999989616,0.061492000000725966,0.061160999997809995]},"getIndexedTaggingSecretAsSender":{"times":[53.86698500000057]},"incrementAppTaggingSecretIndexAsSender":{"times":[36.58671599999798]}}},{"functionName":"private_kernel_inner","time":96.48920100000032},{"functionName":"SchnorrAccount:entrypoint","time":223.3645230000002,"oracles":{"debugLog":{"times":[0.169755000002624,0.08988200000021607,0.16737500000090222]},"fetchTaggedLogs":{"times":[87.72168299999976]},"loadCapsule":{"times":[0.21381599999949685,0.7391009999992093,0.22596599999815226]},"validateEnqueuedNotesAndEvents":{"times":[5.801554000001488]},"getNotes":{"times":[1.1952039999996487]},"getAuthWitness":{"times":[0.12774399999761954]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4207819999974163]}}},{"functionName":"private_kernel_inner","time":130.55298500000208},{"functionName":"private_kernel_reset","time":229.26938999999766},{"functionName":"private_kernel_tail","time":94.42884199999753}],"unaccounted":220.51427300000432}} 18:45:21 aztec-1 | [18:45:21.179] INFO: node Received tx 0x2d2a224004911deef55fb35c400b7a70728bb4a326e606552fbeb9ad35a1ed88 {"txHash":"0x2d2a224004911deef55fb35c400b7a70728bb4a326e606552fbeb9ad35a1ed88"} 18:45:21 aztec-1 | [18:45:21.179] INFO: pxe:service Sent transaction 0x2d2a224004911deef55fb35c400b7a70728bb4a326e606552fbeb9ad35a1ed88 18:45:21 aztec-1 | [18:45:21.255] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02042427800000223s {"duration":0.02042427800000223,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 18:45:21 aztec-1 | [18:45:21.289] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x06295f391e43d4eb1b09abfea0b53d03b28c0e697d52c366d4c2924a5f38acfb","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750099886,"version":3676816240},"txHashes":["0x2d2a224004911deef55fb35c400b7a70728bb4a326e606552fbeb9ad35a1ed88"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":62.88481999999931,"publicProcessDuration":20.56861199999912,"rollupCircuitsDuration":56.446608000002016,"txCount":1,"blockNumber":3,"blockTimestamp":1750099886,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:45:21 aztec-1 | [18:45:21.525] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:21 aztec-1 | [18:45:21.562] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:45:21 aztec-1 | [18:45:21.562] WARN: foundation:test-date-provider Time set to 2025-06-16T18:51:38.000Z {"offset":376438,"timeMs":1750099898000} 18:45:21 aztec-1 | [18:45:21.565] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 18:45:21 aztec-1 | [18:45:21.566] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 18:45:21 aztec-1 | [18:45:21.592] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750099922 18:45:21 aztec-1 | [18:45:21.593] WARN: foundation:test-date-provider Time set to 2025-06-16T18:52:02.000Z {"offset":400407,"timeMs":1750099922000} 18:45:21 aztec-1 | [18:45:21.593] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 18:45:21 aztec-1 | [18:45:21.621] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x06295f391e43d4eb1b09abfea0b53d03b28c0e697d52c366d4c2924a5f38acfb","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750099886,"version":3676816240},"archiveRoot":"0x0d66871c57e3e4cc853fcc59925b825beb8727c1e525cfa57f78b6d364eb6193","archiveNextLeafIndex":4} 18:45:21 aztec-1 | [18:45:21.625] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 18:45:21 aztec-1 | [18:45:21.692] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":16.71816299999773,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750099886,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:45:21 aztec-1 | Initial Accounts: 18:45:21 aztec-1 | 18:45:21 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 18:45:21 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc 18:45:21 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 18:45:21 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 18:45:21 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 18:45:21 aztec-1 | 18:45:21 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 18:45:21 aztec-1 | 18:45:21 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 18:45:21 aztec-1 | 18:45:21 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f 18:45:21 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0 18:45:21 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 18:45:21 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 18:45:21 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 18:45:21 aztec-1 | 18:45:21 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 18:45:21 aztec-1 | 18:45:21 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 18:45:21 aztec-1 | 18:45:21 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 18:45:21 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d 18:45:21 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 18:45:21 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 18:45:21 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 18:45:21 aztec-1 | 18:45:21 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 18:45:21 aztec-1 | 18:45:21 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 18:45:21 aztec-1 | 18:45:21 aztec-1 | 18:45:22 aztec-1 | [18:45:22.471] WARN: pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata 18:45:22 aztec-1 | [18:45:22.471] WARN: pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata 18:45:22 aztec-1 | [18:45:22.475] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 18:45:22 aztec-1 | [18:45:22.496] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 18:45:23 aztec-1 | [18:45:23.248] INFO: pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 18:45:23 aztec-1 | [18:45:23.254] INFO: pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 18:45:26 aztec-1 | [18:45:26.036] INFO: pxe:service Proving completed in 2761.1546949999974ms {"timings":{"total":2761.1546949999974,"sync":32.05037699999957,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":363.77920100000483,"oracles":{"debugLog":{"times":[0.2973779999992985,0.1021230000005744,0.0936729999993986,0.20763600000282167,0.10360300000320422,0.1176530000011553,0.10234199999831617,0.12893399999666144]},"fetchTaggedLogs":{"times":[106.54219600000215]},"loadCapsule":{"times":[0.19303500000023632,0.17057500000009895,0.3177289999985078,0.21311599999899045,0.22386700000060955,1.4801019999977143,0.23988599999938742]},"getSharedSecret":{"times":[4.487796999997954]},"aes128Decrypt":{"times":[1.0463899999995192,0.8105130000003555]},"getPublicKeysAndPartialAddress":{"times":[4.61279999999897]},"getKeyValidationRequest":{"times":[2.0776589999986754]},"storeCapsule":{"times":[3.5082189999993716,3.1390989999999874,3.2497629999998026]},"deleteCapsule":{"times":[3.242901999998139]},"validateEnqueuedNotesAndEvents":{"times":[20.316215000002558]},"getNotes":{"times":[5.441294000000198]},"getAuthWitness":{"times":[0.2502469999999448]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04589199999827542]},"callPrivateFunction":{"times":[903.0398520000017,152.79526400000032]},"notifyEnqueuedPublicFunctionCall":{"times":[0.4162320000032196]}}},{"functionName":"private_kernel_init","time":75.87607299999945},{"functionName":"ContractClassRegisterer:register","time":881.8508110000002,"oracles":{"loadCapsule":{"times":[3.2843939999984286]},"notifyCreatedNullifier":{"times":[0.46227400000134367]},"debugLog":{"times":[0.15376399999877322]},"notifyCreatedContractClassLog":{"times":[8.06372100000226]}}},{"functionName":"private_kernel_inner","time":153.31530000000203},{"functionName":"ContractInstanceDeployer:deploy","time":87.15719499999977,"oracles":{"storeInExecutionCache":{"times":[0.3107290000007197]},"callPrivateFunction":{"times":[58.794433999999455]},"notifyCreatedNullifier":{"times":[0.34808999999950174]},"debugLog":{"times":[0.14082399999824702]}}},{"functionName":"private_kernel_inner","time":139.2684879999979},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":43.19945700000244,"oracles":{}},{"functionName":"private_kernel_inner","time":157.05881699999736},{"functionName":"private_kernel_reset","time":222.30847600000197},{"functionName":"private_kernel_tail","time":107.62452200000189}],"unaccounted":497.66597799999}} 18:45:26 aztec-1 | [18:45:26.221] INFO: node Received tx 0x13f7d12c3f6f2033eb11671d1a3deb51f6e6746e5cb597cbf8927d73e393fdb6 {"txHash":"0x13f7d12c3f6f2033eb11671d1a3deb51f6e6746e5cb597cbf8927d73e393fdb6"} 18:45:26 aztec-1 | [18:45:26.221] INFO: pxe:service Sent transaction 0x13f7d12c3f6f2033eb11671d1a3deb51f6e6746e5cb597cbf8927d73e393fdb6 18:45:27 aztec-1 | [18:45:27.648] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.2738283429999975s {"duration":1.2738283429999975,"rate":31237.33289391888,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768} 18:45:27 aztec-1 | [18:45:27.796] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 27689.827709196215 mana/s {"blockHash":"0x2fb34190c6b95b67aa176fe845bc7f0b7005c2ed98b0a6f3ecd4d50383250202","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750099922,"version":3676816240},"txHashes":["0x13f7d12c3f6f2033eb11671d1a3deb51f6e6746e5cb597cbf8927d73e393fdb6"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1436.9605029999984,"publicProcessDuration":1273.969527000001,"rollupCircuitsDuration":1428.6478549999993,"txCount":1,"blockNumber":4,"blockTimestamp":1750099922,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 18:45:28 aztec-1 | [18:45:28.613] INFO: pxe:service Proving completed in 2575.6238859999976ms {"timings":{"total":2575.6238859999976,"sync":153.5729169999977,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":348.29407300000094,"oracles":{"debugLog":{"times":[0.15001499999925727,0.09531299999798648,0.06866200000149547,0.11825300000054995,0.07268199999816716,0.06012100000225473,0.05926199999885284,0.14819400000124006]},"fetchTaggedLogs":{"times":[127.85065099999701]},"loadCapsule":{"times":[0.23984700000073644,0.7563010000012582,0.5680759999995644,0.25859700000000885,1.0144000000000233,0.16507499999715947,0.18912600000112434]},"getSharedSecret":{"times":[4.703484999998182]},"aes128Decrypt":{"times":[0.21261600000070757,0.4147510000002512]},"getPublicKeysAndPartialAddress":{"times":[2.3460569999988365]},"getKeyValidationRequest":{"times":[1.8555129999986093]},"storeCapsule":{"times":[2.7207480000033684,21.18696600000112,2.843172000000777]},"deleteCapsule":{"times":[2.779039000000921]},"validateEnqueuedNotesAndEvents":{"times":[13.09916499999963]},"getNotes":{"times":[1.786271000000852]},"getAuthWitness":{"times":[0.17389600000024075]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08194199999707052]},"callPrivateFunction":{"times":[717.4522619999989,135.98971399999937]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06254100000296603]}}},{"functionName":"private_kernel_init","time":71.02742399999988},{"functionName":"ContractClassRegisterer:register","time":703.183893999998,"oracles":{"loadCapsule":{"times":[2.8131109999994806]},"notifyCreatedNullifier":{"times":[0.32880999999906635]},"debugLog":{"times":[0.0974129999995057]},"notifyCreatedContractClassLog":{"times":[4.685513999997056]}}},{"functionName":"private_kernel_inner","time":101.84892599999876},{"functionName":"ContractInstanceDeployer:deploy","time":79.02881300000081,"oracles":{"storeInExecutionCache":{"times":[0.17269500000111293]},"callPrivateFunction":{"times":[65.65278000000035]},"notifyCreatedNullifier":{"times":[0.4728739999991376]},"debugLog":{"times":[0.17795500000283937]}}},{"functionName":"private_kernel_inner","time":94.0537239999976},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":44.196124999998574,"oracles":{}},{"functionName":"private_kernel_inner","time":113.27819399999862},{"functionName":"private_kernel_reset","time":340.3820459999988},{"functionName":"private_kernel_tail","time":88.2688969999981}],"unaccounted":438.48885300000984}} 18:45:28 aztec-1 | [18:45:28.765] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:28 aztec-1 | [18:45:28.783] INFO: node Received tx 0x2854fd5f5edb0e87c32180362f3d3b1578819ccf83d7effffaf173bca65bfce3 {"txHash":"0x2854fd5f5edb0e87c32180362f3d3b1578819ccf83d7effffaf173bca65bfce3"} 18:45:28 aztec-1 | [18:45:28.783] INFO: pxe:service Sent transaction 0x2854fd5f5edb0e87c32180362f3d3b1578819ccf83d7effffaf173bca65bfce3 18:45:28 aztec-1 | [18:45:28.845] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:45:28 aztec-1 | [18:45:28.846] WARN: foundation:test-date-provider Time set to 2025-06-16T18:52:14.000Z {"offset":405155,"timeMs":1750099934000} 18:45:28 aztec-1 | [18:45:28.852] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 18:45:28 aztec-1 | [18:45:28.856] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 18:45:28 aztec-1 | [18:45:28.862] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750099958 18:45:28 aztec-1 | [18:45:28.862] WARN: foundation:test-date-provider Time set to 2025-06-16T18:52:38.000Z {"offset":429138,"timeMs":1750099958000} 18:45:28 aztec-1 | [18:45:28.862] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 18:45:28 aztec-1 | [18:45:28.928] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x2fb34190c6b95b67aa176fe845bc7f0b7005c2ed98b0a6f3ecd4d50383250202","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750099922,"version":3676816240},"archiveRoot":"0x2c14c7dd268ef61299d0eb79ccd19b6a3c0f60595f478bbcf31cea53f9aa8565","archiveNextLeafIndex":5} 18:45:29 aztec-1 | [18:45:29.009] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":16.255306000002747,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750099922,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 18:45:29 aztec-1 | [18:45:29.020] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 18:45:30 aztec-1 | [18:45:29.545] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.41650896600000126s {"duration":0.41650896600000126,"rate":759772.3598583927,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064} 18:45:30 aztec-1 | [18:45:29.599] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 657357.3598488378 mana/s {"blockHash":"0x28fe5c97eb00736931e9c20fa3cb58d1b571c38461582e8c5f443d1efd2a6f7c","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750099958,"version":3676816240},"txHashes":["0x2854fd5f5edb0e87c32180362f3d3b1578819ccf83d7effffaf173bca65bfce3"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":481.3642929999987,"publicProcessDuration":416.8382750000019,"rollupCircuitsDuration":476.2744870000024,"txCount":1,"blockNumber":5,"blockTimestamp":1750099958,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 18:45:30 aztec-1 | [18:45:29.728] INFO: aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed. 18:45:30 aztec-1 | [18:45:29.894] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 18:45:30 aztec-1 | [18:45:29.896] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 18:45:30 aztec-1 | [18:45:29.899] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:30 aztec-1 | [18:45:29.963] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750099994 18:45:30 aztec-1 | [18:45:29.963] WARN: foundation:test-date-provider Time set to 2025-06-16T18:53:14.000Z {"offset":464037,"timeMs":1750099994000} 18:45:30 aztec-1 | [18:45:29.963] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 18:45:30 aztec-1 | [18:45:30.068] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x28fe5c97eb00736931e9c20fa3cb58d1b571c38461582e8c5f443d1efd2a6f7c","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750099958,"version":3676816240},"archiveRoot":"0x1b96fadcf92c3507d2bf41d34491a8891c271cd17602ceb3718a0b39debd8bf8","archiveNextLeafIndex":6} 18:45:30 aztec-1 | [18:45:30.073] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 18:45:30 aztec-1 | [18:45:30.141] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":26.875800000001618,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750099958,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 18:45:31 aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 18:45:31 aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 18:45:31 aztec-1 | [18:45:31.153] INFO: aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed. 18:45:31 aztec-1 | [18:45:31.177] WARN: pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata 18:45:31 aztec-1 | [18:45:31.180] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 18:45:31 aztec-1 | [18:45:31.289] INFO: pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e 18:45:34 aztec-1 | [18:45:33.544] INFO: pxe:service Proving completed in 2243.1021949999995ms {"timings":{"total":2243.1021949999995,"sync":41.36619399999836,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":81.4993750000067,"oracles":{"callPrivateFunction":{"times":[745.8366949999981,117.39064099999814,59.10106200000155]}}},{"functionName":"private_kernel_init","time":75.59701399999904},{"functionName":"ContractClassRegisterer:register","time":727.8428490000006,"oracles":{"loadCapsule":{"times":[2.256054999998014]},"notifyCreatedNullifier":{"times":[0.3681609999985085]},"debugLog":{"times":[0.12554300000192598]},"notifyCreatedContractClassLog":{"times":[5.920959999999468]}}},{"functionName":"private_kernel_inner","time":114.8205080000007},{"functionName":"ContractInstanceDeployer:deploy","time":65.04626099999587,"oracles":{"storeInExecutionCache":{"times":[0.15321400000175345]},"callPrivateFunction":{"times":[55.07159699999829]},"notifyCreatedNullifier":{"times":[0.3885210000007646]},"debugLog":{"times":[0.18213500000274507]}}},{"functionName":"private_kernel_inner","time":140.38696999999956},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.43383999999787,"oracles":{}},{"functionName":"private_kernel_inner","time":101.388213000002},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":45.667497999998886,"oracles":{"debugLog":{"times":[0.15209399999730522]}}},{"functionName":"private_kernel_inner","time":101.83275499999945},{"functionName":"private_kernel_reset","time":220.06104100000084},{"functionName":"private_kernel_tail","time":86.9366489999993}],"unaccounted":401.22302800000034}} 18:45:34 aztec-1 | [18:45:33.656] INFO: node Received tx 0x13c57938ab14bfe64c3459f1e8f2fc260fa7df4c96a022d92621b51636bfcbf0 {"txHash":"0x13c57938ab14bfe64c3459f1e8f2fc260fa7df4c96a022d92621b51636bfcbf0"} 18:45:34 aztec-1 | [18:45:33.656] INFO: pxe:service Sent transaction 0x13c57938ab14bfe64c3459f1e8f2fc260fa7df4c96a022d92621b51636bfcbf0 18:45:34 aztec-1 | [18:45:33.784] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.05542765700000018s {"duration":0.05542765700000018,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 18:45:34 aztec-1 | [18:45:33.810] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x11be27be8a0310c80a88f8f09011415f16017a3c7c66b80374278a3905fcddf7","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750099994,"version":3676816240},"txHashes":["0x13c57938ab14bfe64c3459f1e8f2fc260fa7df4c96a022d92621b51636bfcbf0"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":88.31188800000018,"publicProcessDuration":55.61131299999761,"rollupCircuitsDuration":82.96513499999855,"txCount":1,"blockNumber":6,"blockTimestamp":1750099994,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:45:34 aztec-1 | [18:45:33.972] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:34 aztec-1 | [18:45:33.974] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 18:45:34 aztec-1 | [18:45:33.975] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 18:45:34 aztec-1 | [18:45:34.071] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x11be27be8a0310c80a88f8f09011415f16017a3c7c66b80374278a3905fcddf7","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750099994,"version":3676816240},"archiveRoot":"0x2bff494c7ea68dbd412247ff0494d6c7410b8aa2e38adcf3963df0203a20451b","archiveNextLeafIndex":7} 18:45:34 aztec-1 | [18:45:34.075] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750100030 18:45:34 aztec-1 | [18:45:34.075] WARN: foundation:test-date-provider Time set to 2025-06-16T18:53:50.000Z {"offset":495925,"timeMs":1750100030000} 18:45:34 aztec-1 | [18:45:34.075] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 18:45:34 aztec-1 | [18:45:34.079] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 18:45:34 aztec-1 | [18:45:34.138] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":13.688611999998102,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750099994,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:45:34 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 18:45:34 aztec-1 | [18:45:34.676] INFO: aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed. 18:45:34 aztec-1 | [18:45:34.682] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x1364306bc239ce640d30bd96c0c11b8e465dc7cb1c11babdeed8256c84934bdc","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"} 18:45:42 playground-1 | \ 18:45:42 playground-1 | Running 1 test using 1 worker 18:45:42 playground-1 | 18:45:43 playground-1 | 1 [firefox] › browser.spec.ts:3:1 › test 18:45:51 playground-1 | [WebServer] The file does not exist at "/root/aztec-packages/playground/node_modules/.vite/deps/chunk-IUHJT6SR.js" which is in the optimize deps directory. The dependency might be incompatible with the dep optimizer. Try adding it to `optimizeDeps.exclude`.