Parent Log:
http://ci.aztec-labs.com/f5e1a07a17e6d23e
Command: a53e792996799a82 playground/scripts/run_test.sh firefox
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/3b44f825dcd3249b2c8a1105905fa3394aa7213d
Env: REF_NAME=gh-readonly-queue/next/pr-15041-eeab628a4e44477cb6796c5a461ee0c0bb332d75 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Mon Jun 16 17:50:44 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15041_amd64_x1-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_23123200780498f7_next
17:50:44 Network playground-firefox_default Creating
17:50:44 Network playground-firefox_default Created
17:50:44 Container playground-firefox-ethereum-1 Creating
17:50:45 Container playground-firefox-ethereum-1 Created
17:50:45 Container playground-firefox-aztec-1 Creating
17:50:45 Container playground-firefox-aztec-1 Created
17:50:45 Container playground-firefox-playground-1 Creating
17:50:45 Container playground-firefox-playground-1 Created
17:50:45 Attaching to aztec-1, ethereum-1, playground-1
17:50:50 aztec-1 |
17:50:50 aztec-1 | _
17:50:50 aztec-1 | /\ | |
17:50:50 aztec-1 | / \ ___| |_ ___ ___
17:50:50 aztec-1 | / /\ \ |_ / __/ _ \/ __|
17:50:50 aztec-1 | / ____ \ / /| || __/ (__
17:50:50 aztec-1 | /_/___ \_\/___|\__\___|\___|
17:50:50 aztec-1 |
17:50:50 aztec-1 |
https://github.com/AztecProtocol
17:50:50 aztec-1 |
17:50:50 aztec-1 |
17:50:50 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
17:50:50 aztec-1 | Setting up test accounts
17:50:51 aztec-1 | [17:50:51.063]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-q1ncc2/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
17:50:51 aztec-1 | [17:50:51.359]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
17:50:51 aztec-1 | [17:50:51.364]
WARN:
sandbox Set block interval to 12
17:50:51 aztec-1 | [17:50:51.563]
INFO:
sandbox Waiting for 7 transactions to be mined...
17:50:51 aztec-1 | [17:50:51.586]
INFO:
sandbox All transactions mined successfully
17:50:51 aztec-1 | [17:50:51.677]
INFO:
sandbox Waiting for 9 transactions to be mined...
17:50:51 aztec-1 | [17:50:51.696]
INFO:
sandbox All transactions mined successfully
17:50:51 aztec-1 | [17:50:51.847]
INFO:
sandbox Waiting for 11 transactions to be mined...
17:50:51 aztec-1 | [17:50:51.872]
INFO:
sandbox All transactions mined successfully
17:50:51 aztec-1 | [17:50:51.932]
INFO:
sandbox Waiting for 12 transactions to be mined...
17:50:51 aztec-1 | [17:50:51.955]
INFO:
sandbox All transactions mined successfully
17:50:51 aztec-1 | [17:50:51.960]
INFO:
sandbox Waiting for 12 transactions to be mined...
17:50:51 aztec-1 | [17:50:51.987]
INFO:
sandbox All transactions mined successfully
17:50:52 aztec-1 | [17:50:52.003]
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"}
17:50:52 aztec-1 | [17:50:52.003]
INFO:
sandbox Handing over to governance
17:50:52 aztec-1 | [17:50:52.011]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
17:50:52 aztec-1 | [17:50:52.011]
INFO:
telemetry:client Using NoopTelemetryClient
17:50:52 aztec-1 | [17:50:52.011]
INFO:
blob-sink:client Creating local blob sink client.
17:50:52 aztec-1 | [17:50:52.016]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:50:52 aztec-1 | [17:50:52.016]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:55:33.000Z
{"offset":280984,"timeMs":1750096533000}
17:50:52 aztec-1 | [17:50:52.042]
INFO:
archiver:lmdb Starting data store with maxReaders 16
17:50:52 aztec-1 | [17:50:52.509]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x3a180351b797e80be02af37a2c1fa16239ac9d16932075bc1e0366200d17b95c
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x6b6b9c62a5ed31b9c66a7b303da2b03e1ce91a63e0b7628f2eb56619faf05dd2","l1BlockNumber":20}}
17:50:52 aztec-1 | [17:50:52.538]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x3a180351b797e80be02af37a2c1fa16239ac9d16932075bc1e0366200d17b95c","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
17:50:52 aztec-1 | [17:50:52.544]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-W5FPPg/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
17:50:52 aztec-1 | [17:50:52.793]
INFO:
world_state Created world state synchroniser with block history of 64
17:50:52 aztec-1 | [17:50:52.793]
WARN:
node Aztec node is accepting fake proofs
17:50:52 aztec-1 | [17:50:52.804]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
17:50:52 aztec-1 | [17:50:52.820]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
17:50:52 aztec-1 | [17:50:52.835]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
17:50:52 aztec-1 | [17:50:52.846]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
17:50:52 aztec-1 | [17:50:52.850]
INFO:
world_state Started world state synchronizer from block 1
17:50:53 aztec-1 | [17:50:52.853]
INFO:
p2p Starting p2p client from block 0 with empty mempools
17:50:53 aztec-1 | [17:50:53.087]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
17:50:53 aztec-1 | [17:50:53.129]
INFO:
slasher Starting Slasher client...
17:50:53 aztec-1 | [17:50:53.136]
INFO:
sequencer-client Deploying forwarder contract
17:50:53 aztec-1 | [17:50:53.153]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
17:50:53 aztec-1 | [17:50:53.159]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
17:50:53 aztec-1 | [17:50:53.159]
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}
17:50:53 aztec-1 | [17:50:53.161]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
17:50:53 aztec-1 | [17:50:53.161]
INFO:
node Aztec Node version: 0.87.6
17:50:53 aztec-1 | [17:50:53.161]
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"}
17:50:53 aztec-1 | [17:50:53.166]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
17:50:53 aztec-1 | [17:50:53.172]
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":1750096534,"syncedToL1Ts":1750096533,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750096521,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750096557},"newBlockNumber":1,"expectedSlot":1}
17:50:53 aztec-1 | [17:50:53.229]
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":1750096534,"syncedToL1Ts":1750096533,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750096521,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750096557},"newBlockNumber":1,"expectedSlot":1}
17:50:53 aztec-1 | [17:50:53.299]
WARN:
sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2.
{"now":1750096534,"syncedToL1Ts":1750096545,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750096521,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750096557},"newBlockNumber":1,"expectedSlot":1}
17:50:53 aztec-1 | [17:50:53.406]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:50:53 aztec-1 | [17:50:53.406]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:55:45.000Z
{"offset":291594,"timeMs":1750096545000}
17:50:53 aztec-1 | Setting up funded test accounts...
17:50:53 aztec-1 | [17:50:53.555]
INFO:
pxe:service Started PXE connected to chain 31337 version 3633326044
17:50:53 aztec-1 | [17:50:53.660]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
17:50:53 aztec-1 | [17:50:53.741]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
17:50:53 aztec-1 | [17:50:53.745]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
17:50:54 aztec-1 | [17:50:53.920]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
17:50:57 aztec-1 | [17:50:56.802]
INFO:
pxe:service Proving completed in 2835.7255780000005ms
{"timings":{"total":2835.7255780000005,"sync":18.062246999999843,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":172.50407500000074,"oracles":{"callPrivateFunction":{"times":[790.4346570000007,404.6059580000001,226.52020699999957]}}},{"functionName":"private_kernel_init","time":111.10953999999947},{"functionName":"ContractClassRegisterer:register","time":764.3699879999995,"oracles":{"loadCapsule":{"times":[15.078296999999111]},"notifyCreatedNullifier":{"times":[0.7997279999999591]},"debugLog":{"times":[0.4905799999996816]},"notifyCreatedContractClassLog":{"times":[6.628979000000982]}}},{"functionName":"private_kernel_inner","time":170.3846080000003},{"functionName":"SchnorrAccount:constructor","time":374.81475500000124,"oracles":{"getContractInstance":{"times":[6.649810000000798]},"debugLog":{"times":[0.3449609999988752,0.24613499999941268]},"fetchTaggedLogs":{"times":[70.26439100000061]},"loadCapsule":{"times":[2.8763229999985924,2.418214999999691,1.4648980000001757]},"validateEnqueuedNotesAndEvents":{"times":[7.516782999999123]},"notifyCreatedNullifier":{"times":[0.3805030000003171,0.4641279999996186]},"notifyCreatedNote":{"times":[0.6959119999992254]},"getRandomField":{"times":[0.342080000000351,0.33969100000103936,0.18379100000129256,0.31469899999865447,0.1758399999998801,0.13744799999949464,0.1189570000005915,0.09903599999961443,0.1114159999997355,0.17070000000057917,0.09127500000067812]},"getIndexedTaggingSecretAsSender":{"times":[46.431384999999864]},"incrementAppTaggingSecretIndexAsSender":{"times":[40.01741899999979]}}},{"functionName":"private_kernel_inner","time":140.79034599999977},{"functionName":"SchnorrAccount:entrypoint","time":203.48999999999978,"oracles":{"debugLog":{"times":[0.2741359999999986,0.12655799999993178,0.33152999999947497]},"fetchTaggedLogs":{"times":[45.3358989999997]},"loadCapsule":{"times":[0.22106299999904877,0.21323200000006182,0.15840899999966496]},"validateEnqueuedNotesAndEvents":{"times":[9.92338799999925]},"getNotes":{"times":[8.418016999999963]},"getAuthWitness":{"times":[0.3043980000002193]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.8438609999993787]}}},{"functionName":"private_kernel_inner","time":98.17669000000024},{"functionName":"private_kernel_reset","time":194.827999000001},{"functionName":"private_kernel_tail","time":91.6254059999992}],"unaccounted":495.56992399999945}}
17:50:57 aztec-1 | [17:50:56.927]
INFO:
node Received tx 0x21b3b561169a5832f68efce08f2665a1e71cd28057ff2b1d4e58f03a1a86a543
{"txHash":"0x21b3b561169a5832f68efce08f2665a1e71cd28057ff2b1d4e58f03a1a86a543"}
17:50:57 aztec-1 | [17:50:56.927]
INFO:
pxe:service Sent transaction 0x21b3b561169a5832f68efce08f2665a1e71cd28057ff2b1d4e58f03a1a86a543
17:50:57 aztec-1 | [17:50:57.027]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04558657400000084s
{"duration":0.04558657400000084,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
17:50:57 aztec-1 | [17:50:57.059]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x039c93427cc3f851b576502183bd5bbc23ce57b67fd302ee3b6b4554a7e74f18","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750096557,"version":3633326044},"txHashes":["0x21b3b561169a5832f68efce08f2665a1e71cd28057ff2b1d4e58f03a1a86a543"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":86.61654499999895,"publicProcessDuration":46.194680999999036,"rollupCircuitsDuration":79.24366100000043,"txCount":1,"blockNumber":1,"blockTimestamp":1750096557,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:51:00 aztec-1 | [17:50:59.857]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
17:51:00 aztec-1 | [17:50:59.859]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
17:51:00 aztec-1 | [17:50:59.860]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:51:00 aztec-1 | [17:50:59.975]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x039c93427cc3f851b576502183bd5bbc23ce57b67fd302ee3b6b4554a7e74f18","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750096557,"version":3633326044},"archiveRoot":"0x0499b1a8e2fcb5475497862ff8ac809f547476759deb81102c1e58cb82f2a0e8","archiveNextLeafIndex":2}
17:51:00 aztec-1 | [17:50:59.985]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
17:51:00 aztec-1 | [17:51:00.061]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:51:00 aztec-1 | [17:51:00.061]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:55:57.000Z
{"offset":296939,"timeMs":1750096557000}
17:51:00 aztec-1 | [17:51:00.065]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":26.43188199999895,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750096557,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:51:00 aztec-1 | [17:51:00.088]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096593
17:51:00 aztec-1 | [17:51:00.088]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:56:33.000Z
{"offset":332912,"timeMs":1750096593000}
17:51:00 aztec-1 | [17:51:00.088]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
17:51:00 aztec-1 | [17:51:00.102]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
17:51:00 aztec-1 | [17:51:00.214]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
17:51:02 aztec-1 | [17:51:01.935]
INFO:
pxe:service Proving completed in 1700.9444050000002ms
{"timings":{"total":1700.9444050000002,"sync":21.254909000001135,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":117.63468099999955,"oracles":{"callPrivateFunction":{"times":[320.82701500000076,289.70186099999955]}}},{"functionName":"private_kernel_init","time":85.34492799999862},{"functionName":"SchnorrAccount:constructor","time":295.8890929999998,"oracles":{"getContractInstance":{"times":[6.518732999998974]},"debugLog":{"times":[0.1483090000001539,0.11929699999927834]},"fetchTaggedLogs":{"times":[77.07323999999971]},"loadCapsule":{"times":[0.2656060000008438,0.2843670000002021,0.20638200000030338]},"validateEnqueuedNotesAndEvents":{"times":[5.775847999999314]},"notifyCreatedNullifier":{"times":[0.5063809999992372,0.1453090000013617]},"notifyCreatedNote":{"times":[0.21116299999994226]},"getRandomField":{"times":[0.16242899999997462,0.19225200000073528,0.045051999999486725,0.036921999999322,0.054333000000042375,0.04605300000002899,0.03743199999917124,0.034372000000075786,0.030861999999615364,0.034842000000935514,0.05017299999963143]},"getIndexedTaggingSecretAsSender":{"times":[54.77889799999866]},"incrementAppTaggingSecretIndexAsSender":{"times":[22.35966600000029]}}},{"functionName":"private_kernel_inner","time":158.1491700000006},{"functionName":"SchnorrAccount:entrypoint","time":248.80842900000061,"oracles":{"debugLog":{"times":[0.30356899999969755,0.13531899999907182,0.23772500000086438]},"fetchTaggedLogs":{"times":[101.19244199999957]},"loadCapsule":{"times":[0.2736860000004526,0.1937209999996412,0.16986999999971886]},"validateEnqueuedNotesAndEvents":{"times":[6.189892000000327]},"getNotes":{"times":[4.081904999999097]},"getAuthWitness":{"times":[0.4506170000004204]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6697609999991982]}}},{"functionName":"private_kernel_inner","time":121.868437000001},{"functionName":"private_kernel_reset","time":231.20524900000055},{"functionName":"private_kernel_tail","time":79.07626400000117}],"unaccounted":341.7132449999972}}
17:51:02 aztec-1 | [17:51:01.976]
INFO:
node Received tx 0x08ef277b271224216c04b6c54a0c5366085b02fe5054d59c9d5a824e4df3d849
{"txHash":"0x08ef277b271224216c04b6c54a0c5366085b02fe5054d59c9d5a824e4df3d849"}
17:51:02 aztec-1 | [17:51:01.976]
INFO:
pxe:service Sent transaction 0x08ef277b271224216c04b6c54a0c5366085b02fe5054d59c9d5a824e4df3d849
17:51:02 aztec-1 | [17:51:02.055]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.020348868999999468s
{"duration":0.020348868999999468,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
17:51:02 aztec-1 | [17:51:02.090]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2737fc83cbf320e765b50fd5690bfed4f3bddc935abdad3d28febc1d9ee5a463","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750096593,"version":3633326044},"txHashes":["0x08ef277b271224216c04b6c54a0c5366085b02fe5054d59c9d5a824e4df3d849"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":64.9418910000004,"publicProcessDuration":20.467225999998846,"rollupCircuitsDuration":60.200213999998596,"txCount":1,"blockNumber":2,"blockTimestamp":1750096593,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:51:02 aztec-1 | [17:51:02.358]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:51:02 aztec-1 | [17:51:02.372]
WARN:
archiver Failed to reach L2 block 2 at 27 (latest is 1). Rolling back last synched L1 block number to 26.
{"latestLocalL2BlockNumber":1,"latestLocalL2BlockArchive":"0x0499b1a8e2fcb5475497862ff8ac809f547476759deb81102c1e58cb82f2a0e8","blocksSynchedTo":26,"currentL1BlockNumber":27,"provenBlockNumber":1,"provenArchive":"0x0499b1a8e2fcb5475497862ff8ac809f547476759deb81102c1e58cb82f2a0e8","pendingBlockNumber":2,"pendingArchive":"0x01749dc808cc81352c71bf4c63d0cb78fe2d19dd4e119f24fb4fc3a952e47b1d"}
17:51:02 aztec-1 | [17:51:02.377]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:51:02 aztec-1 | [17:51:02.377]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:56:45.000Z
{"offset":342623,"timeMs":1750096605000}
17:51:02 aztec-1 | [17:51:02.379]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
17:51:02 aztec-1 | [17:51:02.381]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
17:51:02 aztec-1 | [17:51:02.401]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096629
17:51:02 aztec-1 | [17:51:02.401]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:57:09.000Z
{"offset":366599,"timeMs":1750096629000}
17:51:02 aztec-1 | [17:51:02.401]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
17:51:02 aztec-1 | [17:51:02.472]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2737fc83cbf320e765b50fd5690bfed4f3bddc935abdad3d28febc1d9ee5a463","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750096593,"version":3633326044},"archiveRoot":"0x01749dc808cc81352c71bf4c63d0cb78fe2d19dd4e119f24fb4fc3a952e47b1d","archiveNextLeafIndex":3}
17:51:02 aztec-1 | [17:51:02.481]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
17:51:02 aztec-1 | [17:51:02.507]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":15.247881000001144,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750096593,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:51:02 aztec-1 | [17:51:02.611]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
17:51:02 aztec-1 | [17:51:02.717]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
17:51:04 aztec-1 | [17:51:04.466]
INFO:
pxe:service Proving completed in 1741.054951000002ms
{"timings":{"total":1741.054951000002,"sync":25.301158000002033,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":86.26775800000178,"oracles":{"callPrivateFunction":{"times":[395.25401200000124,297.08526600000187]}}},{"functionName":"private_kernel_init","time":80.13290799999959},{"functionName":"SchnorrAccount:constructor","time":373.09095399999933,"oracles":{"getContractInstance":{"times":[5.244675999998435]},"debugLog":{"times":[0.14809800000148243,0.10948700000153622]},"fetchTaggedLogs":{"times":[115.99680300000182]},"loadCapsule":{"times":[0.18264199999975972,0.24869500000204425,0.21481300000232295]},"validateEnqueuedNotesAndEvents":{"times":[6.513902999999118]},"notifyCreatedNullifier":{"times":[0.3064589999994496,0.19177199999830918]},"notifyCreatedNote":{"times":[0.13064800000211108]},"getRandomField":{"times":[0.14948899999944842,0.22678299999824958,0.11514700000043376,0.13698800000202027,0.08854499999870313,0.0904049999990093,0.06919399999969755,0.07662399999753688,0.07489500000156113,0.08744500000102562,0.05183300000135205]},"getIndexedTaggingSecretAsSender":{"times":[57.016992000000755]},"incrementAppTaggingSecretIndexAsSender":{"times":[43.56898000000001]}}},{"functionName":"private_kernel_inner","time":154.42873300000065},{"functionName":"SchnorrAccount:entrypoint","time":266.59072399999786,"oracles":{"debugLog":{"times":[0.2027830000006361,0.06188300000212621,0.15030899999692338]},"fetchTaggedLogs":{"times":[105.81731800000125]},"loadCapsule":{"times":[0.1480089999968186,0.13799800000197138,0.12302700000145705]},"validateEnqueuedNotesAndEvents":{"times":[5.716435999998794]},"getNotes":{"times":[1.4537180000006629]},"getAuthWitness":{"times":[0.12071800000194344]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5487939999984519]}}},{"functionName":"private_kernel_inner","time":152.79836400000204},{"functionName":"private_kernel_reset","time":229.26360100000238},{"functionName":"private_kernel_tail","time":95.85720699999729}],"unaccounted":277.32354399999895}}
17:51:04 aztec-1 | [17:51:04.529]
INFO:
node Received tx 0x279afa64fc45ff1c8bd70b9929673bb97b1493834a3e34423f80c8dbf1ae87ea
{"txHash":"0x279afa64fc45ff1c8bd70b9929673bb97b1493834a3e34423f80c8dbf1ae87ea"}
17:51:04 aztec-1 | [17:51:04.529]
INFO:
pxe:service Sent transaction 0x279afa64fc45ff1c8bd70b9929673bb97b1493834a3e34423f80c8dbf1ae87ea
17:51:04 aztec-1 | [17:51:04.615]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02034740800000145s
{"duration":0.02034740800000145,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
17:51:04 aztec-1 | [17:51:04.639]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2203582e1438130a16a38859ca2889f45a79152d367b0d4715151bf594081505","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750096629,"version":3633326044},"txHashes":["0x279afa64fc45ff1c8bd70b9929673bb97b1493834a3e34423f80c8dbf1ae87ea"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":51.72207300000082,"publicProcessDuration":20.449655000000348,"rollupCircuitsDuration":46.11803400000281,"txCount":1,"blockNumber":3,"blockTimestamp":1750096629,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:51:04 aztec-1 | [17:51:04.848]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:51:04 aztec-1 | [17:51:04.898]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:51:04 aztec-1 | [17:51:04.899]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:57:21.000Z
{"offset":376102,"timeMs":1750096641000}
17:51:04 aztec-1 | [17:51:04.906]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
17:51:04 aztec-1 | [17:51:04.908]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
17:51:04 aztec-1 | [17:51:04.932]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096665
17:51:04 aztec-1 | [17:51:04.932]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:57:45.000Z
{"offset":400068,"timeMs":1750096665000}
17:51:04 aztec-1 | [17:51:04.932]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
17:51:04 aztec-1 | [17:51:04.937]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x2203582e1438130a16a38859ca2889f45a79152d367b0d4715151bf594081505","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750096629,"version":3633326044},"archiveRoot":"0x03501ac42568e187bd6bcff13bd767da64216190c9b5ccc7b33184ee37cb1cdf","archiveNextLeafIndex":4}
17:51:04 aztec-1 | [17:51:04.942]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
17:51:04 aztec-1 | Initial Accounts:
17:51:04 aztec-1 |
17:51:04 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
17:51:04 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
17:51:04 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
17:51:04 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
17:51:04 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
17:51:04 aztec-1 |
17:51:04 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
17:51:04 aztec-1 |
17:51:04 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
17:51:04 aztec-1 |
17:51:04 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
17:51:04 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
17:51:04 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
17:51:04 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
17:51:04 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
17:51:04 aztec-1 |
17:51:04 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
17:51:04 aztec-1 |
17:51:04 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
17:51:04 aztec-1 |
17:51:04 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
17:51:04 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
17:51:04 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
17:51:04 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
17:51:04 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
17:51:04 aztec-1 |
17:51:04 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
17:51:04 aztec-1 |
17:51:04 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
17:51:04 aztec-1 |
17:51:04 aztec-1 |
17:51:04 aztec-1 | [17:51:04.961]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":16.56006999999954,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750096629,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
17:51:06 aztec-1 | [17:51:05.786]
WARN:
pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata
17:51:06 aztec-1 | [17:51:05.786]
WARN:
pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata
17:51:06 aztec-1 | [17:51:05.790]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
17:51:06 aztec-1 | [17:51:05.812]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
17:51:07 aztec-1 | [17:51:06.682]
INFO:
pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2
17:51:07 aztec-1 | [17:51:06.685]
INFO:
pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164
17:51:10 aztec-1 | [17:51:09.167]
INFO:
pxe:service Proving completed in 2461.134033000002ms
{"timings":{"total":2461.134033000002,"sync":22.675948000000062,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":411.8341630000032,"oracles":{"debugLog":{"times":[0.22949399999924935,0.1256680000005872,0.10956599999917671,0.2488149999990128,0.11797700000170153,0.11386700000002747,0.10590600000068662,0.22343299999920418]},"fetchTaggedLogs":{"times":[131.08111400000053]},"loadCapsule":{"times":[0.2316240000000107,0.2250640000020212,0.36054199999853154,1.991939999999886,1.6193479999965348,0.6773319999992964,0.2887269999991986]},"getSharedSecret":{"times":[5.69874400000117]},"aes128Decrypt":{"times":[1.0572839999986172,0.7442649999975401]},"getPublicKeysAndPartialAddress":{"times":[5.931548000000475]},"getKeyValidationRequest":{"times":[2.0843949999980396]},"storeCapsule":{"times":[6.29033999999956,3.299369000000297,2.6908319999965897]},"deleteCapsule":{"times":[2.928406000002724]},"validateEnqueuedNotesAndEvents":{"times":[12.280151999999362]},"getNotes":{"times":[4.091546999999991]},"getAuthWitness":{"times":[0.21685300000171992]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.056943999999930384]},"callPrivateFunction":{"times":[815.3171430000002,136.21287400000074]},"notifyEnqueuedPublicFunctionCall":{"times":[0.4254560000008496]}}},{"functionName":"private_kernel_init","time":63.32387299999755},{"functionName":"ContractClassRegisterer:register","time":796.0633600000001,"oracles":{"loadCapsule":{"times":[3.724115000000893]},"notifyCreatedNullifier":{"times":[0.5209409999988566]},"debugLog":{"times":[0.17852100000163773]},"notifyCreatedContractClassLog":{"times":[4.866173999998864]}}},{"functionName":"private_kernel_inner","time":133.90017300000181},{"functionName":"ContractInstanceDeployer:deploy","time":81.0225010000031,"oracles":{"storeInExecutionCache":{"times":[0.3769929999980377]},"callPrivateFunction":{"times":[52.464617999998154]},"notifyCreatedNullifier":{"times":[0.31086900000082096]},"debugLog":{"times":[0.18267099999866332]}}},{"functionName":"private_kernel_inner","time":93.07494899999801},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":36.717146999999386,"oracles":{}},{"functionName":"private_kernel_inner","time":93.78665199999887},{"functionName":"private_kernel_reset","time":219.71291500000007},{"functionName":"private_kernel_tail","time":112.05503400000089}],"unaccounted":396.96731799999907}}
17:51:10 aztec-1 | [17:51:09.343]
INFO:
node Received tx 0x1887630e648be64eb63db8ed89444209a7f3b2402f40d18833b71cb75bdd1e6f
{"txHash":"0x1887630e648be64eb63db8ed89444209a7f3b2402f40d18833b71cb75bdd1e6f"}
17:51:10 aztec-1 | [17:51:09.343]
INFO:
pxe:service Sent transaction 0x1887630e648be64eb63db8ed89444209a7f3b2402f40d18833b71cb75bdd1e6f
17:51:13 aztec-1 | [17:51:12.165]
INFO:
pxe:service Proving completed in 2997.047097999999ms
{"timings":{"total":2997.047097999999,"sync":133.65661900000123,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":588.0355490000038,"oracles":{"debugLog":{"times":[0.257075999998051,0.14135799999712617,0.0977759999987029,0.3183790000002773,0.12986799999998766,0.11508699999831151,0.10495600000285776,0.24772500000108266]},"fetchTaggedLogs":{"times":[252.39392800000132]},"loadCapsule":{"times":[0.5260620000008203,0.20954300000084913,2.56537500000195,0.3810929999999644,1.6238180000000284,0.43683599999712897,0.4100350000007893]},"getSharedSecret":{"times":[6.360514999996667]},"aes128Decrypt":{"times":[0.2977179999979853,0.5687749999997322]},"getPublicKeysAndPartialAddress":{"times":[4.962319999998726]},"getKeyValidationRequest":{"times":[10.600959999999759]},"storeCapsule":{"times":[2.6068969999978435,72.2641029999977,3.55277400000341]},"deleteCapsule":{"times":[3.959298999998282]},"validateEnqueuedNotesAndEvents":{"times":[20.524640000003274]},"getNotes":{"times":[3.3091700000004494]},"getAuthWitness":{"times":[0.28508700000020326]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09799600000042119]},"callPrivateFunction":{"times":[821.5872400000007,200.1392220000016]},"notifyEnqueuedPublicFunctionCall":{"times":[0.1138070000015432]}}},{"functionName":"private_kernel_init","time":74.71351100000174},{"functionName":"ContractClassRegisterer:register","time":790.0782189999954,"oracles":{"loadCapsule":{"times":[2.408565000001545]},"notifyCreatedNullifier":{"times":[0.3814429999983986]},"debugLog":{"times":[0.10373700000127428]},"notifyCreatedContractClassLog":{"times":[2.942207000000053]}}},{"functionName":"private_kernel_inner","time":136.18522200000007},{"functionName":"ContractInstanceDeployer:deploy","time":135.54040299999906,"oracles":{"storeInExecutionCache":{"times":[0.0926949999993667]},"callPrivateFunction":{"times":[62.30501199999708]},"notifyCreatedNullifier":{"times":[0.2660759999998845]},"debugLog":{"times":[0.1053570000003674]}}},{"functionName":"private_kernel_inner","time":114.51672399999734},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":47.98145700000168,"oracles":{}},{"functionName":"private_kernel_inner","time":153.8947909999988},{"functionName":"private_kernel_reset","time":262.7428519999994},{"functionName":"private_kernel_tail","time":125.87106900000072}],"unaccounted":433.8306819999998}}
17:51:13 aztec-1 | [17:51:12.324]
INFO:
node Received tx 0x1220c132c5c7aae0b5fdec02be4fd11c23e17dfdfd025a41077ef78e9b60074e
{"txHash":"0x1220c132c5c7aae0b5fdec02be4fd11c23e17dfdfd025a41077ef78e9b60074e"}
17:51:13 aztec-1 | [17:51:12.324]
INFO:
pxe:service Sent transaction 0x1220c132c5c7aae0b5fdec02be4fd11c23e17dfdfd025a41077ef78e9b60074e
17:51:13 aztec-1 | [17:51:12.335]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 2.8335922790000003s
{"duration":2.8335922790000003,"rate":111678.73456786758,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064}
17:51:13 aztec-1 | [17:51:12.394]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 108801.93674901388 mana/s
{"blockHash":"0x026e14b1b40cf165bf38d6ffa9352286fd6300e90780670216ce6fcbabb55d5a","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750096665,"version":3633326044},"txHashes":["0x1887630e648be64eb63db8ed89444209a7f3b2402f40d18833b71cb75bdd1e6f"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2908.4220970000024,"publicProcessDuration":2833.7364880000023,"rollupCircuitsDuration":2901.5498929999994,"txCount":1,"blockNumber":4,"blockTimestamp":1750096665,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
17:51:13 aztec-1 | [17:51:12.659]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:51:13 aztec-1 | [17:51:12.661]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:51:13 aztec-1 | [17:51:12.661]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:57:57.000Z
{"offset":404339,"timeMs":1750096677000}
17:51:13 aztec-1 | [17:51:12.661]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
17:51:13 aztec-1 | [17:51:12.663]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
17:51:13 aztec-1 | [17:51:12.712]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096701
17:51:13 aztec-1 | [17:51:12.712]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:58:21.000Z
{"offset":428288,"timeMs":1750096701000}
17:51:13 aztec-1 | [17:51:12.712]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
17:51:13 aztec-1 | [17:51:12.831]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x026e14b1b40cf165bf38d6ffa9352286fd6300e90780670216ce6fcbabb55d5a","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750096665,"version":3633326044},"archiveRoot":"0x1cb7b267685aa6acb7ed786280877b0bb7b76d7da7e67410afbf85de6ccf2e13","archiveNextLeafIndex":5}
17:51:13 aztec-1 | [17:51:12.836]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
17:51:13 aztec-1 | [17:51:12.903]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":15.115583000002516,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750096665,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
17:51:13 aztec-1 | [17:51:13.128]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.16261205700000209s
{"duration":0.16261205700000209,"rate":244698.95242761422,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768}
17:51:13 aztec-1 | [17:51:13.160]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 195769.33276526473 mana/s
{"blockHash":"0x150861abff8dc0be450c44317e0425b7ab6fd875543abd875e10657c460c4dc5","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750096701,"version":3633326044},"txHashes":["0x1220c132c5c7aae0b5fdec02be4fd11c23e17dfdfd025a41077ef78e9b60074e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":203.2231389999979,"publicProcessDuration":162.97249899999952,"rollupCircuitsDuration":197.42491899999732,"txCount":1,"blockNumber":5,"blockTimestamp":1750096701,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
17:51:13 aztec-1 | [17:51:13.466]
INFO:
aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed.
17:51:13 aztec-1 | [17:51:13.658]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:51:13 aztec-1 | [17:51:13.678]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
17:51:13 aztec-1 | [17:51:13.678]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:58:33.000Z
{"offset":439322,"timeMs":1750096713000}
17:51:13 aztec-1 | [17:51:13.681]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
17:51:13 aztec-1 | [17:51:13.683]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
17:51:13 aztec-1 | [17:51:13.706]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096737
17:51:13 aztec-1 | [17:51:13.706]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:58:57.000Z
{"offset":463294,"timeMs":1750096737000}
17:51:13 aztec-1 | [17:51:13.706]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
17:51:13 aztec-1 | [17:51:13.778]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x150861abff8dc0be450c44317e0425b7ab6fd875543abd875e10657c460c4dc5","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750096701,"version":3633326044},"archiveRoot":"0x1e9d9da1d6932b03ceefbafdf72c874cf9e365aefdccbb767cab53218a742619","archiveNextLeafIndex":6}
17:51:13 aztec-1 | [17:51:13.783]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
17:51:13 aztec-1 | [17:51:13.843]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":15.53411799999958,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750096701,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
17:51:14 aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
17:51:14 aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
17:51:14 aztec-1 | [17:51:14.516]
INFO:
aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed.
17:51:14 aztec-1 | [17:51:14.548]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
17:51:14 aztec-1 | [17:51:14.551]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
17:51:14 aztec-1 | [17:51:14.687]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
17:51:17 aztec-1 | [17:51:17.215]
INFO:
pxe:service Proving completed in 2505.9751509999987ms
{"timings":{"total":2505.9751509999987,"sync":27.578405000000203,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":84.82939100000294,"oracles":{"callPrivateFunction":{"times":[838.6715030000014,162.94216700000106,48.9476250000007]}}},{"functionName":"private_kernel_init","time":65.42957000000024},{"functionName":"ContractClassRegisterer:register","time":823.1326440000048,"oracles":{"loadCapsule":{"times":[3.2959889999983716]},"notifyCreatedNullifier":{"times":[0.62022799999977]},"debugLog":{"times":[0.21340300000156276]},"notifyCreatedContractClassLog":{"times":[5.708913999998913]}}},{"functionName":"private_kernel_inner","time":133.7813660000029},{"functionName":"ContractInstanceDeployer:deploy","time":86.79914999999892,"oracles":{"storeInExecutionCache":{"times":[0.08972599999833619]},"callPrivateFunction":{"times":[77.62179600000309]},"notifyCreatedNullifier":{"times":[0.222514000000956]},"debugLog":{"times":[0.19584199999735574]}}},{"functionName":"private_kernel_inner","time":133.32907999999952},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":61.816601999998966,"oracles":{}},{"functionName":"private_kernel_inner","time":158.18884099999923},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":38.24486900000193,"oracles":{"debugLog":{"times":[0.207312999998976]}}},{"functionName":"private_kernel_inner","time":146.85202500000014},{"functionName":"private_kernel_reset","time":230.71566900000107},{"functionName":"private_kernel_tail","time":98.9791359999981}],"unaccounted":416.2984029999898}}
17:51:17 aztec-1 | [17:51:17.350]
INFO:
node Received tx 0x1d6f04d6d6d397b6a462f07e79aeed6b2331e42bed363a0a6b9567f36873cf92
{"txHash":"0x1d6f04d6d6d397b6a462f07e79aeed6b2331e42bed363a0a6b9567f36873cf92"}
17:51:17 aztec-1 | [17:51:17.350]
INFO:
pxe:service Sent transaction 0x1d6f04d6d6d397b6a462f07e79aeed6b2331e42bed363a0a6b9567f36873cf92
17:51:17 aztec-1 | [17:51:17.468]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02558971500000189s
{"duration":0.02558971500000189,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
17:51:17 aztec-1 | [17:51:17.498]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x20014c4d9bca8b32b82cc7e728898ae1c346132dd38d32c2151671e0e4bb65ee","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750096737,"version":3633326044},"txHashes":["0x1d6f04d6d6d397b6a462f07e79aeed6b2331e42bed363a0a6b9567f36873cf92"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":64.1436219999996,"publicProcessDuration":25.688720999998623,"rollupCircuitsDuration":58.38001400000212,"txCount":1,"blockNumber":6,"blockTimestamp":1750096737,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:51:17 aztec-1 | [17:51:17.716]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
17:51:17 aztec-1 | [17:51:17.717]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
17:51:17 aztec-1 | [17:51:17.719]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
17:51:17 aztec-1 | [17:51:17.733]
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":"0x1e9d9da1d6932b03ceefbafdf72c874cf9e365aefdccbb767cab53218a742619","blocksSynchedTo":34,"currentL1BlockNumber":35,"provenBlockNumber":5,"provenArchive":"0x1e9d9da1d6932b03ceefbafdf72c874cf9e365aefdccbb767cab53218a742619","pendingBlockNumber":6,"pendingArchive":"0x0cbb5fa9020c422e049bd556c447a2e7623eab2ed375dea7abe8c112538e5dc3"}
17:51:17 aztec-1 | [17:51:17.761]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750096773
17:51:17 aztec-1 | [17:51:17.762]
WARN:
foundation:test-date-provider Time set to 2025-06-16T17:59:33.000Z
{"offset":495239,"timeMs":1750096773000}
17:51:17 aztec-1 | [17:51:17.762]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
17:51:17 aztec-1 | [17:51:17.842]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x20014c4d9bca8b32b82cc7e728898ae1c346132dd38d32c2151671e0e4bb65ee","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750096737,"version":3633326044},"archiveRoot":"0x0cbb5fa9020c422e049bd556c447a2e7623eab2ed375dea7abe8c112538e5dc3","archiveNextLeafIndex":7}
17:51:17 aztec-1 | [17:51:17.848]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
17:51:17 aztec-1 | [17:51:17.879]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":14.977584000000206,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750096737,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
17:51:18 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
17:51:18 aztec-1 | [17:51:18.382]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
17:51:18 aztec-1 | [17:51:18.389]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x27f24d2a1e99e49d4a27746a8374185b307a07325d0d743c1df56a03e39788d2","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
17:51:27 playground-1 | \
17:51:27 playground-1 |
Running 1
test using 1
worker
17:51:27 playground-1 |
17:51:28 playground-1 |
✓ 1 [firefox] › browser.spec.ts:3:1 › test
(12.1s)
17:51:42 playground-1 |
1 passed (17.0s)
17:51:42 playground-1 | \
npm notice
17:51:42 playground-1 |
npm notice New
major version of npm available!
10.9.2 ->
11.4.2
17:51:42 playground-1 |
npm notice Changelog:
https://github.com/npm/cli/releases/tag/v11.4.2
17:51:42 playground-1 |
npm notice To update run:
npm install -g npm@11.4.2
17:51:42 playground-1 |
npm notice
17:51:42 playground-1 | \
17:51:42
playground-1 exited with code 0
17:51:42 Aborting on container exit...
17:51:42 Container playground-firefox-playground-1 Stopping
17:51:42 Container playground-firefox-playground-1 Stopped
17:51:42 Container playground-firefox-aztec-1 Stopping
17:51:44 Container playground-firefox-aztec-1 Stopped
17:51:44 Container playground-firefox-ethereum-1 Stopping
17:51:44 Container playground-firefox-ethereum-1 Stopped