Parent Log: http://ci.aztec-labs.com/5d2b04153c5165af Command: f39c896d2b393f10 playground/scripts/run_test.sh firefox Commit: https://github.com/AztecProtocol/aztec-packages/commit/96a426245731b3f48fcb6dd5e2a683c858706602 Env: REF_NAME=gh-readonly-queue/next/pr-15083-5867520ed258adecfee692b3694d693b2c7964ca CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 21:56:57 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15083_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_23123200780498f7_next 21:56:58 Network playground-firefox_default Creating 21:56:58 Network playground-firefox_default Created 21:56:58 Container playground-firefox-ethereum-1 Creating 21:56:59 Container playground-firefox-ethereum-1 Created 21:56:59 Container playground-firefox-aztec-1 Creating 21:56:59 Container playground-firefox-aztec-1 Created 21:56:59 Container playground-firefox-playground-1 Creating 21:57:00 Container playground-firefox-playground-1 Created 21:57:00 Attaching to aztec-1, ethereum-1, playground-1 21:57:04 aztec-1 | 21:57:04 aztec-1 | _ 21:57:04 aztec-1 | /\ | | 21:57:04 aztec-1 | / \ ___| |_ ___ ___ 21:57:04 aztec-1 | / /\ \ |_ / __/ _ \/ __| 21:57:04 aztec-1 | / ____ \ / /| || __/ (__ 21:57:04 aztec-1 | /_/___ \_\/___|\__\___|\___| 21:57:04 aztec-1 | 21:57:04 aztec-1 | https://github.com/AztecProtocol 21:57:04 aztec-1 | 21:57:04 aztec-1 | 21:57:04 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by... 21:57:04 aztec-1 | Setting up test accounts 21:57:06 aztec-1 | [21:57:05.506] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-Pwce80/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 21:57:06 aztec-1 | [21:57:05.788] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 21:57:06 aztec-1 | [21:57:05.793] WARN: sandbox Set block interval to 12 21:57:06 aztec-1 | [21:57:05.975] INFO: sandbox Waiting for 7 transactions to be mined... 21:57:06 aztec-1 | [21:57:05.998] INFO: sandbox All transactions mined successfully 21:57:06 aztec-1 | [21:57:06.082] INFO: sandbox Waiting for 9 transactions to be mined... 21:57:06 aztec-1 | [21:57:06.110] INFO: sandbox All transactions mined successfully 21:57:06 aztec-1 | [21:57:06.280] INFO: sandbox Waiting for 11 transactions to be mined... 21:57:06 aztec-1 | [21:57:06.304] INFO: sandbox All transactions mined successfully 21:57:06 aztec-1 | [21:57:06.366] INFO: sandbox Waiting for 12 transactions to be mined... 21:57:06 aztec-1 | [21:57:06.392] INFO: sandbox All transactions mined successfully 21:57:06 aztec-1 | [21:57:06.398] INFO: sandbox Waiting for 12 transactions to be mined... 21:57:06 aztec-1 | [21:57:06.421] INFO: sandbox All transactions mined successfully 21:57:06 aztec-1 | [21:57:06.437] 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"} 21:57:06 aztec-1 | [21:57:06.438] INFO: sandbox Handing over to governance 21:57:06 aztec-1 | [21:57:06.445] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 21:57:06 aztec-1 | [21:57:06.446] INFO: telemetry:client Using NoopTelemetryClient 21:57:06 aztec-1 | [21:57:06.446] INFO: blob-sink:client Creating local blob sink client. 21:57:06 aztec-1 | [21:57:06.452] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 21:57:06 aztec-1 | [21:57:06.453] WARN: foundation:test-date-provider Time set to 2025-06-16T22:01:48.000Z {"offset":281547,"timeMs":1750111308000} 21:57:06 aztec-1 | [21:57:06.478] INFO: archiver:lmdb Starting data store with maxReaders 16 21:57:07 aztec-1 | [21:57:06.915] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x1402d2ec0ddf08a038df18d54d0b6b7ea3e45fb022d6609cd77b1324d96231e2 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xd61b0bd557b0702aebe3cd2dc408816130aa39ae422a6c5f2fdcd8dbdcff191d","l1BlockNumber":20}} 21:57:07 aztec-1 | [21:57:06.938] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x1402d2ec0ddf08a038df18d54d0b6b7ea3e45fb022d6609cd77b1324d96231e2","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 21:57:07 aztec-1 | [21:57:06.950] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-ZHRet5/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 21:57:07 aztec-1 | [21:57:07.189] INFO: world_state Created world state synchroniser with block history of 64 21:57:07 aztec-1 | [21:57:07.189] WARN: node Aztec node is accepting fake proofs 21:57:07 aztec-1 | [21:57:07.197] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 21:57:07 aztec-1 | [21:57:07.216] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 21:57:07 aztec-1 | [21:57:07.233] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 21:57:07 aztec-1 | [21:57:07.250] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 21:57:07 aztec-1 | [21:57:07.254] INFO: world_state Started world state synchronizer from block 1 21:57:07 aztec-1 | [21:57:07.257] INFO: p2p Starting p2p client from block 0 with empty mempools 21:57:07 aztec-1 | [21:57:07.545] INFO: epoch-prune-watcher EpochPruneWatcher initialized 21:57:07 aztec-1 | [21:57:07.609] INFO: slasher Starting Slasher client... 21:57:07 aztec-1 | [21:57:07.620] INFO: sequencer-client Deploying forwarder contract 21:57:07 aztec-1 | [21:57:07.645] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 21:57:07 aztec-1 | [21:57:07.652] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 21:57:07 aztec-1 | [21:57:07.653] 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} 21:57:07 aztec-1 | [21:57:07.655] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 21:57:07 aztec-1 | [21:57:07.656] INFO: node Aztec Node version: 0.87.6 21:57:07 aztec-1 | [21:57:07.656] 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"} 21:57:07 aztec-1 | [21:57:07.659] INFO: pxe:data:lmdb Starting data store with maxReaders 16 21:57:07 aztec-1 | [21:57:07.674] 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":1750111309,"syncedToL1Ts":1750111308,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750111296,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750111332},"newBlockNumber":1,"expectedSlot":1} 21:57:07 aztec-1 | [21:57:07.730] 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":1750111309,"syncedToL1Ts":1750111308,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750111296,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750111332},"newBlockNumber":1,"expectedSlot":1} 21:57:07 aztec-1 | [21:57:07.796] 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":1750111309,"syncedToL1Ts":1750111320,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750111296,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750111332},"newBlockNumber":1,"expectedSlot":1} 21:57:07 aztec-1 | [21:57:07.926] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 21:57:07 aztec-1 | [21:57:07.927] WARN: foundation:test-date-provider Time set to 2025-06-16T22:02:00.000Z {"offset":292074,"timeMs":1750111320000} 21:57:08 aztec-1 | Setting up funded test accounts... 21:57:08 aztec-1 | [21:57:08.077] INFO: pxe:service Started PXE connected to chain 31337 version 868854323 21:57:08 aztec-1 | [21:57:08.180] INFO: pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 21:57:08 aztec-1 | [21:57:08.259] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 21:57:08 aztec-1 | [21:57:08.262] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 21:57:08 aztec-1 | [21:57:08.449] INFO: pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 21:57:11 aztec-1 | [21:57:11.272] INFO: pxe:service Proving completed in 2777.8769410000004ms {"timings":{"total":2777.8769410000004,"sync":15.333717999999863,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":166.46215200000188,"oracles":{"callPrivateFunction":{"times":[762.1953240000003,368.1497099999997,218.11749299999974]}}},{"functionName":"private_kernel_init","time":127.94913900000029},{"functionName":"ContractClassRegisterer:register","time":737.5981209999991,"oracles":{"loadCapsule":{"times":[10.103791999999885]},"notifyCreatedNullifier":{"times":[23.588811000001442]},"debugLog":{"times":[0.5133409999998548]},"notifyCreatedContractClassLog":{"times":[9.134162000000288]}}},{"functionName":"private_kernel_inner","time":163.24361900000076},{"functionName":"SchnorrAccount:constructor","time":347.86750100000063,"oracles":{"getContractInstance":{"times":[4.591551999999865]},"debugLog":{"times":[0.15233299999999872,0.16122299999915413]},"fetchTaggedLogs":{"times":[95.30381699999998]},"loadCapsule":{"times":[2.1491270000005898,2.187737999998717,1.8976220000004105]},"validateEnqueuedNotesAndEvents":{"times":[8.966207999999824]},"notifyCreatedNullifier":{"times":[0.3069869999999355,0.3368479999990086]},"notifyCreatedNote":{"times":[0.5698730000003707]},"getRandomField":{"times":[0.27002600000014354,0.21114499999930558,0.06754200000068522,0.1537739999985206,0.06565100000079838,0.06237099999998463,0.03767100000004575,0.035690999999133055,0.05878099999972619,0.07358099999873957,0.039849999999205465]},"getIndexedTaggingSecretAsSender":{"times":[40.288110999999844]},"incrementAppTaggingSecretIndexAsSender":{"times":[32.166291000001365]}}},{"functionName":"private_kernel_inner","time":144.10733700000128},{"functionName":"SchnorrAccount:entrypoint","time":188.29687399999966,"oracles":{"debugLog":{"times":[0.20014500000070257,0.11474199999975099,0.4990010000001348]},"fetchTaggedLogs":{"times":[50.51801699999851]},"loadCapsule":{"times":[0.2509650000010879,0.18543400000089605,0.3708680000017921]},"validateEnqueuedNotesAndEvents":{"times":[6.135046000001239]},"getNotes":{"times":[2.302230999999665]},"getAuthWitness":{"times":[0.3819889999995212]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.3317299999998795]}}},{"functionName":"private_kernel_inner","time":124.98744400000032},{"functionName":"private_kernel_reset","time":176.64168600000085},{"functionName":"private_kernel_tail","time":94.2646650000006}],"unaccounted":491.1246849999952}} 21:57:11 aztec-1 | [21:57:11.400] INFO: node Received tx 0x2c6f8a118727d5827cf325aefc6fb4c880746d4bdb10feec15e9c2e00b6fae5a {"txHash":"0x2c6f8a118727d5827cf325aefc6fb4c880746d4bdb10feec15e9c2e00b6fae5a"} 21:57:11 aztec-1 | [21:57:11.400] INFO: pxe:service Sent transaction 0x2c6f8a118727d5827cf325aefc6fb4c880746d4bdb10feec15e9c2e00b6fae5a 21:57:11 aztec-1 | [21:57:11.496] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04210281099999884s {"duration":0.04210281099999884,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 21:57:11 aztec-1 | [21:57:11.520] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1ce8ab408826c4543c5f446e53f9cc1e7802971fd8557560d1fd0618def4afa0","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750111332,"version":868854323},"txHashes":["0x2c6f8a118727d5827cf325aefc6fb4c880746d4bdb10feec15e9c2e00b6fae5a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":76.1162030000014,"publicProcessDuration":42.659663000000364,"rollupCircuitsDuration":68.90638300000137,"txCount":1,"blockNumber":1,"blockTimestamp":1750111332,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 21:57:14 aztec-1 | [21:57:14.017] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 21:57:14 aztec-1 | [21:57:14.021] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 21:57:14 aztec-1 | [21:57:14.024] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 21:57:14 aztec-1 | [21:57:14.113] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1ce8ab408826c4543c5f446e53f9cc1e7802971fd8557560d1fd0618def4afa0","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750111332,"version":868854323},"archiveRoot":"0x1d9a153face112dee1a711fddbd9ac631e7ebdc390fc0af9a91494a474a37141","archiveNextLeafIndex":2} 21:57:14 aztec-1 | [21:57:14.120] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 21:57:14 aztec-1 | [21:57:14.158] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":18.954498999999487,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750111332,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 21:57:14 aztec-1 | [21:57:14.250] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 21:57:14 aztec-1 | [21:57:14.250] WARN: foundation:test-date-provider Time set to 2025-06-16T22:02:12.000Z {"offset":297750,"timeMs":1750111332000} 21:57:14 aztec-1 | [21:57:14.286] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750111368 21:57:14 aztec-1 | [21:57:14.286] WARN: foundation:test-date-provider Time set to 2025-06-16T22:02:48.000Z {"offset":333714,"timeMs":1750111368000} 21:57:14 aztec-1 | [21:57:14.286] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 21:57:14 aztec-1 | [21:57:14.306] INFO: pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f 21:57:14 aztec-1 | [21:57:14.439] INFO: pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 21:57:16 aztec-1 | [21:57:16.057] INFO: pxe:service Proving completed in 1600.4472879999994ms {"timings":{"total":1600.4472879999994,"sync":20.99868400000014,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":132.47863100000177,"oracles":{"callPrivateFunction":{"times":[400.1795289999991,213.64556400000038]}}},{"functionName":"private_kernel_init","time":80.09215099999892},{"functionName":"SchnorrAccount:constructor","time":366.9405229999993,"oracles":{"getContractInstance":{"times":[11.887923000000228]},"debugLog":{"times":[0.15553300000101444,0.11276299999917683]},"fetchTaggedLogs":{"times":[75.24966400000085]},"loadCapsule":{"times":[0.19177399999898626,0.2572259999997186,0.3104369999982737]},"validateEnqueuedNotesAndEvents":{"times":[5.969622000000527]},"notifyCreatedNullifier":{"times":[0.35430799999994633,0.21261500000036904]},"notifyCreatedNote":{"times":[0.12049300000035146]},"getRandomField":{"times":[0.1293229999992036,0.1811440000001312,0.056242000000565895,0.04108999999880325,0.0397609999999986,0.04166099999929429,0.039891000000352506,0.03460100000120292,0.04605000000083237,0.03159100000084436,0.038850999999340274]},"getIndexedTaggingSecretAsSender":{"times":[78.89914499999941]},"incrementAppTaggingSecretIndexAsSender":{"times":[30.584335999999894]}}},{"functionName":"private_kernel_inner","time":146.8899079999992},{"functionName":"SchnorrAccount:entrypoint","time":189.43589799999972,"oracles":{"debugLog":{"times":[0.1933549999994284,0.08845199999996112,0.14739299999928335]},"fetchTaggedLogs":{"times":[74.13303899999846]},"loadCapsule":{"times":[0.20031400000152644,0.15048299999943993,0.1291930000006687]},"validateEnqueuedNotesAndEvents":{"times":[5.994402999998783]},"getNotes":{"times":[3.1193289999991975]},"getAuthWitness":{"times":[0.1539329999995971]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.3685879999993631]}}},{"functionName":"private_kernel_inner","time":106.57879700000012},{"functionName":"private_kernel_reset","time":197.468707},{"functionName":"private_kernel_tail","time":61.11232100000052}],"unaccounted":298.4516679999997}} 21:57:16 aztec-1 | [21:57:16.098] INFO: node Received tx 0x245b2c38909fb893b0858beab29d32a226fe9e5d645de234efed8fd3a5a5e83a {"txHash":"0x245b2c38909fb893b0858beab29d32a226fe9e5d645de234efed8fd3a5a5e83a"} 21:57:16 aztec-1 | [21:57:16.099] INFO: pxe:service Sent transaction 0x245b2c38909fb893b0858beab29d32a226fe9e5d645de234efed8fd3a5a5e83a 21:57:16 aztec-1 | [21:57:16.174] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01719467000000077s {"duration":0.01719467000000077,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 21:57:16 aztec-1 | [21:57:16.207] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x09a44510bc6ea6faeffe4bcb4bdfe56dd84c4ffef1043b61987178410b48c19e","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750111368,"version":868854323},"txHashes":["0x245b2c38909fb893b0858beab29d32a226fe9e5d645de234efed8fd3a5a5e83a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":57.988162000001466,"publicProcessDuration":17.303531999999905,"rollupCircuitsDuration":52.03429999999935,"txCount":1,"blockNumber":2,"blockTimestamp":1750111368,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 21:57:16 aztec-1 | [21:57:16.388] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 21:57:16 aztec-1 | [21:57:16.391] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750111404 21:57:16 aztec-1 | [21:57:16.391] WARN: foundation:test-date-provider Time set to 2025-06-16T22:03:24.000Z {"offset":367609,"timeMs":1750111404000} 21:57:16 aztec-1 | [21:57:16.391] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 21:57:16 aztec-1 | [21:57:16.496] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 21:57:16 aztec-1 | [21:57:16.497] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 21:57:16 aztec-1 | [21:57:16.506] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x09a44510bc6ea6faeffe4bcb4bdfe56dd84c4ffef1043b61987178410b48c19e","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750111368,"version":868854323},"archiveRoot":"0x2c9c318d22d337086efe5994286adf7738a03e502607d658f208165703f22e15","archiveNextLeafIndex":3} 21:57:16 aztec-1 | [21:57:16.544] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":16.530626000001575,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750111368,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 21:57:16 aztec-1 | [21:57:16.606] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 21:57:16 aztec-1 | [21:57:16.647] INFO: pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 21:57:16 aztec-1 | [21:57:16.772] INFO: pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 21:57:18 aztec-1 | [21:57:18.401] INFO: pxe:service Proving completed in 1618.1230880000003ms {"timings":{"total":1618.1230880000003,"sync":34.940771999999924,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":109.82628800000384,"oracles":{"callPrivateFunction":{"times":[385.1400859999994,329.88566400000127]}}},{"functionName":"private_kernel_init","time":84.2219929999992},{"functionName":"SchnorrAccount:constructor","time":353.64482899999894,"oracles":{"getContractInstance":{"times":[3.9240069999996194]},"debugLog":{"times":[0.17068400000061956,0.09631199999967066]},"fetchTaggedLogs":{"times":[110.46989199999916]},"loadCapsule":{"times":[0.1837039999991248,0.1970339999988937,0.19508499999938067]},"validateEnqueuedNotesAndEvents":{"times":[6.022463000001153]},"notifyCreatedNullifier":{"times":[0.272555999999895,0.26156600000103936]},"notifyCreatedNote":{"times":[0.1478029999998398]},"getRandomField":{"times":[0.1644430000014836,0.181323999999222,0.09349299999848881,0.09980200000063633,0.07526099999995495,0.05031100000087463,0.059951000001092325,0.05972199999996519,0.049261999998634565,0.050251000000571366,0.046890999999959604]},"getIndexedTaggingSecretAsSender":{"times":[50.00949600000058]},"incrementAppTaggingSecretIndexAsSender":{"times":[32.660311999999976]}}},{"functionName":"private_kernel_inner","time":130.1010869999991},{"functionName":"SchnorrAccount:entrypoint","time":298.7404149999966,"oracles":{"debugLog":{"times":[0.2192750000031083,0.12471300000106567,0.23198499999853084]},"fetchTaggedLogs":{"times":[124.4733120000019]},"loadCapsule":{"times":[0.1812339999996766,0.3626379999986966,0.4645300000011048]},"validateEnqueuedNotesAndEvents":{"times":[7.2048890000005485]},"getNotes":{"times":[1.6214060000020254]},"getAuthWitness":{"times":[0.25786599999992177]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.548692000000301]}}},{"functionName":"private_kernel_inner","time":97.35180200000104},{"functionName":"private_kernel_reset","time":150.3757149999983},{"functionName":"private_kernel_tail","time":60.425545999998576}],"unaccounted":298.4946410000048}} 21:57:18 aztec-1 | [21:57:18.445] INFO: node Received tx 0x262200a2dd196e0efe5d06d3eb8a2cd9e472cf99cec248902ddaa98917a25e45 {"txHash":"0x262200a2dd196e0efe5d06d3eb8a2cd9e472cf99cec248902ddaa98917a25e45"} 21:57:18 aztec-1 | [21:57:18.445] INFO: pxe:service Sent transaction 0x262200a2dd196e0efe5d06d3eb8a2cd9e472cf99cec248902ddaa98917a25e45 21:57:18 aztec-1 | [21:57:18.517] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01804269900000145s {"duration":0.01804269900000145,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 21:57:18 aztec-1 | [21:57:18.543] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x03a7848e9bc1fe24908430b08b3b93ce8e5b6de2fbbc33097d62c19c062c2f97","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750111404,"version":868854323},"txHashes":["0x262200a2dd196e0efe5d06d3eb8a2cd9e472cf99cec248902ddaa98917a25e45"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":51.186180999997305,"publicProcessDuration":18.166901999997208,"rollupCircuitsDuration":45.55846699999893,"txCount":1,"blockNumber":3,"blockTimestamp":1750111404,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 21:57:18 aztec-1 | [21:57:18.776] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 21:57:18 aztec-1 | [21:57:18.825] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 21:57:18 aztec-1 | [21:57:18.825] WARN: foundation:test-date-provider Time set to 2025-06-16T22:03:36.000Z {"offset":377175,"timeMs":1750111416000} 21:57:18 aztec-1 | [21:57:18.876] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x03a7848e9bc1fe24908430b08b3b93ce8e5b6de2fbbc33097d62c19c062c2f97","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750111404,"version":868854323},"archiveRoot":"0x10fb8535c9b7b7846a35db5dd71b626bf7a884adf2ad39fc3792a1d959fbd701","archiveNextLeafIndex":4} 21:57:18 aztec-1 | [21:57:18.919] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":15.824819999997999,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750111404,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 21:57:18 aztec-1 | [21:57:18.950] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 21:57:18 aztec-1 | [21:57:18.953] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 21:57:18 aztec-1 | Initial Accounts: 21:57:18 aztec-1 | 21:57:18 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 21:57:18 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc 21:57:18 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 21:57:18 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 21:57:18 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 21:57:18 aztec-1 | 21:57:18 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 21:57:18 aztec-1 | 21:57:18 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 21:57:18 aztec-1 | 21:57:18 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f 21:57:18 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0 21:57:18 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 21:57:18 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 21:57:18 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 21:57:18 aztec-1 | 21:57:18 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 21:57:18 aztec-1 | 21:57:18 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 21:57:18 aztec-1 | 21:57:18 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 21:57:18 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d 21:57:18 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 21:57:18 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 21:57:18 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 21:57:18 aztec-1 | 21:57:18 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 21:57:18 aztec-1 | 21:57:18 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 21:57:18 aztec-1 | 21:57:18 aztec-1 | 21:57:19 aztec-1 | [21:57:19.816] WARN: pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata 21:57:19 aztec-1 | [21:57:19.817] WARN: pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata 21:57:20 aztec-1 | [21:57:19.819] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 21:57:20 aztec-1 | [21:57:19.852] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 21:57:20 aztec-1 | [21:57:20.100] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750111440 21:57:20 aztec-1 | [21:57:20.100] WARN: foundation:test-date-provider Time set to 2025-06-16T22:04:00.000Z {"offset":399900,"timeMs":1750111440000} 21:57:20 aztec-1 | [21:57:20.100] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 21:57:21 aztec-1 | [21:57:20.648] INFO: pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 21:57:21 aztec-1 | [21:57:20.651] INFO: pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 21:57:21 aztec-1 | [21:57:20.655] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 21:57:23 aztec-1 | [21:57:22.929] INFO: pxe:service Proving completed in 2259.2748360000005ms {"timings":{"total":2259.2748360000005,"sync":20.138824999998178,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":350.21975299999394,"oracles":{"debugLog":{"times":[0.22030499999891617,0.10305199999856995,0.091842000001634,0.18437400000038906,0.09125200000198674,0.10360299999956624,0.07021200000235694,0.11529299999892828]},"fetchTaggedLogs":{"times":[121.27683100000286]},"loadCapsule":{"times":[0.21788500000184285,0.1797950000000128,0.29433699999935925,0.1802739999984624,0.26150500000221655,0.18784400000004098,0.17835399999967194]},"getSharedSecret":{"times":[4.540789999999106]},"aes128Decrypt":{"times":[1.0410329999976966,0.7007159999993746]},"getPublicKeysAndPartialAddress":{"times":[1.4726419999969949]},"getKeyValidationRequest":{"times":[1.8954219999977795]},"storeCapsule":{"times":[8.660962000001746,3.3965749999988475,2.5815769999971963]},"deleteCapsule":{"times":[2.766421000000264]},"validateEnqueuedNotesAndEvents":{"times":[19.102591999999277]},"getNotes":{"times":[3.255091999999422]},"getAuthWitness":{"times":[0.123503000002529]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04039100000227336]},"callPrivateFunction":{"times":[696.8551980000011,98.49048799999946]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2533359999979439]}}},{"functionName":"private_kernel_init","time":48.19621499999994},{"functionName":"ContractClassRegisterer:register","time":682.7094260000013,"oracles":{"loadCapsule":{"times":[3.6106399999989662]},"notifyCreatedNullifier":{"times":[0.3056060000017169]},"debugLog":{"times":[0.11046200000055251]},"notifyCreatedContractClassLog":{"times":[5.622983999997814]}}},{"functionName":"private_kernel_inner","time":96.37883099999817},{"functionName":"ContractInstanceDeployer:deploy","time":55.793914000005316,"oracles":{"storeInExecutionCache":{"times":[0.2061649999996007]},"callPrivateFunction":{"times":[35.845933000000514]},"notifyCreatedNullifier":{"times":[0.2285749999973632]},"debugLog":{"times":[0.14866299999994226]}}},{"functionName":"private_kernel_inner","time":127.80851599999733},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":27.282242999997834,"oracles":{}},{"functionName":"private_kernel_inner","time":157.6492560000006},{"functionName":"private_kernel_reset","time":244.0701360000021},{"functionName":"private_kernel_tail","time":86.3320590000003}],"unaccounted":362.69566200000554}} 21:57:23 aztec-1 | [21:57:23.062] INFO: node Received tx 0x26d324a1e4613b4e295d4ed3f7ebc84ed2ddbf8cb5ab74372b2b3cca327ae2cc {"txHash":"0x26d324a1e4613b4e295d4ed3f7ebc84ed2ddbf8cb5ab74372b2b3cca327ae2cc"} 21:57:23 aztec-1 | [21:57:23.062] INFO: pxe:service Sent transaction 0x26d324a1e4613b4e295d4ed3f7ebc84ed2ddbf8cb5ab74372b2b3cca327ae2cc 21:57:25 aztec-1 | [21:57:25.198] INFO: pxe:service Proving completed in 2267.8425640000023ms {"timings":{"total":2267.8425640000023,"sync":105.96861200000058,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":455.195283999994,"oracles":{"debugLog":{"times":[0.1263230000004114,0.10152200000084122,0.08503199999904609,0.20388500000262866,0.1235129999986384,0.11806200000137324,0.10051200000089011,0.1371629999994184]},"fetchTaggedLogs":{"times":[120.81064100000003]},"loadCapsule":{"times":[0.15685300000041025,0.23383499999908963,0.47739000000001397,1.3539199999977427,0.3449380000020028,83.48705600000176,2.1242070000007516]},"getSharedSecret":{"times":[3.651270000002114]},"aes128Decrypt":{"times":[0.18384399999922607,0.6855050000012852]},"getPublicKeysAndPartialAddress":{"times":[1.4225920000026235]},"getKeyValidationRequest":{"times":[50.80434299999979]},"storeCapsule":{"times":[2.5465560000011465,2.684529999998631,2.5661570000011125]},"deleteCapsule":{"times":[2.2575199999992037]},"validateEnqueuedNotesAndEvents":{"times":[20.472123000003194]},"getNotes":{"times":[3.7658139999984996]},"getAuthWitness":{"times":[0.18331400000170106]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0767520000008517]},"callPrivateFunction":{"times":[630.3201279999994,157.12509399999908]},"notifyEnqueuedPublicFunctionCall":{"times":[0.10178200000154902]}}},{"functionName":"private_kernel_init","time":51.67942200000107},{"functionName":"ContractClassRegisterer:register","time":609.879696,"oracles":{"loadCapsule":{"times":[1.3916510000017297]},"notifyCreatedNullifier":{"times":[0.8794190000007802]},"debugLog":{"times":[0.15986400000110734]},"notifyCreatedContractClassLog":{"times":[3.325514000000112]}}},{"functionName":"private_kernel_inner","time":96.89285200000086},{"functionName":"ContractInstanceDeployer:deploy","time":107.0262460000049,"oracles":{"storeInExecutionCache":{"times":[0.07642200000191224]},"callPrivateFunction":{"times":[54.41565300000002]},"notifyCreatedNullifier":{"times":[0.3847879999993893]},"debugLog":{"times":[0.16652400000020862]}}},{"functionName":"private_kernel_inner","time":109.6558440000008},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":38.03968199999872,"oracles":{}},{"functionName":"private_kernel_inner","time":94.16518200000064},{"functionName":"private_kernel_reset","time":168.48072299999694},{"functionName":"private_kernel_tail","time":123.83336999999665}],"unaccounted":307.0256510000072}} 21:57:25 aztec-1 | [21:57:25.338] INFO: node Received tx 0x03b61aa8bf5d382e4243a728ac15e49026390ac6f43b761cb6f4176415fd9f86 {"txHash":"0x03b61aa8bf5d382e4243a728ac15e49026390ac6f43b761cb6f4176415fd9f86"} 21:57:25 aztec-1 | [21:57:25.338] INFO: pxe:service Sent transaction 0x03b61aa8bf5d382e4243a728ac15e49026390ac6f43b761cb6f4176415fd9f86 21:57:25 aztec-1 | [21:57:25.344] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 2.1639532849999994s {"duration":2.1639532849999994,"rate":146237.90734928,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064} 21:57:25 aztec-1 | [21:57:25.398] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 141949.06343393814 mana/s {"blockHash":"0x1987ecad03c9025dfdee2cd13d5bb645f28eb0cfca5041df904f559479f9651b","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750111440,"version":868854323},"txHashes":["0x26d324a1e4613b4e295d4ed3f7ebc84ed2ddbf8cb5ab74372b2b3cca327ae2cc"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2229.256491,"publicProcessDuration":2164.119988999999,"rollupCircuitsDuration":2223.4987330000004,"txCount":1,"blockNumber":4,"blockTimestamp":1750111440,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 21:57:25 aztec-1 | [21:57:25.657] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 21:57:25 aztec-1 | [21:57:25.657] WARN: foundation:test-date-provider Time set to 2025-06-16T22:04:12.000Z {"offset":406343,"timeMs":1750111452000} 21:57:25 aztec-1 | [21:57:25.661] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 21:57:25 aztec-1 | [21:57:25.664] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 21:57:25 aztec-1 | [21:57:25.665] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 21:57:25 aztec-1 | [21:57:25.668] WARN: archiver Failed to reach L2 block 4 at 31 (latest is 3). Rolling back last synched L1 block number to 30. {"latestLocalL2BlockNumber":3,"latestLocalL2BlockArchive":"0x10fb8535c9b7b7846a35db5dd71b626bf7a884adf2ad39fc3792a1d959fbd701","blocksSynchedTo":30,"currentL1BlockNumber":31,"provenBlockNumber":3,"provenArchive":"0x10fb8535c9b7b7846a35db5dd71b626bf7a884adf2ad39fc3792a1d959fbd701","pendingBlockNumber":4,"pendingArchive":"0x0782980accc46a657fb69962f019fdd71c743d74d66b04015aa8635f7b41b6b1"} 21:57:25 aztec-1 | [21:57:25.730] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750111476 21:57:25 aztec-1 | [21:57:25.730] WARN: foundation:test-date-provider Time set to 2025-06-16T22:04:36.000Z {"offset":430270,"timeMs":1750111476000} 21:57:25 aztec-1 | [21:57:25.730] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 21:57:25 aztec-1 | [21:57:25.836] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x1987ecad03c9025dfdee2cd13d5bb645f28eb0cfca5041df904f559479f9651b","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750111440,"version":868854323},"archiveRoot":"0x0782980accc46a657fb69962f019fdd71c743d74d66b04015aa8635f7b41b6b1","archiveNextLeafIndex":5} 21:57:25 aztec-1 | [21:57:25.844] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 21:57:25 aztec-1 | [21:57:25.909] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":17.79037000000244,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750111440,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 21:57:26 aztec-1 | [21:57:26.195] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.22783971399999792s {"duration":0.22783971399999792,"rate":174644.70658526354,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768} 21:57:26 aztec-1 | [21:57:26.227] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 147655.4402654507 mana/s {"blockHash":"0x0e7381fab26cda3fafaf2cb1a0902cf61d9cf212ca92b4b1f018cb318275b524","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750111476,"version":868854323},"txHashes":["0x03b61aa8bf5d382e4243a728ac15e49026390ac6f43b761cb6f4176415fd9f86"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":269.4481580000029,"publicProcessDuration":228.1077099999966,"rollupCircuitsDuration":263.38517499999944,"txCount":1,"blockNumber":5,"blockTimestamp":1750111476,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 21:57:26 aztec-1 | [21:57:26.557] INFO: aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed. 21:57:26 aztec-1 | [21:57:26.710] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 21:57:26 aztec-1 | [21:57:26.772] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 21:57:26 aztec-1 | [21:57:26.772] WARN: foundation:test-date-provider Time set to 2025-06-16T22:04:48.000Z {"offset":441228,"timeMs":1750111488000} 21:57:26 aztec-1 | [21:57:26.780] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 21:57:26 aztec-1 | [21:57:26.783] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 21:57:26 aztec-1 | [21:57:26.793] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750111512 21:57:26 aztec-1 | [21:57:26.793] WARN: foundation:test-date-provider Time set to 2025-06-16T22:05:12.000Z {"offset":465207,"timeMs":1750111512000} 21:57:26 aztec-1 | [21:57:26.793] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 21:57:26 aztec-1 | [21:57:26.854] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x0e7381fab26cda3fafaf2cb1a0902cf61d9cf212ca92b4b1f018cb318275b524","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750111476,"version":868854323},"archiveRoot":"0x1bd8bbd4d2084073acbc2d120a832a984d64e958c541d353b01e618a070ddf1f","archiveNextLeafIndex":6} 21:57:26 aztec-1 | [21:57:26.934] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":17.480844000001525,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750111476,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 21:57:27 aztec-1 | [21:57:26.938] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 21:57:27 aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 21:57:27 aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 21:57:28 aztec-1 | [21:57:27.613] INFO: aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed. 21:57:28 aztec-1 | [21:57:27.648] WARN: pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata 21:57:28 aztec-1 | [21:57:27.651] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 21:57:28 aztec-1 | [21:57:27.826] INFO: pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e 21:57:30 aztec-1 | [21:57:30.063] INFO: pxe:service Proving completed in 2222.7237080000014ms {"timings":{"total":2222.7237080000014,"sync":36.10565300000235,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":91.49374999999782,"oracles":{"callPrivateFunction":{"times":[767.6696709999997,99.3985130000001,42.32991000000038]}}},{"functionName":"private_kernel_init","time":52.03826300000219},{"functionName":"ContractClassRegisterer:register","time":750.9529739999998,"oracles":{"loadCapsule":{"times":[2.907203999999183]},"notifyCreatedNullifier":{"times":[0.33055700000113575]},"debugLog":{"times":[0.104962000001251]},"notifyCreatedContractClassLog":{"times":[4.701343999997334]}}},{"functionName":"private_kernel_inner","time":112.35606700000062},{"functionName":"ContractInstanceDeployer:deploy","time":52.82636999999886,"oracles":{"storeInExecutionCache":{"times":[0.06732199999896693]},"callPrivateFunction":{"times":[41.07972200000222]},"notifyCreatedNullifier":{"times":[0.17805399999997462]},"debugLog":{"times":[0.10054200000013225]}}},{"functionName":"private_kernel_inner","time":113.7474779999975},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":31.431280000000697,"oracles":{}},{"functionName":"private_kernel_inner","time":149.91838300000018},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":30.86273699999947,"oracles":{"debugLog":{"times":[0.09741199999916716]}}},{"functionName":"private_kernel_inner","time":114.8236109999998},{"functionName":"private_kernel_reset","time":203.0815709999988},{"functionName":"private_kernel_tail","time":81.09129100000064}],"unaccounted":401.9942800000026}} 21:57:30 aztec-1 | [21:57:30.158] INFO: node Received tx 0x1418c1fc64fffef8b7953f6c0146ed5ddef0f0ebd527d5afe88e6ea529138b34 {"txHash":"0x1418c1fc64fffef8b7953f6c0146ed5ddef0f0ebd527d5afe88e6ea529138b34"} 21:57:30 aztec-1 | [21:57:30.158] INFO: pxe:service Sent transaction 0x1418c1fc64fffef8b7953f6c0146ed5ddef0f0ebd527d5afe88e6ea529138b34 21:57:30 aztec-1 | [21:57:30.267] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.029258892999998353s {"duration":0.029258892999998353,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 21:57:30 aztec-1 | [21:57:30.286] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x04e3671e6ac70a757799572898d9b49cb18be35535a972b9defbe853504694e7","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750111512,"version":868854323},"txHashes":["0x1418c1fc64fffef8b7953f6c0146ed5ddef0f0ebd527d5afe88e6ea529138b34"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":56.682254999999714,"publicProcessDuration":29.37356500000169,"rollupCircuitsDuration":50.79202499999883,"txCount":1,"blockNumber":6,"blockTimestamp":1750111512,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 21:57:30 aztec-1 | [21:57:30.468] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 21:57:30 aztec-1 | [21:57:30.482] WARN: archiver Failed to reach L2 block 6 at 35 (latest is 5). Rolling back last synched L1 block number to 34. {"latestLocalL2BlockNumber":5,"latestLocalL2BlockArchive":"0x1bd8bbd4d2084073acbc2d120a832a984d64e958c541d353b01e618a070ddf1f","blocksSynchedTo":34,"currentL1BlockNumber":35,"provenBlockNumber":5,"provenArchive":"0x1bd8bbd4d2084073acbc2d120a832a984d64e958c541d353b01e618a070ddf1f","pendingBlockNumber":6,"pendingArchive":"0x06bf34f8b6b089817518a02074158a7c9fe3ebefba07bb26ff66e5d1eaa62cfe"} 21:57:30 aztec-1 | [21:57:30.488] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 21:57:30 aztec-1 | [21:57:30.488] WARN: foundation:test-date-provider Time set to 2025-06-16T22:05:24.000Z {"offset":473512,"timeMs":1750111524000} 21:57:30 aztec-1 | [21:57:30.509] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 21:57:30 aztec-1 | [21:57:30.510] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 21:57:30 aztec-1 | [21:57:30.568] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750111548 21:57:30 aztec-1 | [21:57:30.568] WARN: foundation:test-date-provider Time set to 2025-06-16T22:05:48.000Z {"offset":497432,"timeMs":1750111548000} 21:57:30 aztec-1 | [21:57:30.568] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 21:57:30 aztec-1 | [21:57:30.583] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x04e3671e6ac70a757799572898d9b49cb18be35535a972b9defbe853504694e7","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750111512,"version":868854323},"archiveRoot":"0x06bf34f8b6b089817518a02074158a7c9fe3ebefba07bb26ff66e5d1eaa62cfe","archiveNextLeafIndex":7} 21:57:30 aztec-1 | [21:57:30.588] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 21:57:30 aztec-1 | [21:57:30.644] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":16.837319999998726,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750111512,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 21:57:31 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 21:57:31 aztec-1 | [21:57:31.187] INFO: aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed. 21:57:31 aztec-1 | [21:57:31.198] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x0f448dc6251cc3bb953c3ff6204d865705743d6d83ede909d70d6be1e819299a","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"} 21:57:37 playground-1 | \ 21:57:37 playground-1 | Running 1 test using 1 worker 21:57:37 playground-1 | 21:57:39 playground-1 | 1 [firefox] › browser.spec.ts:3:1 › test (12.7s) 21:57:54 playground-1 | 1 passed (18.5s) 21:57:54 playground-1 | \npm notice 21:57:54 playground-1 | npm notice New major version of npm available! 10.9.2 -> 11.4.2 21:57:54 playground-1 | npm notice Changelog: https://github.com/npm/cli/releases/tag/v11.4.2 21:57:54 playground-1 | npm notice To update run: npm install -g npm@11.4.2 21:57:54 playground-1 | npm notice 21:57:54 playground-1 | \ 21:57:55 playground-1 exited with code 0 21:57:55 Aborting on container exit... 21:57:55 Container playground-firefox-playground-1 Stopping 21:57:55 Container playground-firefox-playground-1 Stopped 21:57:55 Container playground-firefox-aztec-1 Stopping 21:57:56 Container playground-firefox-aztec-1 Stopped 21:57:56 Container playground-firefox-ethereum-1 Stopping 21:57:57 Container playground-firefox-ethereum-1 Stopped