Parent Log:
http://ci.aztec-labs.com/cfa3a08d8c538c28
Command: 096728d2a1186953 playground/scripts/run_test.sh firefox
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/30660269b33bab8cca354c41659533acf4d48e07
Env: REF_NAME=gh-readonly-queue/next/pr-15026-d96baf1c44329e8b2e3a432ad803f702f5184a62 CURRENT_VERSION=0.87.6 CI_FULL=0
Date: Fri Jun 13 09:37:20 UTC 2025
System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-15026_arm64_a1-fast
Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_23123200780498f7_next
09:37:20 Network playground-firefox_default Creating
09:37:20 Network playground-firefox_default Created
09:37:20 Container playground-firefox-ethereum-1 Creating
09:37:20 Container playground-firefox-ethereum-1 Created
09:37:20 Container playground-firefox-aztec-1 Creating
09:37:20 Container playground-firefox-aztec-1 Created
09:37:20 Container playground-firefox-playground-1 Creating
09:37:21 Container playground-firefox-playground-1 Created
09:37:21 Attaching to aztec-1, ethereum-1, playground-1
09:37:25 aztec-1 |
09:37:25 aztec-1 | _
09:37:25 aztec-1 | /\ | |
09:37:25 aztec-1 | / \ ___| |_ ___ ___
09:37:25 aztec-1 | / /\ \ |_ / __/ _ \/ __|
09:37:25 aztec-1 | / ____ \ / /| || __/ (__
09:37:25 aztec-1 | /_/___ \_\/___|\__\___|\___|
09:37:25 aztec-1 |
09:37:25 aztec-1 |
https://github.com/AztecProtocol
09:37:25 aztec-1 |
09:37:25 aztec-1 |
09:37:25 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
09:37:25 aztec-1 | Setting up test accounts
09:37:26 aztec-1 | [09:37:25.704]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-vrMDnB/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
09:37:26 aztec-1 | [09:37:25.976]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
09:37:26 aztec-1 | [09:37:25.981]
WARN:
sandbox Set block interval to 12
09:37:26 aztec-1 | [09:37:26.151]
INFO:
sandbox Waiting for 7 transactions to be mined...
09:37:26 aztec-1 | [09:37:26.174]
INFO:
sandbox All transactions mined successfully
09:37:26 aztec-1 | [09:37:26.248]
INFO:
sandbox Waiting for 9 transactions to be mined...
09:37:26 aztec-1 | [09:37:26.269]
INFO:
sandbox All transactions mined successfully
09:37:26 aztec-1 | [09:37:26.397]
INFO:
sandbox Waiting for 11 transactions to be mined...
09:37:26 aztec-1 | [09:37:26.418]
INFO:
sandbox All transactions mined successfully
09:37:26 aztec-1 | [09:37:26.476]
INFO:
sandbox Waiting for 12 transactions to be mined...
09:37:26 aztec-1 | [09:37:26.498]
INFO:
sandbox All transactions mined successfully
09:37:26 aztec-1 | [09:37:26.502]
INFO:
sandbox Waiting for 12 transactions to be mined...
09:37:26 aztec-1 | [09:37:26.522]
INFO:
sandbox All transactions mined successfully
09:37:26 aztec-1 | [09:37:26.535]
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"}
09:37:26 aztec-1 | [09:37:26.536]
INFO:
sandbox Handing over to governance
09:37:26 aztec-1 | [09:37:26.543]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
09:37:26 aztec-1 | [09:37:26.543]
INFO:
telemetry:client Using NoopTelemetryClient
09:37:26 aztec-1 | [09:37:26.543]
INFO:
blob-sink:client Creating local blob sink client.
09:37:26 aztec-1 | [09:37:26.547]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:37:26 aztec-1 | [09:37:26.547]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:42:09.000Z
{"offset":282453,"timeMs":1749807729000}
09:37:26 aztec-1 | [09:37:26.568]
INFO:
archiver:lmdb Starting data store with maxReaders 16
09:37:26 aztec-1 | [09:37:26.893]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x993c1344d92f14fdb668a5b091a4ebbc301f4e54e85127cf946f6af2a397c058
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xf73397cb280291115b9e993313dcebcd0fc49f09befa649b1e2bd80f33e37737","l1BlockNumber":20}}
09:37:26 aztec-1 | [09:37:26.911]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x993c1344d92f14fdb668a5b091a4ebbc301f4e54e85127cf946f6af2a397c058","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
09:37:27 aztec-1 | [09:37:26.916]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-AYnxrR/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
09:37:27 aztec-1 | [09:37:27.134]
INFO:
world_state Created world state synchroniser with block history of 64
09:37:27 aztec-1 | [09:37:27.134]
WARN:
node Aztec node is accepting fake proofs
09:37:27 aztec-1 | [09:37:27.143]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
09:37:27 aztec-1 | [09:37:27.154]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
09:37:27 aztec-1 | [09:37:27.163]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
09:37:27 aztec-1 | [09:37:27.178]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
09:37:27 aztec-1 | [09:37:27.180]
INFO:
world_state Started world state synchronizer from block 1
09:37:27 aztec-1 | [09:37:27.184]
INFO:
p2p Starting p2p client from block 0 with empty mempools
09:37:27 aztec-1 | [09:37:27.387]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
09:37:27 aztec-1 | [09:37:27.430]
INFO:
slasher Starting Slasher client...
09:37:27 aztec-1 | [09:37:27.437]
INFO:
sequencer-client Deploying forwarder contract
09:37:27 aztec-1 | [09:37:27.455]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
09:37:27 aztec-1 | [09:37:27.461]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
09:37:27 aztec-1 | [09:37:27.461]
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}
09:37:27 aztec-1 | [09:37:27.462]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
09:37:27 aztec-1 | [09:37:27.463]
INFO:
node Aztec Node version: 0.87.6
09:37:27 aztec-1 | [09:37:27.463]
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"}
09:37:27 aztec-1 | [09:37:27.468]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
09:37:27 aztec-1 | [09:37:27.471]
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.
{"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1}
09:37:27 aztec-1 | [09:37:27.529]
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.
{"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1}
09:37:27 aztec-1 | [09:37:27.661]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:37:27 aztec-1 | [09:37:27.661]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:42:21.000Z
{"offset":293339,"timeMs":1749807741000}
09:37:27 aztec-1 | [09:37:27.666]
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.
{"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1}
09:37:27 aztec-1 | Setting up funded test accounts...
09:37:27 aztec-1 | [09:37:27.776]
INFO:
pxe:service Started PXE connected to chain 31337 version 3326517204
09:37:27 aztec-1 | [09:37:27.855]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
09:37:27 aztec-1 | [09:37:27.910]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
09:37:27 aztec-1 | [09:37:27.913]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
09:37:28 aztec-1 | [09:37:28.046]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
09:37:30 aztec-1 | [09:37:30.096]
INFO:
pxe:service Proving completed in 2019.7924119999998ms
{"timings":{"total":2019.7924119999998,"sync":5.16302799999994,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":117.00530499999968,"oracles":{"callPrivateFunction":{"times":[547.2254710000007,263.8732319999999,155.95456999999988]}}},{"functionName":"private_kernel_init","time":87.27664699999968},{"functionName":"ContractClassRegisterer:register","time":533.8441239999993,"oracles":{"loadCapsule":{"times":[5.989071000000877]},"notifyCreatedNullifier":{"times":[0.6355869999997594]},"debugLog":{"times":[17.980591999999888]},"notifyCreatedContractClassLog":{"times":[4.702299000000494]}}},{"functionName":"private_kernel_inner","time":118.58964000000014},{"functionName":"SchnorrAccount:constructor","time":244.81045100000028,"oracles":{"getContractInstance":{"times":[1.8060319999995045]},"debugLog":{"times":[0.14653799999996409,0.09468199999992066]},"fetchTaggedLogs":{"times":[40.06341799999973]},"loadCapsule":{"times":[0.31870400000025256,0.21064500000011321,0.1700089999994816]},"validateEnqueuedNotesAndEvents":{"times":[5.580771999999342]},"notifyCreatedNullifier":{"times":[0.22414800000024115,0.19723900000008143]},"notifyCreatedNote":{"times":[0.5116690000004382]},"getRandomField":{"times":[0.21934299999975337,0.12962699999934557,0.09342599999945378,0.09089399999993475,0.23803599999973812,0.08720900000025722,0.062164999999367865,0.0666430000001128,0.06380300000000716,0.09334099999978207,0.05886999999984255]},"getIndexedTaggingSecretAsSender":{"times":[39.2167929999996]},"incrementAppTaggingSecretIndexAsSender":{"times":[23.18624499999987]}}},{"functionName":"private_kernel_inner","time":101.19013499999983},{"functionName":"SchnorrAccount:entrypoint","time":137.7333320000007,"oracles":{"debugLog":{"times":[0.13765299999977287,0.08311200000025565,0.2278390000001309]},"fetchTaggedLogs":{"times":[35.16141500000049]},"loadCapsule":{"times":[0.19419999999990978,0.17843599999923754,0.1463000000003376]},"validateEnqueuedNotesAndEvents":{"times":[6.010097000000314]},"getNotes":{"times":[1.7452760000005583]},"getAuthWitness":{"times":[0.2987360000006447]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7676959999998871]}}},{"functionName":"private_kernel_inner","time":99.71750100000008},{"functionName":"private_kernel_reset","time":170.08415500000046},{"functionName":"private_kernel_tail","time":65.65876600000047}],"unaccounted":338.7193279999992}}
09:37:30 aztec-1 | [09:37:30.189]
INFO:
node Received tx 0x206ef6b8bc1d59b27e2e36b583e6e8f9654c292300140cfbb36d2bd21f4f94b9
{"txHash":"0x206ef6b8bc1d59b27e2e36b583e6e8f9654c292300140cfbb36d2bd21f4f94b9"}
09:37:30 aztec-1 | [09:37:30.189]
INFO:
pxe:service Sent transaction 0x206ef6b8bc1d59b27e2e36b583e6e8f9654c292300140cfbb36d2bd21f4f94b9
09:37:30 aztec-1 | [09:37:30.271]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.029260797999999342s
{"duration":0.029260797999999342,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
09:37:30 aztec-1 | [09:37:30.294]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x11d95d3ad1f7ef5140531dde0b352c33ccd3d9c9885e1123aff08700a0ce2a06","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807753,"version":3326517204},"txHashes":["0x206ef6b8bc1d59b27e2e36b583e6e8f9654c292300140cfbb36d2bd21f4f94b9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":60.98057200000039,"publicProcessDuration":29.681700000001,"rollupCircuitsDuration":54.781559000000925,"txCount":1,"blockNumber":1,"blockTimestamp":1749807753,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
09:37:33 aztec-1 | [09:37:32.998]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
09:37:33 aztec-1 | [09:37:32.999]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
09:37:33 aztec-1 | [09:37:33.010]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:37:33 aztec-1 | [09:37:33.086]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
09:37:33 aztec-1 | error: "Rollup__SlotAlreadyInChain(2, 2)"
09:37:33 aztec-1 | [09:37:33.086]
WARN:
sequencer Cannot propose block 1 at slot 2 due to failed rollup contract check
09:37:33 aztec-1 | [09:37:33.088]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x11d95d3ad1f7ef5140531dde0b352c33ccd3d9c9885e1123aff08700a0ce2a06","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807753,"version":3326517204},"archiveRoot":"0x08279f3ebf822121c013623a811ad35e3245437fe58fecf057bf8f537a31fefb","archiveNextLeafIndex":2}
09:37:33 aztec-1 | [09:37:33.094]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
09:37:33 aztec-1 | [09:37:33.132]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":14.65264500000012,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749807753,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
09:37:33 aztec-1 | [09:37:33.217]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:37:33 aztec-1 | [09:37:33.217]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:42:33.000Z
{"offset":299783,"timeMs":1749807753000}
09:37:33 aztec-1 | [09:37:33.249]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
09:37:33 aztec-1 | error: "Rollup__SlotAlreadyInChain(2, 2)"
09:37:33 aztec-1 | [09:37:33.249]
WARN:
sequencer Cannot propose block 2 at slot 2 due to failed rollup contract check
09:37:33 aztec-1 | [09:37:33.250]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749807789
09:37:33 aztec-1 | [09:37:33.250]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:43:09.000Z
{"offset":335750,"timeMs":1749807789000}
09:37:33 aztec-1 | [09:37:33.250]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
09:37:33 aztec-1 | [09:37:33.279]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
09:37:33 aztec-1 | [09:37:33.382]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
09:37:35 aztec-1 | [09:37:34.650]
INFO:
pxe:service Proving completed in 1253.1062900000015ms
{"timings":{"total":1253.1062900000015,"sync":16.15611600000011,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":75.91693100000157,"oracles":{"callPrivateFunction":{"times":[300.907142,187.9491969999999]}}},{"functionName":"private_kernel_init","time":51.81513099999938},{"functionName":"SchnorrAccount:constructor","time":280.2628369999984,"oracles":{"getContractInstance":{"times":[4.598857999999382]},"debugLog":{"times":[0.12789599999996426,0.11856900000020687]},"fetchTaggedLogs":{"times":[66.45713699999942]},"loadCapsule":{"times":[0.21244800000022224,0.3296699999991688,0.19094399999994494]},"validateEnqueuedNotesAndEvents":{"times":[4.972156999998333]},"notifyCreatedNullifier":{"times":[0.2616999999991094,0.21803800000088813]},"notifyCreatedNote":{"times":[0.1044610000008106]},"getRandomField":{"times":[0.10573300000032759,0.12180499999885797,0.08848699999907694,0.06826600000022154,0.06863200000043435,0.056757000000288826,0.06194500000128755,0.05696199999874807,0.06232799999997951,0.05549599999903876,0.06170100000053935]},"getIndexedTaggingSecretAsSender":{"times":[51.374463000000105]},"incrementAppTaggingSecretIndexAsSender":{"times":[25.593150000000605]}}},{"functionName":"private_kernel_inner","time":101.72094099999958},{"functionName":"SchnorrAccount:entrypoint","time":166.03871900000013,"oracles":{"debugLog":{"times":[0.15054699999927834,0.09899199999927077,0.13173400000050606]},"fetchTaggedLogs":{"times":[59.01416100000097]},"loadCapsule":{"times":[0.18052300000090327,0.17507200000000012,0.15573700000095414]},"validateEnqueuedNotesAndEvents":{"times":[9.522725000000719]},"getNotes":{"times":[5.291495999999825]},"getAuthWitness":{"times":[0.1583730000002106]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.3635290000001987]}}},{"functionName":"private_kernel_inner","time":103.96161799999936},{"functionName":"private_kernel_reset","time":165.2089219999998},{"functionName":"private_kernel_tail","time":66.7727990000003}],"unaccounted":225.2522760000029}}
09:37:35 aztec-1 | [09:37:34.687]
INFO:
node Received tx 0x0afd2edafb58adb94988b124695a28342e295d719c261d625c3000ef524f2c48
{"txHash":"0x0afd2edafb58adb94988b124695a28342e295d719c261d625c3000ef524f2c48"}
09:37:35 aztec-1 | [09:37:34.687]
INFO:
pxe:service Sent transaction 0x0afd2edafb58adb94988b124695a28342e295d719c261d625c3000ef524f2c48
09:37:35 aztec-1 | [09:37:34.758]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.017440846000001328s
{"duration":0.017440846000001328,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
09:37:35 aztec-1 | [09:37:34.776]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x268d54a9966a1524d9f91c0075001d215ff936de07f7d44ae034d832fd1d352e","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807789,"version":3326517204},"txHashes":["0x0afd2edafb58adb94988b124695a28342e295d719c261d625c3000ef524f2c48"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":45.05708500000037,"publicProcessDuration":17.522737000001143,"rollupCircuitsDuration":39.820739000000685,"txCount":1,"blockNumber":2,"blockTimestamp":1749807789,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
09:37:35 aztec-1 | [09:37:34.949]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
09:37:35 aztec-1 | [09:37:34.953]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
09:37:35 aztec-1 | [09:37:34.958]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:37:35 aztec-1 | [09:37:34.959]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749807825
09:37:35 aztec-1 | [09:37:34.959]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:43:45.000Z
{"offset":370041,"timeMs":1749807825000}
09:37:35 aztec-1 | [09:37:34.959]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
09:37:35 aztec-1 | [09:37:35.052]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x268d54a9966a1524d9f91c0075001d215ff936de07f7d44ae034d832fd1d352e","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807789,"version":3326517204},"archiveRoot":"0x005401932875e222fd03da730efcff203fead4215c81435feb0c5dd354ca0d09","archiveNextLeafIndex":3}
09:37:35 aztec-1 | [09:37:35.056]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
09:37:35 aztec-1 | [09:37:35.078]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":12.890524000000369,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749807789,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
09:37:35 aztec-1 | [09:37:35.216]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
09:37:35 aztec-1 | [09:37:35.322]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
09:37:37 aztec-1 | Initial Accounts:
09:37:37 aztec-1 |
09:37:37 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
09:37:37 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
09:37:37 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
09:37:37 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
09:37:37 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
09:37:37 aztec-1 |
09:37:37 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
09:37:37 aztec-1 |
09:37:37 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
09:37:37 aztec-1 |
09:37:37 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
09:37:37 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
09:37:37 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
09:37:37 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
09:37:37 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
09:37:37 aztec-1 |
09:37:37 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
09:37:37 aztec-1 |
09:37:37 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
09:37:37 aztec-1 |
09:37:37 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
09:37:37 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
09:37:37 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
09:37:37 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
09:37:37 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
09:37:37 aztec-1 |
09:37:37 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
09:37:37 aztec-1 |
09:37:37 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
09:37:37 aztec-1 |
09:37:37 aztec-1 |
09:37:37 aztec-1 | [09:37:36.535]
INFO:
pxe:service Proving completed in 1205.5295449999994ms
{"timings":{"total":1205.5295449999994,"sync":18.022038999999495,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":68.35778000000028,"oracles":{"callPrivateFunction":{"times":[282.01303799999914,185.2609420000008]}}},{"functionName":"private_kernel_init","time":51.75939300000027},{"functionName":"SchnorrAccount:constructor","time":263.63215499999933,"oracles":{"getContractInstance":{"times":[1.7720709999994142]},"debugLog":{"times":[0.10127300000021933,0.07752499999878637]},"fetchTaggedLogs":{"times":[72.44330100000116]},"loadCapsule":{"times":[0.1810220000006666,0.1708070000004227,0.1409270000003744]},"validateEnqueuedNotesAndEvents":{"times":[7.42924099999982]},"notifyCreatedNullifier":{"times":[0.15579900000011548,0.1784299999999348]},"notifyCreatedNote":{"times":[0.09583200000088254]},"getRandomField":{"times":[0.09388099999887345,0.11278700000002573,0.08478099999956612,0.060960000000704895,0.06441300000005867,0.055867000000944245,0.06256500000017695,0.05685600000106206,0.06232300000010582,0.052031999999599066,0.07496499999979278]},"getIndexedTaggingSecretAsSender":{"times":[42.11003900000105]},"incrementAppTaggingSecretIndexAsSender":{"times":[23.041176000000632]}}},{"functionName":"private_kernel_inner","time":100.72595499999989},{"functionName":"SchnorrAccount:entrypoint","time":164.4176239999997,"oracles":{"debugLog":{"times":[0.1194390000000567,0.06677100000160863,0.1094520000006014]},"fetchTaggedLogs":{"times":[65.99194700000044]},"loadCapsule":{"times":[0.14105500000005122,0.1369589999994787,0.14189400000032037]},"validateEnqueuedNotesAndEvents":{"times":[5.460950999999113]},"getNotes":{"times":[0.9164430000000721]},"getAuthWitness":{"times":[0.15969899999981862]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.40044699999998556]}}},{"functionName":"private_kernel_inner","time":100.60976699999992},{"functionName":"private_kernel_reset","time":162.4456850000006},{"functionName":"private_kernel_tail","time":64.50248800000008}],"unaccounted":211.05665899999985}}
09:37:37 aztec-1 | [09:37:36.587]
INFO:
node Received tx 0x2efa0e511ff587dae6fd866c4af03b917710e83738e8156713008b8c1bc5ca98
{"txHash":"0x2efa0e511ff587dae6fd866c4af03b917710e83738e8156713008b8c1bc5ca98"}
09:37:37 aztec-1 | [09:37:36.587]
INFO:
pxe:service Sent transaction 0x2efa0e511ff587dae6fd866c4af03b917710e83738e8156713008b8c1bc5ca98
09:37:37 aztec-1 | [09:37:36.655]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.013922658999999839s
{"duration":0.013922658999999839,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
09:37:37 aztec-1 | [09:37:36.674]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x0ba0e3ea6d29a120d0014bc48aefe1e556e25b3d1d97dc2f1adac6e19549f450","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749807825,"version":3326517204},"txHashes":["0x2efa0e511ff587dae6fd866c4af03b917710e83738e8156713008b8c1bc5ca98"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":39.08981800000038,"publicProcessDuration":14.022500000000946,"rollupCircuitsDuration":34.51967499999955,"txCount":1,"blockNumber":3,"blockTimestamp":1749807825,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
09:37:37 aztec-1 | [09:37:36.841]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
09:37:37 aztec-1 | [09:37:36.843]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
09:37:37 aztec-1 | [09:37:36.846]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:37:37 aztec-1 | [09:37:36.847]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749807861
09:37:37 aztec-1 | [09:37:36.847]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:44:21.000Z
{"offset":404153,"timeMs":1749807861000}
09:37:37 aztec-1 | [09:37:36.847]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
09:37:37 aztec-1 | [09:37:36.930]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x0ba0e3ea6d29a120d0014bc48aefe1e556e25b3d1d97dc2f1adac6e19549f450","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749807825,"version":3326517204},"archiveRoot":"0x09c6cbb4711c8667dd22ec771822fa524e3c099e1eae5af15cd55df8cdac5e0f","archiveNextLeafIndex":4}
09:37:37 aztec-1 | [09:37:36.933]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
09:37:37 aztec-1 | [09:37:36.965]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":16.071160000001328,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749807825,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
09:37:37 aztec-1 | [09:37:37.641]
WARN:
pxe:service No artifact found for contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 when looking for its metadata
09:37:37 aztec-1 | [09:37:37.641]
WARN:
pxe:service No artifact found for contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 when looking for its metadata
09:37:37 aztec-1 | [09:37:37.644]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 as part of deployment for 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45
09:37:37 aztec-1 | [09:37:37.668]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 as part of deployment for 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf
09:37:38 aztec-1 | [09:37:38.353]
INFO:
pxe:service Added contract FPC at 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 with class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1
09:37:38 aztec-1 | [09:37:38.355]
INFO:
pxe:service Added contract Token at 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf with class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645
09:37:40 aztec-1 | [09:37:40.075]
INFO:
pxe:service Proving completed in 1707.455568999998ms
{"timings":{"total":1707.455568999998,"sync":15.562713999999687,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":240.52140899999722,"oracles":{"debugLog":{"times":[0.12734800000180257,0.07933799999955227,0.08568899999954738,0.13600899999801186,0.08024099999965983,0.07294900000124471,0.07115799999883166,0.12649400000009337]},"fetchTaggedLogs":{"times":[73.77035099999921]},"loadCapsule":{"times":[0.1666640000003099,0.12596900000062305,0.22763499999928172,0.8541189999996277,0.15071399999942514,0.14737899999818183,0.13666899999952875]},"getSharedSecret":{"times":[7.759200000000419]},"aes128Decrypt":{"times":[0.8312570000016422,0.5492900000026566]},"getPublicKeysAndPartialAddress":{"times":[3.510005000000092]},"getKeyValidationRequest":{"times":[5.784451999999874]},"storeCapsule":{"times":[2.3482099999964703,2.1433600000018487,3.562385000001086]},"deleteCapsule":{"times":[2.1875399999989895]},"validateEnqueuedNotesAndEvents":{"times":[10.063678999998956]},"getNotes":{"times":[1.4901320000026317]},"getAuthWitness":{"times":[0.17296899999928428]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04980999999679625]},"callPrivateFunction":{"times":[466.7109649999984,96.28235800000039]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2292089999973541]}}},{"functionName":"private_kernel_init","time":49.68364500000098},{"functionName":"ContractClassRegisterer:register","time":453.4289510000017,"oracles":{"loadCapsule":{"times":[2.126962000002095]},"notifyCreatedNullifier":{"times":[0.24848199999905773]},"debugLog":{"times":[0.10347700000056648]},"notifyCreatedContractClassLog":{"times":[3.383001999998669]}}},{"functionName":"private_kernel_inner","time":105.1137060000001},{"functionName":"ContractInstanceDeployer:deploy","time":62.241047999999864,"oracles":{"storeInExecutionCache":{"times":[0.18317600000227685]},"callPrivateFunction":{"times":[36.46571800000311]},"notifyCreatedNullifier":{"times":[0.23727300000246032]},"debugLog":{"times":[0.13340400000015507]}}},{"functionName":"private_kernel_inner","time":100.7986490000003},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":23.580652000000555,"oracles":{}},{"functionName":"private_kernel_inner","time":97.82501100000081},{"functionName":"private_kernel_reset","time":171.74875500000053},{"functionName":"private_kernel_tail","time":79.70364100000006}],"unaccounted":307.24738799999614}}
09:37:40 aztec-1 | [09:37:40.211]
INFO:
node Received tx 0x14ce46e8132acc40c5c37a5c3706bd92a203f24925f73c3345301089964c61ed
{"txHash":"0x14ce46e8132acc40c5c37a5c3706bd92a203f24925f73c3345301089964c61ed"}
09:37:40 aztec-1 | [09:37:40.211]
INFO:
pxe:service Sent transaction 0x14ce46e8132acc40c5c37a5c3706bd92a203f24925f73c3345301089964c61ed
09:37:41 aztec-1 | [09:37:41.295]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.9562182329999996s
{"duration":0.9562182329999996,"rate":43153.32899534872,"totalPublicGas":{"daGas":4096,"l2Gas":41264},"totalBlockGas":{"daGas":166912,"l2Gas":66306},"totalSizeInBytes":10688}
09:37:41 aztec-1 | [09:37:41.491]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 35305.6638283827 mana/s
{"blockHash":"0x13daa120fa0be9d40a1a569050e0e7c352df83d3a2759559c74be033028f1771","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749807861,"version":3326517204},"txHashes":["0x14ce46e8132acc40c5c37a5c3706bd92a203f24925f73c3345301089964c61ed"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1168.700796000001,"publicProcessDuration":956.3247069999998,"rollupCircuitsDuration":1155.5489740000012,"txCount":1,"blockNumber":4,"blockTimestamp":1749807861,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
09:37:42 aztec-1 | [09:37:42.137]
INFO:
pxe:service Proving completed in 2060.895134999999ms
{"timings":{"total":2060.895134999999,"sync":105.73948700000255,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":332.7225980000003,"oracles":{"debugLog":{"times":[0.1291559999990568,0.08434300000226358,0.07996300000013434,0.135614999999234,0.08851299999878393,0.0776689999984228,0.07343099999707192,0.11451200000010431]},"fetchTaggedLogs":{"times":[141.08002399999896]},"loadCapsule":{"times":[0.7904259999995702,0.4136450000005425,0.5211889999991399,0.49009600000135833,0.38791199999832315,0.3687389999977313,0.48741700000027777]},"getSharedSecret":{"times":[5.376582000000781]},"aes128Decrypt":{"times":[0.1868209999993269,0.5294140000005427]},"getPublicKeysAndPartialAddress":{"times":[1.2583360000026005]},"getKeyValidationRequest":{"times":[1.8955480000004172]},"storeCapsule":{"times":[2.506316999999399,2.573850000000675,2.7309239999995043]},"deleteCapsule":{"times":[18.397127000000182]},"validateEnqueuedNotesAndEvents":{"times":[11.831711999999243]},"getNotes":{"times":[2.647680999998556]},"getAuthWitness":{"times":[0.17505099999834783]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06977499999993597]},"callPrivateFunction":{"times":[484.7779249999985,103.92264499999874]},"notifyEnqueuedPublicFunctionCall":{"times":[0.09114799999952083]}}},{"functionName":"private_kernel_init","time":53.956552999999985},{"functionName":"ContractClassRegisterer:register","time":469.66613099999813,"oracles":{"loadCapsule":{"times":[1.7617239999999583]},"notifyCreatedNullifier":{"times":[0.2758219999996072]},"debugLog":{"times":[0.10184900000240305]},"notifyCreatedContractClassLog":{"times":[3.383904000002076]}}},{"functionName":"private_kernel_inner","time":107.81203900000037},{"functionName":"ContractInstanceDeployer:deploy","time":65.23411300000225,"oracles":{"storeInExecutionCache":{"times":[0.08636999999725958]},"callPrivateFunction":{"times":[40.43417899999986]},"notifyCreatedNullifier":{"times":[0.23465199999918696]},"debugLog":{"times":[0.14234099999885075]}}},{"functionName":"private_kernel_inner","time":103.81585099999938},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":27.339404999998806,"oracles":{}},{"functionName":"private_kernel_inner","time":110.54237600000124},{"functionName":"private_kernel_reset","time":171.09331499999826},{"functionName":"private_kernel_tail","time":113.05534900000202}],"unaccounted":399.91791799999555}}
09:37:42 aztec-1 | [09:37:42.379]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:37:42 aztec-1 | [09:37:42.385]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:37:42 aztec-1 | [09:37:42.385]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:44:33.000Z
{"offset":410615,"timeMs":1749807873000}
09:37:42 aztec-1 | [09:37:42.387]
INFO:
node Received tx 0x03365d6cb96ee0ded49535abaee039fd92369d31c91cedfb4585d39e27ee81d7
{"txHash":"0x03365d6cb96ee0ded49535abaee039fd92369d31c91cedfb4585d39e27ee81d7"}
09:37:42 aztec-1 | [09:37:42.387]
INFO:
pxe:service Sent transaction 0x03365d6cb96ee0ded49535abaee039fd92369d31c91cedfb4585d39e27ee81d7
09:37:42 aztec-1 | [09:37:42.389]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
09:37:42 aztec-1 | [09:37:42.391]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
09:37:42 aztec-1 | [09:37:42.393]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749807897
09:37:42 aztec-1 | [09:37:42.393]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:44:57.000Z
{"offset":434607,"timeMs":1749807897000}
09:37:42 aztec-1 | [09:37:42.393]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
09:37:42 aztec-1 | [09:37:42.497]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x13daa120fa0be9d40a1a569050e0e7c352df83d3a2759559c74be033028f1771","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749807861,"version":3326517204},"archiveRoot":"0x2a9976f223c36053bac173cf738278348cf7a1e920a4423b5ebd2a415a62d24e","archiveNextLeafIndex":5}
09:37:42 aztec-1 | [09:37:42.502]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
09:37:42 aztec-1 | [09:37:42.528]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":13.21718200000032,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749807861,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
09:37:43 aztec-1 | [09:37:42.874]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.2539570569999996s
{"duration":0.2539570569999996,"rate":1305137.9785047695,"totalPublicGas":{"daGas":10240,"l2Gas":331449},"totalBlockGas":{"daGas":380928,"l2Gas":356491},"totalSizeInBytes":24064}
09:37:43 aztec-1 | [09:37:42.914]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 1099070.7010025682 mana/s
{"blockHash":"0x11fccd816fbb080f2fca1a30dbbd604bf75fcc6773bbe359f1d85de16b97a9d9","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749807897,"version":3326517204},"txHashes":["0x03365d6cb96ee0ded49535abaee039fd92369d31c91cedfb4585d39e27ee81d7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":301.54695100000026,"publicProcessDuration":254.36205100000006,"rollupCircuitsDuration":296.94883299999856,"txCount":1,"blockNumber":5,"blockTimestamp":1749807897,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
09:37:43 aztec-1 | [09:37:43.120]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
09:37:43 aztec-1 | [09:37:43.126]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
09:37:43 aztec-1 | [09:37:43.128]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:37:43 aztec-1 | [09:37:43.131]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749807933
09:37:43 aztec-1 | [09:37:43.131]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:45:33.000Z
{"offset":469869,"timeMs":1749807933000}
09:37:43 aztec-1 | [09:37:43.131]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
09:37:43 aztec-1 | [09:37:43.280]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x11fccd816fbb080f2fca1a30dbbd604bf75fcc6773bbe359f1d85de16b97a9d9","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749807897,"version":3326517204},"archiveRoot":"0x08888531dda51fadd1dd41ca67a49456a4be5184a3ca089014079c28692ccb3f","archiveNextLeafIndex":6}
09:37:43 aztec-1 | [09:37:43.285]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
09:37:43 aztec-1 | [09:37:43.337]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":17.466812000002392,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749807897,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
09:37:43 aztec-1 | [09:37:43.389]
INFO:
aztecjs:deploy_sent_tx Contract 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 successfully deployed.
09:37:43 aztec-1 | BananaCoin: 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf
09:37:43 aztec-1 | FPC: 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45
09:37:43 aztec-1 | [09:37:43.588]
INFO:
aztecjs:deploy_sent_tx Contract 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf successfully deployed.
09:37:43 aztec-1 | [09:37:43.616]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
09:37:43 aztec-1 | [09:37:43.618]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
09:37:43 aztec-1 | [09:37:43.728]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
09:37:45 aztec-1 | [09:37:45.415]
INFO:
pxe:service Proving completed in 1670.0113649999985ms
{"timings":{"total":1670.0113649999985,"sync":26.992572000002838,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":60.58337799999936,"oracles":{"callPrivateFunction":{"times":[475.7782299999999,97.24482700000226,44.509438000000955]}}},{"functionName":"private_kernel_init","time":48.70368799999778},{"functionName":"ContractClassRegisterer:register","time":464.47274200000174,"oracles":{"loadCapsule":{"times":[1.7257840000020224]},"notifyCreatedNullifier":{"times":[0.26470899999912945]},"debugLog":{"times":[0.11981100000048173]},"notifyCreatedContractClassLog":{"times":[3.363111000002391]}}},{"functionName":"private_kernel_inner","time":99.89638799999739},{"functionName":"ContractInstanceDeployer:deploy","time":61.71925499999634,"oracles":{"storeInExecutionCache":{"times":[0.07157400000141934]},"callPrivateFunction":{"times":[37.94372099999964]},"notifyCreatedNullifier":{"times":[0.21841499999936786]},"debugLog":{"times":[0.15491800000017975]}}},{"functionName":"private_kernel_inner","time":100.52470699999685},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":25.538706000003003,"oracles":{}},{"functionName":"private_kernel_inner","time":99.83380299999772},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":34.26706900000136,"oracles":{"debugLog":{"times":[0.12228700000196113]}}},{"functionName":"private_kernel_inner","time":99.6900229999992},{"functionName":"private_kernel_reset","time":161.52886600000056},{"functionName":"private_kernel_tail","time":66.2515450000028}],"unaccounted":320.00862300000153}}
09:37:45 aztec-1 | [09:37:45.509]
INFO:
node Received tx 0x14738435e7624d7d7da1ef01af236b9748f25158a89a9344ab54882792305714
{"txHash":"0x14738435e7624d7d7da1ef01af236b9748f25158a89a9344ab54882792305714"}
09:37:45 aztec-1 | [09:37:45.509]
INFO:
pxe:service Sent transaction 0x14738435e7624d7d7da1ef01af236b9748f25158a89a9344ab54882792305714
09:37:45 aztec-1 | [09:37:45.608]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02339285999999993s
{"duration":0.02339285999999993,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
09:37:45 aztec-1 | [09:37:45.626]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2a8c7ff9b539fec18e9f724b82d1c17dd615958cd706a8b0e7c13646702b3a6f","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749807933,"version":3326517204},"txHashes":["0x14738435e7624d7d7da1ef01af236b9748f25158a89a9344ab54882792305714"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":48.21591900000203,"publicProcessDuration":23.490281000002142,"rollupCircuitsDuration":43.27313299999878,"txCount":1,"blockNumber":6,"blockTimestamp":1749807933,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
09:37:45 aztec-1 | [09:37:45.795]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:37:45 aztec-1 | [09:37:45.847]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:37:45 aztec-1 | [09:37:45.847]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:45:45.000Z
{"offset":479153,"timeMs":1749807945000}
09:37:45 aztec-1 | [09:37:45.856]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
09:37:45 aztec-1 | [09:37:45.860]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
09:37:45 aztec-1 | [09:37:45.865]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
09:37:45 aztec-1 | error: "Rollup__SlotAlreadyInChain(7, 7)"
09:37:45 aztec-1 | [09:37:45.865]
WARN:
sequencer Cannot propose block 6 at slot 7 due to failed rollup contract check
09:37:45 aztec-1 | [09:37:45.904]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x2a8c7ff9b539fec18e9f724b82d1c17dd615958cd706a8b0e7c13646702b3a6f","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749807933,"version":3326517204},"archiveRoot":"0x17852d32f82e0d9f0524b96478ca534357ecd9f03148ef4f104abb6703ea8942","archiveNextLeafIndex":7}
09:37:45 aztec-1 | [09:37:45.909]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
09:37:45 aztec-1 | [09:37:45.939]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":12.558084999996936,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749807933,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
09:37:46 aztec-1 | [09:37:45.979]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
09:37:46 aztec-1 | error: "Rollup__SlotAlreadyInChain(7, 7)"
09:37:46 aztec-1 | [09:37:45.979]
WARN:
sequencer Cannot propose block 7 at slot 7 due to failed rollup contract check
09:37:46 aztec-1 | [09:37:45.999]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749807969
09:37:46 aztec-1 | [09:37:45.999]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:46:09.000Z
{"offset":503001,"timeMs":1749807969000}
09:37:46 aztec-1 | [09:37:45.999]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
09:37:46 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
09:37:47 aztec-1 | [09:37:46.526]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
09:37:47 aztec-1 | [09:37:46.530]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x2bf2a95060ddbd049be7f501ee6d0dd0fde85c50e642e13a84f201e420805b66","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
09:37:50 playground-1 | \
09:37:50 playground-1 |
Running 1
test using 1
worker
09:37:50 playground-1 |
09:37:51 playground-1 |
1 [firefox] › browser.spec.ts:3:1 › test
09:37:56 playground-1 |
[WebServer] The file does not exist at "/root/aztec-packages/playground/node_modules/.vite/deps/chunk-RU35QIXL.js" which is in the optimize deps directory. The dependency might be incompatible with the dep optimizer. Try adding it to `optimizeDeps.exclude`.
09:37:56 playground-1 |
[WebServer] The file does not exist at "/root/aztec-packages/playground/node_modules/.vite/deps/chunk-UHBOFEX6.js" which is in the optimize deps directory. The dependency might be incompatible with the dep optimizer. Try adding it to `optimizeDeps.exclude`.
09:37:56 playground-1 |
[WebServer] The file does not exist at "/root/aztec-packages/playground/node_modules/.vite/deps/chunk-UHBOFEX6.js" which is in the optimize deps directory. The dependency might be incompatible with the dep optimizer. Try adding it to `optimizeDeps.exclude`.
09:37:56 playground-1 |
[WebServer] The file does not exist at "/root/aztec-packages/playground/node_modules/.vite/deps/chunk-V3AGBFOK.js" which is in the optimize deps directory. The dependency might be incompatible with the dep optimizer. Try adding it to `optimizeDeps.exclude`.
09:37:56 playground-1 |
✓ 1 [firefox] › browser.spec.ts:3:1 › test
(8.1s)
09:38:01 playground-1 |
1 passed (11.7s)
09:38:01 playground-1 | \
09:38:01
playground-1 exited with code 0
09:38:01 Aborting on container exit...
09:38:01 Container playground-firefox-playground-1 Stopping
09:38:01 Container playground-firefox-playground-1 Stopped
09:38:01 Container playground-firefox-aztec-1 Stopping
09:38:02 Container playground-firefox-aztec-1 Stopped
09:38:02 Container playground-firefox-ethereum-1 Stopping
09:38:02 Container playground-firefox-ethereum-1 Stopped