Parent Log:
http://ci.aztec-labs.com/94683bf95cf36212
Command: 5f57f7ba606813df playground/scripts/run_test.sh firefox
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/21a568ac0c9ef351b1923375be41d4620add2b60
Env: REF_NAME=gh-readonly-queue/next/pr-15042-b80949775e5c27908a6055ad24592f7d98bdc45a CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Sun Jun 15 12:38:34 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15042_amd64_x3-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_23123200780498f7_next
12:38:35 Network playground-firefox_default Creating
12:38:35 Network playground-firefox_default Created
12:38:35 Container playground-firefox-ethereum-1 Creating
12:38:35 Container playground-firefox-ethereum-1 Created
12:38:35 Container playground-firefox-aztec-1 Creating
12:38:36 Container playground-firefox-aztec-1 Created
12:38:36 Container playground-firefox-playground-1 Creating
12:38:37 Container playground-firefox-playground-1 Created
12:38:37 Attaching to aztec-1, ethereum-1, playground-1
12:38:42 aztec-1 |
12:38:42 aztec-1 | _
12:38:42 aztec-1 | /\ | |
12:38:42 aztec-1 | / \ ___| |_ ___ ___
12:38:42 aztec-1 | / /\ \ |_ / __/ _ \/ __|
12:38:42 aztec-1 | / ____ \ / /| || __/ (__
12:38:42 aztec-1 | /_/___ \_\/___|\__\___|\___|
12:38:42 aztec-1 |
12:38:42 aztec-1 |
https://github.com/AztecProtocol
12:38:42 aztec-1 |
12:38:42 aztec-1 |
12:38:42 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
12:38:42 aztec-1 | Setting up test accounts
12:38:43 aztec-1 | [12:38:42.865]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-7jR8aC/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
12:38:43 aztec-1 | [12:38:43.141]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
12:38:43 aztec-1 | [12:38:43.146]
WARN:
sandbox Set block interval to 12
12:38:43 aztec-1 | [12:38:43.339]
INFO:
sandbox Waiting for 7 transactions to be mined...
12:38:43 aztec-1 | [12:38:43.360]
INFO:
sandbox All transactions mined successfully
12:38:43 aztec-1 | [12:38:43.459]
INFO:
sandbox Waiting for 9 transactions to be mined...
12:38:43 aztec-1 | [12:38:43.493]
INFO:
sandbox All transactions mined successfully
12:38:43 aztec-1 | [12:38:43.659]
INFO:
sandbox Waiting for 11 transactions to be mined...
12:38:43 aztec-1 | [12:38:43.685]
INFO:
sandbox All transactions mined successfully
12:38:43 aztec-1 | [12:38:43.758]
INFO:
sandbox Waiting for 12 transactions to be mined...
12:38:43 aztec-1 | [12:38:43.786]
INFO:
sandbox All transactions mined successfully
12:38:43 aztec-1 | [12:38:43.791]
INFO:
sandbox Waiting for 12 transactions to be mined...
12:38:43 aztec-1 | [12:38:43.808]
INFO:
sandbox All transactions mined successfully
12:38:43 aztec-1 | [12:38:43.822]
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"}
12:38:43 aztec-1 | [12:38:43.822]
INFO:
sandbox Handing over to governance
12:38:43 aztec-1 | [12:38:43.830]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
12:38:43 aztec-1 | [12:38:43.831]
INFO:
telemetry:client Using NoopTelemetryClient
12:38:43 aztec-1 | [12:38:43.831]
INFO:
blob-sink:client Creating local blob sink client.
12:38:43 aztec-1 | [12:38:43.836]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
12:38:43 aztec-1 | [12:38:43.836]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:43:25.000Z
{"offset":281164,"timeMs":1749991405000}
12:38:43 aztec-1 | [12:38:43.858]
INFO:
archiver:lmdb Starting data store with maxReaders 16
12:38:44 aztec-1 | [12:38:44.273]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xd77b41576acae0ec6ecf7abea54169a82555929b5d5274be61aa209b3f5962e8
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x374d9c8e9951f409ebc81d596a0db6969f4e13044fc60f79961e8375668f6ad5","l1BlockNumber":20}}
12:38:44 aztec-1 | [12:38:44.298]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xd77b41576acae0ec6ecf7abea54169a82555929b5d5274be61aa209b3f5962e8","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
12:38:44 aztec-1 | [12:38:44.307]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-Fcvb81/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
12:38:44 aztec-1 | [12:38:44.564]
INFO:
world_state Created world state synchroniser with block history of 64
12:38:44 aztec-1 | [12:38:44.564]
WARN:
node Aztec node is accepting fake proofs
12:38:44 aztec-1 | [12:38:44.572]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
12:38:44 aztec-1 | [12:38:44.592]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
12:38:44 aztec-1 | [12:38:44.608]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
12:38:44 aztec-1 | [12:38:44.621]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
12:38:44 aztec-1 | [12:38:44.624]
INFO:
world_state Started world state synchronizer from block 1
12:38:45 aztec-1 | [12:38:44.628]
INFO:
p2p Starting p2p client from block 0 with empty mempools
12:38:45 aztec-1 | [12:38:44.889]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
12:38:45 aztec-1 | [12:38:44.950]
INFO:
slasher Starting Slasher client...
12:38:45 aztec-1 | [12:38:44.960]
INFO:
sequencer-client Deploying forwarder contract
12:38:45 aztec-1 | [12:38:44.980]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
12:38:45 aztec-1 | [12:38:44.988]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
12:38:45 aztec-1 | [12:38:44.989]
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}
12:38:45 aztec-1 | [12:38:44.991]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
12:38:45 aztec-1 | [12:38:44.992]
INFO:
node Aztec Node version: 0.87.6
12:38:45 aztec-1 | [12:38:44.992]
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"}
12:38:45 aztec-1 | [12:38:44.996]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
12:38:45 aztec-1 | [12:38:45.007]
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":1749991406,"syncedToL1Ts":1749991405,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1749991393,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1749991429},"newBlockNumber":1,"expectedSlot":1}
12:38:45 aztec-1 | [12:38:45.074]
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":1749991406,"syncedToL1Ts":1749991405,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1749991393,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1749991429},"newBlockNumber":1,"expectedSlot":1}
12:38:45 aztec-1 | [12:38:45.249]
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":1749991406,"syncedToL1Ts":1749991417,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1749991393,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1749991429},"newBlockNumber":1,"expectedSlot":1}
12:38:45 aztec-1 | [12:38:45.249]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
12:38:45 aztec-1 | [12:38:45.249]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:43:37.000Z
{"offset":291751,"timeMs":1749991417000}
12:38:45 aztec-1 | Setting up funded test accounts...
12:38:45 aztec-1 | [12:38:45.394]
INFO:
pxe:service Started PXE connected to chain 31337 version 1516729127
12:38:45 aztec-1 | [12:38:45.488]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
12:38:45 aztec-1 | [12:38:45.567]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
12:38:45 aztec-1 | [12:38:45.570]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
12:38:45 aztec-1 | [12:38:45.781]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
12:38:48 aztec-1 | [12:38:48.859]
INFO:
pxe:service Proving completed in 3031.3330029999997ms
{"timings":{"total":3031.3330029999997,"sync":12.016122999999425,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":171.9992199999997,"oracles":{"callPrivateFunction":{"times":[1018.1975809999994,440.19043599999895,201.45561199999975]}}},{"functionName":"private_kernel_init","time":111.96537900000112},{"functionName":"ContractClassRegisterer:register","time":989.006676,"oracles":{"loadCapsule":{"times":[34.14364100000057]},"notifyCreatedNullifier":{"times":[0.9437679999991815]},"debugLog":{"times":[0.6292020000000775]},"notifyCreatedContractClassLog":{"times":[11.820897999999943]}}},{"functionName":"private_kernel_inner","time":131.84764300000097},{"functionName":"SchnorrAccount:constructor","time":409.0501829999994,"oracles":{"getContractInstance":{"times":[1.4683079999995243]},"debugLog":{"times":[0.21012399999926856,0.2002840000004653]},"fetchTaggedLogs":{"times":[105.146616]},"loadCapsule":{"times":[0.8028360000007524,0.4158480000005511,1.0524600000007922]},"validateEnqueuedNotesAndEvents":{"times":[8.676008000000365]},"notifyCreatedNullifier":{"times":[0.31974600000103237,0.32689599999866914]},"notifyCreatedNote":{"times":[0.7915949999987788]},"getRandomField":{"times":[0.5530309999994643,0.2099640000014915,0.05330099999991944,0.04611099999965518,0.06352100000003702,0.15319300000010116,0.05065100000138045,0.03514999999970314,0.03961100000014994,0.0674909999997908,0.03145000000040454]},"getIndexedTaggingSecretAsSender":{"times":[35.0658399999993]},"incrementAppTaggingSecretIndexAsSender":{"times":[36.70592000000033]}}},{"functionName":"private_kernel_inner","time":159.73177299999952},{"functionName":"SchnorrAccount:entrypoint","time":180.17880100000002,"oracles":{"debugLog":{"times":[0.20477399999981571,0.12570299999970302,0.5554410000004282]},"fetchTaggedLogs":{"times":[48.07140100000106]},"loadCapsule":{"times":[0.2293150000004971,0.1699029999999766,0.1624630000005709]},"validateEnqueuedNotesAndEvents":{"times":[6.251530999999886]},"getNotes":{"times":[4.3021629999984725]},"getAuthWitness":{"times":[0.3654469999983121]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.8396059999995487]}}},{"functionName":"private_kernel_inner","time":141.13346399999864},{"functionName":"private_kernel_reset","time":181.65382800000043},{"functionName":"private_kernel_tail","time":65.68178199999966}],"unaccounted":477.0681310000009}}
12:38:48 aztec-1 | [12:38:48.956]
INFO:
node Received tx 0x25424081b07bf91a03c41aa07583e3675055447ce3a6608af826fb4152ad9c0b
{"txHash":"0x25424081b07bf91a03c41aa07583e3675055447ce3a6608af826fb4152ad9c0b"}
12:38:48 aztec-1 | [12:38:48.956]
INFO:
pxe:service Sent transaction 0x25424081b07bf91a03c41aa07583e3675055447ce3a6608af826fb4152ad9c0b
12:38:49 aztec-1 | [12:38:49.064]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03756332699999985s
{"duration":0.03756332699999985,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
12:38:49 aztec-1 | [12:38:49.090]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x1ef6a25d3ae3444455e38fa5bbdffeb82853e8b4d3dad3e1f8fa185553afb6a7","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749991429,"version":1516729127},"txHashes":["0x25424081b07bf91a03c41aa07583e3675055447ce3a6608af826fb4152ad9c0b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":74.70559700000013,"publicProcessDuration":38.47040499999821,"rollupCircuitsDuration":66.57347900000059,"txCount":1,"blockNumber":1,"blockTimestamp":1749991429,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
12:38:52 aztec-1 | [12:38:51.624]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
12:38:52 aztec-1 | [12:38:51.628]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
12:38:52 aztec-1 | [12:38:51.630]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
12:38:52 aztec-1 | [12:38:51.727]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x1ef6a25d3ae3444455e38fa5bbdffeb82853e8b4d3dad3e1f8fa185553afb6a7","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749991429,"version":1516729127},"archiveRoot":"0x0d289f8a5fe4dbf50b6436f510ba17152f817662bc43f0ecfa88b7219b53022e","archiveNextLeafIndex":2}
12:38:52 aztec-1 | [12:38:51.734]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
12:38:52 aztec-1 | [12:38:51.797]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":17.84815499999968,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749991429,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
12:38:52 aztec-1 | [12:38:51.855]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
12:38:52 aztec-1 | [12:38:51.855]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:43:49.000Z
{"offset":297145,"timeMs":1749991429000}
12:38:52 aztec-1 | [12:38:51.872]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749991465
12:38:52 aztec-1 | [12:38:51.872]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:44:25.000Z
{"offset":333128,"timeMs":1749991465000}
12:38:52 aztec-1 | [12:38:51.872]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
12:38:52 aztec-1 | [12:38:51.895]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
12:38:52 aztec-1 | [12:38:52.036]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
12:38:54 aztec-1 | [12:38:53.721]
INFO:
pxe:service Proving completed in 1659.0160699999997ms
{"timings":{"total":1659.0160699999997,"sync":31.808466000000408,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":94.11148299999877,"oracles":{"callPrivateFunction":{"times":[307.25000100000034,219.6339740000003]}}},{"functionName":"private_kernel_init","time":80.08777100000043},{"functionName":"SchnorrAccount:constructor","time":287.3764060000012,"oracles":{"getContractInstance":{"times":[1.2864150000004884]},"debugLog":{"times":[0.12052199999925506,0.15174300000035146]},"fetchTaggedLogs":{"times":[95.4942800000008]},"loadCapsule":{"times":[0.8296960000006948,0.3951969999998255,0.29471600000033504]},"validateEnqueuedNotesAndEvents":{"times":[6.0114359999988665]},"notifyCreatedNullifier":{"times":[0.4070579999988695,0.1938930000014807]},"notifyCreatedNote":{"times":[0.13157200000023295]},"getRandomField":{"times":[0.12472199999865552,0.07554200000049605,0.03506000000015774,0.030819999999948777,0.041180999998687184,0.0425809999997,0.06661200000053213,0.044151999998575775,0.03073000000040338,0.05738099999871338,0.03262100000029022]},"getIndexedTaggingSecretAsSender":{"times":[34.88833599999998]},"incrementAppTaggingSecretIndexAsSender":{"times":[29.781667000001107]}}},{"functionName":"private_kernel_inner","time":128.4616389999992},{"functionName":"SchnorrAccount:entrypoint","time":197.88559199999872,"oracles":{"debugLog":{"times":[0.2155849999999191,0.08901200000036624,0.2612649999991845]},"fetchTaggedLogs":{"times":[66.5581489999986]},"loadCapsule":{"times":[0.1352630000001227,0.1363230000006297,0.1256630000007135]},"validateEnqueuedNotesAndEvents":{"times":[5.182480999999825]},"getNotes":{"times":[1.3483259999993606]},"getAuthWitness":{"times":[0.19242400000075577]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6008320000000822]}}},{"functionName":"private_kernel_inner","time":167.9623900000006},{"functionName":"private_kernel_reset","time":239.3854339999998},{"functionName":"private_kernel_tail","time":99.55795899999976}],"unaccounted":332.37893000000076}}
12:38:54 aztec-1 | [12:38:53.790]
INFO:
node Received tx 0x2a8fa46566f6413a297adb8e5be57183f5a5b6f3e2d813e3edf1921c4e4c8d16
{"txHash":"0x2a8fa46566f6413a297adb8e5be57183f5a5b6f3e2d813e3edf1921c4e4c8d16"}
12:38:54 aztec-1 | [12:38:53.790]
INFO:
pxe:service Sent transaction 0x2a8fa46566f6413a297adb8e5be57183f5a5b6f3e2d813e3edf1921c4e4c8d16
12:38:54 aztec-1 | [12:38:53.889]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.020947888999999123s
{"duration":0.020947888999999123,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
12:38:54 aztec-1 | [12:38:53.918]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x30396e5c94e49dab0729f19f2c705b0de96e8c96467e8a7e4019635b2e1f9701","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749991465,"version":1516729127},"txHashes":["0x2a8fa46566f6413a297adb8e5be57183f5a5b6f3e2d813e3edf1921c4e4c8d16"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":57.31061399999999,"publicProcessDuration":21.107411999999385,"rollupCircuitsDuration":52.24419999999918,"txCount":1,"blockNumber":2,"blockTimestamp":1749991465,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
12:38:54 aztec-1 | [12:38:54.126]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
12:38:54 aztec-1 | [12:38:54.151]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
12:38:54 aztec-1 | [12:38:54.152]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
12:38:54 aztec-1 | [12:38:54.156]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
12:38:54 aztec-1 | [12:38:54.156]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:44:37.000Z
{"offset":342844,"timeMs":1749991477000}
12:38:54 aztec-1 | [12:38:54.208]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749991501
12:38:54 aztec-1 | [12:38:54.208]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:45:01.000Z
{"offset":366792,"timeMs":1749991501000}
12:38:54 aztec-1 | [12:38:54.208]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
12:38:54 aztec-1 | [12:38:54.233]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x30396e5c94e49dab0729f19f2c705b0de96e8c96467e8a7e4019635b2e1f9701","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749991465,"version":1516729127},"archiveRoot":"0x17e043d5e9f438630c67c091ae5423f8d7dbe566edea0892be5d6430ae3d8eab","archiveNextLeafIndex":3}
12:38:54 aztec-1 | [12:38:54.239]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
12:38:54 aztec-1 | [12:38:54.300]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":15.884326000001238,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749991465,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
12:38:54 aztec-1 | [12:38:54.421]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
12:38:54 aztec-1 | [12:38:54.539]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
12:38:56 aztec-1 | [12:38:56.033]
INFO:
pxe:service Proving completed in 1486.1989810000014ms
{"timings":{"total":1486.1989810000014,"sync":20.423687999998947,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":83.12405299999955,"oracles":{"callPrivateFunction":{"times":[312.2980459999999,249.94252999999662]}}},{"functionName":"private_kernel_init","time":53.60491800000091},{"functionName":"SchnorrAccount:constructor","time":289.9073979999994,"oracles":{"getContractInstance":{"times":[3.4528710000013234]},"debugLog":{"times":[0.10259200000291457,0.06664200000159326]},"fetchTaggedLogs":{"times":[87.78655799999979]},"loadCapsule":{"times":[0.17940399999861256,0.1377730000021984,0.14232300000003306]},"validateEnqueuedNotesAndEvents":{"times":[5.692055999999866]},"notifyCreatedNullifier":{"times":[0.23166399999900023,0.14146299999993062]},"notifyCreatedNote":{"times":[0.13929400000051828]},"getRandomField":{"times":[0.20181400000001304,0.17974300000059884,0.07471199999781675,0.04948100000183331,0.06058100000154809,0.04813099999955739,0.03341000000000349,0.04113100000176928,0.04082100000232458,0.04345200000170735,0.08845199999996112]},"getIndexedTaggingSecretAsSender":{"times":[31.795220999996673]},"incrementAppTaggingSecretIndexAsSender":{"times":[24.814057999999932]}}},{"functionName":"private_kernel_inner","time":144.1566529999982},{"functionName":"SchnorrAccount:entrypoint","time":226.66291300000012,"oracles":{"debugLog":{"times":[0.26600499999767635,0.0690809999978228,0.11583299999983865]},"fetchTaggedLogs":{"times":[93.5882070000007]},"loadCapsule":{"times":[0.24622499999895808,0.12531200000012177,0.12567200000194134]},"validateEnqueuedNotesAndEvents":{"times":[11.946954999999434]},"getNotes":{"times":[7.310809000002337]},"getAuthWitness":{"times":[0.14044300000023213]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4012479999983043]}}},{"functionName":"private_kernel_inner","time":151.64507599999706},{"functionName":"private_kernel_reset","time":184.1755329999978},{"functionName":"private_kernel_tail","time":80.11097100000188}],"unaccounted":252.38777800000753}}
12:38:56 aztec-1 | [12:38:56.092]
INFO:
node Received tx 0x07d56a180110e45e31b9a415e0a2bdb897e37d4dbcea15ac3546142075c890a3
{"txHash":"0x07d56a180110e45e31b9a415e0a2bdb897e37d4dbcea15ac3546142075c890a3"}
12:38:56 aztec-1 | [12:38:56.092]
INFO:
pxe:service Sent transaction 0x07d56a180110e45e31b9a415e0a2bdb897e37d4dbcea15ac3546142075c890a3
12:38:56 aztec-1 | [12:38:56.165]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.017146190999999818s
{"duration":0.017146190999999818,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
12:38:56 aztec-1 | [12:38:56.187]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x19b2fbb712470d4ac043b2753d2bdc52ac78a08e66635784f4658cc44c69a321","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749991501,"version":1516729127},"txHashes":["0x07d56a180110e45e31b9a415e0a2bdb897e37d4dbcea15ac3546142075c890a3"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":46.02773299999899,"publicProcessDuration":17.267374000002746,"rollupCircuitsDuration":40.65925199999765,"txCount":1,"blockNumber":3,"blockTimestamp":1749991501,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
12:38:56 aztec-1 | [12:38:56.422]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
12:38:56 aztec-1 | [12:38:56.430]
WARN:
archiver Failed to reach L2 block 3 at 29 (latest is 2). Rolling back last synched L1 block number to 28.
{"latestLocalL2BlockNumber":2,"latestLocalL2BlockArchive":"0x17e043d5e9f438630c67c091ae5423f8d7dbe566edea0892be5d6430ae3d8eab","blocksSynchedTo":28,"currentL1BlockNumber":29,"provenBlockNumber":2,"provenArchive":"0x17e043d5e9f438630c67c091ae5423f8d7dbe566edea0892be5d6430ae3d8eab","pendingBlockNumber":3,"pendingArchive":"0x03f4b3c1d3fe9302d6b0164ae3e2d661a586eeb8f829e62076f148ae4e68a24e"}
12:38:56 aztec-1 | [12:38:56.466]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
12:38:56 aztec-1 | [12:38:56.466]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:45:13.000Z
{"offset":376534,"timeMs":1749991513000}
12:38:56 aztec-1 | [12:38:56.469]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
12:38:56 aztec-1 | [12:38:56.472]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
12:38:56 aztec-1 | [12:38:56.531]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x19b2fbb712470d4ac043b2753d2bdc52ac78a08e66635784f4658cc44c69a321","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749991501,"version":1516729127},"archiveRoot":"0x03f4b3c1d3fe9302d6b0164ae3e2d661a586eeb8f829e62076f148ae4e68a24e","archiveNextLeafIndex":4}
12:38:56 aztec-1 | [12:38:56.538]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
12:38:56 aztec-1 | [12:38:56.595]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":14.642579999999725,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749991501,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
12:38:56 aztec-1 | [12:38:56.625]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749991537
12:38:56 aztec-1 | [12:38:56.625]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:45:37.000Z
{"offset":400375,"timeMs":1749991537000}
12:38:56 aztec-1 | [12:38:56.626]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
12:38:56 aztec-1 | Initial Accounts:
12:38:56 aztec-1 |
12:38:56 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
12:38:56 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
12:38:56 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
12:38:56 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
12:38:56 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
12:38:56 aztec-1 |
12:38:56 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
12:38:56 aztec-1 |
12:38:56 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
12:38:56 aztec-1 |
12:38:56 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
12:38:56 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
12:38:56 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
12:38:56 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
12:38:56 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
12:38:56 aztec-1 |
12:38:56 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
12:38:56 aztec-1 |
12:38:56 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
12:38:56 aztec-1 |
12:38:56 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
12:38:56 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
12:38:56 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
12:38:56 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
12:38:56 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
12:38:56 aztec-1 |
12:38:56 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
12:38:56 aztec-1 |
12:38:56 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
12:38:56 aztec-1 |
12:38:56 aztec-1 |
12:38:57 aztec-1 | [12:38:57.472]
WARN:
pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata
12:38:57 aztec-1 | [12:38:57.472]
WARN:
pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata
12:38:57 aztec-1 | [12:38:57.477]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
12:38:57 aztec-1 | [12:38:57.510]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
12:38:58 aztec-1 | [12:38:58.510]
INFO:
pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164
12:38:58 aztec-1 | [12:38:58.519]
INFO:
pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2
12:39:01 aztec-1 | [12:39:00.865]
INFO:
pxe:service Proving completed in 2325.8287889999992ms
{"timings":{"total":2325.8287889999992,"sync":21.46237999999721,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":343.5920380000025,"oracles":{"debugLog":{"times":[0.2387849999977334,0.09401200000138488,0.08720200000243494,0.19512400000166963,0.11459300000205985,0.10141199999998207,0.07948200000100769,0.1767440000003262]},"fetchTaggedLogs":{"times":[107.56059300000197]},"loadCapsule":{"times":[0.17993399999977555,0.18741399999998976,0.2898859999986598,0.3084759999983362,0.160743000000366,0.6731639999998151,0.13089300000137882]},"getSharedSecret":{"times":[4.51878200000283]},"aes128Decrypt":{"times":[1.0454810000010184,0.685444999999163]},"getPublicKeysAndPartialAddress":{"times":[3.0159920000005513]},"getKeyValidationRequest":{"times":[2.089363000002777]},"storeCapsule":{"times":[4.785078000000794,2.86406899999929,3.7303759999995236]},"deleteCapsule":{"times":[3.8228180000005523]},"validateEnqueuedNotesAndEvents":{"times":[11.988836000000447]},"getNotes":{"times":[1.7362760000032722]},"getAuthWitness":{"times":[0.17408400000203983]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.050372000001516426]},"callPrivateFunction":{"times":[591.1000569999997,110.86819100000139]},"notifyEnqueuedPublicFunctionCall":{"times":[0.32047700000111945]}}},{"functionName":"private_kernel_init","time":88.71171700000195},{"functionName":"ContractClassRegisterer:register","time":571.7075299999997,"oracles":{"loadCapsule":{"times":[1.9679910000013479]},"notifyCreatedNullifier":{"times":[0.3702369999991788]},"debugLog":{"times":[0.10293199999796343]},"notifyCreatedContractClassLog":{"times":[3.1335739999994985]}}},{"functionName":"private_kernel_inner","time":156.45899500000087},{"functionName":"ContractInstanceDeployer:deploy","time":69.06208400000105,"oracles":{"storeInExecutionCache":{"times":[0.27357499999925494]},"callPrivateFunction":{"times":[40.40158700000029]},"notifyCreatedNullifier":{"times":[0.2882160000008298]},"debugLog":{"times":[0.15020299999741837]}}},{"functionName":"private_kernel_inner","time":140.90833600000042},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":30.548805999998876,"oracles":{}},{"functionName":"private_kernel_inner","time":106.02351100000305},{"functionName":"private_kernel_reset","time":186.03812000000107},{"functionName":"private_kernel_tail","time":122.53393000000142}],"unaccounted":488.7813419999911}}
12:39:01 aztec-1 | [12:39:01.048]
INFO:
node Received tx 0x259a29f5c02c51d33a3d1857ceb9cf55f5586d0de19bd0a4a46a193d4617bf2d
{"txHash":"0x259a29f5c02c51d33a3d1857ceb9cf55f5586d0de19bd0a4a46a193d4617bf2d"}
12:39:01 aztec-1 | [12:39:01.048]
INFO:
pxe:service Sent transaction 0x259a29f5c02c51d33a3d1857ceb9cf55f5586d0de19bd0a4a46a193d4617bf2d
12:39:02 aztec-1 | [12:39:02.842]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.6135571889999991s
{"duration":1.6135571889999991,"rate":24660.421255140292,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768}
12:39:02 aztec-1 | [12:39:02.886]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 23702.569005899237 mana/s
{"blockHash":"0x26360c07c40b0feda3e5a4e9901de6e013ab9d2130b43af0e8de907b00365168","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749991537,"version":1516729127},"txHashes":["0x259a29f5c02c51d33a3d1857ceb9cf55f5586d0de19bd0a4a46a193d4617bf2d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1678.6831629999979,"publicProcessDuration":1613.7291430000005,"rollupCircuitsDuration":1670.2466710000008,"txCount":1,"blockNumber":4,"blockTimestamp":1749991537,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
12:39:03 aztec-1 | [12:39:03.762]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
12:39:03 aztec-1 | [12:39:03.762]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:45:49.000Z
{"offset":405238,"timeMs":1749991549000}
12:39:04 aztec-1 | [12:39:04.035]
INFO:
pxe:service Proving completed in 3168.644271000001ms
{"timings":{"total":3168.644271000001,"sync":144.33552599999894,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":434.6122219999961,"oracles":{"debugLog":{"times":[0.19784400000207825,0.1118819999974221,0.10393199999816716,0.26551499999914085,0.10675199999968754,0.10676199999943492,0.0709919999972044,0.11296200000288081]},"fetchTaggedLogs":{"times":[171.91075199999977]},"loadCapsule":{"times":[0.2924060000004829,0.5298000000002503,0.3207459999975981,0.3853180000005523,1.8819580000017595,0.3739580000001297,0.21682499999951688]},"getSharedSecret":{"times":[6.379039999999804]},"aes128Decrypt":{"times":[0.2662949999976263,0.6253529999994498]},"getPublicKeysAndPartialAddress":{"times":[3.484161000000313]},"getKeyValidationRequest":{"times":[2.9574509999984]},"storeCapsule":{"times":[4.055402999998478,23.80602799999906,5.285617999998067]},"deleteCapsule":{"times":[4.612795000000915]},"validateEnqueuedNotesAndEvents":{"times":[12.805662000002485]},"getNotes":{"times":[4.731686999999511]},"getAuthWitness":{"times":[0.2590349999991304]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.048381000000517815]},"callPrivateFunction":{"times":[954.8019569999997,147.9097789999978]},"notifyEnqueuedPublicFunctionCall":{"times":[0.08864099999846076]}}},{"functionName":"private_kernel_init","time":80.68023299999913},{"functionName":"ContractClassRegisterer:register","time":935.7610669999995,"oracles":{"loadCapsule":{"times":[2.877028999999311]},"notifyCreatedNullifier":{"times":[0.43006900000182213]},"debugLog":{"times":[0.1445029999995313]},"notifyCreatedContractClassLog":{"times":[5.431381000002148]}}},{"functionName":"private_kernel_inner","time":161.55185899999924},{"functionName":"ContractInstanceDeployer:deploy","time":91.97218200000134,"oracles":{"storeInExecutionCache":{"times":[0.07311200000185636]},"callPrivateFunction":{"times":[62.50669099999868]},"notifyCreatedNullifier":{"times":[0.45959900000161724]},"debugLog":{"times":[0.16331300000092597]}}},{"functionName":"private_kernel_inner","time":158.12396900000022},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":42.6559350000025,"oracles":{}},{"functionName":"private_kernel_inner","time":137.59976800000004},{"functionName":"private_kernel_reset","time":187.245934999999},{"functionName":"private_kernel_tail","time":93.12978800000201}],"unaccounted":700.975787000003}}
12:39:04 aztec-1 | [12:39:04.067]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
12:39:04 aztec-1 | [12:39:04.073]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
12:39:04 aztec-1 | [12:39:04.075]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
12:39:04 aztec-1 | [12:39:04.082]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749991573
12:39:04 aztec-1 | [12:39:04.082]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:46:13.000Z
{"offset":428918,"timeMs":1749991573000}
12:39:04 aztec-1 | [12:39:04.082]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
12:39:04 aztec-1 | [12:39:04.177]
INFO:
node Received tx 0x178aff92fc82cd90943acdcdd04623113ead027db389df7cecc713fd90bb2d8a
{"txHash":"0x178aff92fc82cd90943acdcdd04623113ead027db389df7cecc713fd90bb2d8a"}
12:39:04 aztec-1 | [12:39:04.177]
INFO:
pxe:service Sent transaction 0x178aff92fc82cd90943acdcdd04623113ead027db389df7cecc713fd90bb2d8a
12:39:04 aztec-1 | [12:39:04.259]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x26360c07c40b0feda3e5a4e9901de6e013ab9d2130b43af0e8de907b00365168","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749991537,"version":1516729127},"archiveRoot":"0x06daa94a3f4d107fdca6a601fdad2e559b0b3b657dbd8a0608a604cde9a19711","archiveNextLeafIndex":5}
12:39:04 aztec-1 | [12:39:04.267]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
12:39:04 aztec-1 | [12:39:04.284]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":14.976815999998507,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749991537,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
12:39:04 aztec-1 | [12:39:04.550]
INFO:
aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed.
12:39:04 aztec-1 | [12:39:04.798]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.41156324999999927s
{"duration":0.41156324999999927,"rate":768902.4712483453,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064}
12:39:04 aztec-1 | [12:39:04.857]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 661281.3938771667 mana/s
{"blockHash":"0x0fc71cc5512ac55b53d669b8ae31ba13bffd0b1343926ce0434d04612c29a08b","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749991573,"version":1516729127},"txHashes":["0x178aff92fc82cd90943acdcdd04623113ead027db389df7cecc713fd90bb2d8a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":478.5022719999979,"publicProcessDuration":411.94913799999995,"rollupCircuitsDuration":473.3560060000018,"txCount":1,"blockNumber":5,"blockTimestamp":1749991573,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
12:39:05 aztec-1 | [12:39:05.167]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
12:39:05 aztec-1 | [12:39:05.170]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
12:39:05 aztec-1 | [12:39:05.171]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
12:39:05 aztec-1 | [12:39:05.184]
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":"0x06daa94a3f4d107fdca6a601fdad2e559b0b3b657dbd8a0608a604cde9a19711","blocksSynchedTo":32,"currentL1BlockNumber":33,"provenBlockNumber":4,"provenArchive":"0x06daa94a3f4d107fdca6a601fdad2e559b0b3b657dbd8a0608a604cde9a19711","pendingBlockNumber":5,"pendingArchive":"0x10f00dc6c2b6f0b4eb69da8fcfae797245390b8021394b88b75a786b5a8ca3e3"}
12:39:05 aztec-1 | [12:39:05.196]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749991609
12:39:05 aztec-1 | [12:39:05.196]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:46:49.000Z
{"offset":463804,"timeMs":1749991609000}
12:39:05 aztec-1 | [12:39:05.196]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
12:39:05 aztec-1 | [12:39:05.371]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x0fc71cc5512ac55b53d669b8ae31ba13bffd0b1343926ce0434d04612c29a08b","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749991573,"version":1516729127},"archiveRoot":"0x10f00dc6c2b6f0b4eb69da8fcfae797245390b8021394b88b75a786b5a8ca3e3","archiveNextLeafIndex":6}
12:39:05 aztec-1 | [12:39:05.381]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
12:39:05 aztec-1 | [12:39:05.439]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":17.591981000001397,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749991573,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
12:39:06 aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
12:39:06 aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
12:39:07 aztec-1 | [12:39:06.452]
INFO:
aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed.
12:39:07 aztec-1 | [12:39:06.497]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
12:39:07 aztec-1 | [12:39:06.501]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
12:39:07 aztec-1 | [12:39:06.653]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
12:39:09 aztec-1 | [12:39:08.969]
INFO:
pxe:service Proving completed in 2295.5701990000016ms
{"timings":{"total":2295.5701990000016,"sync":23.247255999998742,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":74.01021399999809,"oracles":{"callPrivateFunction":{"times":[681.4706579999984,120.34784500000023,35.3815340000001]}}},{"functionName":"private_kernel_init","time":63.7785670000012},{"functionName":"ContractClassRegisterer:register","time":670.7861690000027,"oracles":{"loadCapsule":{"times":[4.186154999999417]},"notifyCreatedNullifier":{"times":[0.7545559999998659]},"debugLog":{"times":[0.1964239999979327]},"notifyCreatedContractClassLog":{"times":[3.355239000000438]}}},{"functionName":"private_kernel_inner","time":124.61366300000009},{"functionName":"ContractInstanceDeployer:deploy","time":58.10181100000045,"oracles":{"storeInExecutionCache":{"times":[0.05999100000190083]},"callPrivateFunction":{"times":[57.68670099999872]},"notifyCreatedNullifier":{"times":[0.24761500000022352]},"debugLog":{"times":[0.1287030000021332]}}},{"functionName":"private_kernel_inner","time":130.6502760000003},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":46.27560799999992,"oracles":{}},{"functionName":"private_kernel_inner","time":160.44910700000037},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":23.012751999998727,"oracles":{"debugLog":{"times":[0.14551299999948242]}}},{"functionName":"private_kernel_inner","time":149.2390669999986},{"functionName":"private_kernel_reset","time":227.37647699999798},{"functionName":"private_kernel_tail","time":100.60685100000046}],"unaccounted":443.42238100000395}}
12:39:09 aztec-1 | [12:39:09.084]
INFO:
node Received tx 0x121d4d6cf265a2735fd5d4e5995e252984b48055f73320cb163bbaaacfbe4935
{"txHash":"0x121d4d6cf265a2735fd5d4e5995e252984b48055f73320cb163bbaaacfbe4935"}
12:39:09 aztec-1 | [12:39:09.084]
INFO:
pxe:service Sent transaction 0x121d4d6cf265a2735fd5d4e5995e252984b48055f73320cb163bbaaacfbe4935
12:39:09 aztec-1 | [12:39:09.189]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.032723149000001284s
{"duration":0.032723149000001284,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
12:39:09 aztec-1 | [12:39:09.223]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x0b6614f44c28d52bc001c002b06ef915ccf19a29e5edd2ca4f112dd2d164cbaa","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749991609,"version":1516729127},"txHashes":["0x121d4d6cf265a2735fd5d4e5995e252984b48055f73320cb163bbaaacfbe4935"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":74.71834799999851,"publicProcessDuration":33.00925500000085,"rollupCircuitsDuration":69.20407100000011,"txCount":1,"blockNumber":6,"blockTimestamp":1749991609,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
12:39:09 aztec-1 | [12:39:09.469]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
12:39:09 aztec-1 | [12:39:09.472]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
12:39:09 aztec-1 | [12:39:09.473]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
12:39:09 aztec-1 | [12:39:09.486]
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":"0x10f00dc6c2b6f0b4eb69da8fcfae797245390b8021394b88b75a786b5a8ca3e3","blocksSynchedTo":34,"currentL1BlockNumber":35,"provenBlockNumber":5,"provenArchive":"0x10f00dc6c2b6f0b4eb69da8fcfae797245390b8021394b88b75a786b5a8ca3e3","pendingBlockNumber":6,"pendingArchive":"0x2c98f0d719502bd6cf1f840b540080a914124164cf44d401963b58f46d42c64c"}
12:39:09 aztec-1 | [12:39:09.504]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749991645
12:39:09 aztec-1 | [12:39:09.504]
WARN:
foundation:test-date-provider Time set to 2025-06-15T12:47:25.000Z
{"offset":495496,"timeMs":1749991645000}
12:39:09 aztec-1 | [12:39:09.504]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
12:39:09 aztec-1 | [12:39:09.609]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x0b6614f44c28d52bc001c002b06ef915ccf19a29e5edd2ca4f112dd2d164cbaa","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749991609,"version":1516729127},"archiveRoot":"0x2c98f0d719502bd6cf1f840b540080a914124164cf44d401963b58f46d42c64c","archiveNextLeafIndex":7}
12:39:09 aztec-1 | [12:39:09.619]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
12:39:09 aztec-1 | [12:39:09.650]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":23.333706000001257,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749991609,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
12:39:10 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
12:39:10 aztec-1 | [12:39:10.095]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
12:39:10 aztec-1 | [12:39:10.101]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x2d2655c513c2e8feb8c7411b7e807c66287b57bb60572ce85ce1fe0a1e0c925d","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
12:39:19 playground-1 | \
12:39:19 playground-1 |
Running 1
test using 1
worker
12:39:19 playground-1 |
12:39:20 playground-1 |
✓ 1 [firefox] › browser.spec.ts:3:1 › test
(12.5s)
12:39:35 playground-1 |
1 passed (17.8s)
12:39:35 playground-1 | \
npm notice
12:39:35 playground-1 |
npm notice New
major version of npm available!
10.9.2 ->
11.4.2
12:39:35 playground-1 |
npm notice Changelog:
https://github.com/npm/cli/releases/tag/v11.4.2
12:39:35 playground-1 |
npm notice To update run:
npm install -g npm@11.4.2
12:39:35 playground-1 |
npm notice
12:39:35 playground-1 | \
12:39:36
playground-1 exited with code 0
12:39:36 Aborting on container exit...
12:39:36 Container playground-firefox-playground-1 Stopping
12:39:36 Container playground-firefox-playground-1 Stopped
12:39:36 Container playground-firefox-aztec-1 Stopping
12:39:37 Container playground-firefox-aztec-1 Stopped
12:39:37 Container playground-firefox-ethereum-1 Stopping
12:39:38 Container playground-firefox-ethereum-1 Stopped