Parent Log:
http://ci.aztec-labs.com/dc2fa81d7e6e38ef
Command: c0136391379d1261 playground/scripts/run_test.sh webkit
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/1650b3d017a2a4fa5182c8787e79cc108e24e1f4
Env: REF_NAME=gh-readonly-queue/next/pr-14990-77a00686be4080a71b03d68671da6c8b270b62aa CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Thu Jun 12 10:53:01 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14990_amd64_x1-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_4f5ae3bf6a603dd3_next
10:53:02 Network playground-webkit_default Creating
10:53:02 Network playground-webkit_default Created
10:53:02 Container playground-webkit-ethereum-1 Creating
10:53:03 Container playground-webkit-ethereum-1 Created
10:53:03 Container playground-webkit-aztec-1 Creating
10:53:03 Container playground-webkit-aztec-1 Created
10:53:03 Container playground-webkit-playground-1 Creating
10:53:04 Container playground-webkit-playground-1 Created
10:53:04 Attaching to aztec-1, ethereum-1, playground-1
10:53:09 aztec-1 |
10:53:09 aztec-1 | _
10:53:09 aztec-1 | /\ | |
10:53:09 aztec-1 | / \ ___| |_ ___ ___
10:53:09 aztec-1 | / /\ \ |_ / __/ _ \/ __|
10:53:09 aztec-1 | / ____ \ / /| || __/ (__
10:53:09 aztec-1 | /_/___ \_\/___|\__\___|\___|
10:53:09 aztec-1 |
10:53:09 aztec-1 |
https://github.com/AztecProtocol
10:53:09 aztec-1 |
10:53:09 aztec-1 |
10:53:09 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
10:53:10 aztec-1 | Setting up test accounts
10:53:11 aztec-1 | [10:53:10.846]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-ZPMoOI/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
10:53:11 aztec-1 | [10:53:11.113]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
10:53:11 aztec-1 | [10:53:11.119]
WARN:
sandbox Set block interval to 12
10:53:11 aztec-1 | [10:53:11.327]
INFO:
sandbox Waiting for 7 transactions to be mined...
10:53:11 aztec-1 | [10:53:11.350]
INFO:
sandbox All transactions mined successfully
10:53:11 aztec-1 | [10:53:11.437]
INFO:
sandbox Waiting for 9 transactions to be mined...
10:53:11 aztec-1 | [10:53:11.455]
INFO:
sandbox All transactions mined successfully
10:53:11 aztec-1 | [10:53:11.590]
INFO:
sandbox Waiting for 11 transactions to be mined...
10:53:11 aztec-1 | [10:53:11.611]
INFO:
sandbox All transactions mined successfully
10:53:11 aztec-1 | [10:53:11.683]
INFO:
sandbox Waiting for 12 transactions to be mined...
10:53:11 aztec-1 | [10:53:11.705]
INFO:
sandbox All transactions mined successfully
10:53:11 aztec-1 | [10:53:11.711]
INFO:
sandbox Waiting for 12 transactions to be mined...
10:53:11 aztec-1 | [10:53:11.737]
INFO:
sandbox All transactions mined successfully
10:53:11 aztec-1 | [10:53:11.760]
INFO:
sandbox Aztec L1 contracts initialized
{"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x68b1d87f95878fe05b998f19b66f4baba5de1aed","inboxAddress":"0xa12ffa0b9f159bb4c54bce579611927addc51610","outboxAddress":"0x53839913417ebc7171723489f29b9b54f49b4eea","feeJuicePortalAddress":"0x67671478a98e62381bf90cdd328cffcddd26c83a","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"}
10:53:11 aztec-1 | [10:53:11.760]
INFO:
sandbox Handing over to governance
10:53:11 aztec-1 | [10:53:11.773]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x68B1D87F95878fE05B998F19b66F4baba5De1aed
10:53:11 aztec-1 | [10:53:11.774]
INFO:
telemetry:client Using NoopTelemetryClient
10:53:11 aztec-1 | [10:53:11.774]
INFO:
blob-sink:client Creating local blob sink client.
10:53:11 aztec-1 | [10:53:11.779]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
10:53:11 aztec-1 | [10:53:11.779]
WARN:
foundation:test-date-provider Time set to 2025-06-12T10:57:41.000Z
{"offset":269221,"timeMs":1749725861000}
10:53:11 aztec-1 | [10:53:11.804]
INFO:
archiver:lmdb Starting data store with maxReaders 16
10:53:12 aztec-1 | [10:53:12.168]
INFO:
archiver Starting archiver sync to rollup contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed from L1 block 19 to current L1 block 23 with hash 0x5da2ba44700e58ea7fd7d56f6430ed1607c8a19b04bfad49c3e1ed44cf14ea3c
{"blocksSynchedTo":19,"messagesSynchedTo":{"l1BlockHash":"0xf99b2a4dbd65448f306945779c69d29a6831fff4305d23d546dd7c5f38d0264f","l1BlockNumber":19}}
10:53:12 aztec-1 | [10:53:12.190]
INFO:
archiver Initial archiver sync to L1 block 23 complete.
{"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0x5da2ba44700e58ea7fd7d56f6430ed1607c8a19b04bfad49c3e1ed44cf14ea3c","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
10:53:12 aztec-1 | [10:53:12.198]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-8QNJmO/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
10:53:12 aztec-1 | [10:53:12.428]
INFO:
world_state Created world state synchroniser with block history of 64
10:53:12 aztec-1 | [10:53:12.428]
WARN:
node Aztec node is accepting fake proofs
10:53:12 aztec-1 | [10:53:12.439]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
10:53:12 aztec-1 | [10:53:12.457]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
10:53:12 aztec-1 | [10:53:12.472]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
10:53:12 aztec-1 | [10:53:12.483]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
10:53:12 aztec-1 | [10:53:12.488]
INFO:
world_state Started world state synchronizer from block 1
10:53:13 aztec-1 | [10:53:12.491]
INFO:
p2p Starting p2p client from block 0 with empty mempools
10:53:13 aztec-1 | [10:53:12.793]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
10:53:13 aztec-1 | [10:53:12.856]
INFO:
slasher Starting Slasher client...
10:53:13 aztec-1 | [10:53:12.866]
INFO:
sequencer-client Deploying forwarder contract
10:53:13 aztec-1 | [10:53:12.888]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
10:53:13 aztec-1 | [10:53:12.896]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
10:53:13 aztec-1 | [10:53:12.896]
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}
10:53:13 aztec-1 | [10:53:12.898]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
10:53:13 aztec-1 | [10:53:12.899]
INFO:
node Aztec Node version: 0.87.6
10:53:13 aztec-1 | [10:53:12.899]
INFO:
node Aztec Node started on chain 0x7a69
{"rollupAddress":"0x68b1d87f95878fe05b998f19b66f4baba5de1aed","registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","inboxAddress":"0xa12ffa0b9f159bb4c54bce579611927addc51610","outboxAddress":"0x53839913417ebc7171723489f29b9b54f49b4eea","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","feeJuicePortalAddress":"0x67671478a98e62381bf90cdd328cffcddd26c83a","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","slashFactoryAddress":"0xc6e7df5e7b4f2a278906862b61205850344d4e7d","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"}
10:53:13 aztec-1 | [10:53:12.904]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
10:53:13 aztec-1 | [10:53:12.909]
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}
10:53:13 aztec-1 | [10:53:12.983]
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}
10:53:13 aztec-1 | [10:53:13.051]
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}
10:53:13 aztec-1 | [10:53:13.137]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
10:53:13 aztec-1 | [10:53:13.138]
WARN:
foundation:test-date-provider Time set to 2025-06-12T10:57:53.000Z
{"offset":279863,"timeMs":1749725873000}
10:53:13 aztec-1 | Setting up funded test accounts...
10:53:13 aztec-1 | [10:53:13.275]
INFO:
pxe:service Started PXE connected to chain 31337 version 3573608979
10:53:13 aztec-1 | [10:53:13.374]
INFO:
pxe:service Registered account 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef
10:53:13 aztec-1 | [10:53:13.441]
WARN:
pxe:service No artifact found for contract class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f when looking for its metadata
10:53:13 aztec-1 | [10:53:13.443]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f as part of deployment for 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef
10:53:13 aztec-1 | [10:53:13.599]
INFO:
pxe:service Added contract SchnorrAccount at 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f
10:53:16 aztec-1 | [10:53:16.630]
INFO:
pxe:service Proving completed in 2989.803914000001ms
{"timings":{"total":2989.803914000001,"sync":5.664864999999736,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":151.18293500000254,"oracles":{"callPrivateFunction":{"times":[955.7087090000005,393.6806089999991,184.12191100000018]}}},{"functionName":"private_kernel_init","time":120.65783899999951},{"functionName":"ContractClassRegisterer:register","time":935.0649450000001,"oracles":{"loadCapsule":{"times":[41.340048000000024]},"notifyCreatedNullifier":{"times":[1.1075549999986833]},"debugLog":{"times":[0.5617469999997411]},"notifyCreatedContractClassLog":{"times":[10.491479000000254]}}},{"functionName":"private_kernel_inner","time":174.188540000001},{"functionName":"SchnorrAccount:constructor","time":365.06655899999896,"oracles":{"getContractInstance":{"times":[5.372142000000167]},"debugLog":{"times":[0.24150299999928393,0.10790099999940139]},"fetchTaggedLogs":{"times":[92.88623100000041]},"loadCapsule":{"times":[0.40081500000087544,0.24413300000014715,0.2532230000015261]},"validateEnqueuedNotesAndEvents":{"times":[6.263952999999674]},"notifyCreatedNullifier":{"times":[0.3468939999984286,0.23318299999846204]},"notifyCreatedNote":{"times":[0.6704890000000887]},"getRandomField":{"times":[0.4041450000004261,0.34415400000034424,0.15432199999850127,0.11464100000011967,0.3268840000000637,0.11584199999924749,0.08211100000153237,0.08482099999855564,0.07948100000066916,0.1513520000007702,0.050940999999511405]},"getIndexedTaggingSecretAsSender":{"times":[37.650148999999146]},"incrementAppTaggingSecretIndexAsSender":{"times":[28.444147000000157]}}},{"functionName":"private_kernel_inner","time":160.27970399999867},{"functionName":"SchnorrAccount:entrypoint","time":167.6786030000003,"oracles":{"debugLog":{"times":[0.18523300000015297,0.13468100000136474,0.43771600000036415]},"fetchTaggedLogs":{"times":[45.013316000000486]},"loadCapsule":{"times":[0.30110400000012305,0.19232300000112446,0.22081299999990733]},"validateEnqueuedNotesAndEvents":{"times":[6.2318429999995715]},"getNotes":{"times":[4.435238000000027]},"getAuthWitness":{"times":[0.39546599999994214]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.1143449999999575]}}},{"functionName":"private_kernel_inner","time":131.58701399999882},{"functionName":"private_kernel_reset","time":194.10332299999936},{"functionName":"private_kernel_tail","time":90.34881700000005}],"unaccounted":493.98077000000194}}
10:53:16 aztec-1 | [10:53:16.750]
INFO:
node Received tx 0x2100d0ac9d186ead57d35d2f0176665d1f729cefa779d7567a9b848fe1b4ae50
{"txHash":"0x2100d0ac9d186ead57d35d2f0176665d1f729cefa779d7567a9b848fe1b4ae50"}
10:53:16 aztec-1 | [10:53:16.750]
INFO:
pxe:service Sent transaction 0x2100d0ac9d186ead57d35d2f0176665d1f729cefa779d7567a9b848fe1b4ae50
10:53:16 aztec-1 | [10:53:16.834]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.031217462999999043s
{"duration":0.031217462999999043,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
10:53:16 aztec-1 | [10:53:16.862]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x22d662cda74925c34afb1912f98e2086e95cc1c6b16bd84791035755b2048953","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749725885,"version":3573608979},"txHashes":["0x2100d0ac9d186ead57d35d2f0176665d1f729cefa779d7567a9b848fe1b4ae50"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":68.79736200000116,"publicProcessDuration":31.879753000001074,"rollupCircuitsDuration":60.79252499999893,"txCount":1,"blockNumber":1,"blockTimestamp":1749725885,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
10:53:19 aztec-1 | [10:53:19.817]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
10:53:19 aztec-1 | [10:53:19.819]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
10:53:19 aztec-1 | [10:53:19.821]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
10:53:19 aztec-1 | [10:53:19.914]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
10:53:19 aztec-1 | error: "Rollup__SlotAlreadyInChain(2, 2)"
10:53:19 aztec-1 | [10:53:19.914]
WARN:
sequencer Cannot propose block 1 at slot 2 due to failed rollup contract check
10:53:19 aztec-1 | [10:53:19.933]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x22d662cda74925c34afb1912f98e2086e95cc1c6b16bd84791035755b2048953","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749725885,"version":3573608979},"archiveRoot":"0x05c79bf8210db4bb376d3e9f822bed5a151d46b0cf8f996449e70135e890aa5e","archiveNextLeafIndex":2}
10:53:19 aztec-1 | [10:53:19.940]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
10:53:20 aztec-1 | [10:53:20.007]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
10:53:20 aztec-1 | [10:53:20.007]
WARN:
foundation:test-date-provider Time set to 2025-06-12T10:58:05.000Z
{"offset":284993,"timeMs":1749725885000}
10:53:20 aztec-1 | [10:53:20.008]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":21.362802999999985,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749725885,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
10:53:20 aztec-1 | [10:53:20.079]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749725921
10:53:20 aztec-1 | [10:53:20.079]
WARN:
foundation:test-date-provider Time set to 2025-06-12T10:58:41.000Z
{"offset":320921,"timeMs":1749725921000}
10:53:20 aztec-1 | [10:53:20.079]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
10:53:20 aztec-1 | [10:53:20.131]
INFO:
pxe:service Registered account 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741
10:53:20 aztec-1 | [10:53:20.268]
INFO:
pxe:service Added contract SchnorrAccount at 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741 with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f
10:53:22 aztec-1 | [10:53:21.803]
INFO:
pxe:service Proving completed in 1495.849689999999ms
{"timings":{"total":1495.849689999999,"sync":22.1169430000009,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":102.10964400000012,"oracles":{"callPrivateFunction":{"times":[404.99713899999915,241.5907929999994]}}},{"functionName":"private_kernel_init","time":73.25634100000025},{"functionName":"SchnorrAccount:constructor","time":374.05095900000015,"oracles":{"getContractInstance":{"times":[5.669245000000956]},"debugLog":{"times":[0.1744619999990391,0.22477300000173273]},"fetchTaggedLogs":{"times":[100.10857700000088]},"loadCapsule":{"times":[1.1028650000007474,0.33697399999982736,0.2332330000008369]},"validateEnqueuedNotesAndEvents":{"times":[6.059541000000536]},"notifyCreatedNullifier":{"times":[0.35731399999895075,0.3219039999985398]},"notifyCreatedNote":{"times":[0.15550199999961478]},"getRandomField":{"times":[0.13132199999927252,0.22499299999981304,0.13092200000028242,0.12287199999991572,0.151531999999861,0.0955309999990277,0.091350999999122,0.07490099999995437,0.07796100000086881,0.08771100000012666,0.07729099999960454]},"getIndexedTaggingSecretAsSender":{"times":[51.275440000001254]},"incrementAppTaggingSecretIndexAsSender":{"times":[38.324478000000454]}}},{"functionName":"private_kernel_inner","time":97.91517799999929},{"functionName":"SchnorrAccount:entrypoint","time":216.3844590000008,"oracles":{"debugLog":{"times":[0.16374199999881967,0.09067099999992934,0.14498199999979988]},"fetchTaggedLogs":{"times":[53.04101300000002]},"loadCapsule":{"times":[0.188321999999971,0.12844099999892933,0.1282520000004297]},"validateEnqueuedNotesAndEvents":{"times":[7.0237230000002455]},"getNotes":{"times":[6.693977999999333]},"getAuthWitness":{"times":[0.11664099999870814]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.39257499999985157]}}},{"functionName":"private_kernel_inner","time":91.89891799999896},{"functionName":"private_kernel_reset","time":150.0225590000009},{"functionName":"private_kernel_tail","time":93.19372599999951}],"unaccounted":274.9009629999982}}
10:53:22 aztec-1 | [10:53:21.875]
INFO:
node Received tx 0x28e40cec5d1016c5cc0638a33af2c4bd375fd7a9e449f756ae92669428756369
{"txHash":"0x28e40cec5d1016c5cc0638a33af2c4bd375fd7a9e449f756ae92669428756369"}
10:53:22 aztec-1 | [10:53:21.875]
INFO:
pxe:service Sent transaction 0x28e40cec5d1016c5cc0638a33af2c4bd375fd7a9e449f756ae92669428756369
10:53:22 aztec-1 | [10:53:21.981]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.025216614000000845s
{"duration":0.025216614000000845,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
10:53:22 aztec-1 | [10:53:22.010]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x13d535d0e557999ce8c143cd5b4dd70f72c1fccb251a1b52e59d64133c28c4e3","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749725921,"version":3573608979},"txHashes":["0x28e40cec5d1016c5cc0638a33af2c4bd375fd7a9e449f756ae92669428756369"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":61.085659999998825,"publicProcessDuration":25.373546000000715,"rollupCircuitsDuration":56.42628799999875,"txCount":1,"blockNumber":2,"blockTimestamp":1749725921,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:53:22 aztec-1 | [10:53:22.256]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
10:53:22 aztec-1 | [10:53:22.259]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
10:53:22 aztec-1 | [10:53:22.264]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
10:53:22 aztec-1 | [10:53:22.297]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749725957
10:53:22 aztec-1 | [10:53:22.297]
WARN:
foundation:test-date-provider Time set to 2025-06-12T10:59:17.000Z
{"offset":354703,"timeMs":1749725957000}
10:53:22 aztec-1 | [10:53:22.297]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
10:53:22 aztec-1 | [10:53:22.372]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x13d535d0e557999ce8c143cd5b4dd70f72c1fccb251a1b52e59d64133c28c4e3","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749725921,"version":3573608979},"archiveRoot":"0x1c3ee1f178333bc908f3ec757239e4c95854ebf55bf78676c8b94ad28b506164","archiveNextLeafIndex":3}
10:53:22 aztec-1 | [10:53:22.376]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
10:53:22 aztec-1 | [10:53:22.421]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":17.368389999999636,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749725921,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:53:22 aztec-1 | [10:53:22.540]
INFO:
pxe:service Registered account 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923
10:53:22 aztec-1 | [10:53:22.675]
INFO:
pxe:service Added contract SchnorrAccount at 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923 with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f
10:53:24 aztec-1 | [10:53:24.221]
INFO:
pxe:service Proving completed in 1534.5484630000028ms
{"timings":{"total":1534.5484630000028,"sync":29.66739400000006,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":97.45567299999675,"oracles":{"callPrivateFunction":{"times":[370.4733210000013,222.78566299999875]}}},{"functionName":"private_kernel_init","time":46.93427299999894},{"functionName":"SchnorrAccount:constructor","time":342.04494500000146,"oracles":{"getContractInstance":{"times":[4.894384999999602]},"debugLog":{"times":[0.15484199999991688,0.09127100000114297]},"fetchTaggedLogs":{"times":[111.3939160000009]},"loadCapsule":{"times":[0.16923300000053132,0.17416299999968032,0.14816199999768287]},"validateEnqueuedNotesAndEvents":{"times":[5.929728999999497]},"notifyCreatedNullifier":{"times":[0.3015240000022459,0.2940039999994042]},"notifyCreatedNote":{"times":[0.18841299999985495]},"getRandomField":{"times":[0.129081999999471,0.21103299999958836,0.05069000000003143,0.035859999999956926,0.04761099999814178,0.03555100000085076,0.04686999999830732,0.09294100000261096,0.03924099999858299,0.04450100000030943,0.044551000002684304]},"getIndexedTaggingSecretAsSender":{"times":[42.85646900000211]},"incrementAppTaggingSecretIndexAsSender":{"times":[28.102452999999514]}}},{"functionName":"private_kernel_inner","time":106.28083900000274},{"functionName":"SchnorrAccount:entrypoint","time":198.00634499999796,"oracles":{"debugLog":{"times":[0.15935299999910058,0.08543099999951664,0.17484300000069197]},"fetchTaggedLogs":{"times":[76.53406399999949]},"loadCapsule":{"times":[0.15575199999875622,0.15061200000127428,0.13618199999837088]},"validateEnqueuedNotesAndEvents":{"times":[5.328170000000682]},"getNotes":{"times":[2.585214000002452]},"getAuthWitness":{"times":[0.13245200000164914]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.43739600000117207]}}},{"functionName":"private_kernel_inner","time":148.06050200000027},{"functionName":"private_kernel_reset","time":225.61157100000128},{"functionName":"private_kernel_tail","time":69.33977900000173}],"unaccounted":271.1471420000016}}
10:53:24 aztec-1 | [10:53:24.277]
INFO:
node Received tx 0x01995de39804f5aeaec4e9b0d44e7f715f6f8c7c569a6d9cbd3e4fc71469dcf6
{"txHash":"0x01995de39804f5aeaec4e9b0d44e7f715f6f8c7c569a6d9cbd3e4fc71469dcf6"}
10:53:24 aztec-1 | [10:53:24.278]
INFO:
pxe:service Sent transaction 0x01995de39804f5aeaec4e9b0d44e7f715f6f8c7c569a6d9cbd3e4fc71469dcf6
10:53:24 aztec-1 | [10:53:24.345]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.020735935000000608s
{"duration":0.020735935000000608,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
10:53:24 aztec-1 | [10:53:24.386]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x196c6ab14bcff2864fad20748a40fa61035c87b27777624088cccce83ec18edd","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749725957,"version":3573608979},"txHashes":["0x01995de39804f5aeaec4e9b0d44e7f715f6f8c7c569a6d9cbd3e4fc71469dcf6"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":69.82884600000034,"publicProcessDuration":20.936868000000686,"rollupCircuitsDuration":63.808335999998235,"txCount":1,"blockNumber":3,"blockTimestamp":1749725957,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:53:24 aztec-1 | [10:53:24.614]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
10:53:24 aztec-1 | [10:53:24.659]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
10:53:24 aztec-1 | [10:53:24.659]
WARN:
foundation:test-date-provider Time set to 2025-06-12T10:59:29.000Z
{"offset":364341,"timeMs":1749725969000}
10:53:24 aztec-1 | [10:53:24.660]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
10:53:24 aztec-1 | [10:53:24.661]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
10:53:24 aztec-1 | [10:53:24.686]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749725993
10:53:24 aztec-1 | [10:53:24.686]
WARN:
foundation:test-date-provider Time set to 2025-06-12T10:59:53.000Z
{"offset":388314,"timeMs":1749725993000}
10:53:24 aztec-1 | [10:53:24.686]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
10:53:24 aztec-1 | [10:53:24.692]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
10:53:24 aztec-1 | error: "Rollup__SlotAlreadyInChain(4, 4)"
10:53:24 aztec-1 | [10:53:24.692]
WARN:
sequencer Cannot propose block 3 at slot 4 due to failed rollup contract check
10:53:24 aztec-1 | [10:53:24.734]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x196c6ab14bcff2864fad20748a40fa61035c87b27777624088cccce83ec18edd","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749725957,"version":3573608979},"archiveRoot":"0x03a235c1e32f52bb3e718923119f1d96d219340f09d5df50a1ff79249de5d9e6","archiveNextLeafIndex":4}
10:53:24 aztec-1 | [10:53:24.737]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
10:53:24 aztec-1 | [10:53:24.786]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":20.99768899999981,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749725957,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:53:24 aztec-1 | Initial Accounts:
10:53:24 aztec-1 |
10:53:24 aztec-1 | Address: 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef
10:53:24 aztec-1 | Partial Address: 0x25cdbb7a5be4a2b0e9adb1e87d0b5f372a1fa87051c9bcfee1d2c12805bf4aac
10:53:24 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
10:53:24 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
10:53:24 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
10:53:24 aztec-1 |
10:53:24 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
10:53:24 aztec-1 |
10:53:24 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
10:53:24 aztec-1 |
10:53:24 aztec-1 | Address: 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741
10:53:24 aztec-1 | Partial Address: 0x0c7f265c4adbd783aa791ae3f6859e620def9316c9013a9a72c68d3df8514776
10:53:24 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
10:53:24 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
10:53:24 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
10:53:24 aztec-1 |
10:53:24 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
10:53:24 aztec-1 |
10:53:24 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
10:53:24 aztec-1 |
10:53:24 aztec-1 | Address: 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923
10:53:24 aztec-1 | Partial Address: 0x26ee9b51c1ec4a4c6810ea237b0a33367ab5d0c7fd08e07761ac9c429a28ef0a
10:53:24 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
10:53:24 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
10:53:24 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
10:53:24 aztec-1 |
10:53:24 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
10:53:24 aztec-1 |
10:53:24 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
10:53:24 aztec-1 |
10:53:24 aztec-1 |
10:53:25 aztec-1 | [10:53:25.607]
WARN:
pxe:service No artifact found for contract class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3 when looking for its metadata
10:53:25 aztec-1 | [10:53:25.607]
WARN:
pxe:service No artifact found for contract class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249 when looking for its metadata
10:53:25 aztec-1 | [10:53:25.612]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3 as part of deployment for 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae
10:53:25 aztec-1 | [10:53:25.647]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249 as part of deployment for 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7
10:53:26 aztec-1 | [10:53:26.549]
INFO:
pxe:service Added contract FPC at 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae with class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3
10:53:26 aztec-1 | [10:53:26.552]
INFO:
pxe:service Added contract Token at 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 with class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249
10:53:29 aztec-1 | [10:53:28.843]
INFO:
pxe:service Proving completed in 2235.4246539999986ms
{"timings":{"total":2235.4246539999986,"sync":40.131352000000334,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":362.95182100000966,"oracles":{"debugLog":{"times":[0.2237329999989015,0.13573200000246288,0.12972199999785516,0.2803539999986242,0.12982199999896693,0.13594200000079582,0.09139100000174949,0.16709199999968405]},"fetchTaggedLogs":{"times":[133.5340099999994]},"loadCapsule":{"times":[0.5135169999994105,0.15379299999767682,0.28556400000161375,0.24941300000136835,0.24913300000116578,0.20537200000035227,0.1993430000002263]},"getSharedSecret":{"times":[6.090070999998716]},"aes128Decrypt":{"times":[1.2669370000003255,0.8755120000023453]},"getPublicKeysAndPartialAddress":{"times":[1.9367249999995693]},"getKeyValidationRequest":{"times":[2.6365350000014587]},"storeCapsule":{"times":[2.8724490000022342,2.6773450000000594,2.5466340000020864]},"deleteCapsule":{"times":[2.7959679999985383]},"validateEnqueuedNotesAndEvents":{"times":[30.722916999999143]},"getNotes":{"times":[16.501298999999563]},"getAuthWitness":{"times":[0.18418300000121235]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.038799999998445855]},"callPrivateFunction":{"times":[599.2247729999981,95.84804000000076]},"notifyEnqueuedPublicFunctionCall":{"times":[0.27548299999762094]}}},{"functionName":"private_kernel_init","time":56.493069000000105},{"functionName":"ContractClassRegisterer:register","time":588.3119289999959,"oracles":{"loadCapsule":{"times":[1.96604600000137]},"notifyCreatedNullifier":{"times":[0.40150500000163447]},"debugLog":{"times":[0.1852519999993092]},"notifyCreatedContractClassLog":{"times":[3.1417009999968286]}}},{"functionName":"private_kernel_inner","time":151.1465440000029},{"functionName":"ContractInstanceDeployer:deploy","time":65.70092199999635,"oracles":{"storeInExecutionCache":{"times":[0.23141300000133924]},"callPrivateFunction":{"times":[34.11836200000107]},"notifyCreatedNullifier":{"times":[0.22996299999795156]},"debugLog":{"times":[0.11029100000087055]}}},{"functionName":"private_kernel_inner","time":116.55062499999985},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":22.13722300000154,"oracles":{}},{"functionName":"private_kernel_inner","time":115.05182500000228},{"functionName":"private_kernel_reset","time":233.15399999999863},{"functionName":"private_kernel_tail","time":91.66718599999876}],"unaccounted":392.12815799999225}}
10:53:29 aztec-1 | [10:53:29.027]
INFO:
node Received tx 0x1ad428611120eb7e4afdb0f7df4096d616386e269e054e9c5d7ca99099ac0a95
{"txHash":"0x1ad428611120eb7e4afdb0f7df4096d616386e269e054e9c5d7ca99099ac0a95"}
10:53:29 aztec-1 | [10:53:29.027]
INFO:
pxe:service Sent transaction 0x1ad428611120eb7e4afdb0f7df4096d616386e269e054e9c5d7ca99099ac0a95
10:53:31 aztec-1 | [10:53:30.783]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.6087924890000032s
{"duration":1.6087924890000032,"rate":22068.72560802957,"totalPublicGas":{"daGas":4096,"l2Gas":35504},"totalBlockGas":{"daGas":166912,"l2Gas":60546},"totalSizeInBytes":10688}
10:53:31 aztec-1 | [10:53:31.203]
INFO:
pxe:service Proving completed in 2358.1795100000018ms
{"timings":{"total":2358.1795100000018,"sync":147.9954519999992,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":417.67566300000544,"oracles":{"debugLog":{"times":[0.18731300000217743,0.0867419999995036,0.10315099999934318,0.19698200000129873,0.12457200000062585,0.15172199999869918,0.09708200000022771,0.14865199999985634]},"fetchTaggedLogs":{"times":[163.73323299999902]},"loadCapsule":{"times":[14.667132000002312,0.6477789999989909,2.3934430000008433,0.23666299999968032,1.515800000001036,0.319444000000658,0.42859600000156206]},"getSharedSecret":{"times":[9.669653000000835]},"aes128Decrypt":{"times":[0.309385000000475,0.6938899999986461]},"getPublicKeysAndPartialAddress":{"times":[2.365492999997514]},"getKeyValidationRequest":{"times":[5.685609000000113]},"storeCapsule":{"times":[3.1042230000020936,3.629160000000411,5.735478999999032]},"deleteCapsule":{"times":[27.102222999998048]},"validateEnqueuedNotesAndEvents":{"times":[14.525400000002264]},"getNotes":{"times":[3.05876200000057]},"getAuthWitness":{"times":[0.1465520000019751]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0581209999982093]},"callPrivateFunction":{"times":[619.1339159999989,128.55751800000144]},"notifyEnqueuedPublicFunctionCall":{"times":[0.10113099999944097]}}},{"functionName":"private_kernel_init","time":77.8233309999996},{"functionName":"ContractClassRegisterer:register","time":608.8602039999969,"oracles":{"loadCapsule":{"times":[3.210643999998865]},"notifyCreatedNullifier":{"times":[0.5346769999996468]},"debugLog":{"times":[0.1399310000015248]},"notifyCreatedContractClassLog":{"times":[5.414205000000948]}}},{"functionName":"private_kernel_inner","time":117.60031700000036},{"functionName":"ContractInstanceDeployer:deploy","time":65.90732600000047,"oracles":{"storeInExecutionCache":{"times":[0.1049509999975271]},"callPrivateFunction":{"times":[62.29105700000218]},"notifyCreatedNullifier":{"times":[0.27417399999831105]},"debugLog":{"times":[0.13525099999969825]}}},{"functionName":"private_kernel_inner","time":110.94709599999987},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":49.32991899999979,"oracles":{}},{"functionName":"private_kernel_inner","time":100.27440900000147},{"functionName":"private_kernel_reset","time":178.1578410000002},{"functionName":"private_kernel_tail","time":105.56479200000103}],"unaccounted":378.04315999999744}}
10:53:31 aztec-1 | [10:53:31.252]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 16971.776105557095 mana/s
{"blockHash":"0x1565af24e6764aa7a220bf363d38a2032030da0d0c8173de1213bc972a37d0c2","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749725993,"version":3573608979},"txHashes":["0x1ad428611120eb7e4afdb0f7df4096d616386e269e054e9c5d7ca99099ac0a95"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2091.8340019999996,"publicProcessDuration":1608.9025000000001,"rollupCircuitsDuration":2082.1386289999973,"txCount":1,"blockNumber":4,"blockTimestamp":1749725993,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
10:53:31 aztec-1 | [10:53:31.450]
INFO:
node Received tx 0x1aa6e5a2eaf1101649d8476aacca140212859d87a0506993fa2afd9b021d4ed3
{"txHash":"0x1aa6e5a2eaf1101649d8476aacca140212859d87a0506993fa2afd9b021d4ed3"}
10:53:31 aztec-1 | [10:53:31.450]
INFO:
pxe:service Sent transaction 0x1aa6e5a2eaf1101649d8476aacca140212859d87a0506993fa2afd9b021d4ed3
10:53:31 aztec-1 | [10:53:31.657]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
10:53:31 aztec-1 | [10:53:31.660]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749726029
10:53:31 aztec-1 | [10:53:31.660]
WARN:
foundation:test-date-provider Time set to 2025-06-12T11:00:29.000Z
{"offset":417340,"timeMs":1749726029000}
10:53:31 aztec-1 | [10:53:31.660]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
10:53:31 aztec-1 | [10:53:31.667]
WARN:
archiver Failed to reach L2 block 4 at 30 (latest is 3). Rolling back last synched L1 block number to 29.
{"latestLocalL2BlockNumber":3,"latestLocalL2BlockArchive":"0x03a235c1e32f52bb3e718923119f1d96d219340f09d5df50a1ff79249de5d9e6","blocksSynchedTo":29,"currentL1BlockNumber":30,"provenBlockNumber":3,"provenArchive":"0x03a235c1e32f52bb3e718923119f1d96d219340f09d5df50a1ff79249de5d9e6","pendingBlockNumber":4,"pendingArchive":"0x07951ca63321047954b18518fc809d9a908d438367c14582e21e258780fee8b7"}
10:53:31 aztec-1 | [10:53:31.672]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
10:53:31 aztec-1 | [10:53:31.674]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
10:53:31 aztec-1 | [10:53:31.807]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x1565af24e6764aa7a220bf363d38a2032030da0d0c8173de1213bc972a37d0c2","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749725993,"version":3573608979},"archiveRoot":"0x07951ca63321047954b18518fc809d9a908d438367c14582e21e258780fee8b7","archiveNextLeafIndex":5}
10:53:31 aztec-1 | [10:53:31.815]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
10:53:31 aztec-1 | [10:53:31.902]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":21.630826999997225,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749725993,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
10:53:32 aztec-1 | [10:53:32.334]
INFO:
aztecjs:deploy_sent_tx Contract 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae successfully deployed.
10:53:32 aztec-1 | [10:53:32.366]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3734041270000016s
{"duration":0.3734041270000016,"rate":739812.3909862379,"totalPublicGas":{"daGas":10240,"l2Gas":276249},"totalBlockGas":{"daGas":380928,"l2Gas":301291},"totalSizeInBytes":24064}
10:53:32 aztec-1 | [10:53:32.425]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 629046.7062665065 mana/s
{"blockHash":"0x194cde75f0209a5124ba6c4e2d6d65f6e2bbc0637f84bee139016085f42b7639","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749726029,"version":3573608979},"txHashes":["0x1aa6e5a2eaf1101649d8476aacca140212859d87a0506993fa2afd9b021d4ed3"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":439.1250689999979,"publicProcessDuration":373.7044100000021,"rollupCircuitsDuration":434.3591740000011,"txCount":1,"blockNumber":5,"blockTimestamp":1749726029,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
10:53:32 aztec-1 | [10:53:32.727]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
10:53:32 aztec-1 | [10:53:32.732]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
10:53:32 aztec-1 | [10:53:32.732]
WARN:
foundation:test-date-provider Time set to 2025-06-12T11:00:41.000Z
{"offset":428268,"timeMs":1749726041000}
10:53:32 aztec-1 | [10:53:32.737]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
10:53:32 aztec-1 | [10:53:32.739]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
10:53:32 aztec-1 | [10:53:32.743]
WARN:
archiver Failed to reach L2 block 5 at 32 (latest is 4). Rolling back last synched L1 block number to 31.
{"latestLocalL2BlockNumber":4,"latestLocalL2BlockArchive":"0x07951ca63321047954b18518fc809d9a908d438367c14582e21e258780fee8b7","blocksSynchedTo":31,"currentL1BlockNumber":32,"provenBlockNumber":4,"provenArchive":"0x07951ca63321047954b18518fc809d9a908d438367c14582e21e258780fee8b7","pendingBlockNumber":5,"pendingArchive":"0x0f7ea6932fafd23bbc22b1cba5b66ebba46b7a0902bd4d73cee3536fe2c64621"}
10:53:32 aztec-1 | [10:53:32.803]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
10:53:32 aztec-1 | error: "Rollup__SlotAlreadyInChain(6, 6)"
10:53:32 aztec-1 | [10:53:32.804]
WARN:
sequencer Cannot propose block 5 at slot 6 due to failed rollup contract check
10:53:32 aztec-1 | [10:53:32.957]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x194cde75f0209a5124ba6c4e2d6d65f6e2bbc0637f84bee139016085f42b7639","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749726029,"version":3573608979},"archiveRoot":"0x0f7ea6932fafd23bbc22b1cba5b66ebba46b7a0902bd4d73cee3536fe2c64621","archiveNextLeafIndex":6}
10:53:32 aztec-1 | [10:53:32.973]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
10:53:32 aztec-1 | error: "Rollup__SlotAlreadyInChain(6, 6)"
10:53:32 aztec-1 | [10:53:32.973]
WARN:
sequencer Cannot propose block 5 at slot 6 due to failed rollup contract check
10:53:32 aztec-1 | [10:53:32.974]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
10:53:32 aztec-1 | [10:53:32.976]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749726065
10:53:32 aztec-1 | [10:53:32.976]
WARN:
foundation:test-date-provider Time set to 2025-06-12T11:01:05.000Z
{"offset":452024,"timeMs":1749726065000}
10:53:32 aztec-1 | [10:53:32.976]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
10:53:33 aztec-1 | [10:53:33.038]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":29.997111999997287,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749726029,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
10:53:33 aztec-1 | BananaCoin: 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7
10:53:33 aztec-1 | FPC: 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae
10:53:34 aztec-1 | [10:53:33.740]
INFO:
aztecjs:deploy_sent_tx Contract 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 successfully deployed.
10:53:34 aztec-1 | [10:53:33.770]
WARN:
pxe:service No artifact found for contract class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523 when looking for its metadata
10:53:34 aztec-1 | [10:53:33.774]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523 as part of deployment for 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc
10:53:34 aztec-1 | [10:53:33.913]
INFO:
pxe:service Added contract SponsoredFPC at 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc with class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523
10:53:37 aztec-1 | [10:53:36.208]
INFO:
pxe:service Proving completed in 2267.2477050000016ms
{"timings":{"total":2267.2477050000016,"sync":39.93803900000057,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":81.3538410000001,"oracles":{"callPrivateFunction":{"times":[765.2432359999984,120.70555999999851,34.786597999998776]}}},{"functionName":"private_kernel_init","time":74.06953900000008},{"functionName":"ContractClassRegisterer:register","time":741.6764710000025,"oracles":{"loadCapsule":{"times":[1.4060590000008233]},"notifyCreatedNullifier":{"times":[0.5949280000022554]},"debugLog":{"times":[0.18942199999946752]},"notifyCreatedContractClassLog":{"times":[5.338274000001547]}}},{"functionName":"private_kernel_inner","time":127.93723999999929},{"functionName":"ContractInstanceDeployer:deploy","time":62.11896500000148,"oracles":{"storeInExecutionCache":{"times":[0.11333200000080978]},"callPrivateFunction":{"times":[55.10397799999919]},"notifyCreatedNullifier":{"times":[0.20708200000080978]},"debugLog":{"times":[0.09153099999821279]}}},{"functionName":"private_kernel_inner","time":148.0377159999989},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":46.377636999997776,"oracles":{}},{"functionName":"private_kernel_inner","time":149.42154500000106},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":28.519240999998146,"oracles":{"debugLog":{"times":[0.1842030000007071]}}},{"functionName":"private_kernel_inner","time":127.79699700000128},{"functionName":"private_kernel_reset","time":165.97250300000087},{"functionName":"private_kernel_tail","time":75.20827400000053}],"unaccounted":398.819696999999}}
10:53:37 aztec-1 | [10:53:36.320]
INFO:
node Received tx 0x10ba9659e7d59d32b5b0d2661c92276dcf63d244d82940dfe69cc46a2c476b4c
{"txHash":"0x10ba9659e7d59d32b5b0d2661c92276dcf63d244d82940dfe69cc46a2c476b4c"}
10:53:37 aztec-1 | [10:53:36.320]
INFO:
pxe:service Sent transaction 0x10ba9659e7d59d32b5b0d2661c92276dcf63d244d82940dfe69cc46a2c476b4c
10:53:37 aztec-1 | [10:53:36.440]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.039903988999998544s
{"duration":0.039903988999998544,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
10:53:37 aztec-1 | [10:53:36.477]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x17932008028a93aa26a23de067a99423e8475ef99d4bad4e991c08fc740ac49f","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749726065,"version":3573608979},"txHashes":["0x10ba9659e7d59d32b5b0d2661c92276dcf63d244d82940dfe69cc46a2c476b4c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":85.05621999999858,"publicProcessDuration":40.06069099999877,"rollupCircuitsDuration":79.35772200000065,"txCount":1,"blockNumber":6,"blockTimestamp":1749726065,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
10:53:37 aztec-1 | [10:53:36.689]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
10:53:37 aztec-1 | [10:53:36.694]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
10:53:37 aztec-1 | [10:53:36.696]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
10:53:37 aztec-1 | [10:53:36.704]
WARN:
archiver Failed to reach L2 block 6 at 34 (latest is 5). Rolling back last synched L1 block number to 33.
{"latestLocalL2BlockNumber":5,"latestLocalL2BlockArchive":"0x0f7ea6932fafd23bbc22b1cba5b66ebba46b7a0902bd4d73cee3536fe2c64621","blocksSynchedTo":33,"currentL1BlockNumber":34,"provenBlockNumber":5,"provenArchive":"0x0f7ea6932fafd23bbc22b1cba5b66ebba46b7a0902bd4d73cee3536fe2c64621","pendingBlockNumber":6,"pendingArchive":"0x0111d6e53ed636922042ec15f2382724892c981eee3fb859031da15f5256e6ad"}
10:53:37 aztec-1 | [10:53:36.725]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749726101
10:53:37 aztec-1 | [10:53:36.725]
WARN:
foundation:test-date-provider Time set to 2025-06-12T11:01:41.000Z
{"offset":484275,"timeMs":1749726101000}
10:53:37 aztec-1 | [10:53:36.725]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
10:53:37 aztec-1 | [10:53:36.801]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x17932008028a93aa26a23de067a99423e8475ef99d4bad4e991c08fc740ac49f","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749726065,"version":3573608979},"archiveRoot":"0x0111d6e53ed636922042ec15f2382724892c981eee3fb859031da15f5256e6ad","archiveNextLeafIndex":7}
10:53:37 aztec-1 | [10:53:36.806]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
10:53:37 aztec-1 | [10:53:36.858]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":17.80277500000011,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749726065,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
10:53:37 aztec-1 | SponsoredFPC: 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc
10:53:37 aztec-1 | [10:53:37.338]
INFO:
aztecjs:deploy_sent_tx Contract 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc successfully deployed.
10:53:37 aztec-1 | [10:53:37.343]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x08c6b24bd9c265f8c6596b12f540d93a53f5bcd1502d78957c8614575c61c9f4","l2ProtocolContractsTreeRoot":"0x052cc6e2bd1171363e72fb45b9a78fb0ebacedb96c8f1148b3903c3bafa8c458"}
10:53:47 playground-1 | \
10:53:47 playground-1 |
Running 1
test using 1
worker
10:53:47 playground-1 |
10:53:48 playground-1 |
✓ 1 [webkit] › browser.spec.ts:3:1 › test
(11.5s)
10:54:01 playground-1 |
1 passed (15.9s)
10:54:01 playground-1 | \
10:54:01
playground-1 exited with code 0
10:54:01 Aborting on container exit...
10:54:01 Container playground-webkit-playground-1 Stopping
10:54:01 Container playground-webkit-playground-1 Stopped
10:54:01 Container playground-webkit-aztec-1 Stopping
10:54:03 Container playground-webkit-aztec-1 Stopped
10:54:03 Container playground-webkit-ethereum-1 Stopping
10:54:04 Container playground-webkit-ethereum-1 Stopped