Parent Log:
http://ci.aztec-labs.com/78cea4cf271fb3a9
Command: 1c931b55a10f200e playground/scripts/run_test.sh chromium
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/76ca48a2187e3506bb464eae574e49476c2876ca
Env: REF_NAME=gh-readonly-queue/next/pr-15045-9d6fb0bd1594726370a5f3a56591963452264642 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Fri Jun 13 18:08:58 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15045_amd64_x2-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_3af8716c4dfeb01b_next
18:08:58 Network playground-chromium_default Creating
18:08:58 Network playground-chromium_default Created
18:08:58 Container playground-chromium-ethereum-1 Creating
18:08:59 Container playground-chromium-ethereum-1 Created
18:08:59 Container playground-chromium-aztec-1 Creating
18:09:00 Container playground-chromium-aztec-1 Created
18:09:00 Container playground-chromium-playground-1 Creating
18:09:01 Container playground-chromium-playground-1 Created
18:09:01 Attaching to aztec-1, ethereum-1, playground-1
18:09:06 aztec-1 |
18:09:06 aztec-1 | _
18:09:06 aztec-1 | /\ | |
18:09:06 aztec-1 | / \ ___| |_ ___ ___
18:09:06 aztec-1 | / /\ \ |_ / __/ _ \/ __|
18:09:06 aztec-1 | / ____ \ / /| || __/ (__
18:09:06 aztec-1 | /_/___ \_\/___|\__\___|\___|
18:09:06 aztec-1 |
18:09:06 aztec-1 |
https://github.com/AztecProtocol
18:09:06 aztec-1 |
18:09:06 aztec-1 |
18:09:06 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
18:09:06 aztec-1 | Setting up test accounts
18:09:08 aztec-1 | [18:09:07.344]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-Pw9pxq/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
18:09:08 aztec-1 | [18:09:07.640]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
18:09:08 aztec-1 | [18:09:07.657]
WARN:
sandbox Set block interval to 12
18:09:08 aztec-1 | [18:09:07.865]
INFO:
sandbox Waiting for 7 transactions to be mined...
18:09:08 aztec-1 | [18:09:07.884]
INFO:
sandbox All transactions mined successfully
18:09:08 aztec-1 | [18:09:07.969]
INFO:
sandbox Waiting for 9 transactions to be mined...
18:09:08 aztec-1 | [18:09:07.988]
INFO:
sandbox All transactions mined successfully
18:09:08 aztec-1 | [18:09:08.162]
INFO:
sandbox Waiting for 11 transactions to be mined...
18:09:08 aztec-1 | [18:09:08.189]
INFO:
sandbox All transactions mined successfully
18:09:08 aztec-1 | [18:09:08.259]
INFO:
sandbox Waiting for 12 transactions to be mined...
18:09:08 aztec-1 | [18:09:08.292]
INFO:
sandbox All transactions mined successfully
18:09:08 aztec-1 | [18:09:08.299]
INFO:
sandbox Waiting for 12 transactions to be mined...
18:09:08 aztec-1 | [18:09:08.329]
INFO:
sandbox All transactions mined successfully
18:09:08 aztec-1 | [18:09:08.348]
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"}
18:09:08 aztec-1 | [18:09:08.349]
INFO:
sandbox Handing over to governance
18:09:08 aztec-1 | [18:09:08.358]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
18:09:08 aztec-1 | [18:09:08.359]
INFO:
telemetry:client Using NoopTelemetryClient
18:09:08 aztec-1 | [18:09:08.359]
INFO:
blob-sink:client Creating local blob sink client.
18:09:08 aztec-1 | [18:09:08.365]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
18:09:08 aztec-1 | [18:09:08.365]
WARN:
foundation:test-date-provider Time set to 2025-06-13T18:13:50.000Z
{"offset":281635,"timeMs":1749838430000}
18:09:08 aztec-1 | [18:09:08.396]
INFO:
archiver:lmdb Starting data store with maxReaders 16
18:09:08 aztec-1 | [18:09:08.794]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xf592ea1126d92a0eeab67e7b7170df9dbbc0790087263720d71a6ee685032e26
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x0123a5d19210c58a5e2b175b389d0f7a324c96431c7a010ca4be59085e7ceef7","l1BlockNumber":20}}
18:09:08 aztec-1 | [18:09:08.819]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xf592ea1126d92a0eeab67e7b7170df9dbbc0790087263720d71a6ee685032e26","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
18:09:09 aztec-1 | [18:09:08.828]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-SpN4U5/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
18:09:09 aztec-1 | [18:09:09.037]
INFO:
world_state Created world state synchroniser with block history of 64
18:09:09 aztec-1 | [18:09:09.037]
WARN:
node Aztec node is accepting fake proofs
18:09:09 aztec-1 | [18:09:09.049]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
18:09:09 aztec-1 | [18:09:09.063]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
18:09:09 aztec-1 | [18:09:09.076]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
18:09:09 aztec-1 | [18:09:09.089]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
18:09:09 aztec-1 | [18:09:09.102]
INFO:
world_state Started world state synchronizer from block 1
18:09:09 aztec-1 | [18:09:09.107]
INFO:
p2p Starting p2p client from block 0 with empty mempools
18:09:09 aztec-1 | [18:09:09.382]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
18:09:09 aztec-1 | [18:09:09.445]
INFO:
slasher Starting Slasher client...
18:09:09 aztec-1 | [18:09:09.456]
INFO:
sequencer-client Deploying forwarder contract
18:09:09 aztec-1 | [18:09:09.476]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
18:09:09 aztec-1 | [18:09:09.482]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
18:09:09 aztec-1 | [18:09:09.483]
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}
18:09:09 aztec-1 | [18:09:09.485]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
18:09:09 aztec-1 | [18:09:09.486]
INFO:
node Aztec Node version: 0.87.6
18:09:09 aztec-1 | [18:09:09.486]
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"}
18:09:09 aztec-1 | [18:09:09.491]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
18:09:09 aztec-1 | [18:09:09.509]
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":1749838431,"syncedToL1Ts":1749838430,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1749838418,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1749838454},"newBlockNumber":1,"expectedSlot":1}
18:09:09 aztec-1 | [18:09:09.587]
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":1749838431,"syncedToL1Ts":1749838430,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1749838418,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1749838454},"newBlockNumber":1,"expectedSlot":1}
18:09:09 aztec-1 | [18:09:09.648]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
18:09:09 aztec-1 | [18:09:09.648]
WARN:
foundation:test-date-provider Time set to 2025-06-13T18:14:02.000Z
{"offset":292352,"timeMs":1749838442000}
18:09:09 aztec-1 | Setting up funded test accounts...
18:09:10 aztec-1 | [18:09:09.953]
INFO:
pxe:service Started PXE connected to chain 31337 version 1516729127
18:09:10 aztec-1 | [18:09:10.043]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
18:09:10 aztec-1 | [18:09:10.124]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
18:09:10 aztec-1 | [18:09:10.126]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
18:09:10 aztec-1 | [18:09:10.306]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
18:09:13 aztec-1 | [18:09:13.139]
INFO:
pxe:service Proving completed in 2789.1650900000004ms
{"timings":{"total":2789.1650900000004,"sync":6.040451999999277,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":182.06290399999762,"oracles":{"callPrivateFunction":{"times":[900.7728970000007,449.0750740000003,255.8423500000008]}}},{"functionName":"private_kernel_init","time":79.7214669999994},{"functionName":"ContractClassRegisterer:register","time":873.3877600000005,"oracles":{"loadCapsule":{"times":[40.50413099999969]},"notifyCreatedNullifier":{"times":[2.1026959999999235]},"debugLog":{"times":[0.7279789999993227]},"notifyCreatedContractClassLog":{"times":[17.970853999999235]}}},{"functionName":"private_kernel_inner","time":117.18343500000083},{"functionName":"SchnorrAccount:constructor","time":421.7089560000022,"oracles":{"getContractInstance":{"times":[9.310699999999997]},"debugLog":{"times":[0.49854400000003807,0.4014999999999418]},"fetchTaggedLogs":{"times":[86.22575200000028]},"loadCapsule":{"times":[4.1673420000006445,1.0689189999993687,7.3221470000007685]},"validateEnqueuedNotesAndEvents":{"times":[22.599127999999837]},"notifyCreatedNullifier":{"times":[0.5642149999985122,0.3069679999989603]},"notifyCreatedNote":{"times":[1.2669340000011289]},"getRandomField":{"times":[0.6135269999995216,0.2895279999993363,0.056692000000111875,0.18848499999876367,0.08032199999979639,0.0676820000007865,0.05416200000036042,0.07315199999902688,0.04254100000071048,0.07535199999983888,0.04202100000111386]},"getIndexedTaggingSecretAsSender":{"times":[53.703575999999885]},"incrementAppTaggingSecretIndexAsSender":{"times":[34.13639999999941]}}},{"functionName":"private_kernel_inner","time":138.56646100000034},{"functionName":"SchnorrAccount:entrypoint","time":228.954925,"oracles":{"debugLog":{"times":[0.2507869999990362,0.14957399999912013,0.3696399999989808]},"fetchTaggedLogs":{"times":[70.47840800000085]},"loadCapsule":{"times":[0.40352100000018254,0.6586179999994783,1.120600000000195]},"validateEnqueuedNotesAndEvents":{"times":[11.853209000000788]},"getNotes":{"times":[7.17793299999903]},"getAuthWitness":{"times":[0.3592900000003283]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.3221249999987776]}}},{"functionName":"private_kernel_inner","time":94.03620300000148},{"functionName":"private_kernel_reset","time":149.6668499999996},{"functionName":"private_kernel_tail","time":62.91343400000005}],"unaccounted":434.92224299999907}}
18:09:13 aztec-1 | [18:09:13.237]
INFO:
node Received tx 0x0729cd5ccd6b90babf075a31fa8400ddc39179d1d110468768b7fe7dc04c1793
{"txHash":"0x0729cd5ccd6b90babf075a31fa8400ddc39179d1d110468768b7fe7dc04c1793"}
18:09:13 aztec-1 | [18:09:13.238]
INFO:
pxe:service Sent transaction 0x0729cd5ccd6b90babf075a31fa8400ddc39179d1d110468768b7fe7dc04c1793
18:09:13 aztec-1 | [18:09:13.336]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04356954300000143s
{"duration":0.04356954300000143,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
18:09:13 aztec-1 | [18:09:13.358]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x139558854654295192acfa255aa2f7cd9cf79d91607a33b48f1bb111edf24cf7","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749838454,"version":1516729127},"txHashes":["0x0729cd5ccd6b90babf075a31fa8400ddc39179d1d110468768b7fe7dc04c1793"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":76.79468799999995,"publicProcessDuration":44.309663,"rollupCircuitsDuration":68.36610100000144,"txCount":1,"blockNumber":1,"blockTimestamp":1749838454,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
18:09:16 aztec-1 | [18:09:16.183]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
18:09:16 aztec-1 | [18:09:16.187]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
18:09:16 aztec-1 | [18:09:16.190]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:09:16 aztec-1 | [18:09:16.195]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749838490
18:09:16 aztec-1 | [18:09:16.195]
WARN:
foundation:test-date-provider Time set to 2025-06-13T18:14:50.000Z
{"offset":333805,"timeMs":1749838490000}
18:09:16 aztec-1 | [18:09:16.195]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
18:09:16 aztec-1 | [18:09:16.282]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x139558854654295192acfa255aa2f7cd9cf79d91607a33b48f1bb111edf24cf7","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749838454,"version":1516729127},"archiveRoot":"0x095fdcc3766532b5466f1f6a4f8a125f67cd28e1cebc14f248d6444fcade695b","archiveNextLeafIndex":2}
18:09:16 aztec-1 | [18:09:16.291]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
18:09:16 aztec-1 | [18:09:16.340]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":18.50351899999987,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749838454,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
18:09:16 aztec-1 | [18:09:16.473]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
18:09:16 aztec-1 | [18:09:16.609]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
18:09:18 aztec-1 | [18:09:18.353]
INFO:
pxe:service Proving completed in 1715.4999169999992ms
{"timings":{"total":1715.4999169999992,"sync":30.680296000000453,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":108.7324469999985,"oracles":{"callPrivateFunction":{"times":[376.44649799999934,314.270892999999]}}},{"functionName":"private_kernel_init","time":75.6060260000013},{"functionName":"SchnorrAccount:constructor","time":356.84031999999934,"oracles":{"getContractInstance":{"times":[5.494318000000931]},"debugLog":{"times":[0.1602549999988696,0.12385400000130176]},"fetchTaggedLogs":{"times":[89.99223300000085]},"loadCapsule":{"times":[0.22650699999940116,0.1998459999995248,0.15227500000037253]},"validateEnqueuedNotesAndEvents":{"times":[7.72878800000035]},"notifyCreatedNullifier":{"times":[0.18236500000057276,0.25846699999965494]},"notifyCreatedNote":{"times":[0.14349399999991874]},"getRandomField":{"times":[0.11769400000048336,0.23511599999983446,0.08928299999934097,0.05021100000158185,0.045820999999705236,0.031340999999883934,0.052942000000257394,0.03798099999949045,0.03552100000160863,0.04242100000010396,0.06628199999977369]},"getIndexedTaggingSecretAsSender":{"times":[74.51394599999912]},"incrementAppTaggingSecretIndexAsSender":{"times":[44.53317900000002]}}},{"functionName":"private_kernel_inner","time":100.28923000000032},{"functionName":"SchnorrAccount:entrypoint","time":276.4439050000019,"oracles":{"debugLog":{"times":[0.2925580000010086,0.09401200000138488,0.18963499999881606]},"fetchTaggedLogs":{"times":[103.3264620000009]},"loadCapsule":{"times":[0.2255860000004759,0.17648499999995693,0.19719499999882828]},"validateEnqueuedNotesAndEvents":{"times":[5.763474999999744]},"getNotes":{"times":[1.2680939999991097]},"getAuthWitness":{"times":[0.19438499999887426]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5256339999996271]}}},{"functionName":"private_kernel_inner","time":140.56469500000094},{"functionName":"private_kernel_reset","time":232.07772999999906},{"functionName":"private_kernel_tail","time":93.79637600000024}],"unaccounted":300.46889199999714}}
18:09:18 aztec-1 | [18:09:18.418]
INFO:
node Received tx 0x1341cc67348bb070fc6cddbbbafab96db6c361398152e776fa7461e1ff823323
{"txHash":"0x1341cc67348bb070fc6cddbbbafab96db6c361398152e776fa7461e1ff823323"}
18:09:18 aztec-1 | [18:09:18.418]
INFO:
pxe:service Sent transaction 0x1341cc67348bb070fc6cddbbbafab96db6c361398152e776fa7461e1ff823323
18:09:18 aztec-1 | [18:09:18.515]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.023639446000001042s
{"duration":0.023639446000001042,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
18:09:18 aztec-1 | [18:09:18.556]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x1dfa94fce0a2e8a4ad698f46e0764287cff86bcd1f503ea45d46e0586b0bc3b1","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749838490,"version":1516729127},"txHashes":["0x1341cc67348bb070fc6cddbbbafab96db6c361398152e776fa7461e1ff823323"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":72.34493900000052,"publicProcessDuration":23.814421999999468,"rollupCircuitsDuration":66.20036299999992,"txCount":1,"blockNumber":2,"blockTimestamp":1749838490,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
18:09:18 aztec-1 | [18:09:18.800]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
18:09:18 aztec-1 | [18:09:18.806]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
18:09:18 aztec-1 | [18:09:18.809]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:09:18 aztec-1 | [18:09:18.847]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749838526
18:09:18 aztec-1 | [18:09:18.847]
WARN:
foundation:test-date-provider Time set to 2025-06-13T18:15:26.000Z
{"offset":367153,"timeMs":1749838526000}
18:09:18 aztec-1 | [18:09:18.847]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
18:09:18 aztec-1 | [18:09:18.911]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x1dfa94fce0a2e8a4ad698f46e0764287cff86bcd1f503ea45d46e0586b0bc3b1","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749838490,"version":1516729127},"archiveRoot":"0x1cf79245f2b9fdcfc1eabead2b11a92fac5e2ea71ae1f9f2a1925017e151f636","archiveNextLeafIndex":3}
18:09:18 aztec-1 | [18:09:18.915]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
18:09:18 aztec-1 | [18:09:18.964]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":15.307991999998194,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749838490,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
18:09:19 aztec-1 | [18:09:19.093]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
18:09:19 aztec-1 | [18:09:19.247]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
18:09:21 aztec-1 | [18:09:20.845]
INFO:
pxe:service Proving completed in 1586.0880519999992ms
{"timings":{"total":1586.0880519999992,"sync":37.135369999999966,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":106.73826400000326,"oracles":{"callPrivateFunction":{"times":[366.3151050000015,193.69507599999997]}}},{"functionName":"private_kernel_init","time":71.67004000000088},{"functionName":"SchnorrAccount:constructor","time":333.8596209999996,"oracles":{"getContractInstance":{"times":[7.655856000001222]},"debugLog":{"times":[0.16823399999702815,0.08169199999974808]},"fetchTaggedLogs":{"times":[96.091338000002]},"loadCapsule":{"times":[0.17371400000047288,0.15882499999861466,0.16603499999837368]},"validateEnqueuedNotesAndEvents":{"times":[6.475534000001062]},"notifyCreatedNullifier":{"times":[0.17943400000149268,0.22575599999981932]},"notifyCreatedNote":{"times":[0.11929299999974319]},"getRandomField":{"times":[0.13478400000167312,0.16100400000141235,0.0636819999999716,0.03714100000070175,0.07863200000065262,0.03612099999736529,0.027430999998614425,0.029450999998516636,0.04856199999994715,0.03131100000246079,0.03158099999927799]},"getIndexedTaggingSecretAsSender":{"times":[44.344443999998475]},"incrementAppTaggingSecretIndexAsSender":{"times":[17.865772000001016]}}},{"functionName":"private_kernel_inner","time":134.43539999999848},{"functionName":"SchnorrAccount:entrypoint","time":167.1226910000005,"oracles":{"debugLog":{"times":[0.174193999999261,0.09334300000045914,0.16931499999918742]},"fetchTaggedLogs":{"times":[70.88860900000145]},"loadCapsule":{"times":[0.19550499999968451,0.19385499999771127,0.1769140000033076]},"validateEnqueuedNotesAndEvents":{"times":[6.189426000000822]},"getNotes":{"times":[1.2599730000001728]},"getAuthWitness":{"times":[0.11990400000286172]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4095710000001418]}}},{"functionName":"private_kernel_inner","time":128.73789699999907},{"functionName":"private_kernel_reset","time":224.5497170000017},{"functionName":"private_kernel_tail","time":92.93168200000218}],"unaccounted":288.90736999999353}}
18:09:21 aztec-1 | [18:09:20.895]
INFO:
node Received tx 0x066f85be7318fd7d6bea887b331aa5dd242ddb508ea2ed22789eb98501e74f04
{"txHash":"0x066f85be7318fd7d6bea887b331aa5dd242ddb508ea2ed22789eb98501e74f04"}
18:09:21 aztec-1 | [18:09:20.895]
INFO:
pxe:service Sent transaction 0x066f85be7318fd7d6bea887b331aa5dd242ddb508ea2ed22789eb98501e74f04
18:09:21 aztec-1 | [18:09:20.967]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.020093660000002275s
{"duration":0.020093660000002275,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
18:09:21 aztec-1 | [18:09:20.997]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x14a973beb05825e8c454ded1c8514c08907d3fab24b944a3cc650a25c5ea67af","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749838526,"version":1516729127},"txHashes":["0x066f85be7318fd7d6bea887b331aa5dd242ddb508ea2ed22789eb98501e74f04"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":58.387456000000384,"publicProcessDuration":20.271106000000145,"rollupCircuitsDuration":52.35761300000013,"txCount":1,"blockNumber":3,"blockTimestamp":1749838526,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
18:09:21 aztec-1 | [18:09:21.223]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:09:21 aztec-1 | [18:09:21.234]
WARN:
archiver Failed to reach L2 block 3 at 29 (latest is 2). Rolling back last synched L1 block number to 28.
{"latestLocalL2BlockNumber":2,"latestLocalL2BlockArchive":"0x1cf79245f2b9fdcfc1eabead2b11a92fac5e2ea71ae1f9f2a1925017e151f636","blocksSynchedTo":28,"currentL1BlockNumber":29,"provenBlockNumber":2,"provenArchive":"0x1cf79245f2b9fdcfc1eabead2b11a92fac5e2ea71ae1f9f2a1925017e151f636","pendingBlockNumber":3,"pendingArchive":"0x10c47cf32172cb623cfba6ac4a1fb138bfc9b02a83db01e8ea5bb886b17b0f15"}
18:09:21 aztec-1 | [18:09:21.274]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
18:09:21 aztec-1 | [18:09:21.274]
WARN:
foundation:test-date-provider Time set to 2025-06-13T18:15:38.000Z
{"offset":376726,"timeMs":1749838538000}
18:09:21 aztec-1 | [18:09:21.276]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
18:09:21 aztec-1 | [18:09:21.278]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
18:09:21 aztec-1 | [18:09:21.330]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x14a973beb05825e8c454ded1c8514c08907d3fab24b944a3cc650a25c5ea67af","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749838526,"version":1516729127},"archiveRoot":"0x10c47cf32172cb623cfba6ac4a1fb138bfc9b02a83db01e8ea5bb886b17b0f15","archiveNextLeafIndex":4}
18:09:21 aztec-1 | [18:09:21.337]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
18:09:21 aztec-1 | [18:09:21.392]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":16.747166999997717,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749838526,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
18:09:21 aztec-1 | Initial Accounts:
18:09:21 aztec-1 |
18:09:21 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
18:09:21 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
18:09:21 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
18:09:21 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
18:09:21 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
18:09:21 aztec-1 |
18:09:21 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
18:09:21 aztec-1 |
18:09:21 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
18:09:21 aztec-1 |
18:09:21 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
18:09:21 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
18:09:21 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
18:09:21 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
18:09:21 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
18:09:21 aztec-1 |
18:09:21 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
18:09:21 aztec-1 |
18:09:21 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
18:09:21 aztec-1 |
18:09:21 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
18:09:21 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
18:09:21 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
18:09:21 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
18:09:21 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
18:09:21 aztec-1 |
18:09:21 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
18:09:21 aztec-1 |
18:09:21 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
18:09:21 aztec-1 |
18:09:21 aztec-1 |
18:09:21 aztec-1 | [18:09:21.430]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749838562
18:09:21 aztec-1 | [18:09:21.431]
WARN:
foundation:test-date-provider Time set to 2025-06-13T18:16:02.000Z
{"offset":400569,"timeMs":1749838562000}
18:09:21 aztec-1 | [18:09:21.431]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
18:09:22 aztec-1 | [18:09:22.160]
WARN:
pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata
18:09:22 aztec-1 | [18:09:22.160]
WARN:
pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata
18:09:22 aztec-1 | [18:09:22.163]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
18:09:22 aztec-1 | [18:09:22.196]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
18:09:23 aztec-1 | [18:09:22.993]
INFO:
pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164
18:09:23 aztec-1 | [18:09:22.996]
INFO:
pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2
18:09:25 aztec-1 | [18:09:25.194]
INFO:
pxe:service Proving completed in 2175.587282999997ms
{"timings":{"total":2175.587282999997,"sync":36.49483600000167,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":385.8040300000139,"oracles":{"debugLog":{"times":[0.259766999999556,0.11450300000069547,0.11543299999902956,0.21435599999676924,0.12136399999872083,0.10565300000234856,0.09796300000016345,0.21869599999990896]},"fetchTaggedLogs":{"times":[135.65706599999976]},"loadCapsule":{"times":[0.24970699999903445,0.198724999998376,0.3857800000005227,0.24412600000141538,0.19003499999962514,0.20299599999998463,0.1758349999981874]},"getSharedSecret":{"times":[5.985469999999623]},"aes128Decrypt":{"times":[1.0977689999999711,0.815441999999166]},"getPublicKeysAndPartialAddress":{"times":[1.7902180000019143]},"getKeyValidationRequest":{"times":[2.1760580000009213]},"storeCapsule":{"times":[2.7930339999984426,2.398403999999573,2.250260000000708]},"deleteCapsule":{"times":[2.612359999999171]},"validateEnqueuedNotesAndEvents":{"times":[19.37015800000154]},"getNotes":{"times":[13.985224000000017]},"getAuthWitness":{"times":[0.1395039999988512]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06787199999962468]},"callPrivateFunction":{"times":[576.2290630000025,101.27440700000079]},"notifyEnqueuedPublicFunctionCall":{"times":[0.27626799999779905]}}},{"functionName":"private_kernel_init","time":61.031010999999125},{"functionName":"ContractClassRegisterer:register","time":556.6318989999963,"oracles":{"loadCapsule":{"times":[1.7398670000002312]},"notifyCreatedNullifier":{"times":[0.42562200000247685]},"debugLog":{"times":[0.12047299999903771]},"notifyCreatedContractClassLog":{"times":[8.170787999999447]}}},{"functionName":"private_kernel_inner","time":126.10485100000005},{"functionName":"ContractInstanceDeployer:deploy","time":62.60361599999669,"oracles":{"storeInExecutionCache":{"times":[0.2704169999997248]},"callPrivateFunction":{"times":[33.93317699999898]},"notifyCreatedNullifier":{"times":[0.15226400000028661]},"debugLog":{"times":[0.08548199999859207]}}},{"functionName":"private_kernel_inner","time":146.6105290000014},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":26.012303999999858,"oracles":{}},{"functionName":"private_kernel_inner","time":122.59785699999702},{"functionName":"private_kernel_reset","time":143.23935899999924},{"functionName":"private_kernel_tail","time":96.00291600000128}],"unaccounted":412.45407499999055}}
18:09:25 aztec-1 | [18:09:25.381]
INFO:
node Received tx 0x006e6db6ceef3647035fca6001c8fcf194d43f51f8ca2afbda164f22495c53e1
{"txHash":"0x006e6db6ceef3647035fca6001c8fcf194d43f51f8ca2afbda164f22495c53e1"}
18:09:25 aztec-1 | [18:09:25.382]
INFO:
pxe:service Sent transaction 0x006e6db6ceef3647035fca6001c8fcf194d43f51f8ca2afbda164f22495c53e1
18:09:27 aztec-1 | [18:09:26.890]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.3814300350000013s
{"duration":1.3814300350000013,"rate":28804.20940029725,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768}
18:09:27 aztec-1 | [18:09:26.999]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 26479.967450436165 mana/s
{"blockHash":"0x1408a1adb0817bbb2629ccad7d10f2b926098f90f6fb8527e7be9cc849efc680","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749838562,"version":1516729127},"txHashes":["0x006e6db6ceef3647035fca6001c8fcf194d43f51f8ca2afbda164f22495c53e1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1502.6015640000005,"publicProcessDuration":1381.6329210000004,"rollupCircuitsDuration":1493.2295029999987,"txCount":1,"blockNumber":4,"blockTimestamp":1749838562,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
18:09:28 aztec-1 | [18:09:28.114]
INFO:
pxe:service Proving completed in 2918.1242500000008ms
{"timings":{"total":2918.1242500000008,"sync":142.81310700000176,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":423.45189799999935,"oracles":{"debugLog":{"times":[0.1432039999999688,0.09971199999927194,0.10809200000221608,0.23331600000165054,0.11580300000059651,0.10217199999897275,0.11830299999928684,0.10205299999870476]},"fetchTaggedLogs":{"times":[159.66964799999914]},"loadCapsule":{"times":[0.28797800000029383,0.4892230000004929,0.3368690000024799,1.1179689999989932,0.5758349999996426,0.19838499999968917,0.17831500000102096]},"getSharedSecret":{"times":[6.057142000001477]},"aes128Decrypt":{"times":[0.26111699999819393,0.6755780000021332]},"getPublicKeysAndPartialAddress":{"times":[7.497089999997115]},"getKeyValidationRequest":{"times":[5.660291000000143]},"storeCapsule":{"times":[25.22953399999824,4.141410999996879,3.065350999997463]},"deleteCapsule":{"times":[3.512064000002283]},"validateEnqueuedNotesAndEvents":{"times":[24.89377500000046]},"getNotes":{"times":[5.6736520000013115]},"getAuthWitness":{"times":[0.15927400000146008]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.03841100000136066]},"callPrivateFunction":{"times":[954.8460019999984,142.17007999999987]},"notifyEnqueuedPublicFunctionCall":{"times":[0.08598200000051293]}}},{"functionName":"private_kernel_init","time":79.63421899999958},{"functionName":"ContractClassRegisterer:register","time":938.5187470000019,"oracles":{"loadCapsule":{"times":[3.265116999999009]},"notifyCreatedNullifier":{"times":[0.47370299999965937]},"debugLog":{"times":[0.18597500000032596]},"notifyCreatedContractClassLog":{"times":[5.753483000000415]}}},{"functionName":"private_kernel_inner","time":104.28139699999883},{"functionName":"ContractInstanceDeployer:deploy","time":84.97976199999903,"oracles":{"storeInExecutionCache":{"times":[0.06343199999901117]},"callPrivateFunction":{"times":[60.528598000000784]},"notifyCreatedNullifier":{"times":[0.2481870000010531]},"debugLog":{"times":[0.1576439999989816]}}},{"functionName":"private_kernel_inner","time":120.64405499999702},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.720502000000124,"oracles":{}},{"functionName":"private_kernel_inner","time":97.52878699999928},{"functionName":"private_kernel_reset","time":186.97639799999888},{"functionName":"private_kernel_tail","time":68.11391999999978}],"unaccounted":631.4614580000052}}
18:09:28 aztec-1 | [18:09:28.144]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
18:09:28 aztec-1 | [18:09:28.144]
WARN:
foundation:test-date-provider Time set to 2025-06-13T18:16:14.000Z
{"offset":405856,"timeMs":1749838574000}
18:09:28 aztec-1 | [18:09:28.149]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
18:09:28 aztec-1 | [18:09:28.152]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
18:09:28 aztec-1 | [18:09:28.157]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:09:28 aztec-1 | [18:09:28.195]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749838598
18:09:28 aztec-1 | [18:09:28.195]
WARN:
foundation:test-date-provider Time set to 2025-06-13T18:16:38.000Z
{"offset":429805,"timeMs":1749838598000}
18:09:28 aztec-1 | [18:09:28.195]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
18:09:28 aztec-1 | [18:09:28.244]
INFO:
node Received tx 0x2df8faf6a36a5dce99f2c0e4b87c60ffb590fde8ae9aaae8c51f43fe2b86532b
{"txHash":"0x2df8faf6a36a5dce99f2c0e4b87c60ffb590fde8ae9aaae8c51f43fe2b86532b"}
18:09:28 aztec-1 | [18:09:28.244]
INFO:
pxe:service Sent transaction 0x2df8faf6a36a5dce99f2c0e4b87c60ffb590fde8ae9aaae8c51f43fe2b86532b
18:09:28 aztec-1 | [18:09:28.289]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x1408a1adb0817bbb2629ccad7d10f2b926098f90f6fb8527e7be9cc849efc680","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749838562,"version":1516729127},"archiveRoot":"0x14d3c2fce0a69279798f8e7a8ac29917cabbb3f0f86ece1c96fa0570eb9e9be6","archiveNextLeafIndex":5}
18:09:28 aztec-1 | [18:09:28.295]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
18:09:28 aztec-1 | [18:09:28.320]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":13.853279999999359,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749838562,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
18:09:28 aztec-1 | [18:09:28.709]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2917246679999989s
{"duration":0.2917246679999989,"rate":1084762.5679704302,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064}
18:09:28 aztec-1 | [18:09:28.777]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 858796.3694188907 mana/s
{"blockHash":"0x0f34acdb700a4f896a0d9e2c93ac4524d5028fe8694c8b3e46e206168c765f7a","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749838598,"version":1516729127},"txHashes":["0x2df8faf6a36a5dce99f2c0e4b87c60ffb590fde8ae9aaae8c51f43fe2b86532b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":368.44617899999866,"publicProcessDuration":292.06876700000066,"rollupCircuitsDuration":363.56631800000105,"txCount":1,"blockNumber":5,"blockTimestamp":1749838598,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
18:09:28 aztec-1 | [18:09:28.870]
INFO:
aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed.
18:09:29 aztec-1 | [18:09:29.105]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:09:29 aztec-1 | [18:09:29.124]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749838634
18:09:29 aztec-1 | [18:09:29.124]
WARN:
foundation:test-date-provider Time set to 2025-06-13T18:17:14.000Z
{"offset":464876,"timeMs":1749838634000}
18:09:29 aztec-1 | [18:09:29.124]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
18:09:29 aztec-1 | [18:09:29.268]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x0f34acdb700a4f896a0d9e2c93ac4524d5028fe8694c8b3e46e206168c765f7a","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749838598,"version":1516729127},"archiveRoot":"0x26e36504b7110361a38e4db21ad8206bd931f618011cff606f8f363114acecfc","archiveNextLeafIndex":6}
18:09:29 aztec-1 | [18:09:29.299]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
18:09:29 aztec-1 | [18:09:29.301]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
18:09:29 aztec-1 | [18:09:29.347]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":15.727661000000808,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749838598,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
18:09:29 aztec-1 | [18:09:29.347]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
18:09:30 aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
18:09:30 aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
18:09:31 aztec-1 | [18:09:30.530]
INFO:
aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed.
18:09:31 aztec-1 | [18:09:30.567]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
18:09:31 aztec-1 | [18:09:30.569]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
18:09:31 aztec-1 | [18:09:30.734]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
18:09:33 aztec-1 | [18:09:32.876]
INFO:
pxe:service Proving completed in 2130.243199999997ms
{"timings":{"total":2130.243199999997,"sync":27.11625400000048,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":83.19102399999974,"oracles":{"callPrivateFunction":{"times":[817.0020589999986,129.0985010000004,36.56037700000161]}}},{"functionName":"private_kernel_init","time":52.998867000002065},{"functionName":"ContractClassRegisterer:register","time":799.8043890000008,"oracles":{"loadCapsule":{"times":[2.7065719999991416]},"notifyCreatedNullifier":{"times":[0.4224020000001474]},"debugLog":{"times":[0.14586399999825517]},"notifyCreatedContractClassLog":{"times":[5.108767000001535]}}},{"functionName":"private_kernel_inner","time":107.64341799999966},{"functionName":"ContractInstanceDeployer:deploy","time":70.43921200000477,"oracles":{"storeInExecutionCache":{"times":[0.13102300000173273]},"callPrivateFunction":{"times":[60.62441000000035]},"notifyCreatedNullifier":{"times":[0.2147659999973257]},"debugLog":{"times":[0.113482999997359]}}},{"functionName":"private_kernel_inner","time":91.39956299999903},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":44.947651999998925,"oracles":{}},{"functionName":"private_kernel_inner","time":104.85186199999953},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":29.212789999997767,"oracles":{"debugLog":{"times":[0.15386399999988498]}}},{"functionName":"private_kernel_inner","time":122.0154509999993},{"functionName":"private_kernel_reset","time":192.10550500000318},{"functionName":"private_kernel_tail","time":69.72275400000217}],"unaccounted":334.79445899998973}}
18:09:33 aztec-1 | [18:09:32.995]
INFO:
node Received tx 0x0089e181971c22ee0cc4941f39a40512510d487b1e9b18efaff2105b45a79a3c
{"txHash":"0x0089e181971c22ee0cc4941f39a40512510d487b1e9b18efaff2105b45a79a3c"}
18:09:33 aztec-1 | [18:09:32.995]
INFO:
pxe:service Sent transaction 0x0089e181971c22ee0cc4941f39a40512510d487b1e9b18efaff2105b45a79a3c
18:09:33 aztec-1 | [18:09:33.118]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.040453370999999606s
{"duration":0.040453370999999606,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
18:09:33 aztec-1 | [18:09:33.145]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x0008845cc380b165c99874e41f2bfcd6d6ac49bb17cd84e3cd7ac56530b8ed85","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749838634,"version":1516729127},"txHashes":["0x0089e181971c22ee0cc4941f39a40512510d487b1e9b18efaff2105b45a79a3c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":76.90103499999896,"publicProcessDuration":40.604465000000346,"rollupCircuitsDuration":70.13157499999943,"txCount":1,"blockNumber":6,"blockTimestamp":1749838634,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
18:09:33 aztec-1 | [18:09:33.379]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
18:09:33 aztec-1 | [18:09:33.381]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
18:09:33 aztec-1 | [18:09:33.384]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:09:33 aztec-1 | [18:09:33.391]
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":"0x26e36504b7110361a38e4db21ad8206bd931f618011cff606f8f363114acecfc","blocksSynchedTo":34,"currentL1BlockNumber":35,"provenBlockNumber":5,"provenArchive":"0x26e36504b7110361a38e4db21ad8206bd931f618011cff606f8f363114acecfc","pendingBlockNumber":6,"pendingArchive":"0x24725cdaae4fe96171be6d64e260faed5974c04a6b84ca1ec63fcf24ea738167"}
18:09:33 aztec-1 | [18:09:33.412]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749838670
18:09:33 aztec-1 | [18:09:33.412]
WARN:
foundation:test-date-provider Time set to 2025-06-13T18:17:50.000Z
{"offset":496588,"timeMs":1749838670000}
18:09:33 aztec-1 | [18:09:33.412]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
18:09:33 aztec-1 | [18:09:33.491]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x0008845cc380b165c99874e41f2bfcd6d6ac49bb17cd84e3cd7ac56530b8ed85","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749838634,"version":1516729127},"archiveRoot":"0x24725cdaae4fe96171be6d64e260faed5974c04a6b84ca1ec63fcf24ea738167","archiveNextLeafIndex":7}
18:09:33 aztec-1 | [18:09:33.501]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
18:09:33 aztec-1 | [18:09:33.546]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":16.579272999999375,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749838634,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
18:09:34 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
18:09:34 aztec-1 | [18:09:34.012]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
18:09:34 aztec-1 | [18:09:34.019]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x2d2655c513c2e8feb8c7411b7e807c66287b57bb60572ce85ce1fe0a1e0c925d","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
18:09:42 playground-1 | \
18:09:42 playground-1 |
Running 1
test using 1
worker
18:09:42 playground-1 |
18:09:43 playground-1 |
✓ 1 [chromium] › browser.spec.ts:3:1 › test
(6.8s)
18:09:50 playground-1 |
1 passed (9.0s)
18:09:50 playground-1 | \
npm notice
18:09:50 playground-1 |
npm notice New
major version of npm available!
10.9.2 ->
11.4.2
18:09:50 playground-1 |
npm notice Changelog:
https://github.com/npm/cli/releases/tag/v11.4.2
18:09:50 playground-1 |
npm notice To update run:
npm install -g npm@11.4.2
18:09:50 playground-1 |
npm notice
18:09:50 playground-1 | \
18:09:50
playground-1 exited with code 0
18:09:50 Aborting on container exit...
18:09:50 Container playground-chromium-playground-1 Stopping
18:09:50 Container playground-chromium-playground-1 Stopped
18:09:50 Container playground-chromium-aztec-1 Stopping
18:09:52 Container playground-chromium-aztec-1 Stopped
18:09:52 Container playground-chromium-ethereum-1 Stopping
18:09:52 Container playground-chromium-ethereum-1 Stopped