Parent Log:
http://ci.aztec-labs.com/bba6ba24268b9dc1
Command: 7faf93f93ad63fc5:ONLY_TERM_PARENT=1 BOX=vite BROWSER=webkit run_compose_test vite-webkit box boxes
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/30660269b33bab8cca354c41659533acf4d48e07
Env: REF_NAME=gh-readonly-queue/next/pr-15026-d96baf1c44329e8b2e3a432ad803f702f5184a62 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Fri Jun 13 09:39:12 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15026_amd64_x4-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History: [?25l
[+] Running 4/4
09:39:13
✔ Network vite-webkit_default
Created0.1s
09:39:13
✔ Container vite-webkit-ethereum-1
Created0.1s
09:39:13
✔ Container vite-webkit-aztec-1
Created0.1s
09:39:13
✔ Container vite-webkit-box-1
Created0.3s
09:39:13 [?25hAttaching to aztec-1, box-1, ethereum-1
09:39:18
aztec-1 |
09:39:18
aztec-1 | _
09:39:18
aztec-1 | /\ | |
09:39:18
aztec-1 | / \ ___| |_ ___ ___
09:39:18
aztec-1 | / /\ \ |_ / __/ _ \/ __|
09:39:18
aztec-1 | / ____ \ / /| || __/ (__
09:39:18
aztec-1 | /_/___ \_\/___|\__\___|\___|
09:39:18
aztec-1 |
09:39:18
aztec-1 | https://github.com/AztecProtocol
09:39:18
aztec-1 |
09:39:18
aztec-1 |
09:39:18
aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
09:39:18
aztec-1 | Setting up test accounts
09:39:20
aztec-1 | [09:39:19.643]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-cdEfCG/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
09:39:20
aztec-1 | [09:39:19.919]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
09:39:20
aztec-1 | [09:39:19.924]
WARN:
sandbox Set block interval to 12
09:39:20
aztec-1 | [09:39:20.118]
INFO:
sandbox Waiting for 7 transactions to be mined...
09:39:20
aztec-1 | [09:39:20.140]
INFO:
sandbox All transactions mined successfully
09:39:20
aztec-1 | [09:39:20.229]
INFO:
sandbox Waiting for 9 transactions to be mined...
09:39:20
aztec-1 | [09:39:20.256]
INFO:
sandbox All transactions mined successfully
09:39:20
aztec-1 | [09:39:20.394]
INFO:
sandbox Waiting for 11 transactions to be mined...
09:39:20
aztec-1 | [09:39:20.420]
INFO:
sandbox All transactions mined successfully
09:39:20
aztec-1 | [09:39:20.484]
INFO:
sandbox Waiting for 12 transactions to be mined...
09:39:20
aztec-1 | [09:39:20.502]
INFO:
sandbox All transactions mined successfully
09:39:20
aztec-1 | [09:39:20.512]
INFO:
sandbox Waiting for 12 transactions to be mined...
09:39:20
aztec-1 | [09:39:20.534]
INFO:
sandbox All transactions mined successfully
09:39:20
aztec-1 | [09:39:20.550]
INFO:
sandbox Aztec L1 contracts initialized
{"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"}
09:39:20
aztec-1 | [09:39:20.550]
INFO:
sandbox Handing over to governance
09:39:20
aztec-1 | [09:39:20.559]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
09:39:20
aztec-1 | [09:39:20.560]
INFO:
telemetry:client Using NoopTelemetryClient
09:39:20
aztec-1 | [09:39:20.560]
INFO:
blob-sink:client Creating local blob sink client.
09:39:20
aztec-1 | [09:39:20.565]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:39:20
aztec-1 | [09:39:20.565]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:44:02.000Z
{"offset":281435,"timeMs":1749807842000}
09:39:20
aztec-1 | [09:39:20.596]
INFO:
archiver:lmdb Starting data store with maxReaders 16
09:39:21
aztec-1 | [09:39:21.001]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x6ad98e5e483e0fa61d8ef0439258b91f9347c20ef8cfd9881ff41d558e15507a
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x217b9dcde2c9f37fe7abbf11306f97a413d4eac243dce0396f5b34281ad62340","l1BlockNumber":20}}
09:39:21
aztec-1 | [09:39:21.024]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x6ad98e5e483e0fa61d8ef0439258b91f9347c20ef8cfd9881ff41d558e15507a","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
09:39:21
aztec-1 | [09:39:21.032]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-vfFnJI/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
09:39:21
aztec-1 | [09:39:21.306]
INFO:
world_state Created world state synchroniser with block history of 64
09:39:21
aztec-1 | [09:39:21.306]
WARN:
node Aztec node is accepting fake proofs
09:39:21
aztec-1 | [09:39:21.320]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
09:39:21
aztec-1 | [09:39:21.342]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
09:39:21
aztec-1 | [09:39:21.363]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
09:39:21
aztec-1 | [09:39:21.382]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
09:39:21
aztec-1 | [09:39:21.387]
INFO:
world_state Started world state synchronizer from block 1
09:39:21
aztec-1 | [09:39:21.391]
INFO:
p2p Starting p2p client from block 0 with empty mempools
09:39:21
aztec-1 | [09:39:21.664]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
09:39:21
aztec-1 | [09:39:21.735]
INFO:
slasher Starting Slasher client...
09:39:21
aztec-1 | [09:39:21.750]
INFO:
sequencer-client Deploying forwarder contract
09:39:21
aztec-1 | [09:39:21.780]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
09:39:21
aztec-1 | [09:39:21.791]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
09:39:21
aztec-1 | [09:39:21.791]
INFO:
sequencer Sequencer config set
{"transactionPollingIntervalMS":50,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":true}
09:39:21
aztec-1 | [09:39:21.794]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
09:39:21
aztec-1 | [09:39:21.795]
INFO:
node Aztec Node version: 0.87.6
09:39:21
aztec-1 | [09:39:21.795]
INFO:
node Aztec Node started on chain 0x7a69
{"rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","slashFactoryAddress":"0x59b670e9fa9d0a427751af201d676719a970857b","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"}
09:39:21
aztec-1 | [09:39:21.802]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
09:39:21
aztec-1 | [09:39:21.817]
WARN:
sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2.
{"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1}
09:39:21
aztec-1 | [09:39:21.885]
WARN:
sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2.
{"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1}
09:39:21
aztec-1 | [09:39:21.949]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:39:21
aztec-1 | [09:39:21.949]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:44:14.000Z
{"offset":292051,"timeMs":1749807854000}
09:39:22
aztec-1 | [09:39:22.062]
WARN:
sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2.
{"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1}
09:39:22
aztec-1 | Setting up funded test accounts...
09:39:22
aztec-1 | [09:39:22.202]
INFO:
pxe:service Started PXE connected to chain 31337 version 2094187016
09:39:22
aztec-1 | [09:39:22.290]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
09:39:22
aztec-1 | [09:39:22.350]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
09:39:22
aztec-1 | [09:39:22.356]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
09:39:22
aztec-1 | [09:39:22.553]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
09:39:25
aztec-1 | [09:39:25.265]
INFO:
pxe:service Proving completed in 2670.169197ms
{"timings":{"total":2670.169197,"sync":10.141579000000092,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":164.5309150000021,"oracles":{"callPrivateFunction":{"times":[796.6708040000003,358.5509029999994,220.59180500000002]}}},{"functionName":"private_kernel_init","time":83.38508499999989},{"functionName":"ContractClassRegisterer:register","time":770.9223810000012,"oracles":{"loadCapsule":{"times":[31.650141000000076]},"notifyCreatedNullifier":{"times":[0.8067730000002484]},"debugLog":{"times":[0.5062799999996059]},"notifyCreatedContractClassLog":{"times":[9.391179999998712]}}},{"functionName":"private_kernel_inner","time":137.22011199999906},{"functionName":"SchnorrAccount:constructor","time":334.30802799999765,"oracles":{"getContractInstance":{"times":[5.25431799999933]},"debugLog":{"times":[0.12779000000045926,0.1704730000001291]},"fetchTaggedLogs":{"times":[74.72016099999928]},"loadCapsule":{"times":[1.9225690000002942,1.0117889999983163,0.23703800000112096]},"validateEnqueuedNotesAndEvents":{"times":[7.639474999999948]},"notifyCreatedNullifier":{"times":[0.21484699999928125,0.28003199999875505]},"notifyCreatedNote":{"times":[0.43649399999958405]},"getRandomField":{"times":[0.18559500000083062,0.19609499999933178,0.13739999999961583,0.1964159999988624,0.1142889999991894,0.08011600000099861,0.05014399999890884,0.0482929999998305,0.04810400000133086,0.08365600000070117,0.06577499999912106]},"getIndexedTaggingSecretAsSender":{"times":[54.36458799999855]},"incrementAppTaggingSecretIndexAsSender":{"times":[41.3022519999995]}}},{"functionName":"private_kernel_inner","time":149.6487070000003},{"functionName":"SchnorrAccount:entrypoint","time":193.7675789999994,"oracles":{"debugLog":{"times":[0.2686909999993077,0.14484100000117905,0.19607499999983702]},"fetchTaggedLogs":{"times":[70.93672700000025]},"loadCapsule":{"times":[0.2342079999998532,0.2499599999991915,0.28279099999963364]},"validateEnqueuedNotesAndEvents":{"times":[5.669001000000208]},"getNotes":{"times":[1.7484960000001593]},"getAuthWitness":{"times":[0.2169370000010531]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7298860000009881]}}},{"functionName":"private_kernel_inner","time":125.30129400000078},{"functionName":"private_kernel_reset","time":153.50571800000034},{"functionName":"private_kernel_tail","time":90.7824099999998}],"unaccounted":456.65538899999956}}
09:39:25
aztec-1 | [09:39:25.397]
INFO:
node Received tx 0x047f1bfd83fc51c93358f0fc5d8222f1aa6065d7fa20c92b2831bc87e37c7bf9
{"txHash":"0x047f1bfd83fc51c93358f0fc5d8222f1aa6065d7fa20c92b2831bc87e37c7bf9"}
09:39:25
aztec-1 | [09:39:25.397]
INFO:
pxe:service Sent transaction 0x047f1bfd83fc51c93358f0fc5d8222f1aa6065d7fa20c92b2831bc87e37c7bf9
09:39:25
aztec-1 | [09:39:25.497]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04168548200000077s
{"duration":0.04168548200000077,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
09:39:25
aztec-1 | [09:39:25.524]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2021876d9cc2dd266bc921dfb027c970ce92836973fdbc870eb4629983660632","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807866,"version":2094187016},"txHashes":["0x047f1bfd83fc51c93358f0fc5d8222f1aa6065d7fa20c92b2831bc87e37c7bf9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":78.62977399999909,"publicProcessDuration":42.3201310000004,"rollupCircuitsDuration":71.45862699999998,"txCount":1,"blockNumber":1,"blockTimestamp":1749807866,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
09:39:28
aztec-1 | [09:39:28.696]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
09:39:28
aztec-1 | [09:39:28.700]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
09:39:28
aztec-1 | [09:39:28.706]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:39:28
aztec-1 | [09:39:28.710]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749807902
09:39:28
aztec-1 | [09:39:28.710]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:45:02.000Z
{"offset":333290,"timeMs":1749807902000}
09:39:28
aztec-1 | [09:39:28.710]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
09:39:28
aztec-1 | [09:39:28.802]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x2021876d9cc2dd266bc921dfb027c970ce92836973fdbc870eb4629983660632","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807866,"version":2094187016},"archiveRoot":"0x0327d58b4d404d536a7db8df453bfb3c5d0037ca2d85e9344f6b87f53973f6e9","archiveNextLeafIndex":2}
09:39:28
aztec-1 | [09:39:28.808]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
09:39:28
aztec-1 | [09:39:28.871]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":19.29584000000068,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749807866,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
09:39:29
aztec-1 | [09:39:28.982]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
09:39:29
aztec-1 | [09:39:29.093]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
09:39:31
aztec-1 | [09:39:30.735]
INFO:
pxe:service Proving completed in 1614.6653050000004ms
{"timings":{"total":1614.6653050000004,"sync":20.805458000000726,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":106.47214100000201,"oracles":{"callPrivateFunction":{"times":[444.06892399999924,299.93622499999947]}}},{"functionName":"private_kernel_init","time":68.97072399999888},{"functionName":"SchnorrAccount:constructor","time":415.6878660000002,"oracles":{"getContractInstance":{"times":[8.72588899999937]},"debugLog":{"times":[0.2635900000004767,0.12427999999999884]},"fetchTaggedLogs":{"times":[107.87364900000102]},"loadCapsule":{"times":[0.2192460000005667,0.3202340000007098,0.28100199999971665]},"validateEnqueuedNotesAndEvents":{"times":[5.7625089999983174]},"notifyCreatedNullifier":{"times":[0.3225449999990815,0.26421099999970465]},"notifyCreatedNote":{"times":[0.10927799999990384]},"getRandomField":{"times":[0.1284300000006624,0.19614499999988766,0.03829299999961222,0.040372999999817694,0.055274000000281376,0.05030400000032387,0.05080400000042573,0.04636399999981222,0.041014000000359374,0.04982399999971676,0.06457500000033178]},"getIndexedTaggingSecretAsSender":{"times":[70.02052600000025]},"incrementAppTaggingSecretIndexAsSender":{"times":[51.87954499999978]}}},{"functionName":"private_kernel_inner","time":134.4600559999999},{"functionName":"SchnorrAccount:entrypoint","time":270.3430530000005,"oracles":{"debugLog":{"times":[0.29576300000007905,0.13959100000101898,0.25496000000021013]},"fetchTaggedLogs":{"times":[108.05495300000075]},"loadCapsule":{"times":[0.2107770000002347,0.1588530000008177,0.16327300000011746]},"validateEnqueuedNotesAndEvents":{"times":[6.932719000000361]},"getNotes":{"times":[4.788742000000639]},"getAuthWitness":{"times":[0.22668700000031095]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6428300000006857]}}},{"functionName":"private_kernel_inner","time":92.82922899999903},{"functionName":"private_kernel_reset","time":152.10054800000034},{"functionName":"private_kernel_tail","time":69.37032399999953}],"unaccounted":283.6259059999993}}
09:39:31
aztec-1 | [09:39:30.799]
INFO:
node Received tx 0x27e925aa800e9854e15610b58f9f406634668fd43eeee7ab04554d29e87295dc
{"txHash":"0x27e925aa800e9854e15610b58f9f406634668fd43eeee7ab04554d29e87295dc"}
09:39:31
aztec-1 | [09:39:30.799]
INFO:
pxe:service Sent transaction 0x27e925aa800e9854e15610b58f9f406634668fd43eeee7ab04554d29e87295dc
09:39:31
aztec-1 | [09:39:30.877]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.032215455000001385s
{"duration":0.032215455000001385,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
09:39:31
aztec-1 | [09:39:30.900]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2156675e42f2437b328749a07cbbf43a520c6e0c482b955e713168a60a648470","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807902,"version":2094187016},"txHashes":["0x27e925aa800e9854e15610b58f9f406634668fd43eeee7ab04554d29e87295dc"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":60.65458699999908,"publicProcessDuration":32.36889700000029,"rollupCircuitsDuration":56.126084999999875,"txCount":1,"blockNumber":2,"blockTimestamp":1749807902,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
09:39:31
aztec-1 | [09:39:31.143]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:39:31
aztec-1 | [09:39:31.179]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:39:31
aztec-1 | [09:39:31.179]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:45:14.000Z
{"offset":342821,"timeMs":1749807914000}
09:39:31
aztec-1 | [09:39:31.187]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
09:39:31
aztec-1 | [09:39:31.189]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
09:39:31
aztec-1 | [09:39:31.220]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
09:39:31
aztec-1 | error: "Rollup__SlotAlreadyInChain(3, 3)"
09:39:31
aztec-1 | [09:39:31.220]
WARN:
sequencer Cannot propose block 2 at slot 3 due to failed rollup contract check
09:39:31
aztec-1 | [09:39:31.251]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749807938
09:39:31
aztec-1 | [09:39:31.251]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:45:38.000Z
{"offset":366749,"timeMs":1749807938000}
09:39:31
aztec-1 | [09:39:31.251]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
09:39:31
aztec-1 | [09:39:31.285]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2156675e42f2437b328749a07cbbf43a520c6e0c482b955e713168a60a648470","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807902,"version":2094187016},"archiveRoot":"0x1ed437bf74dadded79177febba2d359f758fe2a3d662c79e6f47d600da93a362","archiveNextLeafIndex":3}
09:39:31
aztec-1 | [09:39:31.289]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
09:39:31
aztec-1 | [09:39:31.315]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":16.08691099999851,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749807902,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
09:39:31
aztec-1 | [09:39:31.438]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
09:39:31
aztec-1 | [09:39:31.557]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
09:39:33
aztec-1 | [09:39:33.391]
INFO:
pxe:service Proving completed in 1826.7848909999993ms
{"timings":{"total":1826.7848909999993,"sync":27.370177999997395,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":104.85458100000324,"oracles":{"callPrivateFunction":{"times":[314.9863449999975,328.1269370000009]}}},{"functionName":"private_kernel_init","time":76.50114899999971},{"functionName":"SchnorrAccount:constructor","time":291.42555399999765,"oracles":{"getContractInstance":{"times":[5.223056000002543]},"debugLog":{"times":[0.09159700000236626,0.09058700000241515]},"fetchTaggedLogs":{"times":[96.70861100000184]},"loadCapsule":{"times":[0.20950599999923725,0.27900099999897066,0.1476010000005772]},"validateEnqueuedNotesAndEvents":{"times":[9.286832000001596]},"notifyCreatedNullifier":{"times":[0.31722399999853224,0.21092599999974482]},"notifyCreatedNote":{"times":[0.1739739999975427]},"getRandomField":{"times":[0.1637430000009772,0.2276880000026722,0.042964000000210945,0.04278300000078161,0.030171999998856336,0.030513000001519686,0.040563999998994404,0.03200199999992037,0.04387400000268826,0.058324999998148996,0.030543000000761822]},"getIndexedTaggingSecretAsSender":{"times":[32.39684900000066]},"incrementAppTaggingSecretIndexAsSender":{"times":[32.84774400000242]}}},{"functionName":"private_kernel_inner","time":160.83591700000034},{"functionName":"SchnorrAccount:entrypoint","time":293.3408129999989,"oracles":{"debugLog":{"times":[0.20096600000033504,0.10228800000186311,0.2104460000009567]},"fetchTaggedLogs":{"times":[153.30746200000067]},"loadCapsule":{"times":[0.1822439999996277,0.17197400000077323,0.17848400000002584]},"validateEnqueuedNotesAndEvents":{"times":[5.938382000000274]},"getNotes":{"times":[1.831242000000202]},"getAuthWitness":{"times":[0.2781620000023395]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7361369999998715]}}},{"functionName":"private_kernel_inner","time":152.59349700000166},{"functionName":"private_kernel_reset","time":234.44134099999792},{"functionName":"private_kernel_tail","time":90.662769999999}],"unaccounted":394.75909100000354}}
09:39:33
aztec-1 | [09:39:33.460]
INFO:
node Received tx 0x077f66a3f56004f74b2da21cdb66fb5fe74faea31a632edc4ad7fc6ae8e23e12
{"txHash":"0x077f66a3f56004f74b2da21cdb66fb5fe74faea31a632edc4ad7fc6ae8e23e12"}
09:39:33
aztec-1 | [09:39:33.460]
INFO:
pxe:service Sent transaction 0x077f66a3f56004f74b2da21cdb66fb5fe74faea31a632edc4ad7fc6ae8e23e12
09:39:33
aztec-1 | [09:39:33.545]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.022072245999999723s
{"duration":0.022072245999999723,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
09:39:33
aztec-1 | [09:39:33.584]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2f912b8681758dc37e376132cb200e8e99ccb66ce7e63aa080517dca6d42a515","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749807938,"version":2094187016},"txHashes":["0x077f66a3f56004f74b2da21cdb66fb5fe74faea31a632edc4ad7fc6ae8e23e12"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":68.90732899999784,"publicProcessDuration":22.263981000000058,"rollupCircuitsDuration":62.97510699999839,"txCount":1,"blockNumber":3,"blockTimestamp":1749807938,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
09:39:33
aztec-1 | [09:39:33.832]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:39:33
aztec-1 | [09:39:33.832]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:45:50.000Z
{"offset":376168,"timeMs":1749807950000}
09:39:33
aztec-1 | [09:39:33.837]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
09:39:33
aztec-1 | [09:39:33.840]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
09:39:33
aztec-1 | [09:39:33.843]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:39:33
aztec-1 | [09:39:33.884]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749807974
09:39:33
aztec-1 | [09:39:33.884]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:46:14.000Z
{"offset":400116,"timeMs":1749807974000}
09:39:33
aztec-1 | [09:39:33.884]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
09:39:33
aztec-1 | [09:39:33.946]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x2f912b8681758dc37e376132cb200e8e99ccb66ce7e63aa080517dca6d42a515","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749807938,"version":2094187016},"archiveRoot":"0x083b2e273c66ce6eba5c9ed27b1ca2b02f743af60907ffde29b732fa347da36c","archiveNextLeafIndex":4}
09:39:33
aztec-1 | [09:39:33.949]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
09:39:34
aztec-1 | [09:39:34.011]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":19.246437000001606,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749807938,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
09:39:34
aztec-1 | Initial Accounts:
09:39:34
aztec-1 |
09:39:34
aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
09:39:34
aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
09:39:34
aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
09:39:34
aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
09:39:34
aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
09:39:34
aztec-1 |
09:39:34
aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
09:39:34
aztec-1 |
09:39:34
aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
09:39:34
aztec-1 |
09:39:34
aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
09:39:34
aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
09:39:34
aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
09:39:34
aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
09:39:34
aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
09:39:34
aztec-1 |
09:39:34
aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
09:39:34
aztec-1 |
09:39:34
aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
09:39:34
aztec-1 |
09:39:34
aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
09:39:34
aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
09:39:34
aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
09:39:34
aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
09:39:34
aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
09:39:34
aztec-1 |
09:39:34
aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
09:39:34
aztec-1 |
09:39:34
aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
09:39:34
aztec-1 |
09:39:34
aztec-1 |
09:39:35
aztec-1 | [09:39:34.759]
WARN:
pxe:service No artifact found for contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 when looking for its metadata
09:39:35
aztec-1 | [09:39:34.759]
WARN:
pxe:service No artifact found for contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 when looking for its metadata
09:39:35
aztec-1 | [09:39:34.763]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 as part of deployment for 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45
09:39:35
aztec-1 | [09:39:34.788]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 as part of deployment for 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf
09:39:36
aztec-1 | [09:39:35.617]
INFO:
pxe:service Added contract Token at 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf with class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645
09:39:36
aztec-1 | [09:39:35.623]
INFO:
pxe:service Added contract FPC at 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 with class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1
09:39:38
aztec-1 | [09:39:37.941]
INFO:
pxe:service Proving completed in 2292.103126000002ms
{"timings":{"total":2292.103126000002,"sync":19.80203000000256,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":393.0235029999967,"oracles":{"debugLog":{"times":[0.2655099999974482,0.10082800000236603,0.1105089999982738,0.22457699999722536,0.11858999999822117,0.12268000000040047,0.09505699999863282,0.2641010000006645]},"fetchTaggedLogs":{"times":[134.4375739999996]},"loadCapsule":{"times":[0.24035799999910523,0.3295749999997497,0.5345420000012382,0.1918050000022049,0.18077500000072177,0.41022199999861186,0.3947410000000673]},"getSharedSecret":{"times":[6.471442999998544]},"aes128Decrypt":{"times":[1.1846620000033,0.8046329999997397]},"getPublicKeysAndPartialAddress":{"times":[1.8880869999993593]},"getKeyValidationRequest":{"times":[2.3852550000010524]},"storeCapsule":{"times":[2.680938999998034,2.4094679999980144,2.280467000000499]},"deleteCapsule":{"times":[2.4026059999996505]},"validateEnqueuedNotesAndEvents":{"times":[26.90414199999941]},"getNotes":{"times":[13.448155000001861]},"getAuthWitness":{"times":[0.24787900000228547]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.0698450000018056]},"callPrivateFunction":{"times":[641.4503199999999,135.65512800000215]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3555679999990389]}}},{"functionName":"private_kernel_init","time":62.528111999999965},{"functionName":"ContractClassRegisterer:register","time":624.307716000003,"oracles":{"loadCapsule":{"times":[2.3186400000013236]},"notifyCreatedNullifier":{"times":[0.49691900000107125]},"debugLog":{"times":[0.14045099999930244]},"notifyCreatedContractClassLog":{"times":[4.139931000001525]}}},{"functionName":"private_kernel_inner","time":130.23815699999977},{"functionName":"ContractInstanceDeployer:deploy","time":86.89431799999511,"oracles":{"storeInExecutionCache":{"times":[0.2742510000025504]},"callPrivateFunction":{"times":[45.38762900000074]},"notifyCreatedNullifier":{"times":[0.3237359999984619]},"debugLog":{"times":[0.14358200000060606]}}},{"functionName":"private_kernel_inner","time":93.52631199999814},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":34.240662000003795,"oracles":{}},{"functionName":"private_kernel_inner","time":130.92624100000103},{"functionName":"private_kernel_reset","time":208.17247700000007},{"functionName":"private_kernel_tail","time":72.95827300000019}],"unaccounted":435.48532500000147}}
09:39:38
aztec-1 | [09:39:38.101]
INFO:
node Received tx 0x053a3b1212fca0f2fbce44e35cbd88de5b5e272dbef18eea4f780f92c673843e
{"txHash":"0x053a3b1212fca0f2fbce44e35cbd88de5b5e272dbef18eea4f780f92c673843e"}
09:39:38
aztec-1 | [09:39:38.101]
INFO:
pxe:service Sent transaction 0x053a3b1212fca0f2fbce44e35cbd88de5b5e272dbef18eea4f780f92c673843e
09:39:41
aztec-1 | [09:39:40.620]
INFO:
pxe:service Proving completed in 2677.341192ms
{"timings":{"total":2677.341192,"sync":140.89224599999943,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":471.2462139999916,"oracles":{"debugLog":{"times":[0.18971500000043306,0.08892700000069453,0.07866599999761092,0.11303899999984424,0.11117799999919953,0.09962799999993877,0.11053800000081537,0.19152499999836436]},"fetchTaggedLogs":{"times":[183.30153300000165]},"loadCapsule":{"times":[1.382567000000563,0.2769320000006701,1.7496859999992012,0.2540399999998044,1.4808049999992363,0.6296089999996184,0.8477549999988696]},"getSharedSecret":{"times":[6.37190499999997]},"aes128Decrypt":{"times":[0.29668300000048475,0.6291290000008303]},"getPublicKeysAndPartialAddress":{"times":[2.6445349999994505]},"getKeyValidationRequest":{"times":[5.198123999998643]},"storeCapsule":{"times":[3.34711999999854,78.7627739999989,2.3094290000008186]},"deleteCapsule":{"times":[3.182286999999633]},"validateEnqueuedNotesAndEvents":{"times":[16.948048000002018]},"getNotes":{"times":[1.802121000000625]},"getAuthWitness":{"times":[0.17168300000048475]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05686500000228989]},"callPrivateFunction":{"times":[755.8337949999986,169.17584499999793]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06557500000053551]}}},{"functionName":"private_kernel_init","time":71.43666500000108},{"functionName":"ContractClassRegisterer:register","time":739.2292630000011,"oracles":{"loadCapsule":{"times":[2.5551090000008116]},"notifyCreatedNullifier":{"times":[0.3747400000029302]},"debugLog":{"times":[0.09813799999756156]},"notifyCreatedContractClassLog":{"times":[5.1313090000003285]}}},{"functionName":"private_kernel_inner","time":109.20283199999903},{"functionName":"ContractInstanceDeployer:deploy","time":118.05397100000118,"oracles":{"storeInExecutionCache":{"times":[0.095208000002458]},"callPrivateFunction":{"times":[56.40654599999834]},"notifyCreatedNullifier":{"times":[0.21404600000096252]},"debugLog":{"times":[0.12410000000090804]}}},{"functionName":"private_kernel_inner","time":125.40515099999902},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.15717399999994,"oracles":{}},{"functionName":"private_kernel_inner","time":119.45518900000025},{"functionName":"private_kernel_reset","time":229.35423499999888},{"functionName":"private_kernel_tail","time":101.13278499999797}],"unaccounted":412.7754670000104}}
09:39:41
aztec-1 | [09:39:40.783]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 2.538057192s
{"duration":2.538057192,"rate":130591.6198597624,"totalPublicGas":{"daGas":10240,"l2Gas":331449},"totalBlockGas":{"daGas":380928,"l2Gas":356491},"totalSizeInBytes":24064}
09:39:41
aztec-1 | [09:39:40.815]
INFO:
node Received tx 0x043502bab8929ad7f78184c7df3bfbd636c56bdd1d13d09a33c8bef91b5f2119
{"txHash":"0x043502bab8929ad7f78184c7df3bfbd636c56bdd1d13d09a33c8bef91b5f2119"}
09:39:41
aztec-1 | [09:39:40.815]
INFO:
pxe:service Sent transaction 0x043502bab8929ad7f78184c7df3bfbd636c56bdd1d13d09a33c8bef91b5f2119
09:39:41
aztec-1 | [09:39:40.822]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 128147.47126042744 mana/s
{"blockHash":"0x2308267ef41e9aa70554d4857ac8f9a31e8c97b4011db42aa6b0df8c33e2430a","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749807974,"version":2094187016},"txHashes":["0x053a3b1212fca0f2fbce44e35cbd88de5b5e272dbef18eea4f780f92c673843e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2586.3886700000003,"publicProcessDuration":2538.1700899999996,"rollupCircuitsDuration":2579.5406970000004,"txCount":1,"blockNumber":4,"blockTimestamp":1749807974,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
09:39:41
aztec-1 | [09:39:41.040]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:39:41
aztec-1 | [09:39:41.046]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808010
09:39:41
aztec-1 | [09:39:41.046]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:46:50.000Z
{"offset":428954,"timeMs":1749808010000}
09:39:41
aztec-1 | [09:39:41.046]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
09:39:41
aztec-1 | [09:39:41.048]
WARN:
archiver Failed to reach L2 block 4 at 31 (latest is 3). Rolling back last synched L1 block number to 30.
{"latestLocalL2BlockNumber":3,"latestLocalL2BlockArchive":"0x083b2e273c66ce6eba5c9ed27b1ca2b02f743af60907ffde29b732fa347da36c","blocksSynchedTo":30,"currentL1BlockNumber":31,"provenBlockNumber":3,"provenArchive":"0x083b2e273c66ce6eba5c9ed27b1ca2b02f743af60907ffde29b732fa347da36c","pendingBlockNumber":4,"pendingArchive":"0x0791e6b81cf0a6f8595e3d52a3adf209216ec622d6294b1d3747709a2b11c0b6"}
09:39:41
aztec-1 | [09:39:41.073]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
09:39:41
aztec-1 | [09:39:41.075]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
09:39:41
aztec-1 | [09:39:41.230]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x2308267ef41e9aa70554d4857ac8f9a31e8c97b4011db42aa6b0df8c33e2430a","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749807974,"version":2094187016},"archiveRoot":"0x0791e6b81cf0a6f8595e3d52a3adf209216ec622d6294b1d3747709a2b11c0b6","archiveNextLeafIndex":5}
09:39:41
aztec-1 | [09:39:41.235]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
09:39:41
aztec-1 | [09:39:41.298]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":13.885579000001599,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749807974,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
09:39:41
aztec-1 | [09:39:41.522]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.1692173189999994s
{"duration":0.1692173189999994,"rate":243852.1083057707,"totalPublicGas":{"daGas":4096,"l2Gas":41264},"totalBlockGas":{"daGas":166912,"l2Gas":66306},"totalSizeInBytes":10688}
09:39:41
aztec-1 | [09:39:41.565]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 187030.39061639737 mana/s
{"blockHash":"0x1740616a1c6287f46c8fb22bcb03d8cca92a148971d98adb4e5df7bcb57548ea","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749808010,"version":2094187016},"txHashes":["0x043502bab8929ad7f78184c7df3bfbd636c56bdd1d13d09a33c8bef91b5f2119"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":220.598152999999,"publicProcessDuration":169.698465999998,"rollupCircuitsDuration":214.51310100000046,"txCount":1,"blockNumber":5,"blockTimestamp":1749808010,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
09:39:42
aztec-1 | [09:39:41.825]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
09:39:42
aztec-1 | [09:39:41.831]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
09:39:42
aztec-1 | [09:39:42.103]
INFO:
aztecjs:deploy_sent_tx Contract 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf successfully deployed.
09:39:42
aztec-1 | [09:39:42.113]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:39:42
aztec-1 | [09:39:42.122]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:39:42
aztec-1 | [09:39:42.122]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:47:02.000Z
{"offset":439878,"timeMs":1749808022000}
09:39:42
aztec-1 | [09:39:42.130]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808046
09:39:42
aztec-1 | [09:39:42.130]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:47:26.000Z
{"offset":463870,"timeMs":1749808046000}
09:39:42
aztec-1 | [09:39:42.130]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
09:39:42
aztec-1 | [09:39:42.275]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x1740616a1c6287f46c8fb22bcb03d8cca92a148971d98adb4e5df7bcb57548ea","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749808010,"version":2094187016},"archiveRoot":"0x0f53fdde14d08b07cef29719bc98137a10de5670ad4ac1a58a817192259a5bbd","archiveNextLeafIndex":6}
09:39:42
aztec-1 | [09:39:42.281]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
09:39:42
aztec-1 | [09:39:42.334]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":14.73361599999771,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749808010,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
09:39:42
aztec-1 | BananaCoin: 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf
09:39:42
aztec-1 | FPC: 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45
09:39:42
aztec-1 | [09:39:42.874]
INFO:
aztecjs:deploy_sent_tx Contract 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 successfully deployed.
09:39:42
aztec-1 | [09:39:42.902]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
09:39:42
aztec-1 | [09:39:42.903]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
09:39:43
aztec-1 | [09:39:43.045]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
09:39:46
aztec-1 | [09:39:45.220]
INFO:
pxe:service Proving completed in 2164.9337669999986ms
{"timings":{"total":2164.9337669999986,"sync":24.14941799999724,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":67.48181599999589,"oracles":{"callPrivateFunction":{"times":[740.477511000001,126.40685000000303,32.579594000002544]}}},{"functionName":"private_kernel_init","time":67.78193099999771},{"functionName":"ContractClassRegisterer:register","time":726.0245460000006,"oracles":{"loadCapsule":{"times":[1.5253190000003087]},"notifyCreatedNullifier":{"times":[0.363589000000502]},"debugLog":{"times":[0.15812200000073062]},"notifyCreatedContractClassLog":{"times":[5.284521000001405]}}},{"functionName":"private_kernel_inner","time":115.95470700000078},{"functionName":"ContractInstanceDeployer:deploy","time":69.57643100000132,"oracles":{"storeInExecutionCache":{"times":[0.08539599999858183]},"callPrivateFunction":{"times":[64.80239900000015]},"notifyCreatedNullifier":{"times":[0.2600499999971362]},"debugLog":{"times":[0.11578899999949499]}}},{"functionName":"private_kernel_inner","time":107.51628100000016},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":43.297677000002295,"oracles":{}},{"functionName":"private_kernel_inner","time":116.96189500000037},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":26.123532000001433,"oracles":{"debugLog":{"times":[0.09227699999973993]}}},{"functionName":"private_kernel_inner","time":146.25820300000123},{"functionName":"private_kernel_reset","time":228.5003489999981},{"functionName":"private_kernel_tail","time":97.11557200000243}],"unaccounted":328.1914089999991}}
09:39:46
aztec-1 | [09:39:45.351]
INFO:
node Received tx 0x0297787006e084e7b48655e560c07a21d9697e1001072251af1ab1500decb4c8
{"txHash":"0x0297787006e084e7b48655e560c07a21d9697e1001072251af1ab1500decb4c8"}
09:39:46
aztec-1 | [09:39:45.352]
INFO:
pxe:service Sent transaction 0x0297787006e084e7b48655e560c07a21d9697e1001072251af1ab1500decb4c8
09:39:46
aztec-1 | [09:39:45.465]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03769626199999766s
{"duration":0.03769626199999766,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
09:39:46
aztec-1 | [09:39:45.494]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x278664c7701efd4b2d406828059bf0e0732ac6616b85de890015b92f7038c0ec","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749808046,"version":2094187016},"txHashes":["0x0297787006e084e7b48655e560c07a21d9697e1001072251af1ab1500decb4c8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":73.46690300000046,"publicProcessDuration":37.87421600000016,"rollupCircuitsDuration":69.05907000000298,"txCount":1,"blockNumber":6,"blockTimestamp":1749808046,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
09:39:46
aztec-1 | [09:39:45.733]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
09:39:46
aztec-1 | [09:39:45.736]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
09:39:46
aztec-1 | [09:39:45.741]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
09:39:46
aztec-1 | [09:39:45.780]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808082
09:39:46
aztec-1 | [09:39:45.780]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:48:02.000Z
{"offset":496220,"timeMs":1749808082000}
09:39:46
aztec-1 | [09:39:45.780]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
09:39:46
aztec-1 | [09:39:45.860]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x278664c7701efd4b2d406828059bf0e0732ac6616b85de890015b92f7038c0ec","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749808046,"version":2094187016},"archiveRoot":"0x256cca22eb1a5913c7f6c077b384f96d18d957b9ceda86ed64b594c6e6ef9932","archiveNextLeafIndex":7}
09:39:46
aztec-1 | [09:39:45.870]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
09:39:46
aztec-1 | [09:39:45.894]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":14.667149999997491,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749808046,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
09:39:46
aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
09:39:46
aztec-1 | [09:39:46.366]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
09:39:46
aztec-1 | [09:39:46.373]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x2d2655c513c2e8feb8c7411b7e807c66287b57bb60572ce85ce1fe0a1e0c925d","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
09:39:55
box-1 | \
09:39:55
box-1 | Running 1
test using 1
worker
09:39:55
box-1 |
09:39:56
box-1 | 1 [webkit] › browser.spec.ts:3:1 › test
09:40:22
aztec-1 | [09:40:21.829]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
09:40:22
aztec-1 | [09:40:21.835]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808119
09:40:22
aztec-1 | [09:40:21.842]
ERROR:
aztecjs:utils:watcher Failed to warp to timestamp 1749808118: Error: Error warping: InvalidParamsRpcError: Invalid parameters were provided to the RPC method.
09:40:22
aztec-1 | Double check you have provided the correct parameters.
09:40:22
aztec-1 |
09:40:22
aztec-1 | URL:
http://ethereum:8545
09:40:22
aztec-1 | Request body: {"method":"evm_setNextBlockTimestamp","params":[1749808118]}
09:40:22
aztec-1 |
09:40:22
aztec-1 | Details: Timestamp error: 1749808118 is lower than previous block's timestamp
09:40:22
aztec-1 | Version: viem@2.23.7
09:40:22
aztec-1 | [09:40:21.842]
INFO:
aztecjs:utils:watcher Slot 8 was missed, jumped to next slot
09:40:22
aztec-1 | [09:40:22.037]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:40:22
aztec-1 | [09:40:22.037]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:48:39.000Z
{"offset":496963,"timeMs":1749808119000}
09:40:57
aztec-1 | [09:40:57.149]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808154
09:40:57
aztec-1 | [09:40:57.150]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:49:14.000Z
{"offset":496850,"timeMs":1749808154000}
09:40:57
aztec-1 | [09:40:57.150]
INFO:
aztecjs:utils:watcher Slot 9 was missed, jumped to next slot
09:41:28
✘ 1 [webkit] › browser.spec.ts:3:1 › test (1.5m) 2 [webkit] › browser.spec.ts:3:1 › test (retry #1)
09:41:33
aztec-1 | [09:41:33.209]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808190
09:41:33
aztec-1 | [09:41:33.210]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:49:50.000Z
{"offset":496790,"timeMs":1749808190000}
09:41:33
aztec-1 | [09:41:33.210]
INFO:
aztecjs:utils:watcher Slot 10 was missed, jumped to next slot
09:42:09
aztec-1 | [09:42:09.350]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
09:42:09
aztec-1 | [09:42:09.353]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808227
09:42:09
aztec-1 | [09:42:09.554]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:42:09
aztec-1 | [09:42:09.554]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:50:27.000Z
{"offset":497446,"timeMs":1749808227000}
09:42:45
aztec-1 | [09:42:44.580]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808262
09:42:45
aztec-1 | [09:42:44.580]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:51:02.000Z
{"offset":497420,"timeMs":1749808262000}
09:42:45
aztec-1 | [09:42:44.580]
INFO:
aztecjs:utils:watcher Slot 12 was missed, jumped to next slot
09:43:04
✘ 2 [webkit] › browser.spec.ts:3:1 › test (retry #1) (1.6m) 3 [webkit] › browser.spec.ts:3:1 › test (retry #2)
09:43:21
aztec-1 | [09:43:20.602]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
09:43:21
aztec-1 | [09:43:20.610]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808299
09:43:21
aztec-1 | [09:43:20.811]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:43:21
aztec-1 | [09:43:20.811]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:51:39.000Z
{"offset":498189,"timeMs":1749808299000}
09:43:56
aztec-1 | [09:43:55.996]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808334
09:43:56
aztec-1 | [09:43:55.996]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:52:14.000Z
{"offset":498004,"timeMs":1749808334000}
09:43:56
aztec-1 | [09:43:55.996]
INFO:
aztecjs:utils:watcher Slot 14 was missed, jumped to next slot
09:44:32
aztec-1 | [09:44:32.007]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
09:44:32
aztec-1 | [09:44:32.008]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808371
09:44:32
aztec-1 | [09:44:32.210]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
09:44:32
aztec-1 | [09:44:32.210]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:52:51.000Z
{"offset":498790,"timeMs":1749808371000}
09:44:35
✘ 3 [webkit] › browser.spec.ts:3:1 › test (retry #2) (1.5m) 4 [webkit] › browser.spec.ts:3:1 › test (retry #3)
09:45:07
aztec-1 | [09:45:07.336]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808406
09:45:07
aztec-1 | [09:45:07.336]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:53:26.000Z
{"offset":498664,"timeMs":1749808406000}
09:45:07
aztec-1 | [09:45:07.336]
INFO:
aztecjs:utils:watcher Slot 16 was missed, jumped to next slot
09:45:43
aztec-1 | [09:45:43.438]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749808442
09:45:43
aztec-1 | [09:45:43.438]
WARN:
foundation:test-date-provider Time set to 2025-06-13T09:54:02.000Z
{"offset":498562,"timeMs":1749808442000}
09:45:43
aztec-1 | [09:45:43.438]
INFO:
aztecjs:utils:watcher Slot 17 was missed, jumped to next slot
09:46:05
✘ 4 [webkit] › browser.spec.ts:3:1 › test (retry #3) (1.5m)
09:46:05
box-1 |
09:46:05
box-1 | 1) [webkit] › browser.spec.ts:3:1 › test ─────────────────────────────────────────────────────────
09:46:05
box-1 |
09:46:05
box-1 | Test timeout of 90000ms exceeded.
09:46:05
box-1 |
09:46:05
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
09:46:05
box-1 | Call log:
09:46:05
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
09:46:05
box-1 |
09:46:05
box-1 |
09:46:05
box-1 | 6 |
09:46:05
box-1 | 7 | // Deploy contract
09:46:05
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
09:46:05
box-1 | | ^
09:46:05
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
09:46:05
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
09:46:05
box-1 | 11 |
09:46:05
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
09:46:05
box-1 |
09:46:05
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
09:46:05
box-1 | test-results/browser-test-webkit/test-failed-1.png
09:46:05
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
09:46:05
box-1 |
09:46:05
box-1 | Retry #1 ───────────────────────────────────────────────────────────────────────────────────────
09:46:05
box-1 |
09:46:05
box-1 | Test timeout of 90000ms exceeded.
09:46:05
box-1 |
09:46:05
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
09:46:05
box-1 | Call log:
09:46:05
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
09:46:05
box-1 |
09:46:05
box-1 |
09:46:05
box-1 | 6 |
09:46:05
box-1 | 7 | // Deploy contract
09:46:05
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
09:46:05
box-1 | | ^
09:46:05
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
09:46:05
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
09:46:05
box-1 | 11 |
09:46:05
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
09:46:05
box-1 |
09:46:05
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
09:46:05
box-1 | test-results/browser-test-webkit-retry1/test-failed-1.png
09:46:05
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
09:46:05
box-1 |
09:46:05
box-1 | attachment #2: video (video/webm) ──────────────────────────────────────────────────────────────
09:46:05
box-1 | test-results/browser-test-webkit-retry1/video.webm
09:46:05
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
09:46:05
box-1 |
09:46:05
box-1 | attachment #3: trace (application/zip) ─────────────────────────────────────────────────────────
09:46:05
box-1 | test-results/browser-test-webkit-retry1/trace.zip
09:46:05
box-1 | Usage:
09:46:05
box-1 |
09:46:05
box-1 | yarn playwright show-trace test-results/browser-test-webkit-retry1/trace.zip
09:46:05
box-1 |
09:46:05
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
09:46:05
box-1 |
09:46:05
box-1 | Retry #2 ───────────────────────────────────────────────────────────────────────────────────────
09:46:05
box-1 |
09:46:05
box-1 | Test timeout of 90000ms exceeded.
09:46:05
box-1 |
09:46:05
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
09:46:05
box-1 | Call log:
09:46:05
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
09:46:05
box-1 |
09:46:05
box-1 |
09:46:05
box-1 | 6 |
09:46:05
box-1 | 7 | // Deploy contract
09:46:05
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
09:46:05
box-1 | | ^
09:46:05
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
09:46:05
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
09:46:05
box-1 | 11 |
09:46:05
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
09:46:05
box-1 |
09:46:05
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
09:46:05
box-1 | test-results/browser-test-webkit-retry2/test-failed-1.png
09:46:05
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
09:46:05
box-1 |
09:46:05
box-1 | Retry #3 ───────────────────────────────────────────────────────────────────────────────────────
09:46:05
box-1 |
09:46:05
box-1 | Test timeout of 90000ms exceeded.
09:46:05
box-1 |
09:46:05
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
09:46:05
box-1 | Call log:
09:46:05
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
09:46:05
box-1 |
09:46:05
box-1 |
09:46:05
box-1 | 6 |
09:46:05
box-1 | 7 | // Deploy contract
09:46:05
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
09:46:05
box-1 | | ^
09:46:05
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
09:46:05
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
09:46:05
box-1 | 11 |
09:46:05
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
09:46:05
box-1 |
09:46:05
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
09:46:05
box-1 | test-results/browser-test-webkit-retry3/test-failed-1.png
09:46:05
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
09:46:05
box-1 |
09:46:05
box-1 | 1 failed
09:46:05
box-1 | [webkit] › browser.spec.ts:3:1 › test ──────────────────────────────────────────────────────────
09:46:05
box-1 | \
09:46:05 Aborting on container exit...
09:46:05
box-1 exited with code 1
09:46:06 [?25l[+] Stopping 3/3
09:46:07 ✔ Container vite-webkit-box-1 Stopped0.0s
09:46:07 ✔ Container vite-webkit-aztec-1 Stopped1.8s
09:46:07 ✔ Container vite-webkit-ethereum-1 Stopped0.1s
09:46:07 [?25h