Parent Log:
http://ci.aztec-labs.com/77683c53a968ebf5
Command: 78cd6c924e5aafb5 playground/scripts/run_test.sh firefox
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/eeab628a4e44477cb6796c5a461ee0c0bb332d75
Env: REF_NAME=gh-readonly-queue/next/pr-15059-9a37be7dc4208f0eeb44ec50194c00ca3f5c4cc6 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Mon Jun 16 16:45:12 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15059_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:45:12 Network playground-firefox_default Creating
16:45:12 Network playground-firefox_default Created
16:45:12 Container playground-firefox-ethereum-1 Creating
16:45:13 Container playground-firefox-ethereum-1 Created
16:45:13 Container playground-firefox-aztec-1 Creating
16:45:14 Container playground-firefox-aztec-1 Created
16:45:14 Container playground-firefox-playground-1 Creating
16:45:15 Container playground-firefox-playground-1 Created
16:45:15 Attaching to aztec-1, ethereum-1, playground-1
16:45:20 aztec-1 |
16:45:20 aztec-1 | _
16:45:20 aztec-1 | /\ | |
16:45:20 aztec-1 | / \ ___| |_ ___ ___
16:45:20 aztec-1 | / /\ \ |_ / __/ _ \/ __|
16:45:20 aztec-1 | / ____ \ / /| || __/ (__
16:45:20 aztec-1 | /_/___ \_\/___|\__\___|\___|
16:45:20 aztec-1 |
16:45:20 aztec-1 |
https://github.com/AztecProtocol
16:45:20 aztec-1 |
16:45:20 aztec-1 |
16:45:20 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
16:45:20 aztec-1 | Setting up test accounts
16:45:21 aztec-1 | [16:45:21.173]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-uHGh1V/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
16:45:21 aztec-1 | [16:45:21.418]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
16:45:21 aztec-1 | [16:45:21.423]
WARN:
sandbox Set block interval to 12
16:45:21 aztec-1 | [16:45:21.603]
INFO:
sandbox Waiting for 7 transactions to be mined...
16:45:21 aztec-1 | [16:45:21.622]
INFO:
sandbox All transactions mined successfully
16:45:21 aztec-1 | [16:45:21.707]
INFO:
sandbox Waiting for 9 transactions to be mined...
16:45:21 aztec-1 | [16:45:21.725]
INFO:
sandbox All transactions mined successfully
16:45:21 aztec-1 | [16:45:21.873]
INFO:
sandbox Waiting for 11 transactions to be mined...
16:45:21 aztec-1 | [16:45:21.893]
INFO:
sandbox All transactions mined successfully
16:45:21 aztec-1 | [16:45:21.954]
INFO:
sandbox Waiting for 12 transactions to be mined...
16:45:21 aztec-1 | [16:45:21.981]
INFO:
sandbox All transactions mined successfully
16:45:21 aztec-1 | [16:45:21.986]
INFO:
sandbox Waiting for 12 transactions to be mined...
16:45:22 aztec-1 | [16:45:22.007]
INFO:
sandbox All transactions mined successfully
16:45:22 aztec-1 | [16:45:22.023]
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:45:22 aztec-1 | [16:45:22.023]
INFO:
sandbox Handing over to governance
16:45:22 aztec-1 | [16:45:22.030]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
16:45:22 aztec-1 | [16:45:22.031]
INFO:
telemetry:client Using NoopTelemetryClient
16:45:22 aztec-1 | [16:45:22.031]
INFO:
blob-sink:client Creating local blob sink client.
16:45:22 aztec-1 | [16:45:22.036]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:45:22 aztec-1 | [16:45:22.036]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:50:03.000Z
{"offset":280964,"timeMs":1750092603000}
16:45:22 aztec-1 | [16:45:22.059]
INFO:
archiver:lmdb Starting data store with maxReaders 16
16:45:22 aztec-1 | [16:45:22.478]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x1b7df497ed542913faa476f5175a488a41f8b0fb507ca9f5f547d103412df559
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x66321143470d703b84d1313999095b57e48f1769a0343af70a944c25c84c1479","l1BlockNumber":20}}
16:45:22 aztec-1 | [16:45:22.499]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x1b7df497ed542913faa476f5175a488a41f8b0fb507ca9f5f547d103412df559","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
16:45:22 aztec-1 | [16:45:22.506]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-QaNfU8/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
16:45:22 aztec-1 | [16:45:22.720]
INFO:
world_state Created world state synchroniser with block history of 64
16:45:22 aztec-1 | [16:45:22.720]
WARN:
node Aztec node is accepting fake proofs
16:45:22 aztec-1 | [16:45:22.729]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
16:45:22 aztec-1 | [16:45:22.743]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
16:45:22 aztec-1 | [16:45:22.756]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
16:45:22 aztec-1 | [16:45:22.766]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
16:45:22 aztec-1 | [16:45:22.770]
INFO:
world_state Started world state synchronizer from block 1
16:45:23 aztec-1 | [16:45:22.775]
INFO:
p2p Starting p2p client from block 0 with empty mempools
16:45:23 aztec-1 | [16:45:23.032]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
16:45:23 aztec-1 | [16:45:23.094]
INFO:
slasher Starting Slasher client...
16:45:23 aztec-1 | [16:45:23.104]
INFO:
sequencer-client Deploying forwarder contract
16:45:23 aztec-1 | [16:45:23.125]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
16:45:23 aztec-1 | [16:45:23.132]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
16:45:23 aztec-1 | [16:45:23.133]
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:45:23 aztec-1 | [16:45:23.135]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
16:45:23 aztec-1 | [16:45:23.135]
INFO:
node Aztec Node version: 0.87.6
16:45:23 aztec-1 | [16:45:23.135]
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:45:23 aztec-1 | [16:45:23.139]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
16:45:23 aztec-1 | [16:45:23.150]
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":1750092604,"syncedToL1Ts":1750092603,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750092591,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750092627},"newBlockNumber":1,"expectedSlot":1}
16:45:23 aztec-1 | [16:45:23.221]
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":1750092604,"syncedToL1Ts":1750092603,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750092591,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750092627},"newBlockNumber":1,"expectedSlot":1}
16:45:23 aztec-1 | [16:45:23.296]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:45:23 aztec-1 | [16:45:23.296]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:50:15.000Z
{"offset":291704,"timeMs":1750092615000}
16:45:23 aztec-1 | [16:45:23.299]
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":1750092604,"syncedToL1Ts":1750092615,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750092591,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750092627},"newBlockNumber":1,"expectedSlot":1}
16:45:23 aztec-1 | Setting up funded test accounts...
16:45:23 aztec-1 | [16:45:23.588]
INFO:
pxe:service Started PXE connected to chain 31337 version 3633326044
16:45:23 aztec-1 | [16:45:23.689]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
16:45:23 aztec-1 | [16:45:23.751]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
16:45:23 aztec-1 | [16:45:23.753]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
16:45:23 aztec-1 | [16:45:23.910]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
16:45:27 aztec-1 | [16:45:26.569]
INFO:
pxe:service Proving completed in 2613.4859539999998ms
{"timings":{"total":2613.4859539999998,"sync":10.374348999999711,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":170.83188599999994,"oracles":{"callPrivateFunction":{"times":[959.8038820000002,298.5736849999994,173.09145800000078]}}},{"functionName":"private_kernel_init","time":94.79680700000063},{"functionName":"ContractClassRegisterer:register","time":932.5358220000016,"oracles":{"loadCapsule":{"times":[11.993554999999105]},"notifyCreatedNullifier":{"times":[0.9746520000007877]},"debugLog":{"times":[0.7102100000010978]},"notifyCreatedContractClassLog":{"times":[8.77964299999985]}}},{"functionName":"private_kernel_inner","time":129.9762269999992},{"functionName":"SchnorrAccount:constructor","time":278.4271689999987,"oracles":{"getContractInstance":{"times":[2.7094990000005055]},"debugLog":{"times":[0.13715100000081293,0.12676099999953294]},"fetchTaggedLogs":{"times":[48.75317899999936]},"loadCapsule":{"times":[0.30002499999864085,0.17536499999914668,0.16278400000010151]},"validateEnqueuedNotesAndEvents":{"times":[6.371640000001207]},"notifyCreatedNullifier":{"times":[0.2607319999988249,0.2496420000006765]},"notifyCreatedNote":{"times":[0.8061679999991611]},"getRandomField":{"times":[0.25935199999912584,0.2404100000003382,0.053004999999757274,0.05627500000082364,0.24951099999998405,0.06258499999967171,0.04756400000042049,0.07711599999856844,0.046834999999191496,0.07662700000037148,0.03569299999981013]},"getIndexedTaggingSecretAsSender":{"times":[46.64270000000033]},"incrementAppTaggingSecretIndexAsSender":{"times":[19.160751999999775]}}},{"functionName":"private_kernel_inner","time":119.96766000000025},{"functionName":"SchnorrAccount:entrypoint","time":151.15515099999902,"oracles":{"debugLog":{"times":[0.22041800000079093,0.08791800000108196,0.3273379999991448]},"fetchTaggedLogs":{"times":[44.58416600000055]},"loadCapsule":{"times":[0.26256199999988894,0.2190279999995255,0.20033699999839882]},"validateEnqueuedNotesAndEvents":{"times":[5.595553999999538]},"getNotes":{"times":[2.3919630000000325]},"getAuthWitness":{"times":[0.2501609999999346]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.9053070000009029]}}},{"functionName":"private_kernel_inner","time":112.96867700000075},{"functionName":"private_kernel_reset","time":162.53717399999914},{"functionName":"private_kernel_tail","time":61.44921400000021}],"unaccounted":388.4658180000006}}
16:45:27 aztec-1 | [16:45:26.658]
INFO:
node Received tx 0x25c5da46fdad32eb6112d59189be7dd1a2048328df5217b5ea9607a7e7203d11
{"txHash":"0x25c5da46fdad32eb6112d59189be7dd1a2048328df5217b5ea9607a7e7203d11"}
16:45:27 aztec-1 | [16:45:26.658]
INFO:
pxe:service Sent transaction 0x25c5da46fdad32eb6112d59189be7dd1a2048328df5217b5ea9607a7e7203d11
16:45:27 aztec-1 | [16:45:26.771]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04784610200000134s
{"duration":0.04784610200000134,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
16:45:27 aztec-1 | [16:45:26.806]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x06b312c36d6dd4c2b03bb8ff92fb03111e67c2498d892c76433ca96667e151c2","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750092627,"version":3633326044},"txHashes":["0x25c5da46fdad32eb6112d59189be7dd1a2048328df5217b5ea9607a7e7203d11"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":95.19913199999974,"publicProcessDuration":48.71406500000012,"rollupCircuitsDuration":86.7352950000004,"txCount":1,"blockNumber":1,"blockTimestamp":1750092627,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:45:30 aztec-1 | [16:45:29.897]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
16:45:30 aztec-1 | [16:45:29.899]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
16:45:30 aztec-1 | [16:45:29.902]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:30 aztec-1 | [16:45:29.994]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x06b312c36d6dd4c2b03bb8ff92fb03111e67c2498d892c76433ca96667e151c2","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750092627,"version":3633326044},"archiveRoot":"0x2533a6cb3eb55998a94c1003a432bcd9d155da86ffb544b338b691d65b1273c8","archiveNextLeafIndex":2}
16:45:30 aztec-1 | [16:45:30.000]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
16:45:30 aztec-1 | [16:45:30.067]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":19.49808099999973,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750092627,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:45:30 aztec-1 | [16:45:30.124]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:45:30 aztec-1 | [16:45:30.124]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:50:27.000Z
{"offset":296876,"timeMs":1750092627000}
16:45:30 aztec-1 | [16:45:30.137]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092663
16:45:30 aztec-1 | [16:45:30.137]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:51:03.000Z
{"offset":332863,"timeMs":1750092663000}
16:45:30 aztec-1 | [16:45:30.137]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
16:45:30 aztec-1 | [16:45:30.162]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
16:45:30 aztec-1 | [16:45:30.308]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
16:45:32 aztec-1 | [16:45:32.098]
INFO:
pxe:service Proving completed in 1753.5416989999994ms
{"timings":{"total":1753.5416989999994,"sync":57.31907400000091,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":139.35897199999818,"oracles":{"callPrivateFunction":{"times":[508.70268899999974,350.90310599999975]}}},{"functionName":"private_kernel_init","time":54.96367400000054},{"functionName":"SchnorrAccount:constructor","time":469.0229290000025,"oracles":{"getContractInstance":{"times":[8.298992999998518]},"debugLog":{"times":[0.36910100000022794,0.13910200000100303]},"fetchTaggedLogs":{"times":[133.62323600000127]},"loadCapsule":{"times":[0.3880829999998241,0.31620699999984936,0.27681399999892164]},"validateEnqueuedNotesAndEvents":{"times":[6.110097000000678]},"notifyCreatedNullifier":{"times":[0.5471560000005411,0.2940550000002986]},"notifyCreatedNote":{"times":[0.23893999999927473]},"getRandomField":{"times":[0.33457799999996496,0.3378679999987071,0.15148299999964365,0.09950800000115123,0.08690699999897333,0.07377600000108941,0.09174700000039593,0.060804999999163556,0.08172599999852537,0.08280699999886565,0.08355699999992794]},"getIndexedTaggingSecretAsSender":{"times":[72.33780599999955]},"incrementAppTaggingSecretIndexAsSender":{"times":[63.85330700000122]}}},{"functionName":"private_kernel_inner","time":98.58718799999951},{"functionName":"SchnorrAccount:entrypoint","time":300.30067099999906,"oracles":{"debugLog":{"times":[0.3938829999988229,0.1977470000001631,0.25594200000159617]},"fetchTaggedLogs":{"times":[123.5979470000002]},"loadCapsule":{"times":[0.4614500000006956,0.4415069999995467,1.514989000001151]},"validateEnqueuedNotesAndEvents":{"times":[5.953434000000925]},"getNotes":{"times":[6.778153999999631]},"getAuthWitness":{"times":[0.2736330000007001]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6171720000002097]}}},{"functionName":"private_kernel_inner","time":147.21897700000045},{"functionName":"private_kernel_reset","time":180.73358499999995},{"functionName":"private_kernel_tail","time":54.732395000000906}],"unaccounted":251.30423399999745}}
16:45:32 aztec-1 | [16:45:32.139]
INFO:
node Received tx 0x18e395e9e3f4eaf1ae190a6a184e0fd25d962b06c77a6966d80f56d367cb88f6
{"txHash":"0x18e395e9e3f4eaf1ae190a6a184e0fd25d962b06c77a6966d80f56d367cb88f6"}
16:45:32 aztec-1 | [16:45:32.140]
INFO:
pxe:service Sent transaction 0x18e395e9e3f4eaf1ae190a6a184e0fd25d962b06c77a6966d80f56d367cb88f6
16:45:32 aztec-1 | [16:45:32.224]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.019169273999999858s
{"duration":0.019169273999999858,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
16:45:32 aztec-1 | [16:45:32.250]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x05f68f5a5ada1c1ed445e1c903d29295491862ec87460e40141d9f4dc89b3f0c","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750092663,"version":3633326044},"txHashes":["0x18e395e9e3f4eaf1ae190a6a184e0fd25d962b06c77a6966d80f56d367cb88f6"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":52.79899099999966,"publicProcessDuration":19.291723999998794,"rollupCircuitsDuration":46.841167000000496,"txCount":1,"blockNumber":2,"blockTimestamp":1750092663,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:45:32 aztec-1 | [16:45:32.492]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:32 aztec-1 | [16:45:32.507]
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":"0x2533a6cb3eb55998a94c1003a432bcd9d155da86ffb544b338b691d65b1273c8","blocksSynchedTo":26,"currentL1BlockNumber":27,"provenBlockNumber":1,"provenArchive":"0x2533a6cb3eb55998a94c1003a432bcd9d155da86ffb544b338b691d65b1273c8","pendingBlockNumber":2,"pendingArchive":"0x176a4284f5a9da0652ccf56c6c4b554abfda46415b2b400f9fcac80f4ef9545a"}
16:45:32 aztec-1 | [16:45:32.523]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:45:32 aztec-1 | [16:45:32.523]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:51:15.000Z
{"offset":342477,"timeMs":1750092675000}
16:45:32 aztec-1 | [16:45:32.525]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
16:45:32 aztec-1 | [16:45:32.526]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
16:45:32 aztec-1 | [16:45:32.612]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x05f68f5a5ada1c1ed445e1c903d29295491862ec87460e40141d9f4dc89b3f0c","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750092663,"version":3633326044},"archiveRoot":"0x176a4284f5a9da0652ccf56c6c4b554abfda46415b2b400f9fcac80f4ef9545a","archiveNextLeafIndex":3}
16:45:32 aztec-1 | [16:45:32.616]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
16:45:32 aztec-1 | [16:45:32.656]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":16.28599899999972,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750092663,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:45:32 aztec-1 | [16:45:32.753]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092699
16:45:32 aztec-1 | [16:45:32.754]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:51:39.000Z
{"offset":366246,"timeMs":1750092699000}
16:45:32 aztec-1 | [16:45:32.754]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
16:45:32 aztec-1 | [16:45:32.779]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
16:45:32 aztec-1 | [16:45:32.899]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
16:45:34 aztec-1 | [16:45:34.849]
INFO:
pxe:service Proving completed in 1942.9884029999994ms
{"timings":{"total":1942.9884029999994,"sync":24.044895999999426,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":116.10959100000036,"oracles":{"callPrivateFunction":{"times":[379.7569599999988,341.85109999999986]}}},{"functionName":"private_kernel_init","time":99.2724580000031},{"functionName":"SchnorrAccount:constructor","time":351.42677099999855,"oracles":{"getContractInstance":{"times":[4.547465000003285]},"debugLog":{"times":[0.1757259999976668,0.09120800000164309]},"fetchTaggedLogs":{"times":[106.75722099999984]},"loadCapsule":{"times":[0.321457999998529,0.27581300000019837,0.19820700000127545]},"validateEnqueuedNotesAndEvents":{"times":[5.9729650000008405]},"notifyCreatedNullifier":{"times":[0.31825599999865517,0.3674409999985073]},"notifyCreatedNote":{"times":[0.2133380000013858]},"getRandomField":{"times":[0.20190699999875505,0.2428810000019439,0.046343999998498475,0.048294000000169035,0.044014000002789544,0.034812999998393934,0.05481499999950756,0.04943400000047404,0.03995299999951385,0.0313029999997525,0.052724000001035165]},"getIndexedTaggingSecretAsSender":{"times":[50.65425999999934]},"incrementAppTaggingSecretIndexAsSender":{"times":[35.35875500000111]}}},{"functionName":"private_kernel_inner","time":155.32125299999825},{"functionName":"SchnorrAccount:entrypoint","time":304.21392299999934,"oracles":{"debugLog":{"times":[0.20216699999946286,0.14640199999848846,0.28679399999964517]},"fetchTaggedLogs":{"times":[155.06856200000038]},"loadCapsule":{"times":[0.3421890000026906,0.18665599999803817,0.13588200000231154]},"validateEnqueuedNotesAndEvents":{"times":[5.638918000000558]},"getNotes":{"times":[4.196635000000242]},"getAuthWitness":{"times":[0.42058600000018487]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.9470799999980954]}}},{"functionName":"private_kernel_inner","time":146.06921000000148},{"functionName":"private_kernel_reset","time":258.3212359999998},{"functionName":"private_kernel_tail","time":99.07542000000103}],"unaccounted":389.13364499999807}}
16:45:34 aztec-1 | [16:45:34.921]
INFO:
node Received tx 0x0cc36e3c2e800edf31592d6d4dd5d5f17d213cceb50cea16d413c31af097db0c
{"txHash":"0x0cc36e3c2e800edf31592d6d4dd5d5f17d213cceb50cea16d413c31af097db0c"}
16:45:34 aztec-1 | [16:45:34.922]
INFO:
pxe:service Sent transaction 0x0cc36e3c2e800edf31592d6d4dd5d5f17d213cceb50cea16d413c31af097db0c
16:45:35 aztec-1 | [16:45:34.989]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.021925866999998107s
{"duration":0.021925866999998107,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
16:45:35 aztec-1 | [16:45:35.019]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x21e61e529f72acfdf48d36a078341cb510a69de379d5e9660c0f6110d501f3b8","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750092699,"version":3633326044},"txHashes":["0x0cc36e3c2e800edf31592d6d4dd5d5f17d213cceb50cea16d413c31af097db0c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":61.13039700000081,"publicProcessDuration":22.07934000000023,"rollupCircuitsDuration":55.1778430000013,"txCount":1,"blockNumber":3,"blockTimestamp":1750092699,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:45:35 aztec-1 | [16:45:35.273]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:35 aztec-1 | [16:45:35.292]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:45:35 aztec-1 | [16:45:35.292]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:51:51.000Z
{"offset":375708,"timeMs":1750092711000}
16:45:35 aztec-1 | [16:45:35.294]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
16:45:35 aztec-1 | [16:45:35.295]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
16:45:35 aztec-1 | [16:45:35.322]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092735
16:45:35 aztec-1 | [16:45:35.323]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:52:15.000Z
{"offset":399678,"timeMs":1750092735000}
16:45:35 aztec-1 | [16:45:35.323]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
16:45:35 aztec-1 | [16:45:35.389]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x21e61e529f72acfdf48d36a078341cb510a69de379d5e9660c0f6110d501f3b8","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750092699,"version":3633326044},"archiveRoot":"0x253b6057c8b232154b04bfb8a9716026be7bbad3be581973e21cc6ddbb66cef8","archiveNextLeafIndex":4}
16:45:35 aztec-1 | [16:45:35.394]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
16:45:35 aztec-1 | [16:45:35.454]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":19.51400300000023,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750092699,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:45:35 aztec-1 | Initial Accounts:
16:45:35 aztec-1 |
16:45:35 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
16:45:35 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
16:45:35 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
16:45:35 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
16:45:35 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
16:45:35 aztec-1 |
16:45:35 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
16:45:35 aztec-1 |
16:45:35 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
16:45:35 aztec-1 |
16:45:35 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
16:45:35 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
16:45:35 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
16:45:35 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
16:45:35 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
16:45:35 aztec-1 |
16:45:35 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
16:45:35 aztec-1 |
16:45:35 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
16:45:35 aztec-1 |
16:45:35 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
16:45:35 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
16:45:35 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
16:45:35 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
16:45:35 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
16:45:35 aztec-1 |
16:45:35 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
16:45:35 aztec-1 |
16:45:35 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
16:45:35 aztec-1 |
16:45:35 aztec-1 |
16:45:36 aztec-1 | [16:45:36.365]
WARN:
pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata
16:45:36 aztec-1 | [16:45:36.365]
WARN:
pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata
16:45:36 aztec-1 | [16:45:36.370]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
16:45:36 aztec-1 | [16:45:36.405]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
16:45:37 aztec-1 | [16:45:37.338]
INFO:
pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2
16:45:37 aztec-1 | [16:45:37.350]
INFO:
pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164
16:45:39 aztec-1 | [16:45:39.614]
INFO:
pxe:service Proving completed in 2249.654599999998ms
{"timings":{"total":2249.654599999998,"sync":23.074102000002313,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":337.14429399999426,"oracles":{"debugLog":{"times":[0.22177900000315276,0.07556600000316394,0.10814900000332273,0.23677999999927124,0.15286199999900418,0.14359300000069197,0.08626699999877019,0.12844100000074832]},"fetchTaggedLogs":{"times":[102.426360999998]},"loadCapsule":{"times":[0.18582600000081584,0.16641399999934947,0.24103000000104657,0.24253999999928055,0.2010470000022906,0.26892299999963143,2.4532469999976456]},"getSharedSecret":{"times":[4.563834000000497]},"aes128Decrypt":{"times":[0.9835229999989679,0.67114600000059]},"getPublicKeysAndPartialAddress":{"times":[5.020362999999634]},"getKeyValidationRequest":{"times":[4.076602999997704]},"storeCapsule":{"times":[3.186398999998346,2.6662340000002587,3.8065800000003946]},"deleteCapsule":{"times":[4.809805000000779]},"validateEnqueuedNotesAndEvents":{"times":[18.001894999997603]},"getNotes":{"times":[1.8781479999997828]},"getAuthWitness":{"times":[0.14206199999898672]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04534400000193273]},"callPrivateFunction":{"times":[699.3460500000001,153.7321090000005]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3444579999995767]}}},{"functionName":"private_kernel_init","time":78.64819900000293},{"functionName":"ContractClassRegisterer:register","time":685.3217700000023,"oracles":{"loadCapsule":{"times":[2.986581000001024]},"notifyCreatedNullifier":{"times":[0.42780599999969127]},"debugLog":{"times":[0.1107689999989816]},"notifyCreatedContractClassLog":{"times":[8.832274000000325]}}},{"functionName":"private_kernel_inner","time":109.21292099999846},{"functionName":"ContractInstanceDeployer:deploy","time":93.48165900000095,"oracles":{"storeInExecutionCache":{"times":[0.2189890000008745]},"callPrivateFunction":{"times":[51.90173800000048]},"notifyCreatedNullifier":{"times":[0.2887349999982689]},"debugLog":{"times":[0.13935200000196346]}}},{"functionName":"private_kernel_inner","time":101.7560450000019},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":38.397790999999415,"oracles":{}},{"functionName":"private_kernel_inner","time":100.32751400000052},{"functionName":"private_kernel_reset","time":155.19157099999939},{"functionName":"private_kernel_tail","time":73.90830099999948}],"unaccounted":453.1904329999961}}
16:45:39 aztec-1 | [16:45:39.809]
INFO:
node Received tx 0x0abfaaaef3d1dec901681b1dd91126913ecf86c333aa44c2b227c826fe471544
{"txHash":"0x0abfaaaef3d1dec901681b1dd91126913ecf86c333aa44c2b227c826fe471544"}
16:45:39 aztec-1 | [16:45:39.809]
INFO:
pxe:service Sent transaction 0x0abfaaaef3d1dec901681b1dd91126913ecf86c333aa44c2b227c826fe471544
16:45:42 aztec-1 | [16:45:42.142]
INFO:
pxe:service Proving completed in 2526.6546740000013ms
{"timings":{"total":2526.6546740000013,"sync":152.8705259999988,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":557.0710349999936,"oracles":{"debugLog":{"times":[0.2623219999986759,0.24647100000220235,0.08574699999735458,0.21477900000172667,0.09842899999785004,0.09522799999831477,0.09979799999928218,0.1818760000023758]},"fetchTaggedLogs":{"times":[226.4228060000023]},"loadCapsule":{"times":[1.1436160000012023,0.3158159999984491,0.9391189999987546,0.7034390000007988,1.8567259999981616,0.41986499999984517,0.5843290000011621]},"getSharedSecret":{"times":[6.760399000002508]},"aes128Decrypt":{"times":[0.32834700000239536,0.6626350000005914]},"getPublicKeysAndPartialAddress":{"times":[3.732774000000063]},"getKeyValidationRequest":{"times":[5.435147000000143]},"storeCapsule":{"times":[2.11203800000294,77.86455299999943,4.370128000002296]},"deleteCapsule":{"times":[4.341014999998151]},"validateEnqueuedNotesAndEvents":{"times":[15.05754700000034]},"getNotes":{"times":[2.344977000000654]},"getAuthWitness":{"times":[0.28535399999964284]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06746600000042235]},"callPrivateFunction":{"times":[700.8310750000019,115.31685600000128]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06983600000239676]}}},{"functionName":"private_kernel_init","time":46.09055900000021},{"functionName":"ContractClassRegisterer:register","time":685.1692260000018,"oracles":{"loadCapsule":{"times":[1.7899010000000999]},"notifyCreatedNullifier":{"times":[0.4068940000033763]},"debugLog":{"times":[0.14300200000070618]},"notifyCreatedContractClassLog":{"times":[4.223195999999007]}}},{"functionName":"private_kernel_inner","time":117.70789700000023},{"functionName":"ContractInstanceDeployer:deploy","time":58.73014300000068,"oracles":{"storeInExecutionCache":{"times":[0.07128600000214647]},"callPrivateFunction":{"times":[45.99195099999997]},"notifyCreatedNullifier":{"times":[0.21326799999951618]},"debugLog":{"times":[0.09190799999851151]}}},{"functionName":"private_kernel_inner","time":120.9529999999977},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":36.20698700000139,"oracles":{}},{"functionName":"private_kernel_inner","time":121.91858100000172},{"functionName":"private_kernel_reset","time":178.02419299999747},{"functionName":"private_kernel_tail","time":109.88712799999848}],"unaccounted":342.0253990000092}}
16:45:42 aztec-1 | [16:45:42.260]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 2.268738636000002s
{"duration":2.268738636000002,"rate":139483.67386995905,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064}
16:45:42 aztec-1 | [16:45:42.340]
INFO:
node Received tx 0x1ce1116ba264b243ccc71fd0a0d26a323127fac23777570c650e8c47c7c61df2
{"txHash":"0x1ce1116ba264b243ccc71fd0a0d26a323127fac23777570c650e8c47c7c61df2"}
16:45:42 aztec-1 | [16:45:42.340]
INFO:
pxe:service Sent transaction 0x1ce1116ba264b243ccc71fd0a0d26a323127fac23777570c650e8c47c7c61df2
16:45:42 aztec-1 | [16:45:42.344]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 133498.93334372502 mana/s
{"blockHash":"0x1bd2028624319661159ba7b9b26737d85fb01f6dee13a4c137d2dd00996e8a15","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750092735,"version":3633326044},"txHashes":["0x0abfaaaef3d1dec901681b1dd91126913ecf86c333aa44c2b227c826fe471544"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2370.368899000001,"publicProcessDuration":2268.8754579999986,"rollupCircuitsDuration":2360.007636999999,"txCount":1,"blockNumber":4,"blockTimestamp":1750092735,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
16:45:42 aztec-1 | [16:45:42.619]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
16:45:42 aztec-1 | [16:45:42.622]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
16:45:42 aztec-1 | [16:45:42.625]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092771
16:45:42 aztec-1 | [16:45:42.625]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:52:51.000Z
{"offset":428375,"timeMs":1750092771000}
16:45:42 aztec-1 | [16:45:42.626]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
16:45:42 aztec-1 | [16:45:42.627]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:42 aztec-1 | [16:45:42.633]
WARN:
archiver Failed to reach L2 block 4 at 31 (latest is 3). Rolling back last synched L1 block number to 30.
{"latestLocalL2BlockNumber":3,"latestLocalL2BlockArchive":"0x253b6057c8b232154b04bfb8a9716026be7bbad3be581973e21cc6ddbb66cef8","blocksSynchedTo":30,"currentL1BlockNumber":31,"provenBlockNumber":3,"provenArchive":"0x253b6057c8b232154b04bfb8a9716026be7bbad3be581973e21cc6ddbb66cef8","pendingBlockNumber":4,"pendingArchive":"0x1f14718f871fb25033848b40bc4b12387e919565dba7e813bd3fb227acced087"}
16:45:42 aztec-1 | [16:45:42.785]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x1bd2028624319661159ba7b9b26737d85fb01f6dee13a4c137d2dd00996e8a15","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750092735,"version":3633326044},"archiveRoot":"0x1f14718f871fb25033848b40bc4b12387e919565dba7e813bd3fb227acced087","archiveNextLeafIndex":5}
16:45:42 aztec-1 | [16:45:42.790]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
16:45:42 aztec-1 | [16:45:42.855]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":13.815833000000566,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750092735,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
16:45:43 aztec-1 | [16:45:43.112]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1961500390000001s
{"duration":0.1961500390000001,"rate":202860.01574539568,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768}
16:45:43 aztec-1 | [16:45:43.141]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 170843.9062974234 mana/s
{"blockHash":"0x0a2993678ca4c1c0474cdf420dfeb1e4aa9d4421969dd53590c38ca57fde0179","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750092771,"version":3633326044},"txHashes":["0x1ce1116ba264b243ccc71fd0a0d26a323127fac23777570c650e8c47c7c61df2"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":232.88778100000127,"publicProcessDuration":196.4463340000002,"rollupCircuitsDuration":227.95490600000267,"txCount":1,"blockNumber":5,"blockTimestamp":1750092771,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
16:45:43 aztec-1 | [16:45:43.476]
INFO:
aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed.
16:45:43 aztec-1 | [16:45:43.611]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:43 aztec-1 | [16:45:43.729]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:45:43 aztec-1 | [16:45:43.730]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:53:03.000Z
{"offset":439270,"timeMs":1750092783000}
16:45:43 aztec-1 | [16:45:43.744]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
16:45:43 aztec-1 | [16:45:43.748]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x0a2993678ca4c1c0474cdf420dfeb1e4aa9d4421969dd53590c38ca57fde0179","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750092771,"version":3633326044},"archiveRoot":"0x2c70bf6059fbfc1eb31239d0bf773a229be115aab343850efb4958295963c0d6","archiveNextLeafIndex":6}
16:45:43 aztec-1 | [16:45:43.749]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
16:45:43 aztec-1 | [16:45:43.754]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092807
16:45:43 aztec-1 | [16:45:43.754]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:53:27.000Z
{"offset":463246,"timeMs":1750092807000}
16:45:43 aztec-1 | [16:45:43.754]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
16:45:43 aztec-1 | [16:45:43.808]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":13.960655000002589,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750092771,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
16:45:43 aztec-1 | [16:45:43.819]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
16:45:44 aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
16:45:44 aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
16:45:44 aztec-1 | [16:45:44.549]
INFO:
aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed.
16:45:44 aztec-1 | [16:45:44.579]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
16:45:44 aztec-1 | [16:45:44.582]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
16:45:44 aztec-1 | [16:45:44.745]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
16:45:47 aztec-1 | [16:45:47.285]
INFO:
pxe:service Proving completed in 2525.0875210000013ms
{"timings":{"total":2525.0875210000013,"sync":24.47739999999976,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":88.69709500000317,"oracles":{"callPrivateFunction":{"times":[862.7505829999973,151.0633540000017,75.5558689999998]}}},{"functionName":"private_kernel_init","time":74.09231599999839},{"functionName":"ContractClassRegisterer:register","time":849.1741999999977,"oracles":{"loadCapsule":{"times":[2.541743999998289]},"notifyCreatedNullifier":{"times":[0.41529499999887776]},"debugLog":{"times":[0.16914399999950547]},"notifyCreatedContractClassLog":{"times":[8.373554999998305]}}},{"functionName":"private_kernel_inner","time":139.08009499999753},{"functionName":"ContractInstanceDeployer:deploy","time":94.5594300000048,"oracles":{"storeInExecutionCache":{"times":[0.0770459999985178]},"callPrivateFunction":{"times":[50.05698300000222]},"notifyCreatedNullifier":{"times":[0.21703799999886542]},"debugLog":{"times":[0.12479000000166707]}}},{"functionName":"private_kernel_inner","time":116.91282899999715},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":37.276295999996364,"oracles":{}},{"functionName":"private_kernel_inner","time":151.58843799999886},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":61.470862999998644,"oracles":{"debugLog":{"times":[0.15758399999685935]}}},{"functionName":"private_kernel_inner","time":142.84074200000032},{"functionName":"private_kernel_reset","time":227.23005399999965},{"functionName":"private_kernel_tail","time":78.90718100000231}],"unaccounted":438.7805820000067}}
16:45:47 aztec-1 | [16:45:47.393]
INFO:
node Received tx 0x2df153a5b93ba9b5dc0fc8b9bedfb5dec059f304240c63b680d6e305066ad15a
{"txHash":"0x2df153a5b93ba9b5dc0fc8b9bedfb5dec059f304240c63b680d6e305066ad15a"}
16:45:47 aztec-1 | [16:45:47.393]
INFO:
pxe:service Sent transaction 0x2df153a5b93ba9b5dc0fc8b9bedfb5dec059f304240c63b680d6e305066ad15a
16:45:47 aztec-1 | [16:45:47.506]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.035534870999999836s
{"duration":0.035534870999999836,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
16:45:47 aztec-1 | [16:45:47.536]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x0ba8783b2ca42be2e86781412d7e59c13fe2f43fda3a80216598bc61834fc0e5","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750092807,"version":3633326044},"txHashes":["0x2df153a5b93ba9b5dc0fc8b9bedfb5dec059f304240c63b680d6e305066ad15a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":73.00313400000232,"publicProcessDuration":35.68567299999995,"rollupCircuitsDuration":68.20508999999947,"txCount":1,"blockNumber":6,"blockTimestamp":1750092807,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:45:47 aztec-1 | [16:45:47.807]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
16:45:47 aztec-1 | [16:45:47.814]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
16:45:47 aztec-1 | [16:45:47.816]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:47 aztec-1 | [16:45:47.817]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092843
16:45:47 aztec-1 | [16:45:47.817]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:54:03.000Z
{"offset":495183,"timeMs":1750092843000}
16:45:47 aztec-1 | [16:45:47.817]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
16:45:47 aztec-1 | [16:45:47.916]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x0ba8783b2ca42be2e86781412d7e59c13fe2f43fda3a80216598bc61834fc0e5","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750092807,"version":3633326044},"archiveRoot":"0x15c9d28c47791d755aa12f0546908834712db1504a48e12a0b4eb481a8d8de19","archiveNextLeafIndex":7}
16:45:47 aztec-1 | [16:45:47.922]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
16:45:47 aztec-1 | [16:45:47.968]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":13.55710099999851,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750092807,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:45:48 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
16:45:48 aztec-1 | [16:45:48.416]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
16:45:48 aztec-1 | [16:45:48.422]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x27f24d2a1e99e49d4a27746a8374185b307a07325d0d743c1df56a03e39788d2","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
16:45:56 playground-1 | \
16:45:56 playground-1 |
Running 1
test using 1
worker
16:45:56 playground-1 |
16:45:58 playground-1 |
✓ 1 [firefox] › browser.spec.ts:3:1 › test
(12.3s)
16:46:12 playground-1 |
1 passed (17.8s)
16:46:12 playground-1 | \
npm notice
16:46:12 playground-1 |
npm notice New
major version of npm available!
10.9.2 ->
11.4.2
16:46:12 playground-1 |
npm notice Changelog:
https://github.com/npm/cli/releases/tag/v11.4.2
16:46:12 playground-1 |
npm notice To update run:
npm install -g npm@11.4.2
16:46:12 playground-1 |
npm notice
16:46:12 playground-1 | \
16:46:13
playground-1 exited with code 0
16:46:13 Aborting on container exit...
16:46:13 Container playground-firefox-playground-1 Stopping
16:46:13 Container playground-firefox-playground-1 Stopped
16:46:13 Container playground-firefox-aztec-1 Stopping
16:46:14 Container playground-firefox-aztec-1 Stopped
16:46:14 Container playground-firefox-ethereum-1 Stopping
16:46:16 Container playground-firefox-ethereum-1 Stopped