Parent Log:
http://ci.aztec-labs.com/03c4bdafddbe0b5d
Command: 1297eb3fba03fc3b:ONLY_TERM_PARENT=1 BOX=vite BROWSER=webkit run_compose_test vite-webkit box boxes
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/cf8be0f9e81e248048560619de041e90d9d6990a
Env: REF_NAME=gh-readonly-queue/next/pr-14994-a45107e7f95b675cb2768b6bcb06483b511141f4 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Fri Jun 13 08:04:45 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14994_amd64_x4-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History: [?25l
[+] Running 4/4
08:04:48
✔ Network vite-webkit_default
Created0.3s
08:04:48
✔ Container vite-webkit-ethereum-1
Created0.6s
08:04:48
✔ Container vite-webkit-aztec-1
Created0.8s
08:04:48
✔ Container vite-webkit-box-1
Created1.0s
08:04:48 [?25hAttaching to aztec-1, box-1, ethereum-1
08:04:54
aztec-1 |
08:04:54
aztec-1 | _
08:04:54
aztec-1 | /\ | |
08:04:54
aztec-1 | / \ ___| |_ ___ ___
08:04:54
aztec-1 | / /\ \ |_ / __/ _ \/ __|
08:04:54
aztec-1 | / ____ \ / /| || __/ (__
08:04:54
aztec-1 | /_/___ \_\/___|\__\___|\___|
08:04:54
aztec-1 |
08:04:54
aztec-1 | https://github.com/AztecProtocol
08:04:54
aztec-1 |
08:04:54
aztec-1 |
08:04:54
aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
08:04:54
aztec-1 | Setting up test accounts
08:04:55
aztec-1 | [08:04:54.951]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-YAK8YB/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
08:04:55
aztec-1 | [08:04:55.245]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
08:04:55
aztec-1 | [08:04:55.250]
WARN:
sandbox Set block interval to 12
08:04:55
aztec-1 | [08:04:55.437]
INFO:
sandbox Waiting for 7 transactions to be mined...
08:04:55
aztec-1 | [08:04:55.460]
INFO:
sandbox All transactions mined successfully
08:04:55
aztec-1 | [08:04:55.553]
INFO:
sandbox Waiting for 9 transactions to be mined...
08:04:55
aztec-1 | [08:04:55.577]
INFO:
sandbox All transactions mined successfully
08:04:55
aztec-1 | [08:04:55.712]
INFO:
sandbox Waiting for 11 transactions to be mined...
08:04:55
aztec-1 | [08:04:55.736]
INFO:
sandbox All transactions mined successfully
08:04:55
aztec-1 | [08:04:55.817]
INFO:
sandbox Waiting for 12 transactions to be mined...
08:04:55
aztec-1 | [08:04:55.843]
INFO:
sandbox All transactions mined successfully
08:04:55
aztec-1 | [08:04:55.849]
INFO:
sandbox Waiting for 12 transactions to be mined...
08:04:55
aztec-1 | [08:04:55.878]
INFO:
sandbox All transactions mined successfully
08:04:55
aztec-1 | [08:04:55.900]
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"}
08:04:55
aztec-1 | [08:04:55.900]
INFO:
sandbox Handing over to governance
08:04:55
aztec-1 | [08:04:55.910]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x68B1D87F95878fE05B998F19b66F4baba5De1aed
08:04:55
aztec-1 | [08:04:55.911]
INFO:
telemetry:client Using NoopTelemetryClient
08:04:55
aztec-1 | [08:04:55.911]
INFO:
blob-sink:client Creating local blob sink client.
08:04:55
aztec-1 | [08:04:55.917]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
08:04:55
aztec-1 | [08:04:55.917]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:09:25.000Z
{"offset":269083,"timeMs":1749802165000}
08:04:55
aztec-1 | [08:04:55.947]
INFO:
archiver:lmdb Starting data store with maxReaders 16
08:04:56
aztec-1 | [08:04:56.378]
INFO:
archiver Starting archiver sync to rollup contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed from L1 block 19 to current L1 block 23 with hash 0x525175284e62f6ec26423ffe389b3480316eeacfbb25244624b0771190185d94
{"blocksSynchedTo":19,"messagesSynchedTo":{"l1BlockHash":"0xd751e708d3680cb462cfda4483645f7fc500a99f31b850122e9e80036fa6be0b","l1BlockNumber":19}}
08:04:56
aztec-1 | [08:04:56.402]
INFO:
archiver Initial archiver sync to L1 block 23 complete.
{"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0x525175284e62f6ec26423ffe389b3480316eeacfbb25244624b0771190185d94","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
08:04:56
aztec-1 | [08:04:56.410]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-KtucrE/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
08:04:56
aztec-1 | [08:04:56.664]
INFO:
world_state Created world state synchroniser with block history of 64
08:04:56
aztec-1 | [08:04:56.664]
WARN:
node Aztec node is accepting fake proofs
08:04:56
aztec-1 | [08:04:56.678]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
08:04:56
aztec-1 | [08:04:56.691]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
08:04:56
aztec-1 | [08:04:56.709]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
08:04:56
aztec-1 | [08:04:56.725]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
08:04:56
aztec-1 | [08:04:56.730]
INFO:
world_state Started world state synchronizer from block 1
08:04:57
aztec-1 | [08:04:56.733]
INFO:
p2p Starting p2p client from block 0 with empty mempools
08:04:57
aztec-1 | [08:04:57.052]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
08:04:57
aztec-1 | [08:04:57.121]
INFO:
slasher Starting Slasher client...
08:04:57
aztec-1 | [08:04:57.131]
INFO:
sequencer-client Deploying forwarder contract
08:04:57
aztec-1 | [08:04:57.151]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
08:04:57
aztec-1 | [08:04:57.159]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
08:04:57
aztec-1 | [08:04:57.160]
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}
08:04:57
aztec-1 | [08:04:57.162]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
08:04:57
aztec-1 | [08:04:57.162]
INFO:
node Aztec Node version: 0.87.6
08:04:57
aztec-1 | [08:04:57.162]
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"}
08:04:57
aztec-1 | [08:04:57.166]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
08:04:57
aztec-1 | [08:04:57.178]
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}
08:04:57
aztec-1 | [08:04:57.248]
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}
08:04:57
aztec-1 | [08:04:57.321]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
08:04:57
aztec-1 | [08:04:57.321]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:09:37.000Z
{"offset":279679,"timeMs":1749802177000}
08:04:57
aztec-1 | [08:04:57.432]
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}
08:04:57
aztec-1 | Setting up funded test accounts...
08:04:57
aztec-1 | [08:04:57.606]
INFO:
pxe:service Started PXE connected to chain 31337 version 1767261948
08:04:57
aztec-1 | [08:04:57.712]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
08:04:57
aztec-1 | [08:04:57.795]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
08:04:57
aztec-1 | [08:04:57.797]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
08:04:58
aztec-1 | [08:04:57.983]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
08:05:01
aztec-1 | [08:05:00.994]
INFO:
pxe:service Proving completed in 2965.7813060000008ms
{"timings":{"total":2965.7813060000008,"sync":13.616828000000169,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":175.24392199999602,"oracles":{"callPrivateFunction":{"times":[1106.2058629999992,316.17718200000127,250.7756960000006]}}},{"functionName":"private_kernel_init","time":86.97111799999948},{"functionName":"ContractClassRegisterer:register","time":1080.616366000001,"oracles":{"loadCapsule":{"times":[41.55341599999883]},"notifyCreatedNullifier":{"times":[1.0211619999990944]},"debugLog":{"times":[0.6568200000001525]},"notifyCreatedContractClassLog":{"times":[8.940382999999201]}}},{"functionName":"private_kernel_inner","time":149.88993200000004},{"functionName":"SchnorrAccount:constructor","time":296.6159239999997,"oracles":{"getContractInstance":{"times":[3.961059999999634]},"debugLog":{"times":[0.14567899999929068,0.13155799999913143]},"fetchTaggedLogs":{"times":[68.06338800000049]},"loadCapsule":{"times":[0.28787800000100106,0.23932400000012422,0.19967200000064622]},"validateEnqueuedNotesAndEvents":{"times":[7.058799000000363]},"notifyCreatedNullifier":{"times":[0.22221400000125868,0.2230230000004667]},"notifyCreatedNote":{"times":[0.461819000000105]},"getRandomField":{"times":[0.1526899999989837,0.14899899999909394,0.06421399999999267,0.06624399999964226,0.14712800000052084,0.09402500000032887,0.047001999999338295,0.039152999999714666,0.08040499999879103,0.06828400000085821,0.031602000000930275]},"getIndexedTaggingSecretAsSender":{"times":[53.038024000001315]},"incrementAppTaggingSecretIndexAsSender":{"times":[19.52083700000003]}}},{"functionName":"private_kernel_inner","time":103.59084799999982},{"functionName":"SchnorrAccount:entrypoint","time":224.50444000000243,"oracles":{"debugLog":{"times":[0.20373300000028394,0.1661499999991065,0.4239849999994476]},"fetchTaggedLogs":{"times":[84.69754900000044]},"loadCapsule":{"times":[0.3611220000002504,0.27619599999889033,0.3518420000000333]},"validateEnqueuedNotesAndEvents":{"times":[6.43326100000013]},"getNotes":{"times":[2.680043000000296]},"getAuthWitness":{"times":[0.40815500000098837]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.3234700000011799]}}},{"functionName":"private_kernel_inner","time":117.87619699999959},{"functionName":"private_kernel_reset","time":223.37483000000066},{"functionName":"private_kernel_tail","time":59.2402519999996}],"unaccounted":434.2406490000021}}
08:05:01
aztec-1 | [08:05:01.085]
INFO:
node Received tx 0x2b27d8591c8effeceffcfcaafee63cffd0f28e81170d3f169840728bfc9124d1
{"txHash":"0x2b27d8591c8effeceffcfcaafee63cffd0f28e81170d3f169840728bfc9124d1"}
08:05:01
aztec-1 | [08:05:01.085]
INFO:
pxe:service Sent transaction 0x2b27d8591c8effeceffcfcaafee63cffd0f28e81170d3f169840728bfc9124d1
08:05:01
aztec-1 | [08:05:01.191]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03885031300000082s
{"duration":0.03885031300000082,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
08:05:01
aztec-1 | [08:05:01.215]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x11771952cff4b576c3a5558e5f18b27948da45315b002b5bc5ac30fc04a7eaf8","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749802189,"version":1767261948},"txHashes":["0x2b27d8591c8effeceffcfcaafee63cffd0f28e81170d3f169840728bfc9124d1"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":71.510628,"publicProcessDuration":39.40228500000012,"rollupCircuitsDuration":64.53925399999935,"txCount":1,"blockNumber":1,"blockTimestamp":1749802189,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
08:05:04
aztec-1 | [08:05:03.827]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
08:05:04
aztec-1 | [08:05:03.832]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
08:05:04
aztec-1 | [08:05:03.838]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
08:05:04
aztec-1 | [08:05:03.942]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
08:05:04
aztec-1 | error: "Rollup__SlotAlreadyInChain(2, 2)"
08:05:04
aztec-1 | [08:05:03.942]
WARN:
sequencer Cannot propose block 1 at slot 2 due to failed rollup contract check
08:05:04
aztec-1 | [08:05:03.977]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x11771952cff4b576c3a5558e5f18b27948da45315b002b5bc5ac30fc04a7eaf8","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749802189,"version":1767261948},"archiveRoot":"0x0762cde80c674589f7ac070c3d5fcf144cd4c6798a8ca270cc5ea9ae830dc7f0","archiveNextLeafIndex":2}
08:05:04
aztec-1 | [08:05:03.986]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
08:05:04
aztec-1 | [08:05:04.026]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
08:05:04
aztec-1 | [08:05:04.026]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:09:49.000Z
{"offset":284974,"timeMs":1749802189000}
08:05:04
aztec-1 | [08:05:04.040]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":19.082070999998905,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749802189,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
08:05:04
aztec-1 | [08:05:04.077]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802225
08:05:04
aztec-1 | [08:05:04.077]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:10:25.000Z
{"offset":320923,"timeMs":1749802225000}
08:05:04
aztec-1 | [08:05:04.077]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
08:05:04
aztec-1 | [08:05:04.184]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
08:05:04
aztec-1 | [08:05:04.335]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
08:05:06
aztec-1 | [08:05:05.889]
INFO:
pxe:service Proving completed in 1518.1334559999996ms
{"timings":{"total":1518.1334559999996,"sync":19.32012500000019,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":100.23211499999888,"oracles":{"callPrivateFunction":{"times":[379.88435500000014,258.86202799999955]}}},{"functionName":"private_kernel_init","time":51.6524700000009},{"functionName":"SchnorrAccount:constructor","time":357.00748399999975,"oracles":{"getContractInstance":{"times":[5.135732000000644]},"debugLog":{"times":[0.17401100000097358,0.11016699999890989]},"fetchTaggedLogs":{"times":[117.83630400000038]},"loadCapsule":{"times":[0.32907999999952153,0.3315600000005361,0.4722590000001219]},"validateEnqueuedNotesAndEvents":{"times":[6.1937960000013845]},"notifyCreatedNullifier":{"times":[0.31707900000037625,0.2581159999990632]},"notifyCreatedNote":{"times":[0.16798999999991793]},"getRandomField":{"times":[0.12902799999937997,0.2094729999989795,0.09351599999899918,0.07994500000131666,0.08743500000127824,0.0752440000014758,0.06521400000019639,0.06278399999973772,0.046481999999741674,0.054534000000785454,0.04718300000058662]},"getIndexedTaggingSecretAsSender":{"times":[72.34542800000054]},"incrementAppTaggingSecretIndexAsSender":{"times":[28.86147400000118]}}},{"functionName":"private_kernel_inner","time":97.19832899999892},{"functionName":"SchnorrAccount:entrypoint","time":229.6102490000012,"oracles":{"debugLog":{"times":[0.32106999999996333,0.09672599999976228,0.1377680000005057]},"fetchTaggedLogs":{"times":[96.0760109999992]},"loadCapsule":{"times":[0.23355400000036752,0.19279199999982666,0.18631199999981618]},"validateEnqueuedNotesAndEvents":{"times":[7.8588570000010805]},"getNotes":{"times":[1.5382030000000668]},"getAuthWitness":{"times":[0.17540100000042003]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.44037700000080804]}}},{"functionName":"private_kernel_inner","time":121.6227940000008},{"functionName":"private_kernel_reset","time":194.64667399999962},{"functionName":"private_kernel_tail","time":86.54859200000101}],"unaccounted":260.2946239999983}}
08:05:06
aztec-1 | [08:05:05.942]
INFO:
node Received tx 0x1ded8048edfcf4078f44b718ae9ec7b449817f6549df45eb7dc26d630497d144
{"txHash":"0x1ded8048edfcf4078f44b718ae9ec7b449817f6549df45eb7dc26d630497d144"}
08:05:06
aztec-1 | [08:05:05.942]
INFO:
pxe:service Sent transaction 0x1ded8048edfcf4078f44b718ae9ec7b449817f6549df45eb7dc26d630497d144
08:05:06
aztec-1 | [08:05:06.019]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.022177028000000064s
{"duration":0.022177028000000064,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
08:05:06
aztec-1 | [08:05:06.041]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x19dae96218cc668c7f7e76a110809699b589e0d0667012ee7b3f88e43a446fcb","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749802225,"version":1767261948},"txHashes":["0x1ded8048edfcf4078f44b718ae9ec7b449817f6549df45eb7dc26d630497d144"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":56.280360999999175,"publicProcessDuration":22.35631999999896,"rollupCircuitsDuration":48.27551500000118,"txCount":1,"blockNumber":2,"blockTimestamp":1749802225,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
08:05:06
aztec-1 | [08:05:06.263]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
08:05:06
aztec-1 | [08:05:06.273]
WARN:
archiver Failed to reach L2 block 2 at 26 (latest is 1). Rolling back last synched L1 block number to 25.
{"latestLocalL2BlockNumber":1,"latestLocalL2BlockArchive":"0x0762cde80c674589f7ac070c3d5fcf144cd4c6798a8ca270cc5ea9ae830dc7f0","blocksSynchedTo":25,"currentL1BlockNumber":26,"provenBlockNumber":1,"provenArchive":"0x0762cde80c674589f7ac070c3d5fcf144cd4c6798a8ca270cc5ea9ae830dc7f0","pendingBlockNumber":2,"pendingArchive":"0x2112820e53ec6a1cc9d5437f5117da516cdef318e8bae38f6dd776728856ada9"}
08:05:06
aztec-1 | [08:05:06.331]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
08:05:06
aztec-1 | error: "Rollup__SlotAlreadyInChain(3, 3)"
08:05:06
aztec-1 | [08:05:06.331]
WARN:
sequencer Cannot propose block 2 at slot 3 due to failed rollup contract check
08:05:06
aztec-1 | [08:05:06.391]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x19dae96218cc668c7f7e76a110809699b589e0d0667012ee7b3f88e43a446fcb","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749802225,"version":1767261948},"archiveRoot":"0x2112820e53ec6a1cc9d5437f5117da516cdef318e8bae38f6dd776728856ada9","archiveNextLeafIndex":3}
08:05:06
aztec-1 | [08:05:06.399]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
08:05:06
aztec-1 | error: "Rollup__SlotAlreadyInChain(3, 3)"
08:05:06
aztec-1 | [08:05:06.399]
WARN:
sequencer Cannot propose block 2 at slot 3 due to failed rollup contract check
08:05:06
aztec-1 | [08:05:06.421]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":14.850963000000775,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749802225,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
08:05:06
aztec-1 | [08:05:06.441]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
08:05:06
aztec-1 | [08:05:06.441]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:10:37.000Z
{"offset":330559,"timeMs":1749802237000}
08:05:06
aztec-1 | [08:05:06.444]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
08:05:06
aztec-1 | [08:05:06.445]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
08:05:06
aztec-1 | [08:05:06.524]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
08:05:06
aztec-1 | error: "Rollup__SlotAlreadyInChain(3, 3)"
08:05:06
aztec-1 | [08:05:06.524]
WARN:
sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check
08:05:06
aztec-1 | [08:05:06.527]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802261
08:05:06
aztec-1 | [08:05:06.527]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:11:01.000Z
{"offset":354473,"timeMs":1749802261000}
08:05:06
aztec-1 | [08:05:06.527]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
08:05:06
aztec-1 | [08:05:06.549]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
08:05:06
aztec-1 | [08:05:06.683]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
08:05:06
aztec-1 | [08:05:06.705]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
08:05:08
aztec-1 | Initial Accounts:
08:05:08
aztec-1 |
08:05:08
aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
08:05:08
aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
08:05:08
aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
08:05:08
aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
08:05:08
aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
08:05:08
aztec-1 |
08:05:08
aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
08:05:08
aztec-1 |
08:05:08
aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
08:05:08
aztec-1 |
08:05:08
aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
08:05:08
aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
08:05:08
aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
08:05:08
aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
08:05:08
aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
08:05:08
aztec-1 |
08:05:08
aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
08:05:08
aztec-1 |
08:05:08
aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
08:05:08
aztec-1 |
08:05:08
aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
08:05:08
aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
08:05:08
aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
08:05:08
aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
08:05:08
aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
08:05:08
aztec-1 |
08:05:08
aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
08:05:08
aztec-1 |
08:05:08
aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
08:05:08
aztec-1 |
08:05:08
aztec-1 |
08:05:08
aztec-1 | [08:05:08.104]
INFO:
pxe:service Proving completed in 1408.980309999999ms
{"timings":{"total":1408.980309999999,"sync":17.406848999999056,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":96.15298599999369,"oracles":{"callPrivateFunction":{"times":[404.89707599999747,264.41391499999736]}}},{"functionName":"private_kernel_init","time":47.037749999999505},{"functionName":"SchnorrAccount:constructor","time":376.8835020000006,"oracles":{"getContractInstance":{"times":[2.9911619999984396]},"debugLog":{"times":[0.09407500000088476,0.0734649999976682]},"fetchTaggedLogs":{"times":[107.33644600000116]},"loadCapsule":{"times":[0.20002200000089942,0.18366099999911967,0.14699900000050548]},"validateEnqueuedNotesAndEvents":{"times":[5.967402000002039]},"notifyCreatedNullifier":{"times":[0.5242319999997562,0.18006099999911385]},"notifyCreatedNote":{"times":[0.1569099999978789]},"getRandomField":{"times":[0.2281650000004447,0.16559000000052038,0.10420599999997648,0.055183999997098,0.055303000001003966,0.0404530000014347,0.049162999999680324,0.034082000001944834,0.0457429999987653,0.041562999998859596,0.0611639999988256]},"getIndexedTaggingSecretAsSender":{"times":[43.80680399999983]},"incrementAppTaggingSecretIndexAsSender":{"times":[36.98829900000055]}}},{"functionName":"private_kernel_inner","time":95.52946800000063},{"functionName":"SchnorrAccount:entrypoint","time":239.21578399999999,"oracles":{"debugLog":{"times":[0.2187030000022787,0.09566600000107428,0.19258199999967474]},"fetchTaggedLogs":{"times":[99.68929000000207]},"loadCapsule":{"times":[0.5657940000019153,1.6485600000014529,3.1273110000001907]},"validateEnqueuedNotesAndEvents":{"times":[14.435848000000988]},"getNotes":{"times":[1.3260100000006787]},"getAuthWitness":{"times":[0.20814299999983632]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5747149999988324]}}},{"functionName":"private_kernel_inner","time":89.05870499999946},{"functionName":"private_kernel_reset","time":153.42325699999856},{"functionName":"private_kernel_tail","time":68.21613700000307}],"unaccounted":226.05587200000446}}
08:05:08
aztec-1 | [08:05:08.173]
INFO:
node Received tx 0x1f7c6d8778256e04551c6d3695e97c0d1e550d21511331551a40174cb565517f
{"txHash":"0x1f7c6d8778256e04551c6d3695e97c0d1e550d21511331551a40174cb565517f"}
08:05:08
aztec-1 | [08:05:08.173]
INFO:
pxe:service Sent transaction 0x1f7c6d8778256e04551c6d3695e97c0d1e550d21511331551a40174cb565517f
08:05:08
aztec-1 | [08:05:08.247]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.018412130000000616s
{"duration":0.018412130000000616,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
08:05:08
aztec-1 | [08:05:08.280]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x036ef09efe9b51d83f450f9614037e2a8cbe3c99476e88f5c07bc5b00ae5f5fd","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749802261,"version":1767261948},"txHashes":["0x1f7c6d8778256e04551c6d3695e97c0d1e550d21511331551a40174cb565517f"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":59.5641910000013,"publicProcessDuration":18.538517000000866,"rollupCircuitsDuration":53.32114100000035,"txCount":1,"blockNumber":3,"blockTimestamp":1749802261,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
08:05:08
aztec-1 | [08:05:08.497]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
08:05:08
aztec-1 | [08:05:08.502]
WARN:
archiver Failed to reach L2 block 3 at 28 (latest is 2). Rolling back last synched L1 block number to 27.
{"latestLocalL2BlockNumber":2,"latestLocalL2BlockArchive":"0x2112820e53ec6a1cc9d5437f5117da516cdef318e8bae38f6dd776728856ada9","blocksSynchedTo":27,"currentL1BlockNumber":28,"provenBlockNumber":2,"provenArchive":"0x2112820e53ec6a1cc9d5437f5117da516cdef318e8bae38f6dd776728856ada9","pendingBlockNumber":3,"pendingArchive":"0x1d3d2dc4a63f9fd6b307f6a5970d8f45ab56c758e159b3a0d711dfece07e558b"}
08:05:08
aztec-1 | [08:05:08.547]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
08:05:08
aztec-1 | [08:05:08.547]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:11:13.000Z
{"offset":364453,"timeMs":1749802273000}
08:05:08
aztec-1 | [08:05:08.557]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
08:05:08
aztec-1 | [08:05:08.559]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
08:05:08
aztec-1 | [08:05:08.567]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
08:05:08
aztec-1 | error: "Rollup__SlotAlreadyInChain(4, 4)"
08:05:08
aztec-1 | [08:05:08.567]
WARN:
sequencer Cannot propose block 3 at slot 4 due to failed rollup contract check
08:05:08
aztec-1 | [08:05:08.579]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802297
08:05:08
aztec-1 | [08:05:08.579]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:11:37.000Z
{"offset":388421,"timeMs":1749802297000}
08:05:08
aztec-1 | [08:05:08.579]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
08:05:08
aztec-1 | [08:05:08.614]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x036ef09efe9b51d83f450f9614037e2a8cbe3c99476e88f5c07bc5b00ae5f5fd","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749802261,"version":1767261948},"archiveRoot":"0x1d3d2dc4a63f9fd6b307f6a5970d8f45ab56c758e159b3a0d711dfece07e558b","archiveNextLeafIndex":4}
08:05:08
aztec-1 | [08:05:08.620]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
08:05:08
aztec-1 | [08:05:08.661]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":16.18404400000145,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749802261,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
08:05:09
aztec-1 | [08:05:09.465]
WARN:
pxe:service No artifact found for contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 when looking for its metadata
08:05:09
aztec-1 | [08:05:09.466]
WARN:
pxe:service No artifact found for contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 when looking for its metadata
08:05:09
aztec-1 | [08:05:09.477]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 as part of deployment for 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45
08:05:09
aztec-1 | [08:05:09.508]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 as part of deployment for 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf
08:05:10
aztec-1 | [08:05:10.481]
INFO:
pxe:service Added contract FPC at 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 with class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1
08:05:10
aztec-1 | [08:05:10.487]
INFO:
pxe:service Added contract Token at 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf with class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645
08:05:13
aztec-1 | [08:05:12.948]
INFO:
pxe:service Proving completed in 2407.774541999999ms
{"timings":{"total":2407.774541999999,"sync":42.03503599999749,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":332.0061150000038,"oracles":{"debugLog":{"times":[0.18019099999946775,0.08642600000166567,0.09346499999810476,0.19007099999726051,0.11380699999790522,0.09535600000162958,0.0646439999982249,0.19571199999700184]},"fetchTaggedLogs":{"times":[85.59703399999853]},"loadCapsule":{"times":[3.998663000002125,2.7015150000006543,2.5453850000012608,0.7108129999978701,0.2575460000007297,1.874814000002516,2.0635460000012245]},"getSharedSecret":{"times":[17.637972000000445]},"aes128Decrypt":{"times":[1.0338929999998072,0.5960460000023886]},"getPublicKeysAndPartialAddress":{"times":[7.405859999998938]},"getKeyValidationRequest":{"times":[7.286202999999659]},"storeCapsule":{"times":[3.247957999999926,3.407907000000705,2.9813710000016727]},"deleteCapsule":{"times":[4.059366000001319]},"validateEnqueuedNotesAndEvents":{"times":[20.47825500000181]},"getNotes":{"times":[4.000432999997429]},"getAuthWitness":{"times":[0.19127099999968777]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.09598600000026636]},"callPrivateFunction":{"times":[843.8552729999974,141.50650300000052]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2851569999984349]}}},{"functionName":"private_kernel_init","time":50.32080999999744},{"functionName":"ContractClassRegisterer:register","time":822.0227649999979,"oracles":{"loadCapsule":{"times":[3.479520999997476]},"notifyCreatedNullifier":{"times":[0.37568300000202726]},"debugLog":{"times":[0.15286900000137393]},"notifyCreatedContractClassLog":{"times":[7.751360999998724]}}},{"functionName":"private_kernel_inner","time":135.77937400000155},{"functionName":"ContractInstanceDeployer:deploy","time":73.9344549999987,"oracles":{"storeInExecutionCache":{"times":[0.32202899999902]},"callPrivateFunction":{"times":[69.08631000000241]},"notifyCreatedNullifier":{"times":[0.31584899999870686]},"debugLog":{"times":[0.12074800000118557]}}},{"functionName":"private_kernel_inner","time":96.31005500000174},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":54.327063000000635,"oracles":{}},{"functionName":"private_kernel_inner","time":113.64598899999692},{"functionName":"private_kernel_reset","time":186.69669000000067},{"functionName":"private_kernel_tail","time":92.34294399999999}],"unaccounted":408.3532460000024}}
08:05:13
aztec-1 | [08:05:13.105]
INFO:
node Received tx 0x1aa93fdf21854edda8997deba4051897c409eb196e213372c50f07ed97122485
{"txHash":"0x1aa93fdf21854edda8997deba4051897c409eb196e213372c50f07ed97122485"}
08:05:13
aztec-1 | [08:05:13.105]
INFO:
pxe:service Sent transaction 0x1aa93fdf21854edda8997deba4051897c409eb196e213372c50f07ed97122485
08:05:14
aztec-1 | [08:05:14.787]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.5342789269999995s
{"duration":1.5342789269999995,"rate":26894.71860288414,"totalPublicGas":{"daGas":4096,"l2Gas":41264},"totalBlockGas":{"daGas":166912,"l2Gas":66306},"totalSizeInBytes":10688}
08:05:15
aztec-1 | [08:05:15.016]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 23164.870759125006 mana/s
{"blockHash":"0x14938b92fe556b5435922b6125a1e86034a09cc15fbd826843444ee72ca71dd4","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749802297,"version":1767261948},"txHashes":["0x1aa93fdf21854edda8997deba4051897c409eb196e213372c50f07ed97122485"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1781.2338010000021,"publicProcessDuration":1534.4179150000018,"rollupCircuitsDuration":1773.3961950000012,"txCount":1,"blockNumber":4,"blockTimestamp":1749802297,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
08:05:16
aztec-1 | [08:05:15.554]
INFO:
pxe:service Proving completed in 2605.096547000001ms
{"timings":{"total":2605.096547000001,"sync":120.45312299999932,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":432.9434209999963,"oracles":{"debugLog":{"times":[0.19604199999957928,0.1036759999988135,0.10353599999871221,0.26091599999926984,0.11549699999886798,0.11108700000113458,0.1037270000015269,0.15178900000319118]},"fetchTaggedLogs":{"times":[198.6511169999976]},"loadCapsule":{"times":[0.4566080000004149,1.1214279999985592,0.6301780000030703,0.3940340000008291,1.509382000000187,1.0113510000010137,0.47917900000174996]},"getSharedSecret":{"times":[7.782332999999198]},"aes128Decrypt":{"times":[0.23663500000111526,0.7746270000025106]},"getPublicKeysAndPartialAddress":{"times":[5.272270000001299]},"getKeyValidationRequest":{"times":[2.2486969999990833]},"storeCapsule":{"times":[3.1101090000011027,25.55658300000141,2.7265860000006796]},"deleteCapsule":{"times":[2.5457949999981793]},"validateEnqueuedNotesAndEvents":{"times":[16.86705599999914]},"getNotes":{"times":[2.032533000001422]},"getAuthWitness":{"times":[0.21806400000059512]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.058514000000286615]},"callPrivateFunction":{"times":[689.1436060000015,145.06951999999728]},"notifyEnqueuedPublicFunctionCall":{"times":[0.04768300000068848]}}},{"functionName":"private_kernel_init","time":70.98770599999989},{"functionName":"ContractClassRegisterer:register","time":673.9248819999993,"oracles":{"loadCapsule":{"times":[2.0539649999991525]},"notifyCreatedNullifier":{"times":[0.4458569999987958]},"debugLog":{"times":[0.10888700000214158]},"notifyCreatedContractClassLog":{"times":[5.205206000002363]}}},{"functionName":"private_kernel_inner","time":129.97400199999902},{"functionName":"ContractInstanceDeployer:deploy","time":90.62427000000025,"oracles":{"storeInExecutionCache":{"times":[0.08655500000168104]},"callPrivateFunction":{"times":[49.049731999999494]},"notifyCreatedNullifier":{"times":[0.20354299999962677]},"debugLog":{"times":[0.13572799999747076]}}},{"functionName":"private_kernel_inner","time":114.16071000000011},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":38.28520700000081,"oracles":{}},{"functionName":"private_kernel_inner","time":136.23686299999827},{"functionName":"private_kernel_reset","time":237.82490899999902},{"functionName":"private_kernel_tail","time":95.43779200000063}],"unaccounted":464.24366200000804}}
08:05:16
aztec-1 | [08:05:15.816]
INFO:
node Received tx 0x176747985d50939bb90d82df8054db7171cfb537f5c1847818dc9233967cbb16
{"txHash":"0x176747985d50939bb90d82df8054db7171cfb537f5c1847818dc9233967cbb16"}
08:05:16
aztec-1 | [08:05:15.816]
INFO:
pxe:service Sent transaction 0x176747985d50939bb90d82df8054db7171cfb537f5c1847818dc9233967cbb16
08:05:16
aztec-1 | [08:05:15.832]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
08:05:16
aztec-1 | [08:05:15.835]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
08:05:16
aztec-1 | [08:05:15.836]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
08:05:16
aztec-1 | [08:05:15.841]
WARN:
archiver Failed to reach L2 block 4 at 30 (latest is 3). Rolling back last synched L1 block number to 29.
{"latestLocalL2BlockNumber":3,"latestLocalL2BlockArchive":"0x1d3d2dc4a63f9fd6b307f6a5970d8f45ab56c758e159b3a0d711dfece07e558b","blocksSynchedTo":29,"currentL1BlockNumber":30,"provenBlockNumber":3,"provenArchive":"0x1d3d2dc4a63f9fd6b307f6a5970d8f45ab56c758e159b3a0d711dfece07e558b","pendingBlockNumber":4,"pendingArchive":"0x08f07f4035ca5810fe01ca7d11d9a59b9d61fdc37890ae48c19e29598d8eae84"}
08:05:16
aztec-1 | [08:05:15.898]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
08:05:16
aztec-1 | error: "Rollup__SlotAlreadyInChain(5, 5)"
08:05:16
aztec-1 | [08:05:15.898]
WARN:
sequencer Cannot propose block 4 at slot 5 due to failed rollup contract check
08:05:16
aztec-1 | [08:05:15.913]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802333
08:05:16
aztec-1 | [08:05:15.914]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:12:13.000Z
{"offset":417086,"timeMs":1749802333000}
08:05:16
aztec-1 | [08:05:15.914]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
08:05:16
aztec-1 | [08:05:15.979]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x14938b92fe556b5435922b6125a1e86034a09cc15fbd826843444ee72ca71dd4","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749802297,"version":1767261948},"archiveRoot":"0x08f07f4035ca5810fe01ca7d11d9a59b9d61fdc37890ae48c19e29598d8eae84","archiveNextLeafIndex":5}
08:05:16
aztec-1 | [08:05:15.985]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
08:05:16
aztec-1 | [08:05:16.039]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":15.999123000001418,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749802297,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
08:05:16
aztec-1 | [08:05:16.495]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3777611059999981s
{"duration":0.3777611059999981,"rate":877403.7208584455,"totalPublicGas":{"daGas":10240,"l2Gas":331449},"totalBlockGas":{"daGas":380928,"l2Gas":356491},"totalSizeInBytes":24064}
08:05:16
aztec-1 | [08:05:16.553]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 745171.0845804182 mana/s
{"blockHash":"0x2e719ae429ba22e66320d32555f66e5c34e3105fd4ead77ac6787b976f74433f","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749802333,"version":1767261948},"txHashes":["0x176747985d50939bb90d82df8054db7171cfb537f5c1847818dc9233967cbb16"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":444.76456999999937,"publicProcessDuration":378.0258130000002,"rollupCircuitsDuration":439.90827400000126,"txCount":1,"blockNumber":5,"blockTimestamp":1749802333,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
08:05:16
aztec-1 | [08:05:16.690]
INFO:
aztecjs:deploy_sent_tx Contract 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 successfully deployed.
08:05:16
aztec-1 | [08:05:16.836]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
08:05:16
aztec-1 | [08:05:16.842]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802369
08:05:16
aztec-1 | [08:05:16.842]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:12:49.000Z
{"offset":452158,"timeMs":1749802369000}
08:05:16
aztec-1 | [08:05:16.842]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
08:05:16
aztec-1 | [08:05:16.859]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
08:05:16
aztec-1 | [08:05:16.860]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
08:05:17
aztec-1 | [08:05:17.033]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x2e719ae429ba22e66320d32555f66e5c34e3105fd4ead77ac6787b976f74433f","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749802333,"version":1767261948},"archiveRoot":"0x1922ad39367f3ef0e48a1e4b406d8ca9f392bb366803cdcd0e39d3aebf4e23f1","archiveNextLeafIndex":6}
08:05:17
aztec-1 | [08:05:17.038]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
08:05:17
aztec-1 | [08:05:17.111]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":19.11825200000021,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749802333,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
08:05:18
aztec-1 | BananaCoin: 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf
08:05:18
aztec-1 | FPC: 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45
08:05:18
aztec-1 | [08:05:18.031]
INFO:
aztecjs:deploy_sent_tx Contract 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf successfully deployed.
08:05:18
aztec-1 | [08:05:18.058]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
08:05:18
aztec-1 | [08:05:18.068]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
08:05:18
aztec-1 | [08:05:18.188]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
08:05:20
aztec-1 | [08:05:20.205]
INFO:
pxe:service Proving completed in 2009.2175040000002ms
{"timings":{"total":2009.2175040000002,"sync":34.454705000000104,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":63.66206500000408,"oracles":{"callPrivateFunction":{"times":[666.7586880000017,139.23090299999967,36.736925000001065]}}},{"functionName":"private_kernel_init","time":60.05681700000059},{"functionName":"ContractClassRegisterer:register","time":653.7701689999994,"oracles":{"loadCapsule":{"times":[2.5250139999989187]},"notifyCreatedNullifier":{"times":[0.3087789999990491]},"debugLog":{"times":[0.08376499999940279]},"notifyCreatedContractClassLog":{"times":[2.83118199999808]}}},{"functionName":"private_kernel_inner","time":140.5686229999992},{"functionName":"ContractInstanceDeployer:deploy","time":86.69750099999874,"oracles":{"storeInExecutionCache":{"times":[0.13793799999984913]},"callPrivateFunction":{"times":[57.0341640000006]},"notifyCreatedNullifier":{"times":[0.23400399999809451]},"debugLog":{"times":[0.12869800000044052]}}},{"functionName":"private_kernel_inner","time":91.92412800000238},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.53160500000013,"oracles":{}},{"functionName":"private_kernel_inner","time":105.5088599999981},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":30.159026000001177,"oracles":{"debugLog":{"times":[0.13557900000159862]}}},{"functionName":"private_kernel_inner","time":110.58953899999688},{"functionName":"private_kernel_reset","time":158.35009100000025},{"functionName":"private_kernel_tail","time":71.52189200000066}],"unaccounted":362.42248299999846}}
08:05:20
aztec-1 | [08:05:20.317]
INFO:
node Received tx 0x2c1f1c0899bc1c0f5a89057058a1c930ede749dd8ffa0594e0756cfb6cfa4d45
{"txHash":"0x2c1f1c0899bc1c0f5a89057058a1c930ede749dd8ffa0594e0756cfb6cfa4d45"}
08:05:20
aztec-1 | [08:05:20.317]
INFO:
pxe:service Sent transaction 0x2c1f1c0899bc1c0f5a89057058a1c930ede749dd8ffa0594e0756cfb6cfa4d45
08:05:20
aztec-1 | [08:05:20.441]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04378398100000049s
{"duration":0.04378398100000049,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
08:05:20
aztec-1 | [08:05:20.486]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x0baa2bb254a95c1bec36b0d212c05358af4269f079c195223c41c9ff0ea7c0c8","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749802369,"version":1767261948},"txHashes":["0x2c1f1c0899bc1c0f5a89057058a1c930ede749dd8ffa0594e0756cfb6cfa4d45"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":95.38395699999819,"publicProcessDuration":43.964342999999644,"rollupCircuitsDuration":91.06509499999811,"txCount":1,"blockNumber":6,"blockTimestamp":1749802369,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
08:05:21
aztec-1 | [08:05:20.756]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
08:05:21
aztec-1 | [08:05:20.759]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
08:05:21
aztec-1 | [08:05:20.762]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
08:05:21
aztec-1 | [08:05:20.766]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802405
08:05:21
aztec-1 | [08:05:20.766]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:13:25.000Z
{"offset":484234,"timeMs":1749802405000}
08:05:21
aztec-1 | [08:05:20.766]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
08:05:21
aztec-1 | [08:05:20.869]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x0baa2bb254a95c1bec36b0d212c05358af4269f079c195223c41c9ff0ea7c0c8","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749802369,"version":1767261948},"archiveRoot":"0x1a98d80cb8f41c364635606bc000ccd2a67525db13068cdf993db75ece71f640","archiveNextLeafIndex":7}
08:05:21
aztec-1 | [08:05:20.875]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
08:05:21
aztec-1 | [08:05:20.923]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":13.959005000000616,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749802369,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
08:05:21
aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
08:05:21
aztec-1 | [08:05:21.340]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
08:05:21
aztec-1 | [08:05:21.347]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x2d2655c513c2e8feb8c7411b7e807c66287b57bb60572ce85ce1fe0a1e0c925d","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
08:05:32
box-1 | \
08:05:32
box-1 | Running 1
test using 1
worker
08:05:32
box-1 |
08:05:33
box-1 | 1 [webkit] › browser.spec.ts:3:1 › test
08:05:57
aztec-1 | [08:05:56.922]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802441
08:05:57
aztec-1 | [08:05:56.922]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:14:01.000Z
{"offset":484078,"timeMs":1749802441000}
08:05:57
aztec-1 | [08:05:56.922]
INFO:
aztecjs:utils:watcher Slot 8 was missed, jumped to next slot
08:06:33
aztec-1 | [08:06:33.030]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802477
08:06:33
aztec-1 | [08:06:33.030]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:14:37.000Z
{"offset":483970,"timeMs":1749802477000}
08:06:33
aztec-1 | [08:06:33.030]
INFO:
aztecjs:utils:watcher Slot 9 was missed, jumped to next slot
08:07:05
✘ 1 [webkit] › browser.spec.ts:3:1 › test (1.5m) 2 [webkit] › browser.spec.ts:3:1 › test (retry #1)
08:07:09
aztec-1 | [08:07:09.116]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
08:07:09
aztec-1 | [08:07:09.121]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802514
08:07:09
aztec-1 | [08:07:09.322]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
08:07:09
aztec-1 | [08:07:09.322]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:15:14.000Z
{"offset":484678,"timeMs":1749802514000}
08:07:44
aztec-1 | [08:07:44.418]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802549
08:07:44
aztec-1 | [08:07:44.418]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:15:49.000Z
{"offset":484582,"timeMs":1749802549000}
08:07:44
aztec-1 | [08:07:44.418]
INFO:
aztecjs:utils:watcher Slot 11 was missed, jumped to next slot
08:08:20
aztec-1 | [08:08:20.450]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802585
08:08:20
aztec-1 | [08:08:20.450]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:16:25.000Z
{"offset":484550,"timeMs":1749802585000}
08:08:20
aztec-1 | [08:08:20.450]
INFO:
aztecjs:utils:watcher Slot 12 was missed, jumped to next slot
08:08:41
✘ 2 [webkit] › browser.spec.ts:3:1 › test (retry #1) (1.6m) 3 [webkit] › browser.spec.ts:3:1 › test (retry #2)
08:08:57
aztec-1 | [08:08:56.475]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
08:08:57
aztec-1 | [08:08:56.478]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802622
08:08:57
aztec-1 | [08:08:56.681]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
08:08:57
aztec-1 | [08:08:56.681]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:17:02.000Z
{"offset":485319,"timeMs":1749802622000}
08:09:32
aztec-1 | [08:09:31.820]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802657
08:09:32
aztec-1 | [08:09:31.820]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:17:37.000Z
{"offset":485180,"timeMs":1749802657000}
08:09:32
aztec-1 | [08:09:31.820]
INFO:
aztecjs:utils:watcher Slot 14 was missed, jumped to next slot
08:10:08
aztec-1 | [08:10:07.971]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802693
08:10:08
aztec-1 | [08:10:07.971]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:18:13.000Z
{"offset":485029,"timeMs":1749802693000}
08:10:08
aztec-1 | [08:10:07.971]
INFO:
aztecjs:utils:watcher Slot 15 was missed, jumped to next slot
08:10:12
✘ 3 [webkit] › browser.spec.ts:3:1 › test (retry #2) (1.5m) 4 [webkit] › browser.spec.ts:3:1 › test (retry #3)
08:10:44
aztec-1 | [08:10:44.008]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802729
08:10:44
aztec-1 | [08:10:44.008]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:18:49.000Z
{"offset":484992,"timeMs":1749802729000}
08:10:44
aztec-1 | [08:10:44.008]
INFO:
aztecjs:utils:watcher Slot 16 was missed, jumped to next slot
08:11:20
aztec-1 | [08:11:20.046]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
08:11:20
aztec-1 | [08:11:20.049]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749802766
08:11:20
aztec-1 | [08:11:20.250]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
08:11:20
aztec-1 | [08:11:20.250]
WARN:
foundation:test-date-provider Time set to 2025-06-13T08:19:26.000Z
{"offset":485750,"timeMs":1749802766000}
08:11:42
✘ 4 [webkit] › browser.spec.ts:3:1 › test (retry #3) (1.5m)
08:11:42
box-1 |
08:11:42
box-1 | 1) [webkit] › browser.spec.ts:3:1 › test ─────────────────────────────────────────────────────────
08:11:42
box-1 |
08:11:42
box-1 | Test timeout of 90000ms exceeded.
08:11:42
box-1 |
08:11:42
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
08:11:42
box-1 | Call log:
08:11:42
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
08:11:42
box-1 |
08:11:42
box-1 |
08:11:42
box-1 | 6 |
08:11:42
box-1 | 7 | // Deploy contract
08:11:42
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
08:11:42
box-1 | | ^
08:11:42
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
08:11:42
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
08:11:42
box-1 | 11 |
08:11:42
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
08:11:42
box-1 |
08:11:42
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
08:11:42
box-1 | test-results/browser-test-webkit/test-failed-1.png
08:11:42
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
08:11:42
box-1 |
08:11:42
box-1 | Retry #1 ───────────────────────────────────────────────────────────────────────────────────────
08:11:42
box-1 |
08:11:42
box-1 | Test timeout of 90000ms exceeded.
08:11:42
box-1 |
08:11:42
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
08:11:42
box-1 | Call log:
08:11:42
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
08:11:42
box-1 |
08:11:42
box-1 |
08:11:42
box-1 | 6 |
08:11:42
box-1 | 7 | // Deploy contract
08:11:42
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
08:11:42
box-1 | | ^
08:11:42
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
08:11:42
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
08:11:42
box-1 | 11 |
08:11:42
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
08:11:42
box-1 |
08:11:42
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
08:11:42
box-1 | test-results/browser-test-webkit-retry1/test-failed-1.png
08:11:42
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
08:11:42
box-1 |
08:11:42
box-1 | attachment #2: video (video/webm) ──────────────────────────────────────────────────────────────
08:11:42
box-1 | test-results/browser-test-webkit-retry1/video.webm
08:11:42
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
08:11:42
box-1 |
08:11:42
box-1 | attachment #3: trace (application/zip) ─────────────────────────────────────────────────────────
08:11:42
box-1 | test-results/browser-test-webkit-retry1/trace.zip
08:11:42
box-1 | Usage:
08:11:42
box-1 |
08:11:42
box-1 | yarn playwright show-trace test-results/browser-test-webkit-retry1/trace.zip
08:11:42
box-1 |
08:11:42
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
08:11:42
box-1 |
08:11:42
box-1 | Retry #2 ───────────────────────────────────────────────────────────────────────────────────────
08:11:42
box-1 |
08:11:42
box-1 | Test timeout of 90000ms exceeded.
08:11:42
box-1 |
08:11:42
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
08:11:42
box-1 | Call log:
08:11:42
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
08:11:42
box-1 |
08:11:42
box-1 |
08:11:42
box-1 | 6 |
08:11:42
box-1 | 7 | // Deploy contract
08:11:42
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
08:11:42
box-1 | | ^
08:11:42
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
08:11:42
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
08:11:42
box-1 | 11 |
08:11:42
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
08:11:42
box-1 |
08:11:42
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
08:11:42
box-1 | test-results/browser-test-webkit-retry2/test-failed-1.png
08:11:42
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
08:11:42
box-1 |
08:11:42
box-1 | Retry #3 ───────────────────────────────────────────────────────────────────────────────────────
08:11:42
box-1 |
08:11:42
box-1 | Test timeout of 90000ms exceeded.
08:11:42
box-1 |
08:11:42
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
08:11:42
box-1 | Call log:
08:11:42
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
08:11:42
box-1 |
08:11:42
box-1 |
08:11:42
box-1 | 6 |
08:11:42
box-1 | 7 | // Deploy contract
08:11:42
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
08:11:42
box-1 | | ^
08:11:42
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
08:11:42
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
08:11:42
box-1 | 11 |
08:11:42
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
08:11:42
box-1 |
08:11:42
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
08:11:42
box-1 | test-results/browser-test-webkit-retry3/test-failed-1.png
08:11:42
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
08:11:42
box-1 |
08:11:42
box-1 | 1 failed
08:11:42
box-1 | [webkit] › browser.spec.ts:3:1 › test ──────────────────────────────────────────────────────────
08:11:42
box-1 | \
08:11:42 Aborting on container exit...
08:11:42
box-1 exited with code 1
08:11:42 [?25l[+] Stopping 3/3
08:11:44 ✔ Container vite-webkit-box-1 Stopped0.0s
08:11:44 ✔ Container vite-webkit-aztec-1 Stopped1.3s
08:11:44 ✔ Container vite-webkit-ethereum-1 Stopped0.1s
08:11:44 [?25h