Parent Log:
http://ci.aztec-labs.com/a9198a30c600dd3e
Command: a53e792996799a82 playground/scripts/run_test.sh firefox
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/3b44f825dcd3249b2c8a1105905fa3394aa7213d
Env: REF_NAME=gh-readonly-queue/next/pr-15041-eeab628a4e44477cb6796c5a461ee0c0bb332d75 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Mon Jun 16 17:50:12 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15041_amd64_x3-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_23123200780498f7_next
17:50:13 Network playground-firefox_default Creating
17:50:13 Network playground-firefox_default Created
17:50:13 Container playground-firefox-ethereum-1 Creating
17:50:14 Container playground-firefox-ethereum-1 Created
17:50:14 Container playground-firefox-aztec-1 Creating
17:50:14 Container playground-firefox-aztec-1 Created
17:50:14 Container playground-firefox-playground-1 Creating
17:50:15 Container playground-firefox-playground-1 Created
17:50:15 Attaching to aztec-1, ethereum-1, playground-1
17:50:21 aztec-1 |
17:50:21 aztec-1 | _
17:50:21 aztec-1 | /\ | |
17:50:21 aztec-1 | / \ ___| |_ ___ ___
17:50:21 aztec-1 | / /\ \ |_ / __/ _ \/ __|
17:50:21 aztec-1 | / ____ \ / /| || __/ (__
17:50:21 aztec-1 | /_/___ \_\/___|\__\___|\___|
17:50:21 aztec-1 |
17:50:21 aztec-1 |
https://github.com/AztecProtocol
17:50:21 aztec-1 |
17:50:21 aztec-1 |
17:50:21 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
17:50:21 aztec-1 | Setting up test accounts
17:50:22 aztec-1 | [17:50:21.945]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-4bt8LD/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
17:50:22 aztec-1 | [17:50:22.224]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
17:50:22 aztec-1 | [17:50:22.229]
WARN:
sandbox Set block interval to 12
17:50:22 aztec-1 | [17:50:22.429]
INFO:
sandbox Waiting for 7 transactions to be mined...
17:50:22 aztec-1 | [17:50:22.450]
INFO:
sandbox All transactions mined successfully
17:50:22 aztec-1 | [17:50:22.537]
INFO:
sandbox Waiting for 9 transactions to be mined...
17:50:22 aztec-1 | [17:50:22.564]
INFO:
sandbox All transactions mined successfully
17:50:22 aztec-1 | [17:50:22.724]
INFO:
sandbox Waiting for 11 transactions to be mined...
17:50:22 aztec-1 | [17:50:22.754]
INFO:
sandbox All transactions mined successfully
17:50:22 aztec-1 | [17:50:22.824]
INFO:
sandbox Waiting for 12 transactions to be mined...
17:50:22 aztec-1 | [17:50:22.850]
INFO:
sandbox All transactions mined successfully
17:50:22 aztec-1 | [17:50:22.856]
INFO:
sandbox Waiting for 12 transactions to be mined...
17:50:22 aztec-1 | [17:50:22.877]
INFO:
sandbox All transactions mined successfully
17:50:22 aztec-1 | [17:50:22.890]
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"}
17:50:22 aztec-1 | [17:50:22.890]
INFO:
sandbox Handing over to governance
17:50:22 aztec-1 | [17:50:22.896]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
17:50:22 aztec-1 | [17:50:22.896]
INFO:
telemetry:client Using NoopTelemetryClient
17:50:22 aztec-1 | [17:50:22.897]
INFO:
blob-sink:client Creating local blob sink client.
17:50:22 aztec-1 | [17:50:22.900]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:50:22 aztec-1 | [17:50:22.900]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:55:04.000Z
{"offset":281100,"timeMs":1750096504000}
17:50:22 aztec-1 | [17:50:22.922]
INFO:
archiver:lmdb Starting data store with maxReaders 16
17:50:23 aztec-1 | [17:50:23.322]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x002ca8e16399222700e28b4499228bf0677a96b959e683d6677bc5107df89422
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xadf64c0d4f5e966bc9ccbe75fad5c05d4cec785c7f9a897736249736b009a2b0","l1BlockNumber":20}}
17:50:23 aztec-1 | [17:50:23.349]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x002ca8e16399222700e28b4499228bf0677a96b959e683d6677bc5107df89422","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
17:50:23 aztec-1 | [17:50:23.358]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-ZoKqBY/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
17:50:23 aztec-1 | [17:50:23.582]
INFO:
world_state Created world state synchroniser with block history of 64
17:50:23 aztec-1 | [17:50:23.582]
WARN:
node Aztec node is accepting fake proofs
17:50:23 aztec-1 | [17:50:23.593]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
17:50:23 aztec-1 | [17:50:23.608]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
17:50:23 aztec-1 | [17:50:23.626]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
17:50:23 aztec-1 | [17:50:23.637]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
17:50:23 aztec-1 | [17:50:23.642]
INFO:
world_state Started world state synchronizer from block 1
17:50:24 aztec-1 | [17:50:23.646]
INFO:
p2p Starting p2p client from block 0 with empty mempools
17:50:24 aztec-1 | [17:50:23.936]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
17:50:24 aztec-1 | [17:50:23.995]
INFO:
slasher Starting Slasher client...
17:50:24 aztec-1 | [17:50:24.005]
INFO:
sequencer-client Deploying forwarder contract
17:50:24 aztec-1 | [17:50:24.025]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
17:50:24 aztec-1 | [17:50:24.032]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
17:50:24 aztec-1 | [17:50:24.032]
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}
17:50:24 aztec-1 | [17:50:24.034]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
17:50:24 aztec-1 | [17:50:24.035]
INFO:
node Aztec Node version: 0.87.6
17:50:24 aztec-1 | [17:50:24.035]
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"}
17:50:24 aztec-1 | [17:50:24.041]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
17:50:24 aztec-1 | [17:50:24.049]
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":1750096505,"syncedToL1Ts":1750096504,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750096492,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750096528},"newBlockNumber":1,"expectedSlot":1}
17:50:24 aztec-1 | [17:50:24.106]
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":1750096505,"syncedToL1Ts":1750096504,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750096492,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750096528},"newBlockNumber":1,"expectedSlot":1}
17:50:24 aztec-1 | [17:50:24.163]
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":1750096505,"syncedToL1Ts":1750096516,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750096492,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750096528},"newBlockNumber":1,"expectedSlot":1}
17:50:24 aztec-1 | [17:50:24.266]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:50:24 aztec-1 | [17:50:24.266]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:55:16.000Z
{"offset":291734,"timeMs":1750096516000}
17:50:24 aztec-1 | Setting up funded test accounts...
17:50:24 aztec-1 | [17:50:24.406]
INFO:
pxe:service Started PXE connected to chain 31337 version 3633326044
17:50:24 aztec-1 | [17:50:24.506]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
17:50:24 aztec-1 | [17:50:24.583]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
17:50:24 aztec-1 | [17:50:24.585]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
17:50:24 aztec-1 | [17:50:24.730]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
17:50:28 aztec-1 | [17:50:27.935]
INFO:
pxe:service Proving completed in 3161.9856010000003ms
{"timings":{"total":3161.9856010000003,"sync":5.9478489999992235,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":181.7136320000036,"oracles":{"callPrivateFunction":{"times":[1000.1547280000004,390.6963489999998,227.5934419999994]}}},{"functionName":"private_kernel_init","time":119.76816599999984},{"functionName":"ContractClassRegisterer:register","time":977.0229979999995,"oracles":{"loadCapsule":{"times":[35.78112299999975]},"notifyCreatedNullifier":{"times":[1.0261460000001534]},"debugLog":{"times":[0.5539109999990615]},"notifyCreatedContractClassLog":{"times":[7.925035000000207]}}},{"functionName":"private_kernel_inner","time":156.5932869999997},{"functionName":"SchnorrAccount:constructor","time":361.69911799999863,"oracles":{"getContractInstance":{"times":[5.586252000000968]},"debugLog":{"times":[0.253459000001385,0.2203960000006191]},"fetchTaggedLogs":{"times":[95.04017000000022]},"loadCapsule":{"times":[0.4476730000005773,0.35330599999906553,0.39914999999928114]},"validateEnqueuedNotesAndEvents":{"times":[7.038720000000467]},"notifyCreatedNullifier":{"times":[0.2902119999998831,0.3340150000003632]},"notifyCreatedNote":{"times":[0.5774529999998776]},"getRandomField":{"times":[0.3929490000009537,0.23352699999850302,0.10359799999969255,0.2164759999996022,0.07139599999936763,0.05570399999851361,0.04000300000006973,0.0391829999989568,0.04447299999992538,0.08621600000151375,0.04587399999945774]},"getIndexedTaggingSecretAsSender":{"times":[36.53754899999876]},"incrementAppTaggingSecretIndexAsSender":{"times":[31.596473999999944]}}},{"functionName":"private_kernel_inner","time":118.88220100000035},{"functionName":"SchnorrAccount:entrypoint","time":195.68502399999852,"oracles":{"debugLog":{"times":[0.25006799999937357,0.154872000000978,0.4702550000001793]},"fetchTaggedLogs":{"times":[62.30922199999986]},"loadCapsule":{"times":[0.283132000000478,0.24132800000006682,0.4454329999989568]},"validateEnqueuedNotesAndEvents":{"times":[7.773694000001342]},"getNotes":{"times":[2.219143999998778]},"getAuthWitness":{"times":[0.2911920000005921]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.1553050000002258]}}},{"functionName":"private_kernel_inner","time":150.42031000000134},{"functionName":"private_kernel_reset","time":240.37885500000084},{"functionName":"private_kernel_tail","time":99.85537499999919}],"unaccounted":554.0187859999996}}
17:50:28 aztec-1 | [17:50:28.091]
INFO:
node Received tx 0x20d2eff0d0fb58080794cc5a7a02b207aac12828ae63326de3696dbe9d5b5272
{"txHash":"0x20d2eff0d0fb58080794cc5a7a02b207aac12828ae63326de3696dbe9d5b5272"}
17:50:28 aztec-1 | [17:50:28.091]
INFO:
pxe:service Sent transaction 0x20d2eff0d0fb58080794cc5a7a02b207aac12828ae63326de3696dbe9d5b5272
17:50:28 aztec-1 | [17:50:28.204]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04883347700000013s
{"duration":0.04883347700000013,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
17:50:28 aztec-1 | [17:50:28.228]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x23a02e8ac07ba65c094a3a840ee4bb7ec448e073348ab6d564ee5dacf3b7b778","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750096528,"version":3633326044},"txHashes":["0x20d2eff0d0fb58080794cc5a7a02b207aac12828ae63326de3696dbe9d5b5272"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":85.19990300000063,"publicProcessDuration":50.0763079999997,"rollupCircuitsDuration":75.89809599999899,"txCount":1,"blockNumber":1,"blockTimestamp":1750096528,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:50:31 aztec-1 | [17:50:31.427]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
17:50:31 aztec-1 | [17:50:31.429]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
17:50:31 aztec-1 | [17:50:31.432]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:50:31 aztec-1 | [17:50:31.536]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x23a02e8ac07ba65c094a3a840ee4bb7ec448e073348ab6d564ee5dacf3b7b778","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750096528,"version":3633326044},"archiveRoot":"0x2dcd2cad803cf0a0a1d377183235253caf51270bbb7b24c44842ed771003522a","archiveNextLeafIndex":2}
17:50:31 aztec-1 | [17:50:31.544]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
17:50:31 aztec-1 | [17:50:31.628]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:50:31 aztec-1 | [17:50:31.628]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:55:28.000Z
{"offset":296372,"timeMs":1750096528000}
17:50:31 aztec-1 | [17:50:31.659]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":22.96945400000004,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750096528,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:50:31 aztec-1 | [17:50:31.680]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096564
17:50:31 aztec-1 | [17:50:31.680]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:56:04.000Z
{"offset":332320,"timeMs":1750096564000}
17:50:31 aztec-1 | [17:50:31.680]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
17:50:31 aztec-1 | [17:50:31.703]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
17:50:31 aztec-1 | [17:50:31.848]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
17:50:33 aztec-1 | [17:50:33.730]
INFO:
pxe:service Proving completed in 1857.2358539999987ms
{"timings":{"total":1857.2358539999987,"sync":35.95978600000126,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":126.47241000000031,"oracles":{"callPrivateFunction":{"times":[476.3648599999997,292.3550240000004]}}},{"functionName":"private_kernel_init","time":55.45686399999977},{"functionName":"SchnorrAccount:constructor","time":454.5464400000001,"oracles":{"getContractInstance":{"times":[14.438468000000285]},"debugLog":{"times":[0.29286099999990256,0.12099900000066555]},"fetchTaggedLogs":{"times":[151.01536599999963]},"loadCapsule":{"times":[0.23651699999936682,0.3219939999999042,0.25153799999861803]},"validateEnqueuedNotesAndEvents":{"times":[9.66038799999842]},"notifyCreatedNullifier":{"times":[0.2154549999995652,0.2014949999993405]},"notifyCreatedNote":{"times":[0.15795100000104867]},"getRandomField":{"times":[0.16489300000102958,0.2038749999992433,0.041793000000325264,0.038862999999764725,0.0782550000003539,0.06227500000022701,0.05315400000108639,0.037471999999979744,0.03193199999986973,0.05877399999917543,0.04358399999910034]},"getIndexedTaggingSecretAsSender":{"times":[69.23036400000092]},"incrementAppTaggingSecretIndexAsSender":{"times":[42.25592599999982]}}},{"functionName":"private_kernel_inner","time":149.20128400000067},{"functionName":"SchnorrAccount:entrypoint","time":257.45630600000004,"oracles":{"debugLog":{"times":[0.2705000000005384,0.09303699999873061,0.1424799999986135]},"fetchTaggedLogs":{"times":[100.6589870000007]},"loadCapsule":{"times":[0.2034350000012637,0.17061199999989185,0.13834999999926367]},"validateEnqueuedNotesAndEvents":{"times":[7.144953999999416]},"getNotes":{"times":[1.4333150000002206]},"getAuthWitness":{"times":[0.1649619999989227]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4471929999999702]}}},{"functionName":"private_kernel_inner","time":143.7791470000011},{"functionName":"private_kernel_reset","time":194.69809800000075},{"functionName":"private_kernel_tail","time":93.8614290000005}],"unaccounted":345.8040899999942}}
17:50:33 aztec-1 | [17:50:33.784]
INFO:
node Received tx 0x156ef119682cd3a9650ab70a3eaf275a87e1313d928d75ae82ebd154d184bed7
{"txHash":"0x156ef119682cd3a9650ab70a3eaf275a87e1313d928d75ae82ebd154d184bed7"}
17:50:33 aztec-1 | [17:50:33.784]
INFO:
pxe:service Sent transaction 0x156ef119682cd3a9650ab70a3eaf275a87e1313d928d75ae82ebd154d184bed7
17:50:33 aztec-1 | [17:50:33.880]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03585415699999794s
{"duration":0.03585415699999794,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
17:50:33 aztec-1 | [17:50:33.900]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x25d39761a939d2cf8937badad01b22dca71cf42eb582aae520f5b808883c16d0","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750096564,"version":3633326044},"txHashes":["0x156ef119682cd3a9650ab70a3eaf275a87e1313d928d75ae82ebd154d184bed7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":66.8592690000005,"publicProcessDuration":36.05300200000056,"rollupCircuitsDuration":61.359316000001854,"txCount":1,"blockNumber":2,"blockTimestamp":1750096564,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:50:34 aztec-1 | [17:50:34.106]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:50:34 aztec-1 | [17:50:34.115]
WARN:
archiver Failed to reach L2 block 2 at 27 (latest is 1). Rolling back last synched L1 block number to 26.
{"latestLocalL2BlockNumber":1,"latestLocalL2BlockArchive":"0x2dcd2cad803cf0a0a1d377183235253caf51270bbb7b24c44842ed771003522a","blocksSynchedTo":26,"currentL1BlockNumber":27,"provenBlockNumber":1,"provenArchive":"0x2dcd2cad803cf0a0a1d377183235253caf51270bbb7b24c44842ed771003522a","pendingBlockNumber":2,"pendingArchive":"0x18f0f5ce0408d263018b8ff87b548275cea43b2515e61aab5e8182cd4ec89393"}
17:50:34 aztec-1 | [17:50:34.166]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:50:34 aztec-1 | [17:50:34.166]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:56:16.000Z
{"offset":341834,"timeMs":1750096576000}
17:50:34 aztec-1 | [17:50:34.184]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
17:50:34 aztec-1 | [17:50:34.187]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
17:50:34 aztec-1 | [17:50:34.203]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096600
17:50:34 aztec-1 | [17:50:34.203]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:56:40.000Z
{"offset":365797,"timeMs":1750096600000}
17:50:34 aztec-1 | [17:50:34.203]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
17:50:34 aztec-1 | [17:50:34.232]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x25d39761a939d2cf8937badad01b22dca71cf42eb582aae520f5b808883c16d0","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750096564,"version":3633326044},"archiveRoot":"0x18f0f5ce0408d263018b8ff87b548275cea43b2515e61aab5e8182cd4ec89393","archiveNextLeafIndex":3}
17:50:34 aztec-1 | [17:50:34.236]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
17:50:34 aztec-1 | [17:50:34.267]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":15.3376840000019,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750096564,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:50:34 aztec-1 | [17:50:34.364]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
17:50:34 aztec-1 | [17:50:34.466]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
17:50:36 aztec-1 | [17:50:36.375]
INFO:
pxe:service Proving completed in 1902.2407619999976ms
{"timings":{"total":1902.2407619999976,"sync":23.023127000000386,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":91.40134700000272,"oracles":{"callPrivateFunction":{"times":[459.20056100000147,366.92005900000004]}}},{"functionName":"private_kernel_init","time":49.37921899999856},{"functionName":"SchnorrAccount:constructor","time":439.3292459999975,"oracles":{"getContractInstance":{"times":[4.827534000000014]},"debugLog":{"times":[0.13527999999860185,0.10658800000237534]},"fetchTaggedLogs":{"times":[135.96317400000044]},"loadCapsule":{"times":[0.27441000000180793,0.32596400000329595,1.3243679999977758]},"validateEnqueuedNotesAndEvents":{"times":[19.908148000002257]},"notifyCreatedNullifier":{"times":[0.237397000000783,0.22084600000016508]},"notifyCreatedNote":{"times":[0.13313000000198372]},"getRandomField":{"times":[0.1787239999976009,0.14131099999940488,0.05320400000346126,0.0725349999993341,0.37518700000146055,0.06883499999821652,0.052874000000883825,0.04130299999815179,0.034733000000414904,0.05857399999877089,0.049874000000272645]},"getIndexedTaggingSecretAsSender":{"times":[77.58438500000193]},"incrementAppTaggingSecretIndexAsSender":{"times":[48.32090099999914]}}},{"functionName":"private_kernel_inner","time":104.37210899999991},{"functionName":"SchnorrAccount:entrypoint","time":328.3772749999953,"oracles":{"debugLog":{"times":[0.21508600000015576,0.12527899999986403,0.19842500000231666]},"fetchTaggedLogs":{"times":[141.07725800000117]},"loadCapsule":{"times":[0.19545400000060908,0.16811199999938253,0.13611999999920954]},"validateEnqueuedNotesAndEvents":{"times":[6.039222999999765]},"getNotes":{"times":[1.7581290000016452]},"getAuthWitness":{"times":[0.25365899999815156]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.843142000001535]}}},{"functionName":"private_kernel_inner","time":161.71041100000002},{"functionName":"private_kernel_reset","time":239.2121299999999},{"functionName":"private_kernel_tail","time":97.84251999999833}],"unaccounted":367.59337800000503}}
17:50:36 aztec-1 | [17:50:36.447]
INFO:
node Received tx 0x275bd80e113b81f53922e69f81183a1c8e8f005c923c3da831bb21913a778057
{"txHash":"0x275bd80e113b81f53922e69f81183a1c8e8f005c923c3da831bb21913a778057"}
17:50:36 aztec-1 | [17:50:36.447]
INFO:
pxe:service Sent transaction 0x275bd80e113b81f53922e69f81183a1c8e8f005c923c3da831bb21913a778057
17:50:36 aztec-1 | [17:50:36.538]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.027281238999999916s
{"duration":0.027281238999999916,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
17:50:36 aztec-1 | [17:50:36.570]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x11caff4cb566686ed63d5e7ca6b6df7ded81bd6f48739fb00d53ea6af9c92265","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750096600,"version":3633326044},"txHashes":["0x275bd80e113b81f53922e69f81183a1c8e8f005c923c3da831bb21913a778057"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":70.99034200000096,"publicProcessDuration":27.414679000001343,"rollupCircuitsDuration":65.12477199999921,"txCount":1,"blockNumber":3,"blockTimestamp":1750096600,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:50:36 aztec-1 | [17:50:36.820]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:50:36 aztec-1 | [17:50:36.820]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:56:52.000Z
{"offset":375180,"timeMs":1750096612000}
17:50:36 aztec-1 | [17:50:36.824]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
17:50:36 aztec-1 | [17:50:36.826]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:50:36 aztec-1 | [17:50:36.828]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
17:50:36 aztec-1 | [17:50:36.860]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096636
17:50:36 aztec-1 | [17:50:36.860]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:57:16.000Z
{"offset":399140,"timeMs":1750096636000}
17:50:36 aztec-1 | [17:50:36.860]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
17:50:36 aztec-1 | [17:50:36.950]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x11caff4cb566686ed63d5e7ca6b6df7ded81bd6f48739fb00d53ea6af9c92265","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750096600,"version":3633326044},"archiveRoot":"0x0244ee599f8920bb22492e0416a87ff08cd94dd1bba3f6cf53d82049a150ad07","archiveNextLeafIndex":4}
17:50:36 aztec-1 | [17:50:36.960]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
17:50:36 aztec-1 | [17:50:36.986]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":17.382754000002024,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750096600,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:50:37 aztec-1 | Initial Accounts:
17:50:37 aztec-1 |
17:50:37 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
17:50:37 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
17:50:37 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
17:50:37 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
17:50:37 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
17:50:37 aztec-1 |
17:50:37 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
17:50:37 aztec-1 |
17:50:37 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
17:50:37 aztec-1 |
17:50:37 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
17:50:37 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
17:50:37 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
17:50:37 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
17:50:37 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
17:50:37 aztec-1 |
17:50:37 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
17:50:37 aztec-1 |
17:50:37 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
17:50:37 aztec-1 |
17:50:37 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
17:50:37 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
17:50:37 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
17:50:37 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
17:50:37 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
17:50:37 aztec-1 |
17:50:37 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
17:50:37 aztec-1 |
17:50:37 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
17:50:37 aztec-1 |
17:50:37 aztec-1 |
17:50:38 aztec-1 | [17:50:37.892]
WARN:
pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata
17:50:38 aztec-1 | [17:50:37.892]
WARN:
pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata
17:50:38 aztec-1 | [17:50:37.896]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
17:50:38 aztec-1 | [17:50:37.927]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
17:50:39 aztec-1 | [17:50:38.960]
INFO:
pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2
17:50:39 aztec-1 | [17:50:38.964]
INFO:
pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164
17:50:42 aztec-1 | [17:50:41.608]
INFO:
pxe:service Proving completed in 2620.1753949999984ms
{"timings":{"total":2620.1753949999984,"sync":21.23147600000084,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":430.1326029999982,"oracles":{"debugLog":{"times":[0.2984619999988354,0.10241800000221701,0.08340599999792175,0.15203100000144332,0.10444700000152807,0.09768800000165356,0.08056600000054459,0.15492100000119535]},"fetchTaggedLogs":{"times":[130.2841780000017]},"loadCapsule":{"times":[0.20235500000126194,0.2532290000017383,0.3758879999986675,0.26923900000110734,1.9879360000013548,1.1923669999996491,1.9051599999984319]},"getSharedSecret":{"times":[10.249971000001096]},"aes128Decrypt":{"times":[1.169525999997859,0.6357859999989159]},"getPublicKeysAndPartialAddress":{"times":[8.78652399999919]},"getKeyValidationRequest":{"times":[6.6133240000017395]},"storeCapsule":{"times":[5.972666999998182,2.671386000001803,3.1751729999996314]},"deleteCapsule":{"times":[7.477558000002318]},"validateEnqueuedNotesAndEvents":{"times":[19.25850200000059]},"getNotes":{"times":[3.6885200000033365]},"getAuthWitness":{"times":[0.19206499999927473]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05547400000068592]},"callPrivateFunction":{"times":[774.543321000001,200.8799300000028]},"notifyEnqueuedPublicFunctionCall":{"times":[0.5534899999984191]}}},{"functionName":"private_kernel_init","time":76.10081700000228},{"functionName":"ContractClassRegisterer:register","time":755.7893259999983,"oracles":{"loadCapsule":{"times":[3.170962000000145]},"notifyCreatedNullifier":{"times":[1.131933000000572]},"debugLog":{"times":[0.253378999997949]},"notifyCreatedContractClassLog":{"times":[7.861455999998725]}}},{"functionName":"private_kernel_inner","time":143.2237559999994},{"functionName":"ContractInstanceDeployer:deploy","time":120.62188799999785,"oracles":{"storeInExecutionCache":{"times":[0.3979189999990922]},"callPrivateFunction":{"times":[65.11564200000066]},"notifyCreatedNullifier":{"times":[0.5147470000010799]},"debugLog":{"times":[0.22090599999864935]}}},{"functionName":"private_kernel_inner","time":110.32412499999919},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":48.208614000002854,"oracles":{}},{"functionName":"private_kernel_inner","time":109.00148799999806},{"functionName":"private_kernel_reset","time":191.13392699999895},{"functionName":"private_kernel_tail","time":95.51010999999926}],"unaccounted":518.8972650000032}}
17:50:42 aztec-1 | [17:50:41.823]
INFO:
node Received tx 0x06c0d8ed8783f3141bb5cef53925dfbfbb94ce264083de852d62939e0de2ea8d
{"txHash":"0x06c0d8ed8783f3141bb5cef53925dfbfbb94ce264083de852d62939e0de2ea8d"}
17:50:42 aztec-1 | [17:50:41.823]
INFO:
pxe:service Sent transaction 0x06c0d8ed8783f3141bb5cef53925dfbfbb94ce264083de852d62939e0de2ea8d
17:50:45 aztec-1 | [17:50:44.493]
INFO:
pxe:service Proving completed in 2882.877896000002ms
{"timings":{"total":2882.877896000002,"sync":166.01641599999857,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":574.6999079999987,"oracles":{"debugLog":{"times":[0.22401600000011967,0.11064800000167452,0.12460899999859976,0.2505879999989702,0.1609019999996235,0.13223999999900116,0.07115500000145403,0.18497299999944516]},"fetchTaggedLogs":{"times":[213.6707889999998]},"loadCapsule":{"times":[1.062207999999373,0.9104560000014317,1.3689899999990303,0.616955000001326,91.25288699999874,3.361627000002045,0.9465589999999793]},"getSharedSecret":{"times":[7.1986180000021704]},"aes128Decrypt":{"times":[0.34849499999836553,0.8182300000007672]},"getPublicKeysAndPartialAddress":{"times":[3.1292190000021947]},"getKeyValidationRequest":{"times":[3.0368630000011763]},"storeCapsule":{"times":[4.357898999998724,4.219589000000269,6.600033999999141]},"deleteCapsule":{"times":[6.03088199999911]},"validateEnqueuedNotesAndEvents":{"times":[21.53759799999898]},"getNotes":{"times":[3.6841590000003634]},"getAuthWitness":{"times":[0.23356699999931152]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0635050000018964]},"callPrivateFunction":{"times":[780.4192909999983,190.31854699999894]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06673500000033528]}}},{"functionName":"private_kernel_init","time":54.80907599999773},{"functionName":"ContractClassRegisterer:register","time":760.3939539999992,"oracles":{"loadCapsule":{"times":[2.465779999998631]},"notifyCreatedNullifier":{"times":[0.45827400000052876]},"debugLog":{"times":[0.1306990000011865]},"notifyCreatedContractClassLog":{"times":[5.291228000001865]}}},{"functionName":"private_kernel_inner","time":140.09456599999976},{"functionName":"ContractInstanceDeployer:deploy","time":81.600478999997,"oracles":{"storeInExecutionCache":{"times":[0.07759599999917555]},"callPrivateFunction":{"times":[111.08149000000049]},"notifyCreatedNullifier":{"times":[0.2604189999983646]},"debugLog":{"times":[0.13324899999861373]}}},{"functionName":"private_kernel_inner","time":124.52048500000092},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":95.67108100000041,"oracles":{}},{"functionName":"private_kernel_inner","time":117.86586800000077},{"functionName":"private_kernel_reset","time":237.40914899999916},{"functionName":"private_kernel_tail","time":116.23188800000207}],"unaccounted":413.5650260000075}}
17:50:45 aztec-1 | [17:50:44.646]
INFO:
node Received tx 0x1d48a0a25b597648bf71b6dea4d9d23b8271a125bf27d611c893fb86975b5121
{"txHash":"0x1d48a0a25b597648bf71b6dea4d9d23b8271a125bf27d611c893fb86975b5121"}
17:50:45 aztec-1 | [17:50:44.646]
INFO:
pxe:service Sent transaction 0x1d48a0a25b597648bf71b6dea4d9d23b8271a125bf27d611c893fb86975b5121
17:50:45 aztec-1 | [17:50:44.660]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 2.650097407000001s
{"duration":2.650097407000001,"rate":119411.45980676773,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064}
17:50:45 aztec-1 | [17:50:44.704]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 116532.101865363 mana/s
{"blockHash":"0x268e7151318863dfe14031457c9acc0b94426f34396062797d0e5b90b39f3a46","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750096636,"version":3633326044},"txHashes":["0x06c0d8ed8783f3141bb5cef53925dfbfbb94ce264083de852d62939e0de2ea8d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2715.5074399999976,"publicProcessDuration":2650.2549579999977,"rollupCircuitsDuration":2708.4810450000004,"txCount":1,"blockNumber":4,"blockTimestamp":1750096636,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
17:50:45 aztec-1 | [17:50:44.949]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:50:45 aztec-1 | [17:50:44.956]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:50:45 aztec-1 | [17:50:44.956]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:57:28.000Z
{"offset":403044,"timeMs":1750096648000}
17:50:45 aztec-1 | [17:50:44.957]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096672
17:50:45 aztec-1 | [17:50:44.957]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:57:52.000Z
{"offset":427043,"timeMs":1750096672000}
17:50:45 aztec-1 | [17:50:44.957]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
17:50:45 aztec-1 | [17:50:44.957]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
17:50:45 aztec-1 | [17:50:44.959]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
17:50:45 aztec-1 | [17:50:44.962]
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":"0x0244ee599f8920bb22492e0416a87ff08cd94dd1bba3f6cf53d82049a150ad07","blocksSynchedTo":30,"currentL1BlockNumber":31,"provenBlockNumber":3,"provenArchive":"0x0244ee599f8920bb22492e0416a87ff08cd94dd1bba3f6cf53d82049a150ad07","pendingBlockNumber":4,"pendingArchive":"0x2a7beb1bb588e278e14ad222ba066a1fb244dff801531e3a5d4b02695800973d"}
17:50:45 aztec-1 | [17:50:45.151]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x268e7151318863dfe14031457c9acc0b94426f34396062797d0e5b90b39f3a46","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750096636,"version":3633326044},"archiveRoot":"0x2a7beb1bb588e278e14ad222ba066a1fb244dff801531e3a5d4b02695800973d","archiveNextLeafIndex":5}
17:50:45 aztec-1 | [17:50:45.156]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
17:50:45 aztec-1 | [17:50:45.234]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":20.09059200000047,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750096636,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
17:50:45 aztec-1 | [17:50:45.508]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.21504197900000144s
{"duration":0.21504197900000144,"rate":185038.28966343234,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768}
17:50:45 aztec-1 | [17:50:45.558]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 144369.07508686386 mana/s
{"blockHash":"0x21eeaa05f1037b8b067fab2d81604b4f0f0531d3529b06fdd7b505a6fca91d59","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750096672,"version":3633326044},"txHashes":["0x1d48a0a25b597648bf71b6dea4d9d23b8271a125bf27d611c893fb86975b5121"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":275.5733450000007,"publicProcessDuration":215.58541900000273,"rollupCircuitsDuration":269.3358980000012,"txCount":1,"blockNumber":5,"blockTimestamp":1750096672,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
17:50:46 aztec-1 | [17:50:45.823]
INFO:
aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed.
17:50:46 aztec-1 | [17:50:45.989]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:50:46 aztec-1 | [17:50:46.003]
WARN:
archiver Failed to reach L2 block 5 at 33 (latest is 4). Rolling back last synched L1 block number to 32.
{"latestLocalL2BlockNumber":4,"latestLocalL2BlockArchive":"0x2a7beb1bb588e278e14ad222ba066a1fb244dff801531e3a5d4b02695800973d","blocksSynchedTo":32,"currentL1BlockNumber":33,"provenBlockNumber":4,"provenArchive":"0x2a7beb1bb588e278e14ad222ba066a1fb244dff801531e3a5d4b02695800973d","pendingBlockNumber":5,"pendingArchive":"0x137b5d5de145ba87bd5d9f8c003af5091bca03ef40443fd49cc62b56720b9a84"}
17:50:46 aztec-1 | [17:50:46.032]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:50:46 aztec-1 | [17:50:46.032]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:58:04.000Z
{"offset":437968,"timeMs":1750096684000}
17:50:46 aztec-1 | [17:50:46.039]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
17:50:46 aztec-1 | [17:50:46.044]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
17:50:46 aztec-1 | [17:50:46.055]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096708
17:50:46 aztec-1 | [17:50:46.055]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:58:28.000Z
{"offset":461945,"timeMs":1750096708000}
17:50:46 aztec-1 | [17:50:46.055]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
17:50:46 aztec-1 | [17:50:46.122]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x21eeaa05f1037b8b067fab2d81604b4f0f0531d3529b06fdd7b505a6fca91d59","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750096672,"version":3633326044},"archiveRoot":"0x137b5d5de145ba87bd5d9f8c003af5091bca03ef40443fd49cc62b56720b9a84","archiveNextLeafIndex":6}
17:50:46 aztec-1 | [17:50:46.127]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
17:50:46 aztec-1 | [17:50:46.158]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":16.162327000001824,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750096672,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
17:50:46 aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
17:50:46 aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
17:50:47 aztec-1 | [17:50:46.893]
INFO:
aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed.
17:50:47 aztec-1 | [17:50:46.927]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
17:50:47 aztec-1 | [17:50:46.934]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
17:50:47 aztec-1 | [17:50:47.128]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
17:50:50 aztec-1 | [17:50:49.795]
INFO:
pxe:service Proving completed in 2646.915080999999ms
{"timings":{"total":2646.915080999999,"sync":24.97308300000077,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":137.612251999999,"oracles":{"callPrivateFunction":{"times":[842.6810510000032,187.82887800000026,59.17252400000143]}}},{"functionName":"private_kernel_init","time":65.86085500000263},{"functionName":"ContractClassRegisterer:register","time":814.125724999998,"oracles":{"loadCapsule":{"times":[2.934586000003037]},"notifyCreatedNullifier":{"times":[0.8497229999993579]},"debugLog":{"times":[0.29865199999767356]},"notifyCreatedContractClassLog":{"times":[6.198574999998527]}}},{"functionName":"private_kernel_inner","time":140.07883299999958},{"functionName":"ContractInstanceDeployer:deploy","time":116.6042310000048,"oracles":{"storeInExecutionCache":{"times":[0.1870840000010503]},"callPrivateFunction":{"times":[78.30975899999976]},"notifyCreatedNullifier":{"times":[0.29530200000226614]},"debugLog":{"times":[0.09934699999939767]}}},{"functionName":"private_kernel_inner","time":163.16460799999913},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":54.562214999998105,"oracles":{}},{"functionName":"private_kernel_inner","time":167.3377849999997},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":46.680716000002576,"oracles":{"debugLog":{"times":[0.300202000002173]}}},{"functionName":"private_kernel_inner","time":101.83600599999772},{"functionName":"private_kernel_reset","time":156.63802900000155},{"functionName":"private_kernel_tail","time":72.33487900000182}],"unaccounted":585.1058639999937}}
17:50:50 aztec-1 | [17:50:49.886]
INFO:
node Received tx 0x16fc5b7eda268168d3637f2edc4986abe535bc0eb4aef8b57ebd429631cd48b7
{"txHash":"0x16fc5b7eda268168d3637f2edc4986abe535bc0eb4aef8b57ebd429631cd48b7"}
17:50:50 aztec-1 | [17:50:49.886]
INFO:
pxe:service Sent transaction 0x16fc5b7eda268168d3637f2edc4986abe535bc0eb4aef8b57ebd429631cd48b7
17:50:50 aztec-1 | [17:50:49.964]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.023880333000000975s
{"duration":0.023880333000000975,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
17:50:50 aztec-1 | [17:50:49.991]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x01c9482ea1cb1c59a1b5e92bb85553a1b1dd5916f5d6a8b251aa780d22067c0f","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750096708,"version":3633326044},"txHashes":["0x16fc5b7eda268168d3637f2edc4986abe535bc0eb4aef8b57ebd429631cd48b7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":57.975235999998404,"publicProcessDuration":24.023864000002504,"rollupCircuitsDuration":52.96129799999471,"txCount":1,"blockNumber":6,"blockTimestamp":1750096708,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:50:50 aztec-1 | [17:50:50.152]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:50:50 aztec-1 | [17:50:50.157]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096744
17:50:50 aztec-1 | [17:50:50.157]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:59:04.000Z
{"offset":493843,"timeMs":1750096744000}
17:50:50 aztec-1 | [17:50:50.157]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
17:50:50 aztec-1 | [17:50:50.164]
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":"0x137b5d5de145ba87bd5d9f8c003af5091bca03ef40443fd49cc62b56720b9a84","blocksSynchedTo":34,"currentL1BlockNumber":35,"provenBlockNumber":5,"provenArchive":"0x137b5d5de145ba87bd5d9f8c003af5091bca03ef40443fd49cc62b56720b9a84","pendingBlockNumber":6,"pendingArchive":"0x0cc045c4a0209e889489a8d6bfdea8939fd36fadcfed29d4e4b9f415badfe974"}
17:50:50 aztec-1 | [17:50:50.237]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
17:50:50 aztec-1 | [17:50:50.240]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
17:50:50 aztec-1 | [17:50:50.270]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x01c9482ea1cb1c59a1b5e92bb85553a1b1dd5916f5d6a8b251aa780d22067c0f","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750096708,"version":3633326044},"archiveRoot":"0x0cc045c4a0209e889489a8d6bfdea8939fd36fadcfed29d4e4b9f415badfe974","archiveNextLeafIndex":7}
17:50:50 aztec-1 | [17:50:50.308]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":14.500785000003816,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750096708,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:50:50 aztec-1 | [17:50:50.333]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
17:50:50 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
17:50:51 aztec-1 | [17:50:50.910]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
17:50:51 aztec-1 | [17:50:50.917]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x27f24d2a1e99e49d4a27746a8374185b307a07325d0d743c1df56a03e39788d2","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
17:50:58 playground-1 | \
17:50:58 playground-1 |
Running 1
test using 1
worker
17:50:58 playground-1 |
17:50:59 playground-1 |
✓ 1 [firefox] › browser.spec.ts:3:1 › test
(13.6s)
17:51:25 playground-1 |
1 passed (27.5s)
17:51:25 playground-1 | \
npm notice
17:51:25 playground-1 |
npm notice New
major version of npm available!
10.9.2 ->
11.4.2
17:51:25 playground-1 |
npm notice Changelog:
https://github.com/npm/cli/releases/tag/v11.4.2
17:51:25 playground-1 |
npm notice To update run:
npm install -g npm@11.4.2
17:51:25 playground-1 |
npm notice
17:51:25 playground-1 | \
17:51:25
playground-1 exited with code 0
17:51:25 Aborting on container exit...
17:51:25 Container playground-firefox-playground-1 Stopping
17:51:25 Container playground-firefox-playground-1 Stopped
17:51:25 Container playground-firefox-aztec-1 Stopping
17:51:25 Container playground-firefox-aztec-1 Stopped
17:51:25 Container playground-firefox-ethereum-1 Stopping
17:51:26 Container playground-firefox-ethereum-1 Stopped