Parent Log:
http://ci.aztec-labs.com/dfafad3f43a52d54
Command: fe40933d2a89e7f7 playground/scripts/run_test.sh firefox
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/16fc84676c7308fa5f7ca4a54b67319803d0f5b7
Env: REF_NAME=gh-readonly-queue/next/pr-15072-991b313d676f7cf820bb62a33e57cf5a4c8cf9cf CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Mon Jun 16 16:01:27 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15072_amd64_x1-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_23123200780498f7_next
16:01:27 Network playground-firefox_default Creating
16:01:27 Network playground-firefox_default Created
16:01:27 Container playground-firefox-ethereum-1 Creating
16:01:28 Container playground-firefox-ethereum-1 Created
16:01:28 Container playground-firefox-aztec-1 Creating
16:01:28 Container playground-firefox-aztec-1 Created
16:01:28 Container playground-firefox-playground-1 Creating
16:01:28 Container playground-firefox-playground-1 Created
16:01:28 Attaching to aztec-1, ethereum-1, playground-1
16:01:33 aztec-1 |
16:01:33 aztec-1 | _
16:01:33 aztec-1 | /\ | |
16:01:33 aztec-1 | / \ ___| |_ ___ ___
16:01:33 aztec-1 | / /\ \ |_ / __/ _ \/ __|
16:01:33 aztec-1 | / ____ \ / /| || __/ (__
16:01:33 aztec-1 | /_/___ \_\/___|\__\___|\___|
16:01:33 aztec-1 |
16:01:33 aztec-1 |
https://github.com/AztecProtocol
16:01:33 aztec-1 |
16:01:33 aztec-1 |
16:01:33 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
16:01:33 aztec-1 | Setting up test accounts
16:01:34 aztec-1 | [16:01:33.729]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-j0FoJj/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
16:01:34 aztec-1 | [16:01:33.983]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
16:01:34 aztec-1 | [16:01:33.987]
WARN:
sandbox Set block interval to 12
16:01:34 aztec-1 | [16:01:34.168]
INFO:
sandbox Waiting for 7 transactions to be mined...
16:01:34 aztec-1 | [16:01:34.189]
INFO:
sandbox All transactions mined successfully
16:01:34 aztec-1 | [16:01:34.264]
INFO:
sandbox Waiting for 9 transactions to be mined...
16:01:34 aztec-1 | [16:01:34.286]
INFO:
sandbox All transactions mined successfully
16:01:34 aztec-1 | [16:01:34.431]
INFO:
sandbox Waiting for 11 transactions to be mined...
16:01:34 aztec-1 | [16:01:34.454]
INFO:
sandbox All transactions mined successfully
16:01:34 aztec-1 | [16:01:34.512]
INFO:
sandbox Waiting for 12 transactions to be mined...
16:01:34 aztec-1 | [16:01:34.536]
INFO:
sandbox All transactions mined successfully
16:01:34 aztec-1 | [16:01:34.541]
INFO:
sandbox Waiting for 12 transactions to be mined...
16:01:34 aztec-1 | [16:01:34.561]
INFO:
sandbox All transactions mined successfully
16:01:34 aztec-1 | [16:01:34.573]
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"}
16:01:34 aztec-1 | [16:01:34.573]
INFO:
sandbox Handing over to governance
16:01:34 aztec-1 | [16:01:34.579]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
16:01:34 aztec-1 | [16:01:34.580]
INFO:
telemetry:client Using NoopTelemetryClient
16:01:34 aztec-1 | [16:01:34.580]
INFO:
blob-sink:client Creating local blob sink client.
16:01:34 aztec-1 | [16:01:34.584]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:01:34 aztec-1 | [16:01:34.584]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:06:17.000Z
{"offset":282416,"timeMs":1750089977000}
16:01:34 aztec-1 | [16:01:34.606]
INFO:
archiver:lmdb Starting data store with maxReaders 16
16:01:35 aztec-1 | [16:01:35.303]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xb48451829e2f37e5ffd2b5b12c056251d11144394d6274b4f1d7927403415b52
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xa5fa56e185b99cbbe7be3c779f342b193bbe0f7a95d540cd9cca7328931ad517","l1BlockNumber":20}}
16:01:35 aztec-1 | [16:01:35.387]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xb48451829e2f37e5ffd2b5b12c056251d11144394d6274b4f1d7927403415b52","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
16:01:35 aztec-1 | [16:01:35.398]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-kzszfM/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
16:01:35 aztec-1 | [16:01:35.897]
INFO:
world_state Created world state synchroniser with block history of 64
16:01:35 aztec-1 | [16:01:35.897]
WARN:
node Aztec node is accepting fake proofs
16:01:35 aztec-1 | [16:01:35.909]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
16:01:35 aztec-1 | [16:01:35.930]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
16:01:35 aztec-1 | [16:01:35.947]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
16:01:35 aztec-1 | [16:01:35.961]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
16:01:35 aztec-1 | [16:01:35.965]
INFO:
world_state Started world state synchronizer from block 1
16:01:36 aztec-1 | [16:01:35.968]
INFO:
p2p Starting p2p client from block 0 with empty mempools
16:01:36 aztec-1 | [16:01:36.197]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
16:01:36 aztec-1 | [16:01:36.241]
INFO:
slasher Starting Slasher client...
16:01:36 aztec-1 | [16:01:36.249]
INFO:
sequencer-client Deploying forwarder contract
16:01:36 aztec-1 | [16:01:36.267]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
16:01:36 aztec-1 | [16:01:36.273]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
16:01:36 aztec-1 | [16:01:36.274]
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}
16:01:36 aztec-1 | [16:01:36.275]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
16:01:36 aztec-1 | [16:01:36.276]
INFO:
node Aztec Node version: 0.87.6
16:01:36 aztec-1 | [16:01:36.276]
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"}
16:01:36 aztec-1 | [16:01:36.280]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
16:01:36 aztec-1 | [16:01:36.285]
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":1750089978,"syncedToL1Ts":1750089977,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750089965,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750090001},"newBlockNumber":1,"expectedSlot":1}
16:01:36 aztec-1 | [16:01:36.357]
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":1750089978,"syncedToL1Ts":1750089977,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750089965,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750090001},"newBlockNumber":1,"expectedSlot":1}
16:01:36 aztec-1 | [16:01:36.421]
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":1750089978,"syncedToL1Ts":1750089989,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750089965,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750090001},"newBlockNumber":1,"expectedSlot":1}
16:01:36 aztec-1 | [16:01:36.551]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:01:36 aztec-1 | [16:01:36.551]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:06:29.000Z
{"offset":292449,"timeMs":1750089989000}
16:01:36 aztec-1 | Setting up funded test accounts...
16:01:36 aztec-1 | [16:01:36.698]
INFO:
pxe:service Started PXE connected to chain 31337 version 3633326044
16:01:36 aztec-1 | [16:01:36.791]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
16:01:36 aztec-1 | [16:01:36.854]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
16:01:36 aztec-1 | [16:01:36.856]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
16:01:37 aztec-1 | [16:01:37.030]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
16:01:40 aztec-1 | [16:01:39.559]
INFO:
pxe:service Proving completed in 2483.351428ms
{"timings":{"total":2483.351428,"sync":12.744344000000638,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":158.86896800000068,"oracles":{"callPrivateFunction":{"times":[727.3528159999996,309.24100999999973,201.93351599999914]}}},{"functionName":"private_kernel_init","time":112.36692399999993},{"functionName":"ContractClassRegisterer:register","time":699.8277479999997,"oracles":{"loadCapsule":{"times":[33.160869000000275]},"notifyCreatedNullifier":{"times":[0.7108740000003309]},"debugLog":{"times":[0.4046280000002298]},"notifyCreatedContractClassLog":{"times":[6.696463000000222]}}},{"functionName":"private_kernel_inner","time":119.82360299999891},{"functionName":"SchnorrAccount:constructor","time":289.8304250000001,"oracles":{"getContractInstance":{"times":[4.362557000000379]},"debugLog":{"times":[0.21341399999982968,0.1417120000005525]},"fetchTaggedLogs":{"times":[68.41365099999894]},"loadCapsule":{"times":[0.29717600000003586,0.20276400000147987,0.19299400000090827]},"validateEnqueuedNotesAndEvents":{"times":[7.8605159999988246]},"notifyCreatedNullifier":{"times":[0.20956399999886344,0.25455499999952735]},"notifyCreatedNote":{"times":[0.5978809999996884]},"getRandomField":{"times":[0.3815569999987929,0.17079299999932118,0.051160999999410706,0.050790999999662745,0.1362329999992653,0.09979199999906996,0.038610999999946216,0.03421100000014121,0.04626099999950384,0.05156100000021979,0.046741000000110944]},"getIndexedTaggingSecretAsSender":{"times":[38.23793000000114]},"incrementAppTaggingSecretIndexAsSender":{"times":[20.545909000000393]}}},{"functionName":"private_kernel_inner","time":146.47676200000024},{"functionName":"SchnorrAccount:entrypoint","time":177.92617900000005,"oracles":{"debugLog":{"times":[0.17306300000018382,0.12311200000112876,0.43168899999909627]},"fetchTaggedLogs":{"times":[49.313670999999886]},"loadCapsule":{"times":[0.24475499999971362,0.19199399999888556,0.19567400000050839]},"validateEnqueuedNotesAndEvents":{"times":[5.793224999999438]},"getNotes":{"times":[5.24726499999997]},"getAuthWitness":{"times":[0.44493899999906716]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.9752300000000105]}}},{"functionName":"private_kernel_inner","time":103.6209200000012},{"functionName":"private_kernel_reset","time":162.76960700000018},{"functionName":"private_kernel_tail","time":91.16452300000128}],"unaccounted":407.93142499999703}}
16:01:40 aztec-1 | [16:01:39.658]
INFO:
node Received tx 0x1a2ce6fe426babe985e61783bda3f61f3b41fc90556fc37257b517b8992e5043
{"txHash":"0x1a2ce6fe426babe985e61783bda3f61f3b41fc90556fc37257b517b8992e5043"}
16:01:40 aztec-1 | [16:01:39.659]
INFO:
pxe:service Sent transaction 0x1a2ce6fe426babe985e61783bda3f61f3b41fc90556fc37257b517b8992e5043
16:01:40 aztec-1 | [16:01:39.751]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03570350999999937s
{"duration":0.03570350999999937,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
16:01:40 aztec-1 | [16:01:39.773]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2bbac8b107abcade7d9ca7d0fcd4ac9bd85775f612f1f772dfe2c605276ddfe6","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750090001,"version":3633326044},"txHashes":["0x1a2ce6fe426babe985e61783bda3f61f3b41fc90556fc37257b517b8992e5043"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":68.12061399999948,"publicProcessDuration":36.35960299999897,"rollupCircuitsDuration":60.78478900000118,"txCount":1,"blockNumber":1,"blockTimestamp":1750090001,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:01:43 aztec-1 | [16:01:42.359]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
16:01:43 aztec-1 | [16:01:42.361]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
16:01:43 aztec-1 | [16:01:42.363]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:43 aztec-1 | [16:01:42.451]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x2bbac8b107abcade7d9ca7d0fcd4ac9bd85775f612f1f772dfe2c605276ddfe6","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750090001,"version":3633326044},"archiveRoot":"0x1dac42b5652c81a06c2bd55fdf3e65f5359775598c21609fb245b77254ebeefa","archiveNextLeafIndex":2}
16:01:43 aztec-1 | [16:01:42.458]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
16:01:43 aztec-1 | [16:01:42.549]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:01:43 aztec-1 | [16:01:42.549]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:06:41.000Z
{"offset":298451,"timeMs":1750090001000}
16:01:43 aztec-1 | [16:01:42.551]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":19.739888000000064,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750090001,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:01:43 aztec-1 | [16:01:42.580]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
16:01:43 aztec-1 | [16:01:42.584]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750090037
16:01:43 aztec-1 | [16:01:42.584]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:07:17.000Z
{"offset":334416,"timeMs":1750090037000}
16:01:43 aztec-1 | [16:01:42.584]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
16:01:43 aztec-1 | [16:01:42.721]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
16:01:45 aztec-1 | [16:01:44.331]
INFO:
pxe:service Proving completed in 1587.197270999999ms
{"timings":{"total":1587.197270999999,"sync":41.5555889999996,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":105.84614600000168,"oracles":{"callPrivateFunction":{"times":[405.88478700000087,235.01049000000057]}}},{"functionName":"private_kernel_init","time":69.26359500000035},{"functionName":"SchnorrAccount:constructor","time":376.76209200000085,"oracles":{"getContractInstance":{"times":[4.430276999999478]},"debugLog":{"times":[0.17552400000022317,0.11043199999949138]},"fetchTaggedLogs":{"times":[105.13156100000015]},"loadCapsule":{"times":[0.278706000000966,0.25490499999978056,0.2256649999999354]},"validateEnqueuedNotesAndEvents":{"times":[5.953057000000626]},"notifyCreatedNullifier":{"times":[0.3210959999996703,0.4876399999993737]},"notifyCreatedNote":{"times":[0.1254819999994652]},"getRandomField":{"times":[0.10123199999907229,0.16272299999945972,0.07012199999917357,0.037791000000652275,0.032690999998521875,0.04161999999996624,0.03614999999990687,0.03214099999968312,0.036061000000700005,0.032771000000138883,0.04119100000025355]},"getIndexedTaggingSecretAsSender":{"times":[47.25616100000116]},"incrementAppTaggingSecretIndexAsSender":{"times":[58.27675799999997]}}},{"functionName":"private_kernel_inner","time":87.88601100000051},{"functionName":"SchnorrAccount:entrypoint","time":209.78082299999915,"oracles":{"debugLog":{"times":[0.1972939999996015,0.11437300000034156,0.17429399999855377]},"fetchTaggedLogs":{"times":[78.8413729999993]},"loadCapsule":{"times":[0.21607399999993504,0.16267299999890383,0.1687240000010206]},"validateEnqueuedNotesAndEvents":{"times":[5.922845999999481]},"getNotes":{"times":[1.7349640000011277]},"getAuthWitness":{"times":[0.23445499999979802]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5887920000004669]}}},{"functionName":"private_kernel_inner","time":143.51627700000063},{"functionName":"private_kernel_reset","time":207.77678399999968},{"functionName":"private_kernel_tail","time":79.60180899999978}],"unaccounted":265.2081449999969}}
16:01:45 aztec-1 | [16:01:44.377]
INFO:
node Received tx 0x22c2de3b88007b8099cf35c2f55a2c04f858d693028a5ea4d902391c3ba7b9a4
{"txHash":"0x22c2de3b88007b8099cf35c2f55a2c04f858d693028a5ea4d902391c3ba7b9a4"}
16:01:45 aztec-1 | [16:01:44.377]
INFO:
pxe:service Sent transaction 0x22c2de3b88007b8099cf35c2f55a2c04f858d693028a5ea4d902391c3ba7b9a4
16:01:45 aztec-1 | [16:01:44.454]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01975089900000057s
{"duration":0.01975089900000057,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
16:01:45 aztec-1 | [16:01:44.483]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2fced76196e4c7c86f0f0fff498365a2e73ec839f9bdea21d372b9ed01f466de","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750090037,"version":3633326044},"txHashes":["0x22c2de3b88007b8099cf35c2f55a2c04f858d693028a5ea4d902391c3ba7b9a4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":57.682786999999735,"publicProcessDuration":19.939782999999807,"rollupCircuitsDuration":51.352052000000185,"txCount":1,"blockNumber":2,"blockTimestamp":1750090037,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:01:45 aztec-1 | [16:01:44.705]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:45 aztec-1 | [16:01:44.722]
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":"0x1dac42b5652c81a06c2bd55fdf3e65f5359775598c21609fb245b77254ebeefa","blocksSynchedTo":26,"currentL1BlockNumber":27,"provenBlockNumber":1,"provenArchive":"0x1dac42b5652c81a06c2bd55fdf3e65f5359775598c21609fb245b77254ebeefa","pendingBlockNumber":2,"pendingArchive":"0x2aee189acc3041f40c0d786db0e31a81147a40f68b1bd927f8f5ac3b77a3cfa3"}
16:01:45 aztec-1 | [16:01:44.764]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:01:45 aztec-1 | [16:01:44.764]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:07:29.000Z
{"offset":344236,"timeMs":1750090049000}
16:01:45 aztec-1 | [16:01:44.770]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
16:01:45 aztec-1 | [16:01:44.773]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
16:01:45 aztec-1 | [16:01:44.825]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2fced76196e4c7c86f0f0fff498365a2e73ec839f9bdea21d372b9ed01f466de","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750090037,"version":3633326044},"archiveRoot":"0x2aee189acc3041f40c0d786db0e31a81147a40f68b1bd927f8f5ac3b77a3cfa3","archiveNextLeafIndex":3}
16:01:45 aztec-1 | [16:01:44.833]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
16:01:45 aztec-1 | [16:01:44.867]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":14.142029000000548,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750090037,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:01:45 aztec-1 | [16:01:44.966]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:01:45 aztec-1 | [16:01:44.966]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:07:53.000Z
{"offset":368034,"timeMs":1750090073000}
16:01:45 aztec-1 | [16:01:44.966]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750090073
16:01:45 aztec-1 | [16:01:44.966]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:07:53.000Z
{"offset":368034,"timeMs":1750090073000}
16:01:45 aztec-1 | [16:01:44.966]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
16:01:45 aztec-1 | [16:01:44.989]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
16:01:45 aztec-1 | [16:01:45.101]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
16:01:47 aztec-1 | Initial Accounts:
16:01:47 aztec-1 |
16:01:47 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
16:01:47 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
16:01:47 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
16:01:47 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
16:01:47 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
16:01:47 aztec-1 |
16:01:47 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
16:01:47 aztec-1 |
16:01:47 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
16:01:47 aztec-1 |
16:01:47 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
16:01:47 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
16:01:47 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
16:01:47 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
16:01:47 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
16:01:47 aztec-1 |
16:01:47 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
16:01:47 aztec-1 |
16:01:47 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
16:01:47 aztec-1 |
16:01:47 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
16:01:47 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
16:01:47 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
16:01:47 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
16:01:47 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
16:01:47 aztec-1 |
16:01:47 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
16:01:47 aztec-1 |
16:01:47 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
16:01:47 aztec-1 |
16:01:47 aztec-1 |
16:01:47 aztec-1 | [16:01:46.707]
INFO:
pxe:service Proving completed in 1595.6667279999983ms
{"timings":{"total":1595.6667279999983,"sync":23.508092999998553,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":91.56733500000337,"oracles":{"callPrivateFunction":{"times":[376.4028359999993,249.55096599999888]}}},{"functionName":"private_kernel_init","time":57.69104700000025},{"functionName":"SchnorrAccount:constructor","time":349.371162999998,"oracles":{"getContractInstance":{"times":[3.723512999999002]},"debugLog":{"times":[0.18720399999983783,0.12225299999954586]},"fetchTaggedLogs":{"times":[127.58783399999993]},"loadCapsule":{"times":[0.2912849999993341,0.19982399999935296,0.1747429999995802]},"validateEnqueuedNotesAndEvents":{"times":[6.34489499999836]},"notifyCreatedNullifier":{"times":[0.24724500000047556,0.22415399999954388]},"notifyCreatedNote":{"times":[0.15789300000142248]},"getRandomField":{"times":[0.09848200000124052,0.19286299999839684,0.05378099999870756,0.0704009999990376,0.043491000000358326,0.04534099999909813,0.04877000000124099,0.04646099999990838,0.05121099999996659,0.046441000000413624,0.046140999998897314]},"getIndexedTaggingSecretAsSender":{"times":[49.99410499999976]},"incrementAppTaggingSecretIndexAsSender":{"times":[27.792756999999256]}}},{"functionName":"private_kernel_inner","time":138.35046599999987},{"functionName":"SchnorrAccount:entrypoint","time":220.17037699999855,"oracles":{"debugLog":{"times":[0.18147299999873212,0.09107199999925797,0.1739240000024438]},"fetchTaggedLogs":{"times":[87.20391799999925]},"loadCapsule":{"times":[0.2066930000000866,0.17579400000249734,0.17758299999695737]},"validateEnqueuedNotesAndEvents":{"times":[5.8558760000014445]},"getNotes":{"times":[11.838273000001209]},"getAuthWitness":{"times":[0.16618300000118325]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.422497999999905]}}},{"functionName":"private_kernel_inner","time":139.2735130000001},{"functionName":"private_kernel_reset","time":223.27803899999708},{"functionName":"private_kernel_tail","time":83.25182000000132}],"unaccounted":269.20487500000127}}
16:01:47 aztec-1 | [16:01:46.760]
INFO:
node Received tx 0x221d4b62cc7fcb865bce7ee962226c5adf4f2a25c890e04dbd68d57fab37f8bb
{"txHash":"0x221d4b62cc7fcb865bce7ee962226c5adf4f2a25c890e04dbd68d57fab37f8bb"}
16:01:47 aztec-1 | [16:01:46.760]
INFO:
pxe:service Sent transaction 0x221d4b62cc7fcb865bce7ee962226c5adf4f2a25c890e04dbd68d57fab37f8bb
16:01:47 aztec-1 | [16:01:46.831]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.018998084999999266s
{"duration":0.018998084999999266,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
16:01:47 aztec-1 | [16:01:46.853]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x1c7dc034c69ad54a2bfd750a6f7775a193397e5f25fa8f89f65e26d0f016c017","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750090073,"version":3633326044},"txHashes":["0x221d4b62cc7fcb865bce7ee962226c5adf4f2a25c890e04dbd68d57fab37f8bb"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":48.59610799999791,"publicProcessDuration":19.10863700000118,"rollupCircuitsDuration":43.02861800000028,"txCount":1,"blockNumber":3,"blockTimestamp":1750090073,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:01:47 aztec-1 | [16:01:47.036]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:47 aztec-1 | [16:01:47.041]
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":"0x2aee189acc3041f40c0d786db0e31a81147a40f68b1bd927f8f5ac3b77a3cfa3","blocksSynchedTo":28,"currentL1BlockNumber":29,"provenBlockNumber":2,"provenArchive":"0x2aee189acc3041f40c0d786db0e31a81147a40f68b1bd927f8f5ac3b77a3cfa3","pendingBlockNumber":3,"pendingArchive":"0x0988da801aa0ecf119a94e077302b61af284b20785ed0797bdec0f8455a0b08a"}
16:01:47 aztec-1 | [16:01:47.127]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x1c7dc034c69ad54a2bfd750a6f7775a193397e5f25fa8f89f65e26d0f016c017","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750090073,"version":3633326044},"archiveRoot":"0x0988da801aa0ecf119a94e077302b61af284b20785ed0797bdec0f8455a0b08a","archiveNextLeafIndex":4}
16:01:47 aztec-1 | [16:01:47.153]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":14.898203000000649,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750090073,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:01:47 aztec-1 | [16:01:47.220]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:01:47 aztec-1 | [16:01:47.220]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:08:05.000Z
{"offset":377780,"timeMs":1750090085000}
16:01:47 aztec-1 | [16:01:47.223]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
16:01:47 aztec-1 | [16:01:47.224]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
16:01:48 aztec-1 | [16:01:48.001]
WARN:
pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata
16:01:48 aztec-1 | [16:01:48.001]
WARN:
pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata
16:01:48 aztec-1 | [16:01:48.004]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
16:01:48 aztec-1 | [16:01:48.037]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
16:01:48 aztec-1 | [16:01:48.245]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750090109
16:01:48 aztec-1 | [16:01:48.245]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:08:29.000Z
{"offset":400755,"timeMs":1750090109000}
16:01:48 aztec-1 | [16:01:48.245]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
16:01:48 aztec-1 | [16:01:48.755]
INFO:
pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2
16:01:48 aztec-1 | [16:01:48.758]
INFO:
pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164
16:01:48 aztec-1 | [16:01:48.759]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
16:01:50 aztec-1 | [16:01:50.907]
INFO:
pxe:service Proving completed in 2135.4258929999996ms
{"timings":{"total":2135.4258929999996,"sync":18.884892000001855,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":356.9099520000018,"oracles":{"debugLog":{"times":[0.20127399999910267,0.11084199999822886,0.101172000002407,0.20805399999881047,0.1465829999979178,0.12187199999971199,0.10044199999902048,0.1953639999992447]},"fetchTaggedLogs":{"times":[128.8021770000014]},"loadCapsule":{"times":[0.24318500000299537,0.1592430000018794,0.2965460000013991,0.26564499999949476,0.32046700000137207,0.3274459999993269,0.17635299999892595]},"getSharedSecret":{"times":[5.08408000000054]},"aes128Decrypt":{"times":[1.0710010000002512,0.787585999998555]},"getPublicKeysAndPartialAddress":{"times":[1.711223999998765]},"getKeyValidationRequest":{"times":[4.289844999999332]},"storeCapsule":{"times":[3.5739700000012817,3.0479899999991176,2.979789000000892]},"deleteCapsule":{"times":[3.0890810000018973]},"validateEnqueuedNotesAndEvents":{"times":[23.85037000000011]},"getNotes":{"times":[2.4026469999989786]},"getAuthWitness":{"times":[0.18151399999987916]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.08980200000223704]},"callPrivateFunction":{"times":[651.4982659999987,132.0821219999998]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3971369999999297]}}},{"functionName":"private_kernel_init","time":65.79515700000047},{"functionName":"ContractClassRegisterer:register","time":633.2156269999978,"oracles":{"loadCapsule":{"times":[3.368475999999646]},"notifyCreatedNullifier":{"times":[0.32867699999769684]},"debugLog":{"times":[0.13826300000073388]},"notifyCreatedContractClassLog":{"times":[2.795764999998937]}}},{"functionName":"private_kernel_inner","time":92.4441310000002},{"functionName":"ContractInstanceDeployer:deploy","time":78.90835400000287,"oracles":{"storeInExecutionCache":{"times":[0.26760599999761325]},"callPrivateFunction":{"times":[52.64601700000276]},"notifyCreatedNullifier":{"times":[0.3399170000011509]},"debugLog":{"times":[0.14980300000024727]}}},{"functionName":"private_kernel_inner","time":96.83673799999815},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":37.90054699999746,"oracles":{}},{"functionName":"private_kernel_inner","time":134.5039199999992},{"functionName":"private_kernel_reset","time":150.98494500000015},{"functionName":"private_kernel_tail","time":73.85100500000044}],"unaccounted":395.1906249999993}}
16:01:51 aztec-1 | [16:01:51.068]
INFO:
node Received tx 0x0d43c7e09e82da68beb920bf5dd886493645dd3ac30bf6d7da60ede233385851
{"txHash":"0x0d43c7e09e82da68beb920bf5dd886493645dd3ac30bf6d7da60ede233385851"}
16:01:51 aztec-1 | [16:01:51.068]
INFO:
pxe:service Sent transaction 0x0d43c7e09e82da68beb920bf5dd886493645dd3ac30bf6d7da60ede233385851
16:01:54 aztec-1 | [16:01:53.412]
INFO:
pxe:service Proving completed in 2504.815611000002ms
{"timings":{"total":2504.815611000002,"sync":133.92553899999984,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":428.32389799999874,"oracles":{"debugLog":{"times":[0.15262299999812967,0.10761199999978999,0.06242099999872153,0.11691300000165938,0.11240199999883771,0.12172199999986333,0.06125199999951292,0.12117199999920558]},"fetchTaggedLogs":{"times":[192.70823699999892]},"loadCapsule":{"times":[1.787144999998418,0.39866799999799696,0.5778810000010708,0.2941159999973024,2.0691200000001118,0.3839079999997921,0.43842899999799556]},"getSharedSecret":{"times":[6.868676000001869]},"aes128Decrypt":{"times":[0.2156649999997171,0.7136140000002342]},"getPublicKeysAndPartialAddress":{"times":[1.339326000001165]},"getKeyValidationRequest":{"times":[2.233803999999509]},"storeCapsule":{"times":[3.107011000000057,54.510693999996874,2.5393799999983457]},"deleteCapsule":{"times":[3.047950000000128]},"validateEnqueuedNotesAndEvents":{"times":[12.486226000000897]},"getNotes":{"times":[1.68560300000172]},"getAuthWitness":{"times":[0.14638299999933224]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.051569999999628635]},"callPrivateFunction":{"times":[773.8172560000021,142.6982910000006]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06923100000130944]}}},{"functionName":"private_kernel_init","time":75.92833599999722},{"functionName":"ContractClassRegisterer:register","time":756.0895170000003,"oracles":{"loadCapsule":{"times":[1.5991519999988668]},"notifyCreatedNullifier":{"times":[0.5097300000015821]},"debugLog":{"times":[0.17819300000337535]},"notifyCreatedContractClassLog":{"times":[4.091169999999693]}}},{"functionName":"private_kernel_inner","time":154.10093699999925},{"functionName":"ContractInstanceDeployer:deploy","time":79.10578799999712,"oracles":{"storeInExecutionCache":{"times":[0.11974300000292715]},"callPrivateFunction":{"times":[64.04634200000146]},"notifyCreatedNullifier":{"times":[0.34838700000182143]},"debugLog":{"times":[0.16612300000269897]}}},{"functionName":"private_kernel_inner","time":104.01856999999654},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":47.95865500000218,"oracles":{}},{"functionName":"private_kernel_inner","time":104.14347199999975},{"functionName":"private_kernel_reset","time":156.71654800000033},{"functionName":"private_kernel_tail","time":81.96925499999998}],"unaccounted":382.5350960000105}}
16:01:54 aztec-1 | [16:01:53.500]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 2.3273882660000016s
{"duration":2.3273882660000016,"rate":135968.71850861167,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064}
16:01:54 aztec-1 | [16:01:53.550]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 132594.19595769452 mana/s
{"blockHash":"0x1a8d244794a29012cd2751e0ec4f13814911f68477a43f63a1f4ffefb6e17751","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750090109,"version":3633326044},"txHashes":["0x0d43c7e09e82da68beb920bf5dd886493645dd3ac30bf6d7da60ede233385851"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2386.5655509999997,"publicProcessDuration":2327.5242580000013,"rollupCircuitsDuration":2379.462961000001,"txCount":1,"blockNumber":4,"blockTimestamp":1750090109,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
16:01:54 aztec-1 | [16:01:53.551]
INFO:
node Received tx 0x013d1970a90bf7a7aed65fed29161fb94ed44df68492e6a6298087810880dc73
{"txHash":"0x013d1970a90bf7a7aed65fed29161fb94ed44df68492e6a6298087810880dc73"}
16:01:54 aztec-1 | [16:01:53.551]
INFO:
pxe:service Sent transaction 0x013d1970a90bf7a7aed65fed29161fb94ed44df68492e6a6298087810880dc73
16:01:54 aztec-1 | [16:01:53.736]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
16:01:54 aztec-1 | [16:01:53.739]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
16:01:54 aztec-1 | [16:01:53.742]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:54 aztec-1 | [16:01:53.745]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750090145
16:01:54 aztec-1 | [16:01:53.745]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:09:05.000Z
{"offset":431255,"timeMs":1750090145000}
16:01:54 aztec-1 | [16:01:53.745]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
16:01:54 aztec-1 | [16:01:53.934]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x1a8d244794a29012cd2751e0ec4f13814911f68477a43f63a1f4ffefb6e17751","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750090109,"version":3633326044},"archiveRoot":"0x01153511ccd4931b7eaaceb68e07277840e3ba9ef91d1692d7fadaf936e5582a","archiveNextLeafIndex":5}
16:01:54 aztec-1 | [16:01:53.940]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
16:01:54 aztec-1 | [16:01:54.006]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":14.612288000000262,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750090109,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
16:01:54 aztec-1 | [16:01:54.240]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.16640172900000108s
{"duration":0.16640172900000108,"rate":239126.12109937717,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768}
16:01:54 aztec-1 | [16:01:54.275]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 182202.84832537206 mana/s
{"blockHash":"0x1bef8db08e656bbe93efccf0011be70007ca24340c29c6582ee58605357ed62f","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750090145,"version":3633326044},"txHashes":["0x013d1970a90bf7a7aed65fed29161fb94ed44df68492e6a6298087810880dc73"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":218.35866199999873,"publicProcessDuration":166.7133849999991,"rollupCircuitsDuration":211.63651899999968,"txCount":1,"blockNumber":5,"blockTimestamp":1750090145,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
16:01:54 aztec-1 | [16:01:54.466]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:54 aztec-1 | [16:01:54.470]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
16:01:54 aztec-1 | [16:01:54.472]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
16:01:54 aztec-1 | [16:01:54.690]
INFO:
aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed.
16:01:54 aztec-1 | [16:01:54.703]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:01:54 aztec-1 | [16:01:54.703]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:09:17.000Z
{"offset":442297,"timeMs":1750090157000}
16:01:54 aztec-1 | [16:01:54.705]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750090181
16:01:54 aztec-1 | [16:01:54.705]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:09:41.000Z
{"offset":466295,"timeMs":1750090181000}
16:01:54 aztec-1 | [16:01:54.705]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
16:01:54 aztec-1 | [16:01:54.839]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x1bef8db08e656bbe93efccf0011be70007ca24340c29c6582ee58605357ed62f","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750090145,"version":3633326044},"archiveRoot":"0x1ac7bf0262d1cad5f5839ca7dec68c0a50a3a4e00c6778bd6d40fa0993115293","archiveNextLeafIndex":6}
16:01:54 aztec-1 | [16:01:54.845]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
16:01:54 aztec-1 | [16:01:54.882]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":16.501164999997854,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750090145,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
16:01:55 aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
16:01:55 aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
16:01:55 aztec-1 | [16:01:55.739]
INFO:
aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed.
16:01:55 aztec-1 | [16:01:55.770]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
16:01:55 aztec-1 | [16:01:55.774]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
16:01:55 aztec-1 | [16:01:55.952]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
16:01:59 aztec-1 | [16:01:58.323]
INFO:
pxe:service Proving completed in 2353.1061819999995ms
{"timings":{"total":2353.1061819999995,"sync":34.110961999998835,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":76.70255100000577,"oracles":{"callPrivateFunction":{"times":[815.9665060000007,113.48575599999822,40.886445000000094]}}},{"functionName":"private_kernel_init","time":61.51456099999996},{"functionName":"ContractClassRegisterer:register","time":798.6073549999965,"oracles":{"loadCapsule":{"times":[2.4801789999983157]},"notifyCreatedNullifier":{"times":[0.3432360000006156]},"debugLog":{"times":[0.14915299999847775]},"notifyCreatedContractClassLog":{"times":[5.3034740000002785]}}},{"functionName":"private_kernel_inner","time":115.69529899999907},{"functionName":"ContractInstanceDeployer:deploy","time":68.5754710000001,"oracles":{"storeInExecutionCache":{"times":[0.06949100000201724]},"callPrivateFunction":{"times":[48.71251999999731]},"notifyCreatedNullifier":{"times":[0.31424600000173086]},"debugLog":{"times":[0.1619730000020354]}}},{"functionName":"private_kernel_inner","time":151.88109299999996},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":34.33463599999959,"oracles":{}},{"functionName":"private_kernel_inner","time":154.609037000002},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":33.13023299999986,"oracles":{"debugLog":{"times":[0.1403229999996256]}}},{"functionName":"private_kernel_inner","time":100.94286800000191},{"functionName":"private_kernel_reset","time":211.31804399999965},{"functionName":"private_kernel_tail","time":89.96775300000081}],"unaccounted":421.71631899999556}}
16:01:59 aztec-1 | [16:01:58.456]
INFO:
node Received tx 0x24838fcbc90bc4f9a66ab1a2a6e0cef331ded2ad65d83233052213c4fc35fdaf
{"txHash":"0x24838fcbc90bc4f9a66ab1a2a6e0cef331ded2ad65d83233052213c4fc35fdaf"}
16:01:59 aztec-1 | [16:01:58.456]
INFO:
pxe:service Sent transaction 0x24838fcbc90bc4f9a66ab1a2a6e0cef331ded2ad65d83233052213c4fc35fdaf
16:01:59 aztec-1 | [16:01:58.582]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.0461783800000012s
{"duration":0.0461783800000012,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
16:01:59 aztec-1 | [16:01:58.620]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2ccc30f07170bcdbf2c298afc1867944f78046686ba044694e038058db946334","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750090181,"version":3633326044},"txHashes":["0x24838fcbc90bc4f9a66ab1a2a6e0cef331ded2ad65d83233052213c4fc35fdaf"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":94.13036399999692,"publicProcessDuration":46.326491999996506,"rollupCircuitsDuration":88.22121899999911,"txCount":1,"blockNumber":6,"blockTimestamp":1750090181,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:01:59 aztec-1 | [16:01:58.785]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
16:01:59 aztec-1 | [16:01:58.786]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
16:01:59 aztec-1 | [16:01:58.789]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:01:59 aztec-1 | [16:01:58.795]
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":"0x1ac7bf0262d1cad5f5839ca7dec68c0a50a3a4e00c6778bd6d40fa0993115293","blocksSynchedTo":34,"currentL1BlockNumber":35,"provenBlockNumber":5,"provenArchive":"0x1ac7bf0262d1cad5f5839ca7dec68c0a50a3a4e00c6778bd6d40fa0993115293","pendingBlockNumber":6,"pendingArchive":"0x2e2febe962ac5c3e3550cb90b38f6692fc6d8a19a163b3de7320b391f4cf7266"}
16:01:59 aztec-1 | [16:01:58.856]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750090217
16:01:59 aztec-1 | [16:01:58.856]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:10:17.000Z
{"offset":498144,"timeMs":1750090217000}
16:01:59 aztec-1 | [16:01:58.856]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
16:01:59 aztec-1 | [16:01:58.903]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x2ccc30f07170bcdbf2c298afc1867944f78046686ba044694e038058db946334","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750090181,"version":3633326044},"archiveRoot":"0x2e2febe962ac5c3e3550cb90b38f6692fc6d8a19a163b3de7320b391f4cf7266","archiveNextLeafIndex":7}
16:01:59 aztec-1 | [16:01:58.909]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
16:01:59 aztec-1 | [16:01:58.965]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":19.25296900000103,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750090181,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:01:59 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
16:01:59 aztec-1 | [16:01:59.475]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
16:01:59 aztec-1 | [16:01:59.484]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x27f24d2a1e99e49d4a27746a8374185b307a07325d0d743c1df56a03e39788d2","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
16:02:04 playground-1 | \
16:02:04 playground-1 |
Running 1
test using 1
worker
16:02:04 playground-1 |
16:02:05 playground-1 |
✓ 1 [firefox] › browser.spec.ts:3:1 › test
(12.3s)
16:02:20 playground-1 |
1 passed (17.2s)
16:02:20 playground-1 | \
npm notice
16:02:20 playground-1 |
npm notice New
major version of npm available!
10.9.2 ->
11.4.2
16:02:20 playground-1 |
npm notice Changelog:
https://github.com/npm/cli/releases/tag/v11.4.2
16:02:20 playground-1 |
npm notice To update run:
npm install -g npm@11.4.2
16:02:20 playground-1 |
npm notice
16:02:20 playground-1 | \
16:02:21
playground-1 exited with code 0
16:02:21 Aborting on container exit...
16:02:21 Container playground-firefox-playground-1 Stopping
16:02:21 Container playground-firefox-playground-1 Stopped
16:02:21 Container playground-firefox-aztec-1 Stopping
16:02:22 Container playground-firefox-aztec-1 Stopped
16:02:22 Container playground-firefox-ethereum-1 Stopping
16:02:23 Container playground-firefox-ethereum-1 Stopped