Parent Log:
http://ci.aztec-labs.com/46bd051ed37662bb
Command: ad99e0f0cec37417 playground/scripts/run_test.sh chromium
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/4800d08570523bc1b2a9e8ec0dfb09e326f4689a
Env: REF_NAME=gh-readonly-queue/next/pr-14900-d3bba2d69dbc070d51bcd50607354193573876ba CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Fri Jun 13 13:35:14 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14900_amd64_x2-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_3af8716c4dfeb01b_next
13:35:14 Network playground-chromium_default Creating
13:35:14 Network playground-chromium_default Created
13:35:14 Container playground-chromium-ethereum-1 Creating
13:35:15 Container playground-chromium-ethereum-1 Created
13:35:15 Container playground-chromium-aztec-1 Creating
13:35:15 Container playground-chromium-aztec-1 Created
13:35:15 Container playground-chromium-playground-1 Creating
13:35:16 Container playground-chromium-playground-1 Created
13:35:16 Attaching to aztec-1, ethereum-1, playground-1
13:35:21 aztec-1 |
13:35:21 aztec-1 | _
13:35:21 aztec-1 | /\ | |
13:35:21 aztec-1 | / \ ___| |_ ___ ___
13:35:21 aztec-1 | / /\ \ |_ / __/ _ \/ __|
13:35:21 aztec-1 | / ____ \ / /| || __/ (__
13:35:21 aztec-1 | /_/___ \_\/___|\__\___|\___|
13:35:21 aztec-1 |
13:35:21 aztec-1 |
https://github.com/AztecProtocol
13:35:21 aztec-1 |
13:35:21 aztec-1 |
13:35:21 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
13:35:21 aztec-1 | Setting up test accounts
13:35:22 aztec-1 | [13:35:22.257]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-6onsjM/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
13:35:22 aztec-1 | [13:35:22.538]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
13:35:22 aztec-1 | [13:35:22.544]
WARN:
sandbox Set block interval to 12
13:35:22 aztec-1 | [13:35:22.760]
INFO:
sandbox Waiting for 7 transactions to be mined...
13:35:22 aztec-1 | [13:35:22.790]
INFO:
sandbox All transactions mined successfully
13:35:22 aztec-1 | [13:35:22.887]
INFO:
sandbox Waiting for 9 transactions to be mined...
13:35:22 aztec-1 | [13:35:22.911]
INFO:
sandbox All transactions mined successfully
13:35:23 aztec-1 | [13:35:23.065]
INFO:
sandbox Waiting for 11 transactions to be mined...
13:35:23 aztec-1 | [13:35:23.092]
INFO:
sandbox All transactions mined successfully
13:35:23 aztec-1 | [13:35:23.172]
INFO:
sandbox Waiting for 12 transactions to be mined...
13:35:23 aztec-1 | [13:35:23.196]
INFO:
sandbox All transactions mined successfully
13:35:23 aztec-1 | [13:35:23.212]
INFO:
sandbox Waiting for 12 transactions to be mined...
13:35:23 aztec-1 | [13:35:23.241]
INFO:
sandbox All transactions mined successfully
13:35:23 aztec-1 | [13:35:23.262]
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"}
13:35:23 aztec-1 | [13:35:23.263]
INFO:
sandbox Handing over to governance
13:35:23 aztec-1 | [13:35:23.277]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
13:35:23 aztec-1 | [13:35:23.278]
INFO:
telemetry:client Using NoopTelemetryClient
13:35:23 aztec-1 | [13:35:23.278]
INFO:
blob-sink:client Creating local blob sink client.
13:35:23 aztec-1 | [13:35:23.285]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
13:35:23 aztec-1 | [13:35:23.285]
WARN:
foundation:test-date-provider Time set to 2025-06-13T13:40:04.000Z
{"offset":280715,"timeMs":1749822004000}
13:35:23 aztec-1 | [13:35:23.317]
INFO:
archiver:lmdb Starting data store with maxReaders 16
13:35:23 aztec-1 | [13:35:23.742]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xbc63b946f825b8119b16ba145993e43da5ddda08025ed17ba2f8a8b4f05324ae
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x7f5c97f69f7d8a323b4143ebe048d6f9c08f12c936e9bce06499c0504b422671","l1BlockNumber":20}}
13:35:23 aztec-1 | [13:35:23.766]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xbc63b946f825b8119b16ba145993e43da5ddda08025ed17ba2f8a8b4f05324ae","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
13:35:24 aztec-1 | [13:35:23.777]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-e48Zdf/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
13:35:24 aztec-1 | [13:35:24.031]
INFO:
world_state Created world state synchroniser with block history of 64
13:35:24 aztec-1 | [13:35:24.031]
WARN:
node Aztec node is accepting fake proofs
13:35:24 aztec-1 | [13:35:24.042]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
13:35:24 aztec-1 | [13:35:24.061]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
13:35:24 aztec-1 | [13:35:24.072]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
13:35:24 aztec-1 | [13:35:24.086]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
13:35:24 aztec-1 | [13:35:24.091]
INFO:
world_state Started world state synchronizer from block 1
13:35:24 aztec-1 | [13:35:24.095]
INFO:
p2p Starting p2p client from block 0 with empty mempools
13:35:24 aztec-1 | [13:35:24.394]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
13:35:24 aztec-1 | [13:35:24.459]
INFO:
slasher Starting Slasher client...
13:35:24 aztec-1 | [13:35:24.470]
INFO:
sequencer-client Deploying forwarder contract
13:35:24 aztec-1 | [13:35:24.491]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
13:35:24 aztec-1 | [13:35:24.499]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
13:35:24 aztec-1 | [13:35:24.500]
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}
13:35:24 aztec-1 | [13:35:24.502]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
13:35:24 aztec-1 | [13:35:24.503]
INFO:
node Aztec Node version: 0.87.6
13:35:24 aztec-1 | [13:35:24.503]
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"}
13:35:24 aztec-1 | [13:35:24.510]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
13:35:24 aztec-1 | [13:35:24.520]
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":1749822005,"syncedToL1Ts":1749822004,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1749821992,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1749822028},"newBlockNumber":1,"expectedSlot":1}
13:35:24 aztec-1 | [13:35:24.654]
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":1749822005,"syncedToL1Ts":1749822004,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1749821992,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1749822028},"newBlockNumber":1,"expectedSlot":1}
13:35:24 aztec-1 | [13:35:24.661]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
13:35:24 aztec-1 | [13:35:24.661]
WARN:
foundation:test-date-provider Time set to 2025-06-13T13:40:16.000Z
{"offset":291339,"timeMs":1749822016000}
13:35:24 aztec-1 | Setting up funded test accounts...
13:35:25 aztec-1 | [13:35:24.926]
INFO:
pxe:service Started PXE connected to chain 31337 version 2094187016
13:35:25 aztec-1 | [13:35:25.016]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
13:35:25 aztec-1 | [13:35:25.085]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
13:35:25 aztec-1 | [13:35:25.089]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
13:35:25 aztec-1 | [13:35:25.244]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
13:35:28 aztec-1 | [13:35:27.904]
INFO:
pxe:service Proving completed in 2629.5251089999992ms
{"timings":{"total":2629.5251089999992,"sync":4.800481000000218,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":167.81610400000227,"oracles":{"callPrivateFunction":{"times":[753.8350659999987,416.73652200000106,215.76567400000022]}}},{"functionName":"private_kernel_init","time":98.978384},{"functionName":"ContractClassRegisterer:register","time":733.7223700000013,"oracles":{"loadCapsule":{"times":[13.856631000000561]},"notifyCreatedNullifier":{"times":[56.808084000000235]},"debugLog":{"times":[0.5552139999999781]},"notifyCreatedContractClassLog":{"times":[7.914259000001039]}}},{"functionName":"private_kernel_inner","time":131.0903159999998},{"functionName":"SchnorrAccount:constructor","time":385.39240999999856,"oracles":{"getContractInstance":{"times":[2.9708559999999125]},"debugLog":{"times":[0.24926000000050408,0.12094000000070082]},"fetchTaggedLogs":{"times":[92.87252900000021]},"loadCapsule":{"times":[0.3939809999992576,0.2606710000000021,0.24229900000136695]},"validateEnqueuedNotesAndEvents":{"times":[8.553509999999733]},"notifyCreatedNullifier":{"times":[0.3387569999995321,0.2259780000003957]},"notifyCreatedNote":{"times":[0.7014359999993758]},"getRandomField":{"times":[0.3086439999988215,0.2658510000001115,0.11308900000040012,0.10309800000140967,0.20438599999943108,0.1583120000013878,0.07050600000002305,0.06207400000130292,0.08282599999984086,0.10428799999863259,0.12717999999949825]},"getIndexedTaggingSecretAsSender":{"times":[45.15798799999902]},"incrementAppTaggingSecretIndexAsSender":{"times":[18.778732999999193]}}},{"functionName":"private_kernel_inner","time":99.75147599999946},{"functionName":"SchnorrAccount:entrypoint","time":193.19266999999854,"oracles":{"debugLog":{"times":[0.3537079999987327,0.09982800000034331,0.401531999999861]},"fetchTaggedLogs":{"times":[61.71342399999958]},"loadCapsule":{"times":[0.33878700000059325,0.3210959999996703,0.242539000000761]},"validateEnqueuedNotesAndEvents":{"times":[6.458194000000731]},"getNotes":{"times":[3.2010749999990367]},"getAuthWitness":{"times":[0.4617069999985688]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.1237589999982447]}}},{"functionName":"private_kernel_inner","time":104.07090900000003},{"functionName":"private_kernel_reset","time":197.89689400000134},{"functionName":"private_kernel_tail","time":80.4901260000006}],"unaccounted":432.3229689999971}}
13:35:28 aztec-1 | [13:35:28.062]
INFO:
node Received tx 0x06e05582729ebf0539e2f17b5eb1bd309ee597daf8362241a5aaeaa1f32ce96a
{"txHash":"0x06e05582729ebf0539e2f17b5eb1bd309ee597daf8362241a5aaeaa1f32ce96a"}
13:35:28 aztec-1 | [13:35:28.062]
INFO:
pxe:service Sent transaction 0x06e05582729ebf0539e2f17b5eb1bd309ee597daf8362241a5aaeaa1f32ce96a
13:35:28 aztec-1 | [13:35:28.177]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.060624305999999704s
{"duration":0.060624305999999704,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
13:35:28 aztec-1 | [13:35:28.210]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x25cebbd7a9df3ab32b67bf3299e67ac60e7ccf874ec650d3d5ca597643a4206c","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749822028,"version":2094187016},"txHashes":["0x06e05582729ebf0539e2f17b5eb1bd309ee597daf8362241a5aaeaa1f32ce96a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":106.92338600000039,"publicProcessDuration":61.75570700000026,"rollupCircuitsDuration":97.96934399999918,"txCount":1,"blockNumber":1,"blockTimestamp":1749822028,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
13:35:32 aztec-1 | [13:35:31.388]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
13:35:32 aztec-1 | [13:35:31.391]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
13:35:32 aztec-1 | [13:35:31.395]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
13:35:32 aztec-1 | [13:35:31.399]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749822064
13:35:32 aztec-1 | [13:35:31.399]
WARN:
foundation:test-date-provider Time set to 2025-06-13T13:41:04.000Z
{"offset":332601,"timeMs":1749822064000}
13:35:32 aztec-1 | [13:35:31.399]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
13:35:32 aztec-1 | [13:35:31.501]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x25cebbd7a9df3ab32b67bf3299e67ac60e7ccf874ec650d3d5ca597643a4206c","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749822028,"version":2094187016},"archiveRoot":"0x041b0d55c6178f4cf25490727bb48d4c255d841619f67a45f810f6e653bc1504","archiveNextLeafIndex":2}
13:35:32 aztec-1 | [13:35:31.510]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
13:35:32 aztec-1 | [13:35:31.534]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":18.07597700000042,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749822028,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
13:35:32 aztec-1 | [13:35:31.661]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
13:35:32 aztec-1 | [13:35:31.790]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
13:35:34 aztec-1 | [13:35:33.415]
INFO:
pxe:service Proving completed in 1592.747722ms
{"timings":{"total":1592.747722,"sync":27.693419999999605,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":103.48394200000257,"oracles":{"callPrivateFunction":{"times":[378.5278760000001,235.4675189999998]}}},{"functionName":"private_kernel_init","time":68.17910699999993},{"functionName":"SchnorrAccount:constructor","time":352.02067999999963,"oracles":{"getContractInstance":{"times":[7.191990999999689]},"debugLog":{"times":[0.22075799999947776,0.29429399999935413]},"fetchTaggedLogs":{"times":[108.95984800000042]},"loadCapsule":{"times":[0.24863900000127614,0.4173929999997199,0.40780200000153854]},"validateEnqueuedNotesAndEvents":{"times":[6.181891000000178]},"notifyCreatedNullifier":{"times":[0.32626600000003236,0.22401799999897776]},"notifyCreatedNote":{"times":[0.198114999999234]},"getRandomField":{"times":[0.17098400000031688,0.18647500000042783,0.048824000001332024,0.04282299999977113,0.060364999999364954,0.04688400000122783,0.040174000001570676,0.04033300000082818,0.038642999999865424,0.0386129999988043,0.053063999999722]},"getIndexedTaggingSecretAsSender":{"times":[47.8778540000003]},"incrementAppTaggingSecretIndexAsSender":{"times":[30.426767999999356]}}},{"functionName":"private_kernel_inner","time":132.07620400000087},{"functionName":"SchnorrAccount:entrypoint","time":201.24537999999848,"oracles":{"debugLog":{"times":[0.2616010000001552,0.1291799999999057,0.13397099999929196]},"fetchTaggedLogs":{"times":[74.20980599999893]},"loadCapsule":{"times":[0.239729000000807,0.19122499999866704,0.15631200000098033]},"validateEnqueuedNotesAndEvents":{"times":[5.480885999999373]},"getNotes":{"times":[1.244369000000006]},"getAuthWitness":{"times":[0.1307600000000093]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.547683999999208]}}},{"functionName":"private_kernel_inner","time":117.95334100000036},{"functionName":"private_kernel_reset","time":190.25249600000097},{"functionName":"private_kernel_tail","time":73.99787000000106}],"unaccounted":325.8452819999966}}
13:35:34 aztec-1 | [13:35:33.468]
INFO:
node Received tx 0x0e9428380b8bc8d12b3464b512d93181932da96c27e0355c5ee5604755f35302
{"txHash":"0x0e9428380b8bc8d12b3464b512d93181932da96c27e0355c5ee5604755f35302"}
13:35:34 aztec-1 | [13:35:33.468]
INFO:
pxe:service Sent transaction 0x0e9428380b8bc8d12b3464b512d93181932da96c27e0355c5ee5604755f35302
13:35:34 aztec-1 | [13:35:33.562]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02470529300000089s
{"duration":0.02470529300000089,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
13:35:34 aztec-1 | [13:35:33.602]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2e89b3956bddd44c145939f9bb537b00a294c59cd53ae78f00308a16b3c0797f","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749822064,"version":2094187016},"txHashes":["0x0e9428380b8bc8d12b3464b512d93181932da96c27e0355c5ee5604755f35302"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":71.60377899999912,"publicProcessDuration":24.85992499999884,"rollupCircuitsDuration":66.82400000000052,"txCount":1,"blockNumber":2,"blockTimestamp":1749822064,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
13:35:34 aztec-1 | [13:35:33.858]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
13:35:34 aztec-1 | [13:35:33.858]
WARN:
foundation:test-date-provider Time set to 2025-06-13T13:41:16.000Z
{"offset":342142,"timeMs":1749822076000}
13:35:34 aztec-1 | [13:35:33.863]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
13:35:34 aztec-1 | [13:35:33.866]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
13:35:34 aztec-1 | [13:35:33.867]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
13:35:34 aztec-1 | [13:35:33.887]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749822100
13:35:34 aztec-1 | [13:35:33.887]
WARN:
foundation:test-date-provider Time set to 2025-06-13T13:41:40.000Z
{"offset":366113,"timeMs":1749822100000}
13:35:34 aztec-1 | [13:35:33.887]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
13:35:34 aztec-1 | [13:35:33.956]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2e89b3956bddd44c145939f9bb537b00a294c59cd53ae78f00308a16b3c0797f","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749822064,"version":2094187016},"archiveRoot":"0x12d4e093d7de34d836f79e501daec83f7e10cffc8b357f450e192b0d2065d966","archiveNextLeafIndex":3}
13:35:34 aztec-1 | [13:35:33.960]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
13:35:34 aztec-1 | [13:35:34.025]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":15.543594999999186,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749822064,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
13:35:34 aztec-1 | [13:35:34.157]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
13:35:34 aztec-1 | [13:35:34.285]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
13:35:36 aztec-1 | [13:35:35.918]
INFO:
pxe:service Proving completed in 1623.060010000001ms
{"timings":{"total":1623.060010000001,"sync":24.566682000000583,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":107.36820199999784,"oracles":{"callPrivateFunction":{"times":[343.74821299999894,260.53825100000176]}}},{"functionName":"private_kernel_init","time":96.43785199999911},{"functionName":"SchnorrAccount:constructor","time":319.26557700000194,"oracles":{"getContractInstance":{"times":[3.01183900000251]},"debugLog":{"times":[0.0948679999964952,0.06898500000170316]},"fetchTaggedLogs":{"times":[111.76305000000139]},"loadCapsule":{"times":[0.27779300000111107,0.2373390000029758,0.14764199999990524]},"validateEnqueuedNotesAndEvents":{"times":[9.170208000003186]},"notifyCreatedNullifier":{"times":[0.17880399999921792,0.20977700000003097]},"notifyCreatedNote":{"times":[0.0974370000003546]},"getRandomField":{"times":[0.12960000000020955,0.09075700000175857,0.03322199999820441,0.039293999998335494,0.026721999998699175,0.02674200000183191,0.035553000001527835,0.030011999999260297,0.04004400000121677,0.06411500000103842,0.033912999999301974]},"getIndexedTaggingSecretAsSender":{"times":[33.065277000001515]},"incrementAppTaggingSecretIndexAsSender":{"times":[29.01134500000262]}}},{"functionName":"private_kernel_inner","time":101.15499700000146},{"functionName":"SchnorrAccount:entrypoint","time":237.09470800000054,"oracles":{"debugLog":{"times":[0.24469999999928405,0.1424120000010589,0.27483199999915087]},"fetchTaggedLogs":{"times":[101.78301699999793]},"loadCapsule":{"times":[2.3665380000020377,4.84630499999912,2.697434000001522]},"validateEnqueuedNotesAndEvents":{"times":[18.382760999997117]},"getNotes":{"times":[3.238197000002401]},"getAuthWitness":{"times":[0.19461600000067847]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.8225549999988289]}}},{"functionName":"private_kernel_inner","time":108.79583400000047},{"functionName":"private_kernel_reset","time":194.35053299999709},{"functionName":"private_kernel_tail","time":93.62851900000169}],"unaccounted":340.39710600000035}}
13:35:36 aztec-1 | [13:35:35.986]
INFO:
node Received tx 0x2df5a7e451cc9be93d4d2e4154ff0b01cbd3d5e2e97bb43f89ce7aff97c75906
{"txHash":"0x2df5a7e451cc9be93d4d2e4154ff0b01cbd3d5e2e97bb43f89ce7aff97c75906"}
13:35:36 aztec-1 | [13:35:35.986]
INFO:
pxe:service Sent transaction 0x2df5a7e451cc9be93d4d2e4154ff0b01cbd3d5e2e97bb43f89ce7aff97c75906
13:35:36 aztec-1 | [13:35:36.081]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03314892400000099s
{"duration":0.03314892400000099,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
13:35:36 aztec-1 | [13:35:36.107]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x22430b18d48943392d5842344b8ff7869a45bbfb3fd6eb93217f5fd729d8668c","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749822100,"version":2094187016},"txHashes":["0x2df5a7e451cc9be93d4d2e4154ff0b01cbd3d5e2e97bb43f89ce7aff97c75906"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":67.35956200000146,"publicProcessDuration":33.33244800000102,"rollupCircuitsDuration":61.38086699999985,"txCount":1,"blockNumber":3,"blockTimestamp":1749822100,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
13:35:36 aztec-1 | [13:35:36.335]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
13:35:36 aztec-1 | [13:35:36.357]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
13:35:36 aztec-1 | [13:35:36.358]
WARN:
foundation:test-date-provider Time set to 2025-06-13T13:41:52.000Z
{"offset":375642,"timeMs":1749822112000}
13:35:36 aztec-1 | [13:35:36.362]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
13:35:36 aztec-1 | [13:35:36.363]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
13:35:36 aztec-1 | [13:35:36.407]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749822136
13:35:36 aztec-1 | [13:35:36.407]
WARN:
foundation:test-date-provider Time set to 2025-06-13T13:42:16.000Z
{"offset":399593,"timeMs":1749822136000}
13:35:36 aztec-1 | [13:35:36.407]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
13:35:36 aztec-1 | [13:35:36.440]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x22430b18d48943392d5842344b8ff7869a45bbfb3fd6eb93217f5fd729d8668c","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749822100,"version":2094187016},"archiveRoot":"0x0116007dda6c75959afa2fc984e06df9853191940550b71a827a13845285c336","archiveNextLeafIndex":4}
13:35:36 aztec-1 | [13:35:36.457]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
13:35:36 aztec-1 | [13:35:36.496]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":21.276191000000836,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749822100,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
13:35:36 aztec-1 | Initial Accounts:
13:35:36 aztec-1 |
13:35:36 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
13:35:36 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
13:35:36 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
13:35:36 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
13:35:36 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
13:35:36 aztec-1 |
13:35:36 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
13:35:36 aztec-1 |
13:35:36 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
13:35:36 aztec-1 |
13:35:36 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
13:35:36 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
13:35:36 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
13:35:36 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
13:35:36 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
13:35:36 aztec-1 |
13:35:36 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
13:35:36 aztec-1 |
13:35:36 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
13:35:36 aztec-1 |
13:35:36 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
13:35:36 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
13:35:36 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
13:35:36 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
13:35:36 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
13:35:36 aztec-1 |
13:35:36 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
13:35:36 aztec-1 |
13:35:36 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
13:35:36 aztec-1 |
13:35:36 aztec-1 |
13:35:37 aztec-1 | [13:35:37.312]
WARN:
pxe:service No artifact found for contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 when looking for its metadata
13:35:37 aztec-1 | [13:35:37.313]
WARN:
pxe:service No artifact found for contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 when looking for its metadata
13:35:37 aztec-1 | [13:35:37.317]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 as part of deployment for 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45
13:35:37 aztec-1 | [13:35:37.352]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 as part of deployment for 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf
13:35:38 aztec-1 | [13:35:38.302]
INFO:
pxe:service Added contract FPC at 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 with class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1
13:35:38 aztec-1 | [13:35:38.309]
INFO:
pxe:service Added contract Token at 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf with class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645
13:35:41 aztec-1 | [13:35:40.760]
INFO:
pxe:service Proving completed in 2431.238573999999ms
{"timings":{"total":2431.238573999999,"sync":29.338080999998056,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":418.96017700000084,"oracles":{"debugLog":{"times":[0.22330800000054296,0.1527620000015304,0.08022599999821978,0.12500999999974738,0.10168800000246847,0.0725559999991674,0.10705800000141608,0.2056960000008985]},"fetchTaggedLogs":{"times":[152.21790500000134]},"loadCapsule":{"times":[3.7094450000004144,0.28593300000284216,0.38302000000112457,0.21481700000003912,0.9057619999985036,0.33362599999964004,0.23744900000019697]},"getSharedSecret":{"times":[7.306860999997298]},"aes128Decrypt":{"times":[1.1172389999992447,0.6512719999991532]},"getPublicKeysAndPartialAddress":{"times":[2.638829999999871]},"getKeyValidationRequest":{"times":[1.9899589999986347]},"storeCapsule":{"times":[3.235247000000527,2.693654000002425,2.6613709999983257]},"deleteCapsule":{"times":[2.9011700000010023]},"validateEnqueuedNotesAndEvents":{"times":[41.629306999999244]},"getNotes":{"times":[9.865513000000647]},"getAuthWitness":{"times":[0.2376490000024205]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.057885000001988374]},"callPrivateFunction":{"times":[743.4046369999996,127.75010000000111]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3146450000022014]}}},{"functionName":"private_kernel_init","time":55.79138299999977},{"functionName":"ContractClassRegisterer:register","time":722.4777849999991,"oracles":{"loadCapsule":{"times":[9.760325999999623]},"notifyCreatedNullifier":{"times":[0.4686169999986305]},"debugLog":{"times":[0.16815300000234856]},"notifyCreatedContractClassLog":{"times":[4.35350599999947]}}},{"functionName":"private_kernel_inner","time":123.94641799999954},{"functionName":"ContractInstanceDeployer:deploy","time":79.07315299999755,"oracles":{"storeInExecutionCache":{"times":[0.31365399999776855]},"callPrivateFunction":{"times":[50.83650899999702]},"notifyCreatedNullifier":{"times":[0.2709209999993618]},"debugLog":{"times":[0.1025679999984277]}}},{"functionName":"private_kernel_inner","time":142.68216699999903},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.14513000000079,"oracles":{}},{"functionName":"private_kernel_inner","time":89.31890700000076},{"functionName":"private_kernel_reset","time":151.76175800000055},{"functionName":"private_kernel_tail","time":106.1708260000014}],"unaccounted":472.57278900000165}}
13:35:41 aztec-1 | [13:35:40.955]
INFO:
node Received tx 0x0058d4ee1befc6da68e7b085908afd91edf1506087f57c541e0f35d6a8726a6a
{"txHash":"0x0058d4ee1befc6da68e7b085908afd91edf1506087f57c541e0f35d6a8726a6a"}
13:35:41 aztec-1 | [13:35:40.955]
INFO:
pxe:service Sent transaction 0x0058d4ee1befc6da68e7b085908afd91edf1506087f57c541e0f35d6a8726a6a
13:35:43 aztec-1 | [13:35:42.965]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.8594961040000018s
{"duration":1.8594961040000018,"rate":21398.807942864052,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":166912,"l2Gas":64833},"totalSizeInBytes":10688}
13:35:43 aztec-1 | [13:35:43.197]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 18880.520488676222 mana/s
{"blockHash":"0x0aaceff392fdc423b1130935b73ce261a40a5ac8d72843c61b0243f8357c01a8","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749822136,"version":2094187016},"txHashes":["0x0058d4ee1befc6da68e7b085908afd91edf1506087f57c541e0f35d6a8726a6a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2107.4400769999993,"publicProcessDuration":1859.6793590000016,"rollupCircuitsDuration":2095.2140949999994,"txCount":1,"blockNumber":4,"blockTimestamp":1749822136,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
13:35:43 aztec-1 | [13:35:43.668]
INFO:
pxe:service Proving completed in 2906.9255410000005ms
{"timings":{"total":2906.9255410000005,"sync":159.4849409999988,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":481.62592299999596,"oracles":{"debugLog":{"times":[0.16745300000184216,0.12967099999877973,0.11612899999818183,0.18948500000260537,0.09293799999795738,0.06434499999886611,0.07913700000062818,0.16362300000037067]},"fetchTaggedLogs":{"times":[179.2425320000002]},"loadCapsule":{"times":[0.7432990000015707,0.8755899999996473,17.398902999997517,0.35803799999848707,0.23826899999767193,22.183171999997285,0.7831420000002254]},"getSharedSecret":{"times":[8.689109999999346]},"aes128Decrypt":{"times":[0.24927999999999884,0.5910970000004454]},"getPublicKeysAndPartialAddress":{"times":[5.78005999999732]},"getKeyValidationRequest":{"times":[5.645047999998496]},"storeCapsule":{"times":[2.5759350000007544,2.4089920000005804,3.8261639999982435]},"deleteCapsule":{"times":[2.343985999999859]},"validateEnqueuedNotesAndEvents":{"times":[14.36225099999865]},"getNotes":{"times":[10.499674999999115]},"getAuthWitness":{"times":[0.23771900000065216]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06172499999956926]},"callPrivateFunction":{"times":[1018.5655169999991,183.36301500000263]},"notifyEnqueuedPublicFunctionCall":{"times":[0.09787800000049174]}}},{"functionName":"private_kernel_init","time":45.144812999998976},{"functionName":"ContractClassRegisterer:register","time":993.577322000001,"oracles":{"loadCapsule":{"times":[3.2253359999995155]},"notifyCreatedNullifier":{"times":[0.565904999999475]},"debugLog":{"times":[0.17628400000103284]},"notifyCreatedContractClassLog":{"times":[6.966143000001466]}}},{"functionName":"private_kernel_inner","time":92.2483519999987},{"functionName":"ContractInstanceDeployer:deploy","time":91.03649400000359,"oracles":{"storeInExecutionCache":{"times":[0.09087800000270363]},"callPrivateFunction":{"times":[63.00188100000014]},"notifyCreatedNullifier":{"times":[0.3763700000017707]},"debugLog":{"times":[0.15562299999874085]}}},{"functionName":"private_kernel_inner","time":118.78190800000084},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":46.34856999999829,"oracles":{}},{"functionName":"private_kernel_inner","time":125.45295800000167},{"functionName":"private_kernel_reset","time":218.07603000000017},{"functionName":"private_kernel_tail","time":90.41612700000042}],"unaccounted":444.7321030000021}}
13:35:43 aztec-1 | [13:35:43.855]
INFO:
node Received tx 0x0bcb98c4ab361b5cba6de08b1bba64656754fd35c3b26f311032b9cc6107f6d7
{"txHash":"0x0bcb98c4ab361b5cba6de08b1bba64656754fd35c3b26f311032b9cc6107f6d7"}
13:35:43 aztec-1 | [13:35:43.855]
INFO:
pxe:service Sent transaction 0x0bcb98c4ab361b5cba6de08b1bba64656754fd35c3b26f311032b9cc6107f6d7
13:35:44 aztec-1 | [13:35:44.008]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
13:35:44 aztec-1 | [13:35:44.009]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
13:35:44 aztec-1 | [13:35:44.012]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
13:35:44 aztec-1 | [13:35:44.016]
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":"0x0116007dda6c75959afa2fc984e06df9853191940550b71a827a13845285c336","blocksSynchedTo":30,"currentL1BlockNumber":31,"provenBlockNumber":3,"provenArchive":"0x0116007dda6c75959afa2fc984e06df9853191940550b71a827a13845285c336","pendingBlockNumber":4,"pendingArchive":"0x1e64dfacf8c94a8a4ea388697ca0ecc67292978b53b75730f46a9e88b967a199"}
13:35:44 aztec-1 | [13:35:44.040]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749822172
13:35:44 aztec-1 | [13:35:44.040]
WARN:
foundation:test-date-provider Time set to 2025-06-13T13:42:52.000Z
{"offset":427960,"timeMs":1749822172000}
13:35:44 aztec-1 | [13:35:44.040]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
13:35:44 aztec-1 | [13:35:44.141]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x0aaceff392fdc423b1130935b73ce261a40a5ac8d72843c61b0243f8357c01a8","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749822136,"version":2094187016},"archiveRoot":"0x1e64dfacf8c94a8a4ea388697ca0ecc67292978b53b75730f46a9e88b967a199","archiveNextLeafIndex":5}
13:35:44 aztec-1 | [13:35:44.146]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
13:35:44 aztec-1 | [13:35:44.174]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":19.01267899999948,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749822136,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
13:35:44 aztec-1 | [13:35:44.616]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3508419480000011s
{"duration":0.3508419480000011,"rate":901978.8021471109,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064}
13:35:44 aztec-1 | [13:35:44.683]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 745444.72139489 mana/s
{"blockHash":"0x17e4f232651760863546950904508b4b9c3a3e5f7e964d7da4b42137484f90ba","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749822172,"version":2094187016},"txHashes":["0x0bcb98c4ab361b5cba6de08b1bba64656754fd35c3b26f311032b9cc6107f6d7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":424.46725199999855,"publicProcessDuration":351.22210800000175,"rollupCircuitsDuration":420.0416299999997,"txCount":1,"blockNumber":5,"blockTimestamp":1749822172,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
13:35:44 aztec-1 | [13:35:44.838]
INFO:
aztecjs:deploy_sent_tx Contract 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 successfully deployed.
13:35:44 aztec-1 | [13:35:44.983]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
13:35:44 aztec-1 | [13:35:44.986]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
13:35:44 aztec-1 | [13:35:44.988]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
13:35:44 aztec-1 | [13:35:44.989]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749822208
13:35:44 aztec-1 | [13:35:44.989]
WARN:
foundation:test-date-provider Time set to 2025-06-13T13:43:28.000Z
{"offset":463011,"timeMs":1749822208000}
13:35:44 aztec-1 | [13:35:44.989]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
13:35:45 aztec-1 | [13:35:45.147]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x17e4f232651760863546950904508b4b9c3a3e5f7e964d7da4b42137484f90ba","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749822172,"version":2094187016},"archiveRoot":"0x16c8863498caa84703408c64e6950db6e284ed60d816cf8088c34a8ee300e5a3","archiveNextLeafIndex":6}
13:35:45 aztec-1 | [13:35:45.155]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
13:35:45 aztec-1 | [13:35:45.235]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":22.652008000000933,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749822172,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
13:35:46 aztec-1 | BananaCoin: 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf
13:35:46 aztec-1 | FPC: 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45
13:35:46 aztec-1 | [13:35:46.206]
INFO:
aztecjs:deploy_sent_tx Contract 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf successfully deployed.
13:35:46 aztec-1 | [13:35:46.239]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
13:35:46 aztec-1 | [13:35:46.244]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
13:35:46 aztec-1 | [13:35:46.414]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
13:35:49 aztec-1 | [13:35:48.714]
INFO:
pxe:service Proving completed in 2263.7039609999993ms
{"timings":{"total":2263.7039609999993,"sync":30.783353999999235,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":118.55902200000855,"oracles":{"callPrivateFunction":{"times":[789.2975399999996,178.68962399999873,55.61263499999768]}}},{"functionName":"private_kernel_init","time":55.07677200000035},{"functionName":"ContractClassRegisterer:register","time":765.042344999998,"oracles":{"loadCapsule":{"times":[6.069531000001007]},"notifyCreatedNullifier":{"times":[0.442124999997759]},"debugLog":{"times":[0.16773299999840674]},"notifyCreatedContractClassLog":{"times":[5.673530000000028]}}},{"functionName":"private_kernel_inner","time":93.90372299999945},{"functionName":"ContractInstanceDeployer:deploy","time":113.24794899999324,"oracles":{"storeInExecutionCache":{"times":[0.09665799999856972]},"callPrivateFunction":{"times":[66.11010800000076]},"notifyCreatedNullifier":{"times":[0.21416799999860814]},"debugLog":{"times":[0.13073000000076718]}}},{"functionName":"private_kernel_inner","time":120.40421699999933},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":46.31718600000386,"oracles":{}},{"functionName":"private_kernel_inner","time":126.87169100000028},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":43.35435999999754,"oracles":{"debugLog":{"times":[0.10912900000039372]}}},{"functionName":"private_kernel_inner","time":103.30905999999959},{"functionName":"private_kernel_reset","time":178.0547630000001},{"functionName":"private_kernel_tail","time":82.24588799999765}],"unaccounted":386.53363100000206}}
13:35:49 aztec-1 | [13:35:48.848]
INFO:
node Received tx 0x1002411e0f89f74d8475f5af812cf161ceac2a9a11381e3037c4722c0e50d3da
{"txHash":"0x1002411e0f89f74d8475f5af812cf161ceac2a9a11381e3037c4722c0e50d3da"}
13:35:49 aztec-1 | [13:35:48.848]
INFO:
pxe:service Sent transaction 0x1002411e0f89f74d8475f5af812cf161ceac2a9a11381e3037c4722c0e50d3da
13:35:49 aztec-1 | [13:35:48.973]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.041869203999998716s
{"duration":0.041869203999998716,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
13:35:49 aztec-1 | [13:35:49.013]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x1b7d719bf28ef65fb408c9c3675ba1a6df9a1e876314e0e9f0958c5c0779542b","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749822208,"version":2094187016},"txHashes":["0x1002411e0f89f74d8475f5af812cf161ceac2a9a11381e3037c4722c0e50d3da"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":92.95906899999682,"publicProcessDuration":42.19922000000224,"rollupCircuitsDuration":84.35594500000298,"txCount":1,"blockNumber":6,"blockTimestamp":1749822208,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
13:35:49 aztec-1 | [13:35:49.242]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
13:35:49 aztec-1 | [13:35:49.245]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
13:35:49 aztec-1 | [13:35:49.254]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
13:35:49 aztec-1 | [13:35:49.263]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749822244
13:35:49 aztec-1 | [13:35:49.263]
WARN:
foundation:test-date-provider Time set to 2025-06-13T13:44:04.000Z
{"offset":494737,"timeMs":1749822244000}
13:35:49 aztec-1 | [13:35:49.263]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
13:35:49 aztec-1 | [13:35:49.267]
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":"0x16c8863498caa84703408c64e6950db6e284ed60d816cf8088c34a8ee300e5a3","blocksSynchedTo":34,"currentL1BlockNumber":35,"provenBlockNumber":5,"provenArchive":"0x16c8863498caa84703408c64e6950db6e284ed60d816cf8088c34a8ee300e5a3","pendingBlockNumber":6,"pendingArchive":"0x25234d36c00923f7093ab05f500d7088ffdb2b68ed779579338a31d888eee66e"}
13:35:49 aztec-1 | [13:35:49.384]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x1b7d719bf28ef65fb408c9c3675ba1a6df9a1e876314e0e9f0958c5c0779542b","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749822208,"version":2094187016},"archiveRoot":"0x25234d36c00923f7093ab05f500d7088ffdb2b68ed779579338a31d888eee66e","archiveNextLeafIndex":7}
13:35:49 aztec-1 | [13:35:49.391]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
13:35:49 aztec-1 | [13:35:49.412]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":13.42940599999929,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749822208,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
13:35:49 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
13:35:50 aztec-1 | [13:35:49.875]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
13:35:50 aztec-1 | [13:35:49.884]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x2d2655c513c2e8feb8c7411b7e807c66287b57bb60572ce85ce1fe0a1e0c925d","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
13:35:58 playground-1 | \
13:35:58 playground-1 |
Running 1
test using 1
worker
13:35:58 playground-1 |
13:35:59 playground-1 |
✓ 1 [chromium] › browser.spec.ts:3:1 › test
(9.0s)
13:36:09 playground-1 |
1 passed (12.6s)
13:36:09 playground-1 | \
13:36:09
playground-1 exited with code 0
13:36:09 Aborting on container exit...
13:36:09 Container playground-chromium-playground-1 Stopping
13:36:09 Container playground-chromium-playground-1 Stopped
13:36:09 Container playground-chromium-aztec-1 Stopping
13:36:11 Container playground-chromium-aztec-1 Stopped
13:36:11 Container playground-chromium-ethereum-1 Stopping
13:36:11 Container playground-chromium-ethereum-1 Stopped