Parent Log:
http://ci.aztec-labs.com/e47430d112c0bab3
Command: 15278c1c1d5bf96f:ONLY_TERM_PARENT=1 BOX=vite BROWSER=firefox run_compose_test vite-firefox box boxes
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/dd8277bc6c015d3410ac1884ace6fba583681565
Env: REF_NAME=gh-readonly-queue/next/pr-14873-0468ab2582dd9875f5ada4cc87085956c779a625 CURRENT_VERSION=0.87.6 CI_FULL=0
Date: Wed Jun 11 01:18:25 UTC 2025
System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-14873_arm64_a1-fast
Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s
History: [?25l
[+] Running 4/4
01:18:26
✔ Network vite-firefox_default
Created0.1s
01:18:26
✔ Container vite-firefox-ethereum-1
Created0.1s
01:18:26
✔ Container vite-firefox-aztec-1
Created0.2s
01:18:26
✔ Container vite-firefox-box-1
Created0.1s
01:18:26 [?25hAttaching to aztec-1, box-1, ethereum-1
01:18:30
aztec-1 |
01:18:30
aztec-1 | _
01:18:30
aztec-1 | /\ | |
01:18:30
aztec-1 | / \ ___| |_ ___ ___
01:18:30
aztec-1 | / /\ \ |_ / __/ _ \/ __|
01:18:30
aztec-1 | / ____ \ / /| || __/ (__
01:18:30
aztec-1 | /_/___ \_\/___|\__\___|\___|
01:18:30
aztec-1 |
01:18:30
aztec-1 | https://github.com/AztecProtocol
01:18:30
aztec-1 |
01:18:30
aztec-1 |
01:18:30
aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
01:18:30
aztec-1 | Setting up test accounts
01:18:32
aztec-1 | [01:18:31.064]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-82WcwV/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
01:18:32
aztec-1 | [01:18:31.313]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
01:18:32
aztec-1 | [01:18:31.318]
WARN:
sandbox Set block interval to 12
01:18:32
aztec-1 | [01:18:31.485]
INFO:
sandbox Waiting for 7 transactions to be mined...
01:18:32
aztec-1 | [01:18:31.508]
INFO:
sandbox All transactions mined successfully
01:18:32
aztec-1 | [01:18:31.586]
INFO:
sandbox Waiting for 9 transactions to be mined...
01:18:32
aztec-1 | [01:18:31.604]
INFO:
sandbox All transactions mined successfully
01:18:32
aztec-1 | [01:18:31.720]
INFO:
sandbox Waiting for 11 transactions to be mined...
01:18:32
aztec-1 | [01:18:31.742]
INFO:
sandbox All transactions mined successfully
01:18:32
aztec-1 | [01:18:31.805]
INFO:
sandbox Waiting for 12 transactions to be mined...
01:18:32
aztec-1 | [01:18:31.827]
INFO:
sandbox All transactions mined successfully
01:18:32
aztec-1 | [01:18:31.832]
INFO:
sandbox Waiting for 12 transactions to be mined...
01:18:32
aztec-1 | [01:18:31.857]
INFO:
sandbox All transactions mined successfully
01:18:32
aztec-1 | [01:18:31.871]
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"}
01:18:32
aztec-1 | [01:18:31.872]
INFO:
sandbox Handing over to governance
01:18:32
aztec-1 | [01:18:31.878]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x68B1D87F95878fE05B998F19b66F4baba5De1aed
01:18:32
aztec-1 | [01:18:31.878]
INFO:
telemetry:client Using NoopTelemetryClient
01:18:32
aztec-1 | [01:18:31.879]
INFO:
blob-sink:client Creating local blob sink client.
01:18:32
aztec-1 | [01:18:31.882]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
01:18:32
aztec-1 | [01:18:31.882]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:23:02.000Z
{"offset":270118,"timeMs":1749604982000}
01:18:32
aztec-1 | [01:18:31.900]
INFO:
archiver:lmdb Starting data store with maxReaders 16
01:18:32
aztec-1 | [01:18:32.226]
INFO:
archiver Starting archiver sync to rollup contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed from L1 block 19 to current L1 block 23 with hash 0x9153f4c63dfbd4e9d0d97065608a609f09e9f04fe5ea1c0aa91933f45d6f88cf
{"blocksSynchedTo":19,"messagesSynchedTo":{"l1BlockHash":"0x15e1987b2e48c7cac73771cb4b67fff3bfb052877d7b1dcdb3071421d791b3fc","l1BlockNumber":19}}
01:18:32
aztec-1 | [01:18:32.249]
INFO:
archiver Initial archiver sync to L1 block 23 complete.
{"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0x9153f4c63dfbd4e9d0d97065608a609f09e9f04fe5ea1c0aa91933f45d6f88cf","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
01:18:32
aztec-1 | [01:18:32.253]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-eKeqn9/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
01:18:32
aztec-1 | [01:18:32.473]
INFO:
world_state Created world state synchroniser with block history of 64
01:18:32
aztec-1 | [01:18:32.473]
WARN:
node Aztec node is accepting fake proofs
01:18:32
aztec-1 | [01:18:32.483]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
01:18:32
aztec-1 | [01:18:32.501]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
01:18:32
aztec-1 | [01:18:32.513]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
01:18:32
aztec-1 | [01:18:32.526]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
01:18:32
aztec-1 | [01:18:32.529]
INFO:
world_state Started world state synchronizer from block 1
01:18:32
aztec-1 | [01:18:32.531]
INFO:
p2p Starting p2p client from block 0 with empty mempools
01:18:32
aztec-1 | [01:18:32.731]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
01:18:32
aztec-1 | [01:18:32.775]
INFO:
slasher Starting Slasher client...
01:18:32
aztec-1 | [01:18:32.783]
INFO:
sequencer-client Deploying forwarder contract
01:18:32
aztec-1 | [01:18:32.801]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
01:18:32
aztec-1 | [01:18:32.807]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
01:18:32
aztec-1 | [01:18:32.807]
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}
01:18:32
aztec-1 | [01:18:32.809]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
01:18:32
aztec-1 | [01:18:32.809]
INFO:
node Aztec Node version: 0.87.6
01:18:32
aztec-1 | [01:18:32.809]
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"}
01:18:32
aztec-1 | [01:18:32.812]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
01:18:32
aztec-1 | [01:18:32.816]
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}
01:18:32
aztec-1 | [01:18:32.873]
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}
01:18:33
aztec-1 | [01:18:33.001]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
01:18:33
aztec-1 | [01:18:33.001]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:23:14.000Z
{"offset":280999,"timeMs":1749604994000}
01:18:33
aztec-1 | Setting up funded test accounts...
01:18:33
aztec-1 | [01:18:33.116]
INFO:
pxe:service Started PXE connected to chain 31337 version 2260892458
01:18:33
aztec-1 | [01:18:33.187]
INFO:
pxe:service Registered account 0x22828b6d3c9d62322e98a5d4236d8a5d8c9a27f5057d9e96de9ee429fde04bfd
01:18:33
aztec-1 | [01:18:33.248]
WARN:
pxe:service No artifact found for contract class 0x1e0a7a2452cb4e380c191ff9ce3857575153a59fb25231dcd6f67cbecf7ddcb3 when looking for its metadata
01:18:33
aztec-1 | [01:18:33.251]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x1e0a7a2452cb4e380c191ff9ce3857575153a59fb25231dcd6f67cbecf7ddcb3 as part of deployment for 0x22828b6d3c9d62322e98a5d4236d8a5d8c9a27f5057d9e96de9ee429fde04bfd
01:18:33
aztec-1 | [01:18:33.367]
INFO:
pxe:service Added contract SchnorrAccount at 0x22828b6d3c9d62322e98a5d4236d8a5d8c9a27f5057d9e96de9ee429fde04bfd with class 0x1e0a7a2452cb4e380c191ff9ce3857575153a59fb25231dcd6f67cbecf7ddcb3
01:18:35
aztec-1 | [01:18:35.367]
INFO:
pxe:service Proving completed in 1971.4628630000007ms
{"timings":{"total":1971.4628630000007,"sync":3.728562000000238,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":117.77882699999827,"oracles":{"callPrivateFunction":{"times":[535.7890550000002,265.8239880000001,146.05468199999996]}}},{"functionName":"private_kernel_init","time":85.79964799999925},{"functionName":"ContractClassRegisterer:register","time":524.2432480000007,"oracles":{"loadCapsule":{"times":[20.31434899999931]},"notifyCreatedNullifier":{"times":[0.4563429999998334]},"debugLog":{"times":[0.3766729999997551]},"notifyCreatedContractClassLog":{"times":[4.707142999999633]}}},{"functionName":"private_kernel_inner","time":113.9290489999994},{"functionName":"SchnorrAccount:constructor","time":247.71406500000103,"oracles":{"getContractInstance":{"times":[4.37413800000013]},"debugLog":{"times":[0.1515400000007503,0.1197680000004766]},"fetchTaggedLogs":{"times":[39.0380269999996]},"loadCapsule":{"times":[0.35515699999996286,0.21319599999969796,0.22105999999985215]},"validateEnqueuedNotesAndEvents":{"times":[5.720430000000306]},"notifyCreatedNullifier":{"times":[0.22068100000069535,0.23849199999949633]},"notifyCreatedNote":{"times":[0.5231890000004569]},"getRandomField":{"times":[0.21562699999958568,0.13791500000024826,0.11198999999942316,0.1251720000000205,0.2491040000004432,0.10400699999991048,0.07002999999986059,0.07286500000009255,0.061850000000049477,0.10013600000002043,0.10368600000037986]},"getIndexedTaggingSecretAsSender":{"times":[34.616729999999734]},"incrementAppTaggingSecretIndexAsSender":{"times":[26.16267499999958]}}},{"functionName":"private_kernel_inner","time":104.93763300000046},{"functionName":"SchnorrAccount:entrypoint","time":129.45749599999908,"oracles":{"debugLog":{"times":[0.14233799999965413,0.0844649999999092,0.22435399999994843]},"fetchTaggedLogs":{"times":[29.713001000000077]},"loadCapsule":{"times":[0.19594599999982165,0.18307499999991705,0.15113000000019383]},"validateEnqueuedNotesAndEvents":{"times":[4.914350000000013]},"getNotes":{"times":[1.6365860000005341]},"getAuthWitness":{"times":[0.291520999999193]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.714310000000296]}}},{"functionName":"private_kernel_inner","time":103.77686199999971},{"functionName":"private_kernel_reset","time":168.7338439999994},{"functionName":"private_kernel_tail","time":67.9237720000001}],"unaccounted":303.43985700000303}}
01:18:35
aztec-1 | [01:18:35.460]
INFO:
node Received tx 0x1d621b208b1404e0e85515114668f6c6de6d2cbccdd2c0bf874ced733f842fb7
{"txHash":"0x1d621b208b1404e0e85515114668f6c6de6d2cbccdd2c0bf874ced733f842fb7"}
01:18:35
aztec-1 | [01:18:35.460]
INFO:
pxe:service Sent transaction 0x1d621b208b1404e0e85515114668f6c6de6d2cbccdd2c0bf874ced733f842fb7
01:18:35
aztec-1 | [01:18:35.545]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.029958774000000632s
{"duration":0.029958774000000632,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
01:18:35
aztec-1 | [01:18:35.650]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x30576241e658c15ac5d14bf3596540bf7e41bf7d43b5dc37a3380e0f226752f1","globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":1,"slotNumber":2,"timestamp":1749605006,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1d621b208b1404e0e85515114668f6c6de6d2cbccdd2c0bf874ced733f842fb7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":143.27570600000035,"publicProcessDuration":30.411432999999306,"rollupCircuitsDuration":137.08360100000027,"txCount":1,"blockNumber":1,"blockTimestamp":1749605006,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
01:18:38
aztec-1 | [01:18:38.430]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
01:18:38
aztec-1 | [01:18:38.433]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
01:18:38
aztec-1 | [01:18:38.436]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
01:18:38
aztec-1 | [01:18:38.441]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605042
01:18:38
aztec-1 | [01:18:38.441]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:24:02.000Z
{"offset":323559,"timeMs":1749605042000}
01:18:38
aztec-1 | [01:18:38.441]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
01:18:38
aztec-1 | [01:18:38.518]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x30576241e658c15ac5d14bf3596540bf7e41bf7d43b5dc37a3380e0f226752f1","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":1,"slotNumber":2,"timestamp":1749605006,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2cb7b77d82bd72002332ca43c51061b9941c67472db5d31ec1a5631118b333aa","archiveNextLeafIndex":2}
01:18:38
aztec-1 | [01:18:38.523]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
01:18:38
aztec-1 | [01:18:38.578]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":14.670245999999679,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749605006,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
01:18:38
aztec-1 | [01:18:38.705]
INFO:
pxe:service Registered account 0x25dae54b61ff7de5dedc990c42c263d892798ace06406d0a37bf3e25c1f45e70
01:18:38
aztec-1 | [01:18:38.803]
INFO:
pxe:service Added contract SchnorrAccount at 0x25dae54b61ff7de5dedc990c42c263d892798ace06406d0a37bf3e25c1f45e70 with class 0x1e0a7a2452cb4e380c191ff9ce3857575153a59fb25231dcd6f67cbecf7ddcb3
01:18:40
aztec-1 | [01:18:40.027]
INFO:
pxe:service Proving completed in 1202.6995149999984ms
{"timings":{"total":1202.6995149999984,"sync":22.368373999999676,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":65.48527699999977,"oracles":{"callPrivateFunction":{"times":[282.5908479999998,180.28014900000016]}}},{"functionName":"private_kernel_init","time":48.99479100000099},{"functionName":"SchnorrAccount:constructor","time":264.1723239999992,"oracles":{"getContractInstance":{"times":[0.9055520000001707]},"debugLog":{"times":[0.13542899999993097,0.09997099999964121]},"fetchTaggedLogs":{"times":[46.04702300000099]},"loadCapsule":{"times":[0.576694999999745,0.7995410000003176,2.85366200000135]},"validateEnqueuedNotesAndEvents":{"times":[19.81362900000022]},"notifyCreatedNullifier":{"times":[0.22338400000080583,0.18706099999872094]},"notifyCreatedNote":{"times":[0.09775300000001153]},"getRandomField":{"times":[0.1165739999996731,0.15554299999894283,0.08891800000128569,0.09872999999970489,0.0960849999992206,0.06712100000004284,0.07750300000043353,0.06358900000122958,0.05406299999958719,0.05479700000068988,0.0609630000017205]},"getIndexedTaggingSecretAsSender":{"times":[39.07167800000025]},"incrementAppTaggingSecretIndexAsSender":{"times":[30.42376200000035]}}},{"functionName":"private_kernel_inner","time":103.66955899999994},{"functionName":"SchnorrAccount:entrypoint","time":164.7771010000015,"oracles":{"debugLog":{"times":[0.15011799999956565,0.1024809999998979,0.12780500000008033]},"fetchTaggedLogs":{"times":[55.986439000000246]},"loadCapsule":{"times":[0.519813000000795,1.6240170000000944,0.2814090000010765]},"validateEnqueuedNotesAndEvents":{"times":[8.407432999998491]},"getNotes":{"times":[0.7875160000003234]},"getAuthWitness":{"times":[0.1512380000003759]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.3860339999991993]}}},{"functionName":"private_kernel_inner","time":103.63534699999946},{"functionName":"private_kernel_reset","time":162.33787399999892},{"functionName":"private_kernel_tail","time":68.10741100000087}],"unaccounted":199.15145699999812}}
01:18:40
aztec-1 | [01:18:40.070]
INFO:
node Received tx 0x2383171286097b1034d46fdbc1c6b20e39671632a8be771f1db536831999e3ac
{"txHash":"0x2383171286097b1034d46fdbc1c6b20e39671632a8be771f1db536831999e3ac"}
01:18:40
aztec-1 | [01:18:40.070]
INFO:
pxe:service Sent transaction 0x2383171286097b1034d46fdbc1c6b20e39671632a8be771f1db536831999e3ac
01:18:40
aztec-1 | [01:18:40.146]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.014012735000000248s
{"duration":0.014012735000000248,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
01:18:40
aztec-1 | [01:18:40.245]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2692f2273a1100f5a4f22252804bee85f099adbec648a5b59ea010ee9af6d077","globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":2,"slotNumber":3,"timestamp":1749605042,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x2383171286097b1034d46fdbc1c6b20e39671632a8be771f1db536831999e3ac"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":119.02066500000001,"publicProcessDuration":14.094747999999527,"rollupCircuitsDuration":114.43233200000032,"txCount":1,"blockNumber":2,"blockTimestamp":1749605042,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
01:18:40
aztec-1 | [01:18:40.492]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
01:18:40
aztec-1 | [01:18:40.494]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
01:18:40
aztec-1 | [01:18:40.495]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
01:18:40
aztec-1 | [01:18:40.564]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
01:18:40
aztec-1 | error: "Rollup__SlotAlreadyInChain(3, 3)"
01:18:40
aztec-1 | [01:18:40.564]
WARN:
sequencer Cannot propose block 2 at slot 3 due to failed rollup contract check
01:18:40
aztec-1 | [01:18:40.569]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605078
01:18:40
aztec-1 | [01:18:40.569]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:24:38.000Z
{"offset":357431,"timeMs":1749605078000}
01:18:40
aztec-1 | [01:18:40.569]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
01:18:40
aztec-1 | [01:18:40.594]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2692f2273a1100f5a4f22252804bee85f099adbec648a5b59ea010ee9af6d077","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":2,"slotNumber":3,"timestamp":1749605042,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0876659325dc4faa24688510bbe2ba34df4a547d38c887611307c32e58968da3","archiveNextLeafIndex":3}
01:18:40
aztec-1 | [01:18:40.598]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
01:18:40
aztec-1 | [01:18:40.620]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":15.423229999998512,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749605042,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
01:18:40
aztec-1 | [01:18:40.761]
INFO:
pxe:service Registered account 0x1df90685beb948d4fdde692f1e18b6634aaabd1980cce908f7059111f9becf25
01:18:40
aztec-1 | [01:18:40.854]
INFO:
pxe:service Added contract SchnorrAccount at 0x1df90685beb948d4fdde692f1e18b6634aaabd1980cce908f7059111f9becf25 with class 0x1e0a7a2452cb4e380c191ff9ce3857575153a59fb25231dcd6f67cbecf7ddcb3
01:18:42
aztec-1 | Initial Accounts:
01:18:42
aztec-1 |
01:18:42
aztec-1 | Address: 0x22828b6d3c9d62322e98a5d4236d8a5d8c9a27f5057d9e96de9ee429fde04bfd
01:18:42
aztec-1 | Partial Address: 0x16db131d6e913f54b4f6fd631500cc0241a6412a24a4cb74da96811fba0ec327
01:18:42
aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
01:18:42
aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
01:18:42
aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
01:18:42
aztec-1 |
01:18:42
aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
01:18:42
aztec-1 |
01:18:42
aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
01:18:42
aztec-1 |
01:18:42
aztec-1 | Address: 0x25dae54b61ff7de5dedc990c42c263d892798ace06406d0a37bf3e25c1f45e70
01:18:42
aztec-1 | Partial Address: 0x2b8c8c270a45d067567f8e73b246ff78620ad8d8291e56f4e1a4cc5e0b996fd1
01:18:42
aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
01:18:42
aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
01:18:42
aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
01:18:42
aztec-1 |
01:18:42
aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
01:18:42
aztec-1 |
01:18:42
aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
01:18:42
aztec-1 |
01:18:42
aztec-1 | Address: 0x1df90685beb948d4fdde692f1e18b6634aaabd1980cce908f7059111f9becf25
01:18:42
aztec-1 | Partial Address: 0x2adb5d0b4254e4ec06aefef7eab04377f8f8547e510986af056eddc98851c737
01:18:42
aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
01:18:42
aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
01:18:42
aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
01:18:42
aztec-1 |
01:18:42
aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
01:18:42
aztec-1 |
01:18:42
aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
01:18:42
aztec-1 |
01:18:42
aztec-1 |
01:18:42
aztec-1 | [01:18:41.988]
INFO:
pxe:service Proving completed in 1126.783222ms
{"timings":{"total":1126.783222,"sync":23.830626999999367,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":61.61033800000223,"oracles":{"callPrivateFunction":{"times":[243.30566699999872,183.00909899999897]}}},{"functionName":"private_kernel_init","time":48.28722000000016},{"functionName":"SchnorrAccount:constructor","time":224.52266400000008,"oracles":{"getContractInstance":{"times":[4.083861000000979]},"debugLog":{"times":[0.09875199999987672,0.076666999999361]},"fetchTaggedLogs":{"times":[71.02427499999976]},"loadCapsule":{"times":[0.1509040000000823,0.16888599999947473,0.15561499999967054]},"validateEnqueuedNotesAndEvents":{"times":[6.3747610000009445]},"notifyCreatedNullifier":{"times":[0.1500530000012077,0.20569199999954435]},"notifyCreatedNote":{"times":[0.08905699999922945]},"getRandomField":{"times":[0.08406599999943865,0.11866700000064156,0.07115899999917019,0.05790000000160944,0.048194999999395804,0.06617700000060722,0.047861000000921194,0.05250100000012026,0.0472009999994043,0.05203799999981129,0.048467999999047606]},"getIndexedTaggingSecretAsSender":{"times":[34.25160099999994]},"incrementAppTaggingSecretIndexAsSender":{"times":[15.475114999999278]}}},{"functionName":"private_kernel_inner","time":102.68193600000086},{"functionName":"SchnorrAccount:entrypoint","time":166.56666799999948,"oracles":{"debugLog":{"times":[0.11395999999876949,0.07179100000030303,0.1256730000004609]},"fetchTaggedLogs":{"times":[70.64144699999997]},"loadCapsule":{"times":[0.14394799999899988,0.13030499999877065,0.11484999999993306]},"validateEnqueuedNotesAndEvents":{"times":[5.333614999999554]},"getNotes":{"times":[2.3758679999991728]},"getAuthWitness":{"times":[0.14070399999945948]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.34256399999867426]}}},{"functionName":"private_kernel_inner","time":102.67254299999877},{"functionName":"private_kernel_reset","time":160.98681399999987},{"functionName":"private_kernel_tail","time":64.48890900000151}],"unaccounted":171.1355029999977}}
01:18:42
aztec-1 | [01:18:42.036]
INFO:
node Received tx 0x05842f7a0ecf1b3c01a7dac26e8260cc54a9552a4ccc867fa4302f12e3373bcd
{"txHash":"0x05842f7a0ecf1b3c01a7dac26e8260cc54a9552a4ccc867fa4302f12e3373bcd"}
01:18:42
aztec-1 | [01:18:42.036]
INFO:
pxe:service Sent transaction 0x05842f7a0ecf1b3c01a7dac26e8260cc54a9552a4ccc867fa4302f12e3373bcd
01:18:42
aztec-1 | [01:18:42.105]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01328010600000016s
{"duration":0.01328010600000016,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
01:18:42
aztec-1 | [01:18:42.202]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x24da86331de535cff22ee999de5343a9ecd75361ae8a5f633222314bfff0898e","globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":3,"slotNumber":4,"timestamp":1749605078,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x05842f7a0ecf1b3c01a7dac26e8260cc54a9552a4ccc867fa4302f12e3373bcd"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":116.34110599999985,"publicProcessDuration":13.362506999999823,"rollupCircuitsDuration":111.50695300000007,"txCount":1,"blockNumber":3,"blockTimestamp":1749605078,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
01:18:42
aztec-1 | [01:18:42.449]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
01:18:42
aztec-1 | [01:18:42.498]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
01:18:42
aztec-1 | [01:18:42.498]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:24:50.000Z
{"offset":367502,"timeMs":1749605090000}
01:18:42
aztec-1 | [01:18:42.502]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
01:18:42
aztec-1 | [01:18:42.506]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
01:18:42
aztec-1 | [01:18:42.515]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
01:18:42
aztec-1 | error: "Rollup__SlotAlreadyInChain(4, 4)"
01:18:42
aztec-1 | [01:18:42.515]
WARN:
sequencer Cannot propose block 3 at slot 4 due to failed rollup contract check
01:18:42
aztec-1 | [01:18:42.520]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605114
01:18:42
aztec-1 | [01:18:42.520]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:25:14.000Z
{"offset":391480,"timeMs":1749605114000}
01:18:42
aztec-1 | [01:18:42.520]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
01:18:42
aztec-1 | [01:18:42.538]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x24da86331de535cff22ee999de5343a9ecd75361ae8a5f633222314bfff0898e","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":3,"slotNumber":4,"timestamp":1749605078,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x0d4dd7a7dca2e4b77b585fd319473e224b53f477a0e53ece1d7a395751a1ad45","archiveNextLeafIndex":4}
01:18:42
aztec-1 | [01:18:42.541]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
01:18:42
aztec-1 | [01:18:42.560]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":17.372628000000987,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749605078,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
01:18:43
aztec-1 | [01:18:43.236]
WARN:
pxe:service No artifact found for contract class 0x2d8603578ea8874817b8011aae10516006868a995cbebe97ae9dd8723bf4d966 when looking for its metadata
01:18:43
aztec-1 | [01:18:43.236]
WARN:
pxe:service No artifact found for contract class 0x13f5fad84ee238c8baa64642720114a4340e6a69d5361c3cb071fc38a6dab17e when looking for its metadata
01:18:43
aztec-1 | [01:18:43.238]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2d8603578ea8874817b8011aae10516006868a995cbebe97ae9dd8723bf4d966 as part of deployment for 0x236282d2941a9964441e8c03d3fdbedfb8612628a5120a8d2176fd38c4f471a8
01:18:43
aztec-1 | [01:18:43.262]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x13f5fad84ee238c8baa64642720114a4340e6a69d5361c3cb071fc38a6dab17e as part of deployment for 0x0bbc669ad0020a26ef02a1fd3b86ef3e0d0c1c8f3bf6881ff2aad1d2d4574117
01:18:43
aztec-1 | [01:18:43.931]
INFO:
pxe:service Added contract FPC at 0x236282d2941a9964441e8c03d3fdbedfb8612628a5120a8d2176fd38c4f471a8 with class 0x2d8603578ea8874817b8011aae10516006868a995cbebe97ae9dd8723bf4d966
01:18:43
aztec-1 | [01:18:43.935]
INFO:
pxe:service Added contract Token at 0x0bbc669ad0020a26ef02a1fd3b86ef3e0d0c1c8f3bf6881ff2aad1d2d4574117 with class 0x13f5fad84ee238c8baa64642720114a4340e6a69d5361c3cb071fc38a6dab17e
01:18:46
aztec-1 | [01:18:45.669]
INFO:
pxe:service Proving completed in 1719.3225920000004ms
{"timings":{"total":1719.3225920000004,"sync":20.128765999997995,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":264.5008839999973,"oracles":{"debugLog":{"times":[0.12674100000003818,0.09155600000303821,0.08739500000228873,0.1394609999988461,0.103940999997576,0.07664099999965401,0.07931099999768776,0.1257210000003397]},"fetchTaggedLogs":{"times":[105.13695200000075]},"loadCapsule":{"times":[0.5698699999993551,0.2998359999983222,0.433485000001383,0.1720530000020517,0.20351400000072317,0.22938599999906728,0.15565699999933713]},"getSharedSecret":{"times":[4.269995999999082]},"aes128Decrypt":{"times":[0.7875919999969483,0.6310950000006414]},"getPublicKeysAndPartialAddress":{"times":[1.1799580000006245]},"getKeyValidationRequest":{"times":[1.6195760000009614]},"storeCapsule":{"times":[2.5832790000022214,2.3419689999973343,2.432763000000705]},"deleteCapsule":{"times":[2.9892629999994824]},"validateEnqueuedNotesAndEvents":{"times":[10.549216999999771]},"getNotes":{"times":[11.54814400000032]},"getAuthWitness":{"times":[0.14802299999792012]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.042093000000022585]},"callPrivateFunction":{"times":[465.1571949999998,91.15828200000033]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2329230000032112]}}},{"functionName":"private_kernel_init","time":54.76753800000006},{"functionName":"ContractClassRegisterer:register","time":456.4225230000011,"oracles":{"loadCapsule":{"times":[3.4102569999995467]},"notifyCreatedNullifier":{"times":[0.23863799999890034]},"debugLog":{"times":[0.10598799999934272]},"notifyCreatedContractClassLog":{"times":[3.4265329999980167]}}},{"functionName":"private_kernel_inner","time":100.14408999999796},{"functionName":"ContractInstanceDeployer:deploy","time":58.23910099999921,"oracles":{"storeInExecutionCache":{"times":[0.1958989999984624]},"callPrivateFunction":{"times":[32.10564599999998]},"notifyCreatedNullifier":{"times":[0.22800800000186427]},"debugLog":{"times":[0.11131999999997788]}}},{"functionName":"private_kernel_inner","time":100.03892600000108},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":22.422098999999434,"oracles":{}},{"functionName":"private_kernel_inner","time":104.57567500000005},{"functionName":"private_kernel_reset","time":169.1888199999994},{"functionName":"private_kernel_tail","time":81.42542099999991}],"unaccounted":287.46874900000694}}
01:18:46
aztec-1 | [01:18:45.809]
INFO:
node Received tx 0x0db8921a0d1f982c063db2e89988a7b00eee133955b18df02df672354f072f2e
{"txHash":"0x0db8921a0d1f982c063db2e89988a7b00eee133955b18df02df672354f072f2e"}
01:18:46
aztec-1 | [01:18:45.809]
INFO:
pxe:service Sent transaction 0x0db8921a0d1f982c063db2e89988a7b00eee133955b18df02df672354f072f2e
01:18:47
aztec-1 | [01:18:46.706]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.7852027640000014s
{"duration":0.7852027640000014,"rate":45216.3461818888,"totalPublicGas":{"daGas":4096,"l2Gas":35504},"totalBlockGas":{"daGas":166912,"l2Gas":60546},"totalSizeInBytes":10688}
01:18:47
aztec-1 | [01:18:46.873]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 36940.91054558331 mana/s
{"blockHash":"0x1a7488b8d2f39a3c35f0b5897d01c7e04d47bc1bdc4242cb2e0ba3116caebba6","globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":4,"slotNumber":5,"timestamp":1749605114,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36280},"txHashes":["0x0db8921a0d1f982c063db2e89988a7b00eee133955b18df02df672354f072f2e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":961.0442549999971,"publicProcessDuration":785.3037330000006,"rollupCircuitsDuration":953.169378999999,"txCount":1,"blockNumber":4,"blockTimestamp":1749605114,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
01:18:47
aztec-1 | [01:18:47.482]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
01:18:47
aztec-1 | [01:18:47.482]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:25:26.000Z
{"offset":398518,"timeMs":1749605126000}
01:18:47
aztec-1 | [01:18:47.491]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
01:18:47
aztec-1 | [01:18:47.492]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605150
01:18:47
aztec-1 | [01:18:47.492]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:25:50.000Z
{"offset":422508,"timeMs":1749605150000}
01:18:47
aztec-1 | [01:18:47.492]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
01:18:47
aztec-1 | [01:18:47.495]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
01:18:47
aztec-1 | [01:18:47.496]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
01:18:48
aztec-1 | [01:18:47.851]
INFO:
pxe:service Proving completed in 2181.0818249999975ms
{"timings":{"total":2181.0818249999975,"sync":112.03395799999998,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":322.02246099999684,"oracles":{"debugLog":{"times":[0.11318200000096112,0.08470600000146078,0.06908100000146078,0.1409590000002936,0.09167299999899114,0.08215199999904144,0.06876900000133901,0.10421099999803118]},"fetchTaggedLogs":{"times":[133.81541899999866]},"loadCapsule":{"times":[0.2746320000005653,0.2535809999972116,0.37175999999817577,0.5224490000000515,0.31100399999922956,0.2089269999996759,0.23287100000015926]},"getSharedSecret":{"times":[4.761564000000362]},"aes128Decrypt":{"times":[0.17823800000041956,0.5080410000009579]},"getPublicKeysAndPartialAddress":{"times":[2.2337679999982356]},"getKeyValidationRequest":{"times":[3.7273070000010193]},"storeCapsule":{"times":[3.0358630000009725,17.523865000002843,2.128496000001178]},"deleteCapsule":{"times":[2.409719999999652]},"validateEnqueuedNotesAndEvents":{"times":[21.430294999998296]},"getNotes":{"times":[4.0142459999988205]},"getAuthWitness":{"times":[0.15333100000134436]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04494599999816273]},"callPrivateFunction":{"times":[460.18927399999666,90.34055600000283]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06603899999754503]}}},{"functionName":"private_kernel_init","time":48.724608000000444},{"functionName":"ContractClassRegisterer:register","time":450.6863830000002,"oracles":{"loadCapsule":{"times":[1.7441890000009153]},"notifyCreatedNullifier":{"times":[0.2755010000000766]},"debugLog":{"times":[0.10604400000011083]},"notifyCreatedContractClassLog":{"times":[3.4079600000004575]}}},{"functionName":"private_kernel_inner","time":99.89757399999871},{"functionName":"ContractInstanceDeployer:deploy","time":59.0781730000017,"oracles":{"storeInExecutionCache":{"times":[0.07327100000111386]},"callPrivateFunction":{"times":[31.833072000001266]},"notifyCreatedNullifier":{"times":[0.21603899999900023]},"debugLog":{"times":[0.1327449999989767]}}},{"functionName":"private_kernel_inner","time":101.08509299999787},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":20.467000000000553,"oracles":{}},{"functionName":"private_kernel_inner","time":103.01338899999973},{"functionName":"private_kernel_reset","time":166.7627990000001},{"functionName":"private_kernel_tail","time":81.24794699999984}],"unaccounted":616.0624400000015}}
01:18:48
aztec-1 | [01:18:48.011]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x1a7488b8d2f39a3c35f0b5897d01c7e04d47bc1bdc4242cb2e0ba3116caebba6","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":4,"slotNumber":5,"timestamp":1749605114,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36280},"archiveRoot":"0x24815ef0433c3c8c1ee589d3a1f08ddebc86fe12fba8a28d5400873b380fe8f3","archiveNextLeafIndex":5}
01:18:48
aztec-1 | [01:18:48.025]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
01:18:48
aztec-1 | [01:18:48.028]
INFO:
node Received tx 0x276eb1b08c8a769edd9bac3863281fa119a6747a8ab36ea3367cda94c6dfd39e
{"txHash":"0x276eb1b08c8a769edd9bac3863281fa119a6747a8ab36ea3367cda94c6dfd39e"}
01:18:48
aztec-1 | [01:18:48.028]
INFO:
pxe:service Sent transaction 0x276eb1b08c8a769edd9bac3863281fa119a6747a8ab36ea3367cda94c6dfd39e
01:18:48
aztec-1 | [01:18:48.071]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":11.252070999998978,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749605114,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
01:18:48
aztec-1 | [01:18:48.379]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.24226061299999857s
{"duration":0.24226061299999857,"rate":1140296.7926940795,"totalPublicGas":{"daGas":10240,"l2Gas":276249},"totalBlockGas":{"daGas":380928,"l2Gas":301291},"totalSizeInBytes":24064}
01:18:48
aztec-1 | [01:18:48.501]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 744775.5792312521 mana/s
{"blockHash":"0x19f65977670616753b1bb48b087efd023efa9a0e11d99e10158434f11983fd6c","globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":5,"slotNumber":6,"timestamp":1749605150,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36280},"txHashes":["0x276eb1b08c8a769edd9bac3863281fa119a6747a8ab36ea3367cda94c6dfd39e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":370.8895330000014,"publicProcessDuration":242.68898700000136,"rollupCircuitsDuration":366.1807090000002,"txCount":1,"blockNumber":5,"blockTimestamp":1749605150,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
01:18:48
aztec-1 | [01:18:48.787]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
01:18:48
aztec-1 | [01:18:48.790]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
01:18:48
aztec-1 | [01:18:48.791]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
01:18:48
aztec-1 | [01:18:48.834]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605186
01:18:48
aztec-1 | [01:18:48.834]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:26:26.000Z
{"offset":457166,"timeMs":1749605186000}
01:18:48
aztec-1 | [01:18:48.834]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
01:18:48
aztec-1 | [01:18:48.958]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x19f65977670616753b1bb48b087efd023efa9a0e11d99e10158434f11983fd6c","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":5,"slotNumber":6,"timestamp":1749605150,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36280},"archiveRoot":"0x02d6c77e82cf97a471294d1badbb4512a821c12ca8b8255a83666df04f5384f8","archiveNextLeafIndex":6}
01:18:48
aztec-1 | [01:18:48.964]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
01:18:49
aztec-1 | [01:18:49.023]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":13.532326000000467,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749605150,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
01:18:49
aztec-1 | [01:18:49.053]
INFO:
aztecjs:deploy_sent_tx Contract 0x236282d2941a9964441e8c03d3fdbedfb8612628a5120a8d2176fd38c4f471a8 successfully deployed.
01:18:49
aztec-1 | BananaCoin: 0x0bbc669ad0020a26ef02a1fd3b86ef3e0d0c1c8f3bf6881ff2aad1d2d4574117
01:18:49
aztec-1 | FPC: 0x236282d2941a9964441e8c03d3fdbedfb8612628a5120a8d2176fd38c4f471a8
01:18:49
aztec-1 | [01:18:49.241]
INFO:
aztecjs:deploy_sent_tx Contract 0x0bbc669ad0020a26ef02a1fd3b86ef3e0d0c1c8f3bf6881ff2aad1d2d4574117 successfully deployed.
01:18:49
aztec-1 | [01:18:49.257]
WARN:
pxe:service No artifact found for contract class 0x22d0f70ca733363084c38ccc50e378b8ccb67d55b95ee123d0aa33a83c226536 when looking for its metadata
01:18:49
aztec-1 | [01:18:49.259]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x22d0f70ca733363084c38ccc50e378b8ccb67d55b95ee123d0aa33a83c226536 as part of deployment for 0x2c9335ea947a838ef09089e2a60d1d10055da91e2da702f403675ba2e61d24f6
01:18:49
aztec-1 | [01:18:49.375]
INFO:
pxe:service Added contract SponsoredFPC at 0x2c9335ea947a838ef09089e2a60d1d10055da91e2da702f403675ba2e61d24f6 with class 0x22d0f70ca733363084c38ccc50e378b8ccb67d55b95ee123d0aa33a83c226536
01:18:51
aztec-1 | [01:18:50.993]
INFO:
pxe:service Proving completed in 1608.479464ms
{"timings":{"total":1608.479464,"sync":37.724568999998155,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":47.445997999999236,"oracles":{"callPrivateFunction":{"times":[451.4567790000001,98.07417500000156,21.11613700000089]}}},{"functionName":"private_kernel_init","time":48.25821900000301},{"functionName":"ContractClassRegisterer:register","time":443.0948669999998,"oracles":{"loadCapsule":{"times":[1.7455030000019178]},"notifyCreatedNullifier":{"times":[0.23217700000168406]},"debugLog":{"times":[0.12283399999796529]},"notifyCreatedContractClassLog":{"times":[3.3717410000026575]}}},{"functionName":"private_kernel_inner","time":103.53530600000158},{"functionName":"ContractInstanceDeployer:deploy","time":68.58393600000272,"oracles":{"storeInExecutionCache":{"times":[0.07257200000094599]},"callPrivateFunction":{"times":[28.21002800000133]},"notifyCreatedNullifier":{"times":[0.21402900000248337]},"debugLog":{"times":[0.17526100000031875]}}},{"functionName":"private_kernel_inner","time":103.4758980000006},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":20.59908899999573,"oracles":{}},{"functionName":"private_kernel_inner","time":99.6881280000016},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":16.90693200000169,"oracles":{"debugLog":{"times":[0.10317500000019209]}}},{"functionName":"private_kernel_inner","time":99.03420600000027},{"functionName":"private_kernel_reset","time":161.6510249999992},{"functionName":"private_kernel_tail","time":64.38604600000326}],"unaccounted":294.09524499999316}}
01:18:51
aztec-1 | [01:18:51.087]
INFO:
node Received tx 0x05e67ec510c4fa6ec391b08bc444ffe0654201f2c402a89122abd9c12d4723f0
{"txHash":"0x05e67ec510c4fa6ec391b08bc444ffe0654201f2c402a89122abd9c12d4723f0"}
01:18:51
aztec-1 | [01:18:51.087]
INFO:
pxe:service Sent transaction 0x05e67ec510c4fa6ec391b08bc444ffe0654201f2c402a89122abd9c12d4723f0
01:18:51
aztec-1 | [01:18:51.176]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02122588100000212s
{"duration":0.02122588100000212,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
01:18:51
aztec-1 | [01:18:51.281]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x08b332ba396157d4a45c34301d9ccb773dddb32900fb35031ab442096f225f0b","globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":6,"slotNumber":7,"timestamp":1749605186,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36280},"txHashes":["0x05e67ec510c4fa6ec391b08bc444ffe0654201f2c402a89122abd9c12d4723f0"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":132.3683400000009,"publicProcessDuration":21.343536000000313,"rollupCircuitsDuration":127.88305300000138,"txCount":1,"blockNumber":6,"blockTimestamp":1749605186,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
01:18:51
aztec-1 | [01:18:51.534]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
01:18:51
aztec-1 | [01:18:51.537]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
01:18:51
aztec-1 | [01:18:51.538]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
01:18:51
aztec-1 | [01:18:51.542]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605222
01:18:51
aztec-1 | [01:18:51.543]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:27:02.000Z
{"offset":490458,"timeMs":1749605222000}
01:18:51
aztec-1 | [01:18:51.543]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
01:18:51
aztec-1 | [01:18:51.549]
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":"0x02d6c77e82cf97a471294d1badbb4512a821c12ca8b8255a83666df04f5384f8","blocksSynchedTo":33,"currentL1BlockNumber":34,"provenBlockNumber":5,"provenArchive":"0x02d6c77e82cf97a471294d1badbb4512a821c12ca8b8255a83666df04f5384f8","pendingBlockNumber":6,"pendingArchive":"0x19b66078e0d429f3c4fa59cb61a321dfe1c643638f3543514b522e0df9d64a02"}
01:18:51
aztec-1 | [01:18:51.644]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x08b332ba396157d4a45c34301d9ccb773dddb32900fb35031ab442096f225f0b","blockNumber":6,"txCount":1,"globalVariables":{"chainId":31337,"version":2260892458,"blockNumber":6,"slotNumber":7,"timestamp":1749605186,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36280},"archiveRoot":"0x19b66078e0d429f3c4fa59cb61a321dfe1c643638f3543514b522e0df9d64a02","archiveNextLeafIndex":7}
01:18:51
aztec-1 | [01:18:51.650]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
01:18:51
aztec-1 | [01:18:51.694]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":12.289547999997012,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749605186,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
01:18:52
aztec-1 | SponsoredFPC: 0x2c9335ea947a838ef09089e2a60d1d10055da91e2da702f403675ba2e61d24f6
01:18:52
aztec-1 | [01:18:52.108]
INFO:
aztecjs:deploy_sent_tx Contract 0x2c9335ea947a838ef09089e2a60d1d10055da91e2da702f403675ba2e61d24f6 successfully deployed.
01:18:52
aztec-1 | [01:18:52.112]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x0bc1f0f94422384f840378e946d14ecd5f0b3fac5ccff51b89e3526d9bb7e077","l2ProtocolContractsTreeRoot":"0x1c4b5674dce9e7303f1cdb6eca384f6ba451f4a675f88d11d11ea2ad454944b0"}
01:18:56
box-1 | \
01:18:56
box-1 | Running 1
test using 1
worker
01:18:56
box-1 |
01:18:56
box-1 | 1 [firefox] › browser.spec.ts:3:1 › test
01:19:28
aztec-1 | [01:19:27.637]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
01:19:28
aztec-1 | [01:19:27.640]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605259
01:19:28
aztec-1 | [01:19:27.843]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
01:19:28
aztec-1 | [01:19:27.843]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:27:39.000Z
{"offset":491157,"timeMs":1749605259000}
01:20:03
aztec-1 | [01:20:02.990]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605294
01:20:03
aztec-1 | [01:20:02.990]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:28:14.000Z
{"offset":491010,"timeMs":1749605294000}
01:20:03
aztec-1 | [01:20:02.990]
INFO:
aztecjs:utils:watcher Slot 9 was missed, jumped to next slot
01:20:29
✘ 1 [firefox] › browser.spec.ts:3:1 › test (1.5m) 2 [firefox] › browser.spec.ts:3:1 › test (retry #1)
01:20:39
aztec-1 | [01:20:39.024]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605330
01:20:39
aztec-1 | [01:20:39.024]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:28:50.000Z
{"offset":490976,"timeMs":1749605330000}
01:20:39
aztec-1 | [01:20:39.024]
INFO:
aztecjs:utils:watcher Slot 10 was missed, jumped to next slot
01:21:15
aztec-1 | [01:21:15.057]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605366
01:21:15
aztec-1 | [01:21:15.057]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:29:26.000Z
{"offset":490943,"timeMs":1749605366000}
01:21:15
aztec-1 | [01:21:15.057]
INFO:
aztecjs:utils:watcher Slot 11 was missed, jumped to next slot
01:21:51
aztec-1 | [01:21:51.148]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
01:21:51
aztec-1 | [01:21:51.152]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605402
01:21:51
aztec-1 | [01:21:51.152]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:30:02.000Z
{"offset":490848,"timeMs":1749605402000}
01:21:51
aztec-1 | [01:21:51.152]
INFO:
aztecjs:utils:watcher Slot 12 was missed, jumped to next slot
01:21:51
aztec-1 | [01:21:51.153]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605403
01:21:51
aztec-1 | [01:21:51.354]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
01:21:51
aztec-1 | [01:21:51.354]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:30:14.000Z
{"offset":502646,"timeMs":1749605414000}
01:22:01
✘ 2 [firefox] › browser.spec.ts:3:1 › test (retry #1) (1.5m) 3 [firefox] › browser.spec.ts:3:1 › test (retry #2)
01:22:15
aztec-1 | [01:22:15.407]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605438
01:22:15
aztec-1 | [01:22:15.407]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:30:38.000Z
{"offset":502593,"timeMs":1749605438000}
01:22:15
aztec-1 | [01:22:15.407]
INFO:
aztecjs:utils:watcher Slot 13 was missed, jumped to next slot
01:22:51
aztec-1 | [01:22:51.442]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
01:22:51
aztec-1 | [01:22:51.443]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605475
01:22:51
aztec-1 | [01:22:51.644]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
01:22:51
aztec-1 | [01:22:51.644]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:31:15.000Z
{"offset":503356,"timeMs":1749605475000}
01:23:26
aztec-1 | [01:23:26.687]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605510
01:23:26
aztec-1 | [01:23:26.687]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:31:50.000Z
{"offset":503313,"timeMs":1749605510000}
01:23:26
aztec-1 | [01:23:26.687]
INFO:
aztecjs:utils:watcher Slot 15 was missed, jumped to next slot
01:23:32
✘ 3 [firefox] › browser.spec.ts:3:1 › test (retry #2) (1.5m) 4 [firefox] › browser.spec.ts:3:1 › test (retry #3)
01:24:02
aztec-1 | [01:24:02.760]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605546
01:24:02
aztec-1 | [01:24:02.760]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:32:26.000Z
{"offset":503240,"timeMs":1749605546000}
01:24:02
aztec-1 | [01:24:02.760]
INFO:
aztecjs:utils:watcher Slot 16 was missed, jumped to next slot
01:24:39
aztec-1 | [01:24:38.795]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
01:24:39
aztec-1 | [01:24:38.797]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749605583
01:24:39
aztec-1 | [01:24:38.996]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
01:24:39
aztec-1 | [01:24:38.997]
WARN:
foundation:test-date-provider Time set to 2025-06-11T01:33:03.000Z
{"offset":504003,"timeMs":1749605583000}
01:25:03
✘ 4 [firefox] › browser.spec.ts:3:1 › test (retry #3) (1.5m)
01:25:03
box-1 |
01:25:03
box-1 | 1) [firefox] › browser.spec.ts:3:1 › test ────────────────────────────────────────────────────────
01:25:03
box-1 |
01:25:03
box-1 | Test timeout of 90000ms exceeded.
01:25:03
box-1 |
01:25:03
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
01:25:03
box-1 | Call log:
01:25:03
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
01:25:03
box-1 |
01:25:03
box-1 |
01:25:03
box-1 | 6 |
01:25:03
box-1 | 7 | // Deploy contract
01:25:03
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
01:25:03
box-1 | | ^
01:25:03
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
01:25:03
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
01:25:03
box-1 | 11 |
01:25:03
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
01:25:03
box-1 |
01:25:03
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
01:25:03
box-1 | test-results/browser-test-firefox/test-failed-1.png
01:25:03
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
01:25:03
box-1 |
01:25:03
box-1 | Retry #1 ───────────────────────────────────────────────────────────────────────────────────────
01:25:03
box-1 |
01:25:03
box-1 | Test timeout of 90000ms exceeded.
01:25:03
box-1 |
01:25:03
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
01:25:03
box-1 | Call log:
01:25:03
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
01:25:03
box-1 |
01:25:03
box-1 |
01:25:03
box-1 | 6 |
01:25:03
box-1 | 7 | // Deploy contract
01:25:03
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
01:25:03
box-1 | | ^
01:25:03
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
01:25:03
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
01:25:03
box-1 | 11 |
01:25:03
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
01:25:03
box-1 |
01:25:03
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
01:25:03
box-1 | test-results/browser-test-firefox-retry1/test-failed-1.png
01:25:03
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
01:25:03
box-1 |
01:25:03
box-1 | attachment #2: video (video/webm) ──────────────────────────────────────────────────────────────
01:25:03
box-1 | test-results/browser-test-firefox-retry1/video.webm
01:25:03
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
01:25:03
box-1 |
01:25:03
box-1 | attachment #3: trace (application/zip) ─────────────────────────────────────────────────────────
01:25:03
box-1 | test-results/browser-test-firefox-retry1/trace.zip
01:25:03
box-1 | Usage:
01:25:03
box-1 |
01:25:03
box-1 | yarn playwright show-trace test-results/browser-test-firefox-retry1/trace.zip
01:25:03
box-1 |
01:25:03
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
01:25:03
box-1 |
01:25:03
box-1 | Retry #2 ───────────────────────────────────────────────────────────────────────────────────────
01:25:03
box-1 |
01:25:03
box-1 | Test timeout of 90000ms exceeded.
01:25:03
box-1 |
01:25:03
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
01:25:03
box-1 | Call log:
01:25:03
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
01:25:03
box-1 |
01:25:03
box-1 |
01:25:03
box-1 | 6 |
01:25:03
box-1 | 7 | // Deploy contract
01:25:03
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
01:25:03
box-1 | | ^
01:25:03
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
01:25:03
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
01:25:03
box-1 | 11 |
01:25:03
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
01:25:03
box-1 |
01:25:03
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
01:25:03
box-1 | test-results/browser-test-firefox-retry2/test-failed-1.png
01:25:03
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
01:25:03
box-1 |
01:25:03
box-1 | Retry #3 ───────────────────────────────────────────────────────────────────────────────────────
01:25:03
box-1 |
01:25:03
box-1 | Test timeout of 90000ms exceeded.
01:25:03
box-1 |
01:25:03
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
01:25:03
box-1 | Call log:
01:25:03
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
01:25:03
box-1 |
01:25:03
box-1 |
01:25:03
box-1 | 6 |
01:25:03
box-1 | 7 | // Deploy contract
01:25:03
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
01:25:03
box-1 | | ^
01:25:03
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
01:25:03
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
01:25:03
box-1 | 11 |
01:25:03
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
01:25:03
box-1 |
01:25:03
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
01:25:03
box-1 | test-results/browser-test-firefox-retry3/test-failed-1.png
01:25:03
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
01:25:03
box-1 |
01:25:03
box-1 | 1 failed
01:25:03
box-1 | [firefox] › browser.spec.ts:3:1 › test ─────────────────────────────────────────────────────────
01:25:03
box-1 | \
01:25:03 Aborting on container exit...
01:25:03
box-1 exited with code 1
01:25:03 [?25l[+] Stopping 3/3
01:25:05 ✔ Container vite-firefox-box-1 Stopped0.0s
01:25:05 ✔ Container vite-firefox-aztec-1 Stopped1.5s
01:25:05 ✔ Container vite-firefox-ethereum-1 Stopped0.1s
01:25:05 [?25h