Parent Log:
http://ci.aztec-labs.com/29098e34bc98632e
Command: 528125ce821934c7 playground/scripts/run_test.sh firefox
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/1e338a3fb2e2077f1feaee8b86c42644ff8a5352
Env: REF_NAME=gh-readonly-queue/next/pr-15075-fa4d5ef48c8de52059b5658bbd42e4514386f7db CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Mon Jun 16 16:45:29 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15075_amd64_x2-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_23123200780498f7_next
16:45:29 Network playground-firefox_default Creating
16:45:29 Network playground-firefox_default Created
16:45:29 Container playground-firefox-ethereum-1 Creating
16:45:30 Container playground-firefox-ethereum-1 Created
16:45:30 Container playground-firefox-aztec-1 Creating
16:45:31 Container playground-firefox-aztec-1 Created
16:45:31 Container playground-firefox-playground-1 Creating
16:45:31 Container playground-firefox-playground-1 Created
16:45:31 Attaching to aztec-1, ethereum-1, playground-1
16:45:35 aztec-1 |
16:45:35 aztec-1 | _
16:45:35 aztec-1 | /\ | |
16:45:35 aztec-1 | / \ ___| |_ ___ ___
16:45:35 aztec-1 | / /\ \ |_ / __/ _ \/ __|
16:45:35 aztec-1 | / ____ \ / /| || __/ (__
16:45:35 aztec-1 | /_/___ \_\/___|\__\___|\___|
16:45:35 aztec-1 |
16:45:35 aztec-1 |
https://github.com/AztecProtocol
16:45:35 aztec-1 |
16:45:35 aztec-1 |
16:45:35 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
16:45:36 aztec-1 | Setting up test accounts
16:45:37 aztec-1 | [16:45:36.596]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-Z6rZ1q/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
16:45:37 aztec-1 | [16:45:36.874]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
16:45:37 aztec-1 | [16:45:36.878]
WARN:
sandbox Set block interval to 12
16:45:37 aztec-1 | [16:45:37.055]
INFO:
sandbox Waiting for 7 transactions to be mined...
16:45:37 aztec-1 | [16:45:37.077]
INFO:
sandbox All transactions mined successfully
16:45:37 aztec-1 | [16:45:37.160]
INFO:
sandbox Waiting for 9 transactions to be mined...
16:45:37 aztec-1 | [16:45:37.174]
INFO:
sandbox All transactions mined successfully
16:45:37 aztec-1 | [16:45:37.310]
INFO:
sandbox Waiting for 11 transactions to be mined...
16:45:37 aztec-1 | [16:45:37.332]
INFO:
sandbox All transactions mined successfully
16:45:37 aztec-1 | [16:45:37.386]
INFO:
sandbox Waiting for 12 transactions to be mined...
16:45:37 aztec-1 | [16:45:37.409]
INFO:
sandbox All transactions mined successfully
16:45:37 aztec-1 | [16:45:37.414]
INFO:
sandbox Waiting for 12 transactions to be mined...
16:45:37 aztec-1 | [16:45:37.434]
INFO:
sandbox All transactions mined successfully
16:45:37 aztec-1 | [16:45:37.447]
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:37 aztec-1 | [16:45:37.447]
INFO:
sandbox Handing over to governance
16:45:37 aztec-1 | [16:45:37.454]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
16:45:37 aztec-1 | [16:45:37.455]
INFO:
telemetry:client Using NoopTelemetryClient
16:45:37 aztec-1 | [16:45:37.455]
INFO:
blob-sink:client Creating local blob sink client.
16:45:37 aztec-1 | [16:45:37.459]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:45:37 aztec-1 | [16:45:37.459]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:50:19.000Z
{"offset":281541,"timeMs":1750092619000}
16:45:37 aztec-1 | [16:45:37.479]
INFO:
archiver:lmdb Starting data store with maxReaders 16
16:45:38 aztec-1 | [16:45:37.838]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x41249ac8d8f04809937c025bdfcbf07568c244e361faef9689c8cfa3194ebfe4
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x823e6e99f2bc986c12a42a03407b440bf11a348e4326d9a80705bdf9c0b28a98","l1BlockNumber":20}}
16:45:38 aztec-1 | [16:45:37.863]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x41249ac8d8f04809937c025bdfcbf07568c244e361faef9689c8cfa3194ebfe4","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
16:45:38 aztec-1 | [16:45:37.872]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-JfMBah/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
16:45:38 aztec-1 | [16:45:38.126]
INFO:
world_state Created world state synchroniser with block history of 64
16:45:38 aztec-1 | [16:45:38.127]
WARN:
node Aztec node is accepting fake proofs
16:45:38 aztec-1 | [16:45:38.136]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
16:45:38 aztec-1 | [16:45:38.155]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
16:45:38 aztec-1 | [16:45:38.173]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
16:45:38 aztec-1 | [16:45:38.188]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
16:45:38 aztec-1 | [16:45:38.193]
INFO:
world_state Started world state synchronizer from block 1
16:45:38 aztec-1 | [16:45:38.196]
INFO:
p2p Starting p2p client from block 0 with empty mempools
16:45:38 aztec-1 | [16:45:38.474]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
16:45:38 aztec-1 | [16:45:38.539]
INFO:
slasher Starting Slasher client...
16:45:38 aztec-1 | [16:45:38.550]
INFO:
sequencer-client Deploying forwarder contract
16:45:38 aztec-1 | [16:45:38.571]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
16:45:38 aztec-1 | [16:45:38.577]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
16:45:38 aztec-1 | [16:45:38.578]
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:38 aztec-1 | [16:45:38.580]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
16:45:38 aztec-1 | [16:45:38.580]
INFO:
node Aztec Node version: 0.87.6
16:45:38 aztec-1 | [16:45:38.581]
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:38 aztec-1 | [16:45:38.586]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
16:45:38 aztec-1 | [16:45:38.594]
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":1750092620,"syncedToL1Ts":1750092619,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750092607,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750092643},"newBlockNumber":1,"expectedSlot":1}
16:45:38 aztec-1 | [16:45:38.658]
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":1750092620,"syncedToL1Ts":1750092619,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750092607,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750092643},"newBlockNumber":1,"expectedSlot":1}
16:45:38 aztec-1 | [16:45:38.825]
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":1750092620,"syncedToL1Ts":1750092631,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750092607,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750092643},"newBlockNumber":1,"expectedSlot":1}
16:45:38 aztec-1 | [16:45:38.825]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:45:38 aztec-1 | [16:45:38.825]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:50:31.000Z
{"offset":292175,"timeMs":1750092631000}
16:45:38 aztec-1 | Setting up funded test accounts...
16:45:39 aztec-1 | [16:45:38.946]
INFO:
pxe:service Started PXE connected to chain 31337 version 3633326044
16:45:39 aztec-1 | [16:45:39.021]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
16:45:39 aztec-1 | [16:45:39.082]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
16:45:39 aztec-1 | [16:45:39.086]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
16:45:39 aztec-1 | [16:45:39.239]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
16:45:42 aztec-1 | [16:45:42.025]
INFO:
pxe:service Proving completed in 2743.7079679999997ms
{"timings":{"total":2743.7079679999997,"sync":8.315795000000435,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":169.56616399999893,"oracles":{"callPrivateFunction":{"times":[889.8789539999998,393.04277,223.02790099999947]}}},{"functionName":"private_kernel_init","time":121.80294299999878},{"functionName":"ContractClassRegisterer:register","time":866.813795,"oracles":{"loadCapsule":{"times":[8.46035699999993]},"notifyCreatedNullifier":{"times":[21.687490000000253]},"debugLog":{"times":[1.0133539999997083]},"notifyCreatedContractClassLog":{"times":[7.7289670000000115]}}},{"functionName":"private_kernel_inner","time":130.89054800000122},{"functionName":"SchnorrAccount:constructor","time":365.318436999999,"oracles":{"getContractInstance":{"times":[5.03563000000031]},"debugLog":{"times":[0.25206400000024587,0.13646199999857345]},"fetchTaggedLogs":{"times":[79.54121900000064]},"loadCapsule":{"times":[0.49218699999983073,0.3306250000005093,0.23817300000155228]},"validateEnqueuedNotesAndEvents":{"times":[7.419302000000243]},"notifyCreatedNullifier":{"times":[0.3320239999993646,0.2652330000000802]},"notifyCreatedNote":{"times":[0.7795900000000984]},"getRandomField":{"times":[0.3340749999988475,0.2475640000011481,0.050139999999373686,0.06546100000014121,0.19620300000133284,0.06222100000013597,0.04905999999937194,0.04600100000061502,0.04693100000076811,0.08669100000042818,0.05043099999966216]},"getIndexedTaggingSecretAsSender":{"times":[51.635802999999214]},"incrementAppTaggingSecretIndexAsSender":{"times":[27.246076000001267]}}},{"functionName":"private_kernel_inner","time":112.87723000000005},{"functionName":"SchnorrAccount:entrypoint","time":196.84717000000092,"oracles":{"debugLog":{"times":[0.18618200000128127,0.0912609999995766,0.46161599999868486]},"fetchTaggedLogs":{"times":[57.794058999999834]},"loadCapsule":{"times":[1.1859559999993508,0.8902920000000449,0.6895800000002055]},"validateEnqueuedNotesAndEvents":{"times":[8.011121000001367]},"getNotes":{"times":[12.012876000000688]},"getAuthWitness":{"times":[0.3755349999992177]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0437540000002627]}}},{"functionName":"private_kernel_inner","time":98.01174399999945},{"functionName":"private_kernel_reset","time":158.90386500000022},{"functionName":"private_kernel_tail","time":60.88720099999955}],"unaccounted":453.47307600000113}}
16:45:42 aztec-1 | [16:45:42.122]
INFO:
node Received tx 0x2672677f133c3023eb16320e414df44883ec6bf18dee6698e2a397a43765aef1
{"txHash":"0x2672677f133c3023eb16320e414df44883ec6bf18dee6698e2a397a43765aef1"}
16:45:42 aztec-1 | [16:45:42.122]
INFO:
pxe:service Sent transaction 0x2672677f133c3023eb16320e414df44883ec6bf18dee6698e2a397a43765aef1
16:45:42 aztec-1 | [16:45:42.223]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.045511078999999885s
{"duration":0.045511078999999885,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
16:45:42 aztec-1 | [16:45:42.258]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x0bcd32887dd2438cc9c6174f3a4aed843b2311ee9cfa9c09810f8c7e342604a1","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750092643,"version":3633326044},"txHashes":["0x2672677f133c3023eb16320e414df44883ec6bf18dee6698e2a397a43765aef1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":89.45257599999968,"publicProcessDuration":46.137048000000505,"rollupCircuitsDuration":82.60751100000016,"txCount":1,"blockNumber":1,"blockTimestamp":1750092643,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:45:45 aztec-1 | [16:45:44.750]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
16:45:45 aztec-1 | [16:45:44.754]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
16:45:45 aztec-1 | [16:45:44.766]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:45 aztec-1 | [16:45:44.771]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092679
16:45:45 aztec-1 | [16:45:44.771]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:51:19.000Z
{"offset":334229,"timeMs":1750092679000}
16:45:45 aztec-1 | [16:45:44.771]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
16:45:45 aztec-1 | [16:45:44.843]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x0bcd32887dd2438cc9c6174f3a4aed843b2311ee9cfa9c09810f8c7e342604a1","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750092643,"version":3633326044},"archiveRoot":"0x2e24c75d47ec1a41b87520c54c7619ae028fffabe6f57a0a8fb8f596f6df0862","archiveNextLeafIndex":2}
16:45:45 aztec-1 | [16:45:44.850]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
16:45:45 aztec-1 | [16:45:44.931]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":49.177019000000655,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750092643,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:45:45 aztec-1 | [16:45:45.000]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
16:45:45 aztec-1 | [16:45:45.144]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
16:45:47 aztec-1 | [16:45:46.725]
INFO:
pxe:service Proving completed in 1549.1109029999989ms
{"timings":{"total":1549.1109029999989,"sync":24.59523000000081,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":107.05505800000356,"oracles":{"callPrivateFunction":{"times":[410.3922700000003,258.71631400000115]}}},{"functionName":"private_kernel_init","time":62.734967000000324},{"functionName":"SchnorrAccount:constructor","time":375.8904939999993,"oracles":{"getContractInstance":{"times":[10.701508000000103]},"debugLog":{"times":[0.16040199999952165,0.0939010000001872]},"fetchTaggedLogs":{"times":[96.43044199999895]},"loadCapsule":{"times":[0.6451489999999467,0.5927690000007715,2.831358999999793]},"validateEnqueuedNotesAndEvents":{"times":[17.853367000001526]},"notifyCreatedNullifier":{"times":[0.2578430000012304,0.18917200000032608]},"notifyCreatedNote":{"times":[0.14466199999878881]},"getRandomField":{"times":[0.17232199999853037,0.24375299999883282,0.09902099999999336,0.04350999999951455,0.038620999999693595,0.03290999999990163,0.036371000000144704,0.031161000000793138,0.03296099999897706,0.04281000000082713,0.03825000000142609]},"getIndexedTaggingSecretAsSender":{"times":[52.14871999999923]},"incrementAppTaggingSecretIndexAsSender":{"times":[35.46940100000029]}}},{"functionName":"private_kernel_inner","time":120.1235400000005},{"functionName":"SchnorrAccount:entrypoint","time":234.3579579999987,"oracles":{"debugLog":{"times":[0.4302160000006552,0.16232200000013108,0.09184199999981502]},"fetchTaggedLogs":{"times":[90.147296000001]},"loadCapsule":{"times":[0.8275320000011561,3.090422999999646,0.3131539999994857]},"validateEnqueuedNotesAndEvents":{"times":[12.861828000000969]},"getNotes":{"times":[1.4869799999996758]},"getAuthWitness":{"times":[0.12727199999972072]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.3976149999998597]}}},{"functionName":"private_kernel_inner","time":127.36675900000046},{"functionName":"private_kernel_reset","time":163.9091239999998},{"functionName":"private_kernel_tail","time":59.460871999999654}],"unaccounted":273.6169009999958}}
16:45:47 aztec-1 | [16:45:46.764]
INFO:
node Received tx 0x27530fbe17b52f111bf07e428ce36c8f374a25153eed43344f8d51f3da6a923b
{"txHash":"0x27530fbe17b52f111bf07e428ce36c8f374a25153eed43344f8d51f3da6a923b"}
16:45:47 aztec-1 | [16:45:46.764]
INFO:
pxe:service Sent transaction 0x27530fbe17b52f111bf07e428ce36c8f374a25153eed43344f8d51f3da6a923b
16:45:47 aztec-1 | [16:45:46.824]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01566517600000043s
{"duration":0.01566517600000043,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
16:45:47 aztec-1 | [16:45:46.843]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x130678c258636a7c43fe3d1e231149dae17a0f076cd1178f9b493589271a1e25","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750092679,"version":3633326044},"txHashes":["0x27530fbe17b52f111bf07e428ce36c8f374a25153eed43344f8d51f3da6a923b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":43.198677000000316,"publicProcessDuration":15.766417999999248,"rollupCircuitsDuration":37.50173799999902,"txCount":1,"blockNumber":2,"blockTimestamp":1750092679,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:45:47 aztec-1 | [16:45:46.996]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
16:45:47 aztec-1 | [16:45:46.999]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
16:45:47 aztec-1 | [16:45:47.003]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092715
16:45:47 aztec-1 | [16:45:47.003]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:51:55.000Z
{"offset":367997,"timeMs":1750092715000}
16:45:47 aztec-1 | [16:45:47.003]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
16:45:47 aztec-1 | [16:45:47.004]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:47 aztec-1 | [16:45:47.101]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x130678c258636a7c43fe3d1e231149dae17a0f076cd1178f9b493589271a1e25","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750092679,"version":3633326044},"archiveRoot":"0x27cfd36813af2bcff586fe537e84ee4921c268dba36268edaf0aebbb0dde8521","archiveNextLeafIndex":3}
16:45:47 aztec-1 | [16:45:47.107]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
16:45:47 aztec-1 | [16:45:47.131]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":14.53233999999975,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750092679,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:45:47 aztec-1 | [16:45:47.285]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
16:45:47 aztec-1 | [16:45:47.404]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
16:45:49 aztec-1 | [16:45:48.946]
INFO:
pxe:service Proving completed in 1531.8973849999984ms
{"timings":{"total":1531.8973849999984,"sync":27.306407000000036,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":75.22384000000056,"oracles":{"callPrivateFunction":{"times":[305.5211709999985,243.67543699999987]}}},{"functionName":"private_kernel_init","time":81.15432099999998},{"functionName":"SchnorrAccount:constructor","time":286.17689299999984,"oracles":{"getContractInstance":{"times":[2.4520940000002156]},"debugLog":{"times":[0.11614099999860628,0.06556100000125298]},"fetchTaggedLogs":{"times":[89.22442299999966]},"loadCapsule":{"times":[0.15536299999985204,0.1398619999999937,0.16164299999945797]},"validateEnqueuedNotesAndEvents":{"times":[7.522194000001036]},"notifyCreatedNullifier":{"times":[0.2299330000005284,0.12240100000053644]},"notifyCreatedNote":{"times":[0.11196199999903911]},"getRandomField":{"times":[0.16912199999933364,0.09985099999903468,0.055750999999872874,0.03814000000056694,0.03265099999953236,0.043211000000155764,0.046689999999216525,0.027801000000181375,0.030689999999594875,0.026120000000446453,0.026810999999725027]},"getIndexedTaggingSecretAsSender":{"times":[45.81375300000036]},"incrementAppTaggingSecretIndexAsSender":{"times":[26.6075579999997]}}},{"functionName":"private_kernel_inner","time":149.57958599999984},{"functionName":"SchnorrAccount:entrypoint","time":221.4732499999991,"oracles":{"debugLog":{"times":[0.19981299999926705,0.057280000000901055,0.26406300000053307]},"fetchTaggedLogs":{"times":[105.97924400000011]},"loadCapsule":{"times":[0.16274300000077346,0.18081299999903422,0.13046199999917008]},"validateEnqueuedNotesAndEvents":{"times":[5.620457999999417]},"getNotes":{"times":[1.5826130000004923]},"getAuthWitness":{"times":[0.1885629999997036]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6174889999983861]}}},{"functionName":"private_kernel_inner","time":96.95530900000085},{"functionName":"private_kernel_reset","time":220.9796529999985},{"functionName":"private_kernel_tail","time":91.36510199999975}],"unaccounted":281.68302399999993}}
16:45:49 aztec-1 | [16:45:49.020]
INFO:
node Received tx 0x150cc666a346e222f16d4a6952ad1411c3215c21dce5729c5d0217d196b776dc
{"txHash":"0x150cc666a346e222f16d4a6952ad1411c3215c21dce5729c5d0217d196b776dc"}
16:45:49 aztec-1 | [16:45:49.020]
INFO:
pxe:service Sent transaction 0x150cc666a346e222f16d4a6952ad1411c3215c21dce5729c5d0217d196b776dc
16:45:49 aztec-1 | [16:45:49.097]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.023609126000003016s
{"duration":0.023609126000003016,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
16:45:49 aztec-1 | [16:45:49.130]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x1ae5542270db298b26b1726679143ba280fa24f770f5256762d1fcaac6778de8","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750092715,"version":3633326044},"txHashes":["0x150cc666a346e222f16d4a6952ad1411c3215c21dce5729c5d0217d196b776dc"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":63.15885200000048,"publicProcessDuration":23.73588799999925,"rollupCircuitsDuration":57.766108999996504,"txCount":1,"blockNumber":3,"blockTimestamp":1750092715,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:45:49 aztec-1 | [16:45:49.368]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:49 aztec-1 | [16:45:49.374]
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":"0x27cfd36813af2bcff586fe537e84ee4921c268dba36268edaf0aebbb0dde8521","blocksSynchedTo":28,"currentL1BlockNumber":29,"provenBlockNumber":2,"provenArchive":"0x27cfd36813af2bcff586fe537e84ee4921c268dba36268edaf0aebbb0dde8521","pendingBlockNumber":3,"pendingArchive":"0x255166ad3a6f465b2cbe88b5b0c43ca35de78f8972391383e20b3e27c1891d7a"}
16:45:49 aztec-1 | [16:45:49.391]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:45:49 aztec-1 | [16:45:49.391]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:52:07.000Z
{"offset":377609,"timeMs":1750092727000}
16:45:49 aztec-1 | [16:45:49.395]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
16:45:49 aztec-1 | [16:45:49.396]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
16:45:49 aztec-1 | [16:45:49.420]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092751
16:45:49 aztec-1 | [16:45:49.420]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:52:31.000Z
{"offset":401580,"timeMs":1750092751000}
16:45:49 aztec-1 | [16:45:49.420]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
16:45:49 aztec-1 | [16:45:49.469]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x1ae5542270db298b26b1726679143ba280fa24f770f5256762d1fcaac6778de8","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750092715,"version":3633326044},"archiveRoot":"0x255166ad3a6f465b2cbe88b5b0c43ca35de78f8972391383e20b3e27c1891d7a","archiveNextLeafIndex":4}
16:45:49 aztec-1 | [16:45:49.474]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
16:45:49 aztec-1 | [16:45:49.507]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":19.263645999999426,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750092715,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
16:45:49 aztec-1 | Initial Accounts:
16:45:49 aztec-1 |
16:45:49 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
16:45:49 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
16:45:49 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
16:45:49 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
16:45:49 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
16:45:49 aztec-1 |
16:45:49 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
16:45:49 aztec-1 |
16:45:49 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
16:45:49 aztec-1 |
16:45:49 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
16:45:49 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
16:45:49 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
16:45:49 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
16:45:49 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
16:45:49 aztec-1 |
16:45:49 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
16:45:49 aztec-1 |
16:45:49 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
16:45:49 aztec-1 |
16:45:49 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
16:45:49 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
16:45:49 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
16:45:49 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
16:45:49 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
16:45:49 aztec-1 |
16:45:49 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
16:45:49 aztec-1 |
16:45:49 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
16:45:49 aztec-1 |
16:45:49 aztec-1 |
16:45:50 aztec-1 | [16:45:50.227]
WARN:
pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata
16:45:50 aztec-1 | [16:45:50.227]
WARN:
pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata
16:45:50 aztec-1 | [16:45:50.231]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
16:45:50 aztec-1 | [16:45:50.252]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
16:45:51 aztec-1 | [16:45:50.958]
INFO:
pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164
16:45:51 aztec-1 | [16:45:50.974]
INFO:
pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2
16:45:54 aztec-1 | [16:45:53.528]
INFO:
pxe:service Proving completed in 2536.2650009999998ms
{"timings":{"total":2536.2650009999998,"sync":24.710660999997344,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":382.940711999996,"oracles":{"debugLog":{"times":[0.21600300000136485,0.11720100000093225,0.12027200000011362,0.24318299999868032,0.13123199999972712,0.15321299999777693,0.13422200000059092,0.2655930000000808]},"fetchTaggedLogs":{"times":[135.39822099999947]},"loadCapsule":{"times":[0.23384400000213645,0.3715249999986554,0.5852180000001681,0.25876399999833666,0.24390299999868148,0.45109599999705097,1.668533000000025]},"getSharedSecret":{"times":[6.557881000000634]},"aes128Decrypt":{"times":[1.1330649999981688,0.8925520000011602]},"getPublicKeysAndPartialAddress":{"times":[2.0162680000030377]},"getKeyValidationRequest":{"times":[2.564385999998194]},"storeCapsule":{"times":[3.0664429999997083,2.558085000000574,2.588525999999547]},"deleteCapsule":{"times":[3.0019820000015898]},"validateEnqueuedNotesAndEvents":{"times":[26.694359000000986]},"getNotes":{"times":[2.4167129999987083]},"getAuthWitness":{"times":[0.2251730000025418]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07510099999853992]},"callPrivateFunction":{"times":[785.3206399999981,153.32539799999722]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3824650000024121]}}},{"functionName":"private_kernel_init","time":69.72465300000113},{"functionName":"ContractClassRegisterer:register","time":771.7966730000007,"oracles":{"loadCapsule":{"times":[3.6974719999998342]},"notifyCreatedNullifier":{"times":[0.3520349999998871]},"debugLog":{"times":[0.11974200000258861]},"notifyCreatedContractClassLog":{"times":[8.024320000000444]}}},{"functionName":"private_kernel_inner","time":128.38061399999788},{"functionName":"ContractInstanceDeployer:deploy","time":86.98003100000642,"oracles":{"storeInExecutionCache":{"times":[0.32084499999837135]},"callPrivateFunction":{"times":[62.75158700000247]},"notifyCreatedNullifier":{"times":[0.3307139999997162]},"debugLog":{"times":[0.16216200000053504]}}},{"functionName":"private_kernel_inner","time":146.1608500000002},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":45.15950399999565,"oracles":{}},{"functionName":"private_kernel_inner","time":140.4533709999996},{"functionName":"private_kernel_reset","time":207.0202109999991},{"functionName":"private_kernel_tail","time":91.93476999999984}],"unaccounted":441.00295100000585}}
16:45:54 aztec-1 | [16:45:53.641]
INFO:
node Received tx 0x0d38a0cacaf56ac77e8b965cd9b57bd7fc652eb6ee821395070af5c1d10428d8
{"txHash":"0x0d38a0cacaf56ac77e8b965cd9b57bd7fc652eb6ee821395070af5c1d10428d8"}
16:45:54 aztec-1 | [16:45:53.641]
INFO:
pxe:service Sent transaction 0x0d38a0cacaf56ac77e8b965cd9b57bd7fc652eb6ee821395070af5c1d10428d8
16:45:55 aztec-1 | [16:45:54.903]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.1169115820000006s
{"duration":1.1169115820000006,"rate":35625.917611802484,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768}
16:45:55 aztec-1 | [16:45:55.039]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 31371.630901998302 mana/s
{"blockHash":"0x063978ee8c276979df448f78ebd2415e66a25da3f6e954550b1200cec5dddfa3","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750092751,"version":3633326044},"txHashes":["0x0d38a0cacaf56ac77e8b965cd9b57bd7fc652eb6ee821395070af5c1d10428d8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1268.3178340000013,"publicProcessDuration":1117.057453999998,"rollupCircuitsDuration":1257.8619399999989,"txCount":1,"blockNumber":4,"blockTimestamp":1750092751,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
16:45:56 aztec-1 | [16:45:55.790]
INFO:
pxe:service Proving completed in 2261.122335ms
{"timings":{"total":2261.122335,"sync":94.90689100000236,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":362.471890000008,"oracles":{"debugLog":{"times":[0.25519400000121095,0.08327199999985169,0.0932119999997667,0.12136200000168174,0.0729410000021744,0.0701310000004014,0.08465200000136974,0.19127300000036485]},"fetchTaggedLogs":{"times":[143.68348500000138]},"loadCapsule":{"times":[0.16022200000224984,0.20692300000155228,11.569749999998749,0.22230299999864656,1.079584999999497,1.0003739999992831,0.3666849999972328]},"getSharedSecret":{"times":[4.552392000001419]},"aes128Decrypt":{"times":[0.17656299999725888,0.4273960000027728]},"getPublicKeysAndPartialAddress":{"times":[2.422403000000486]},"getKeyValidationRequest":{"times":[1.8476059999993595]},"storeCapsule":{"times":[2.501795000000129,2.7291469999981928,3.363506999998208]},"deleteCapsule":{"times":[22.84249500000078]},"validateEnqueuedNotesAndEvents":{"times":[10.58760600000096]},"getNotes":{"times":[5.812950000003184]},"getAuthWitness":{"times":[0.27001300000119954]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06707100000130595]},"callPrivateFunction":{"times":[629.9106829999982,106.17059700000027]},"notifyEnqueuedPublicFunctionCall":{"times":[0.09851100000014412]}}},{"functionName":"private_kernel_init","time":50.70203000000038},{"functionName":"ContractClassRegisterer:register","time":615.6815260000003,"oracles":{"loadCapsule":{"times":[2.510324999999284]},"notifyCreatedNullifier":{"times":[0.3871450000006007]},"debugLog":{"times":[0.14659200000096462]},"notifyCreatedContractClassLog":{"times":[2.9704209999981686]}}},{"functionName":"private_kernel_inner","time":90.89445600000181},{"functionName":"ContractInstanceDeployer:deploy","time":64.3829590000023,"oracles":{"storeInExecutionCache":{"times":[0.07413100000121631]},"callPrivateFunction":{"times":[41.84867799999847]},"notifyCreatedNullifier":{"times":[0.3827259999998205]},"debugLog":{"times":[0.1289519999991171]}}},{"functionName":"private_kernel_inner","time":120.08501000000251},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":27.66209099999469,"oracles":{}},{"functionName":"private_kernel_inner","time":128.78723000000173},{"functionName":"private_kernel_reset","time":178.26652399999875},{"functionName":"private_kernel_tail","time":116.6786030000003}],"unaccounted":410.6031249999869}}
16:45:56 aztec-1 | [16:45:56.065]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
16:45:56 aztec-1 | [16:45:56.065]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:52:43.000Z
{"offset":406935,"timeMs":1750092763000}
16:45:56 aztec-1 | [16:45:56.078]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
16:45:56 aztec-1 | [16:45:56.091]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
16:45:56 aztec-1 | [16:45:56.091]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092787
16:45:56 aztec-1 | [16:45:56.091]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:53:07.000Z
{"offset":430909,"timeMs":1750092787000}
16:45:56 aztec-1 | [16:45:56.091]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
16:45:56 aztec-1 | [16:45:56.095]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:56 aztec-1 | [16:45:56.100]
INFO:
node Received tx 0x27b78a53b79ca77549259de6079759e05fa7ad4b6f936a2e1b54ed4f1b6882e2
{"txHash":"0x27b78a53b79ca77549259de6079759e05fa7ad4b6f936a2e1b54ed4f1b6882e2"}
16:45:56 aztec-1 | [16:45:56.100]
INFO:
pxe:service Sent transaction 0x27b78a53b79ca77549259de6079759e05fa7ad4b6f936a2e1b54ed4f1b6882e2
16:45:56 aztec-1 | [16:45:56.228]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x063978ee8c276979df448f78ebd2415e66a25da3f6e954550b1200cec5dddfa3","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750092751,"version":3633326044},"archiveRoot":"0x217a184abb8833afaa787bd58103e88ff44294bcf81f6bcb54b27a2c9b9f1611","archiveNextLeafIndex":5}
16:45:56 aztec-1 | [16:45:56.234]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
16:45:56 aztec-1 | [16:45:56.300]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":14.617672000000312,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750092751,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
16:45:56 aztec-1 | [16:45:56.690]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3248772710000012s
{"duration":0.3248772710000012,"rate":974066.2959459508,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064}
16:45:56 aztec-1 | [16:45:56.734]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 833253.1573058087 mana/s
{"blockHash":"0x2348ab95783b236013517ab3ece5c30c112ae6693f98013ba82eb2025491f3e2","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750092787,"version":3633326044},"txHashes":["0x27b78a53b79ca77549259de6079759e05fa7ad4b6f936a2e1b54ed4f1b6882e2"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":379.75489899999957,"publicProcessDuration":325.2234260000005,"rollupCircuitsDuration":374.68742900000143,"txCount":1,"blockNumber":5,"blockTimestamp":1750092787,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
16:45:57 aztec-1 | [16:45:56.999]
INFO:
aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed.
16:45:57 aztec-1 | [16:45:56.999]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
16:45:57 aztec-1 | [16:45:57.003]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:45:57 aztec-1 | [16:45:57.005]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
16:45:57 aztec-1 | [16:45:57.012]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092823
16:45:57 aztec-1 | [16:45:57.012]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:53:43.000Z
{"offset":465988,"timeMs":1750092823000}
16:45:57 aztec-1 | [16:45:57.012]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
16:45:57 aztec-1 | [16:45:57.119]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x2348ab95783b236013517ab3ece5c30c112ae6693f98013ba82eb2025491f3e2","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750092787,"version":3633326044},"archiveRoot":"0x12c5bca696ad2abb5176086223149f8db49a8cc58f9c3ec90dbe1a3bcfe3742a","archiveNextLeafIndex":6}
16:45:57 aztec-1 | [16:45:57.124]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
16:45:57 aztec-1 | [16:45:57.196]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":18.089540000000852,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750092787,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
16:45:58 aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
16:45:58 aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
16:45:59 aztec-1 | [16:45:58.386]
INFO:
aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed.
16:45:59 aztec-1 | [16:45:58.421]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
16:45:59 aztec-1 | [16:45:58.424]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
16:45:59 aztec-1 | [16:45:58.593]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
16:46:01 aztec-1 | [16:46:00.959]
INFO:
pxe:service Proving completed in 2344.950423000002ms
{"timings":{"total":2344.950423000002,"sync":25.438861999999062,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":94.46392500000002,"oracles":{"callPrivateFunction":{"times":[796.9251160000022,137.05411500000264,36.858188999998674]}}},{"functionName":"private_kernel_init","time":58.785603000000265},{"functionName":"ContractClassRegisterer:register","time":768.8273859999972,"oracles":{"loadCapsule":{"times":[3.293324999998731]},"notifyCreatedNullifier":{"times":[0.3590550000008079]},"debugLog":{"times":[0.17339199999696575]},"notifyCreatedContractClassLog":{"times":[3.16996300000028]}}},{"functionName":"private_kernel_inner","time":108.61813099999927},{"functionName":"ContractInstanceDeployer:deploy","time":76.71626100000503,"oracles":{"storeInExecutionCache":{"times":[0.08908200000223587]},"callPrivateFunction":{"times":[74.02018300000054]},"notifyCreatedNullifier":{"times":[0.19443300000057206]},"debugLog":{"times":[0.09723100000337581]}}},{"functionName":"private_kernel_inner","time":159.114880000001},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":47.54468799999813,"oracles":{}},{"functionName":"private_kernel_inner","time":164.32088099999964},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":28.739057999999204,"oracles":{"debugLog":{"times":[0.10179100000095787]}}},{"functionName":"private_kernel_inner","time":128.8365509999967},{"functionName":"private_kernel_reset","time":172.81581800000276},{"functionName":"private_kernel_tail","time":70.6018559999975}],"unaccounted":440.1265230000063}}
16:46:01 aztec-1 | [16:46:01.099]
INFO:
node Received tx 0x272ee9a4da892948f10eebd757ae1c996b45d99823d1a5e5b89d64e9444731c1
{"txHash":"0x272ee9a4da892948f10eebd757ae1c996b45d99823d1a5e5b89d64e9444731c1"}
16:46:01 aztec-1 | [16:46:01.099]
INFO:
pxe:service Sent transaction 0x272ee9a4da892948f10eebd757ae1c996b45d99823d1a5e5b89d64e9444731c1
16:46:01 aztec-1 | [16:46:01.214]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04133348099999785s
{"duration":0.04133348099999785,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
16:46:01 aztec-1 | [16:46:01.238]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x1af523a5e94b624e1844b42f908c584771ed2d6d9f13da0c1f0d5becb45857c8","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750092823,"version":3633326044},"txHashes":["0x272ee9a4da892948f10eebd757ae1c996b45d99823d1a5e5b89d64e9444731c1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":78.79169900000124,"publicProcessDuration":41.57202399999733,"rollupCircuitsDuration":72.2098679999981,"txCount":1,"blockNumber":6,"blockTimestamp":1750092823,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:46:01 aztec-1 | [16:46:01.432]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
16:46:01 aztec-1 | [16:46:01.434]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
16:46:01 aztec-1 | [16:46:01.436]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
16:46:01 aztec-1 | [16:46:01.449]
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":"0x12c5bca696ad2abb5176086223149f8db49a8cc58f9c3ec90dbe1a3bcfe3742a","blocksSynchedTo":34,"currentL1BlockNumber":35,"provenBlockNumber":5,"provenArchive":"0x12c5bca696ad2abb5176086223149f8db49a8cc58f9c3ec90dbe1a3bcfe3742a","pendingBlockNumber":6,"pendingArchive":"0x27c45c6ee91a1a8e768dfac35f262f31d93034db533aee7457f26730edd175fe"}
16:46:01 aztec-1 | [16:46:01.508]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750092859
16:46:01 aztec-1 | [16:46:01.508]
WARN:
foundation:test-date-provider Time set to 2025-06-16T16:54:19.000Z
{"offset":497492,"timeMs":1750092859000}
16:46:01 aztec-1 | [16:46:01.508]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
16:46:01 aztec-1 | [16:46:01.558]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x1af523a5e94b624e1844b42f908c584771ed2d6d9f13da0c1f0d5becb45857c8","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750092823,"version":3633326044},"archiveRoot":"0x27c45c6ee91a1a8e768dfac35f262f31d93034db533aee7457f26730edd175fe","archiveNextLeafIndex":7}
16:46:01 aztec-1 | [16:46:01.564]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
16:46:01 aztec-1 | [16:46:01.600]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":19.757613000001584,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750092823,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
16:46:02 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
16:46:02 aztec-1 | [16:46:02.116]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
16:46:02 aztec-1 | [16:46:02.124]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x27f24d2a1e99e49d4a27746a8374185b307a07325d0d743c1df56a03e39788d2","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
16:46:09 playground-1 | \
16:46:09 playground-1 |
Running 1
test using 1
worker
16:46:09 playground-1 |
16:46:10 playground-1 |
✓ 1 [firefox] › browser.spec.ts:3:1 › test
(13.9s)
16:46:32 playground-1 |
1 passed (25.3s)
16:46:32 playground-1 | \
npm notice
16:46:32 playground-1 |
npm notice New
major version of npm available!
10.9.2 ->
11.4.2
16:46:32 playground-1 |
npm notice Changelog:
https://github.com/npm/cli/releases/tag/v11.4.2
16:46:32 playground-1 |
npm notice To update run:
npm install -g npm@11.4.2
16:46:32 playground-1 |
npm notice
16:46:32 playground-1 | \
16:46:33
playground-1 exited with code 0
16:46:33 Aborting on container exit...
16:46:33 Container playground-firefox-playground-1 Stopping
16:46:33 Container playground-firefox-playground-1 Stopped
16:46:33 Container playground-firefox-aztec-1 Stopping
16:46:35 Container playground-firefox-aztec-1 Stopped
16:46:35 Container playground-firefox-ethereum-1 Stopping
16:46:35 Container playground-firefox-ethereum-1 Stopped