Parent Log:
http://ci.aztec-labs.com/a4948abd03df6c68
Command: 5eaefa4ebba844bd:ONLY_TERM_PARENT=1 BOX=vite BROWSER=webkit run_compose_test vite-webkit box boxes
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/0894618ded24dc2deab9e92e1888aa081f5f585e
Env: REF_NAME=gh-readonly-queue/next/pr-14968-1faede1b877a148b46fe6c8ad03986e139b38e95 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Wed Jun 11 14:50:39 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14968_amd64_x1-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History: [?25l
[+] Running 4/4
14:50:40
✔ Network vite-webkit_default
Created0.1s
14:50:40
✔ Container vite-webkit-ethereum-1
Created0.1s
14:50:40
✔ Container vite-webkit-aztec-1
Created0.1s
14:50:40
✔ Container vite-webkit-box-1
Created0.1s
14:50:40 [?25hAttaching to aztec-1, box-1, ethereum-1
14:50:45
aztec-1 |
14:50:45
aztec-1 | _
14:50:45
aztec-1 | /\ | |
14:50:45
aztec-1 | / \ ___| |_ ___ ___
14:50:45
aztec-1 | / /\ \ |_ / __/ _ \/ __|
14:50:45
aztec-1 | / ____ \ / /| || __/ (__
14:50:45
aztec-1 | /_/___ \_\/___|\__\___|\___|
14:50:45
aztec-1 |
14:50:45
aztec-1 | https://github.com/AztecProtocol
14:50:45
aztec-1 |
14:50:45
aztec-1 |
14:50:45
aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
14:50:45
aztec-1 | Setting up test accounts
14:50:46
aztec-1 | [14:50:46.217]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-E79D9J/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
14:50:46
aztec-1 | [14:50:46.528]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
14:50:46
aztec-1 | [14:50:46.534]
WARN:
sandbox Set block interval to 12
14:50:46
aztec-1 | [14:50:46.756]
INFO:
sandbox Waiting for 7 transactions to be mined...
14:50:46
aztec-1 | [14:50:46.780]
INFO:
sandbox All transactions mined successfully
14:50:46
aztec-1 | [14:50:46.859]
INFO:
sandbox Waiting for 9 transactions to be mined...
14:50:46
aztec-1 | [14:50:46.881]
INFO:
sandbox All transactions mined successfully
14:50:47
aztec-1 | [14:50:47.045]
INFO:
sandbox Waiting for 11 transactions to be mined...
14:50:47
aztec-1 | [14:50:47.067]
INFO:
sandbox All transactions mined successfully
14:50:47
aztec-1 | [14:50:47.138]
INFO:
sandbox Waiting for 12 transactions to be mined...
14:50:47
aztec-1 | [14:50:47.162]
INFO:
sandbox All transactions mined successfully
14:50:47
aztec-1 | [14:50:47.167]
INFO:
sandbox Waiting for 12 transactions to be mined...
14:50:47
aztec-1 | [14:50:47.195]
INFO:
sandbox All transactions mined successfully
14:50:47
aztec-1 | [14:50:47.214]
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"}
14:50:47
aztec-1 | [14:50:47.215]
INFO:
sandbox Handing over to governance
14:50:47
aztec-1 | [14:50:47.221]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x68B1D87F95878fE05B998F19b66F4baba5De1aed
14:50:47
aztec-1 | [14:50:47.222]
INFO:
telemetry:client Using NoopTelemetryClient
14:50:47
aztec-1 | [14:50:47.222]
INFO:
blob-sink:client Creating local blob sink client.
14:50:47
aztec-1 | [14:50:47.226]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
14:50:47
aztec-1 | [14:50:47.226]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:55:16.000Z
{"offset":268774,"timeMs":1749653716000}
14:50:47
aztec-1 | [14:50:47.255]
INFO:
archiver:lmdb Starting data store with maxReaders 16
14:50:47
aztec-1 | [14:50:47.692]
INFO:
archiver Starting archiver sync to rollup contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed from L1 block 19 to current L1 block 23 with hash 0xe4ca0c57356a8c7bfa1fec7174a14f6436d749e3731decbb7ba9af6df528eefb
{"blocksSynchedTo":19,"messagesSynchedTo":{"l1BlockHash":"0x7d20ce5c18f18fcc0d2febeb2165a213c5c9695e6f40e29a55345416186547a0","l1BlockNumber":19}}
14:50:47
aztec-1 | [14:50:47.718]
INFO:
archiver Initial archiver sync to L1 block 23 complete.
{"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0xe4ca0c57356a8c7bfa1fec7174a14f6436d749e3731decbb7ba9af6df528eefb","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
14:50:48
aztec-1 | [14:50:47.727]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-OlgcAv/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
14:50:48
aztec-1 | [14:50:47.998]
INFO:
world_state Created world state synchroniser with block history of 64
14:50:48
aztec-1 | [14:50:47.998]
WARN:
node Aztec node is accepting fake proofs
14:50:48
aztec-1 | [14:50:48.007]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
14:50:48
aztec-1 | [14:50:48.025]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
14:50:48
aztec-1 | [14:50:48.046]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
14:50:48
aztec-1 | [14:50:48.070]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
14:50:48
aztec-1 | [14:50:48.074]
INFO:
world_state Started world state synchronizer from block 1
14:50:48
aztec-1 | [14:50:48.076]
INFO:
p2p Starting p2p client from block 0 with empty mempools
14:50:48
aztec-1 | [14:50:48.302]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
14:50:48
aztec-1 | [14:50:48.349]
INFO:
slasher Starting Slasher client...
14:50:48
aztec-1 | [14:50:48.362]
INFO:
sequencer-client Deploying forwarder contract
14:50:48
aztec-1 | [14:50:48.393]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
14:50:48
aztec-1 | [14:50:48.405]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
14:50:48
aztec-1 | [14:50:48.406]
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}
14:50:48
aztec-1 | [14:50:48.407]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
14:50:48
aztec-1 | [14:50:48.408]
INFO:
node Aztec Node version: 0.87.6
14:50:48
aztec-1 | [14:50:48.408]
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"}
14:50:48
aztec-1 | [14:50:48.414]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
14:50:48
aztec-1 | [14:50:48.429]
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}
14:50:48
aztec-1 | [14:50:48.491]
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}
14:50:48
aztec-1 | [14:50:48.659]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
14:50:48
aztec-1 | [14:50:48.659]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:55:28.000Z
{"offset":279341,"timeMs":1749653728000}
14:50:48
aztec-1 | [14:50:48.667]
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}
14:50:48
aztec-1 | Setting up funded test accounts...
14:50:48
aztec-1 | [14:50:48.883]
INFO:
pxe:service Started PXE connected to chain 31337 version 891987980
14:50:49
aztec-1 | [14:50:49.029]
INFO:
pxe:service Registered account 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef
14:50:49
aztec-1 | [14:50:49.134]
WARN:
pxe:service No artifact found for contract class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f when looking for its metadata
14:50:49
aztec-1 | [14:50:49.138]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f as part of deployment for 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef
14:50:49
aztec-1 | [14:50:49.305]
INFO:
pxe:service Added contract SchnorrAccount at 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f
14:50:52
aztec-1 | [14:50:52.047]
INFO:
pxe:service Proving completed in 2689.785465000001ms
{"timings":{"total":2689.785465000001,"sync":15.768823000000339,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":172.1738919999989,"oracles":{"callPrivateFunction":{"times":[784.2071989999986,405.4191210000008,244.5324039999996]}}},{"functionName":"private_kernel_init","time":110.44766700000037},{"functionName":"ContractClassRegisterer:register","time":765.7127569999993,"oracles":{"loadCapsule":{"times":[12.98355199999969]},"notifyCreatedNullifier":{"times":[30.840774000000238]},"debugLog":{"times":[0.9219590000011522]},"notifyCreatedContractClassLog":{"times":[5.077146999999968]}}},{"functionName":"private_kernel_inner","time":152.37149300000056},{"functionName":"SchnorrAccount:constructor","time":379.89034100000026,"oracles":{"getContractInstance":{"times":[3.052483999999822]},"debugLog":{"times":[0.21683699999994133,0.1296940000011091]},"fetchTaggedLogs":{"times":[92.73454799999854]},"loadCapsule":{"times":[0.6055580000011105,0.5043060000007245,0.29344900000069174]},"validateEnqueuedNotesAndEvents":{"times":[6.931713999998465]},"notifyCreatedNullifier":{"times":[0.3342300000003888,0.19833700000162935]},"notifyCreatedNote":{"times":[0.5165560000004916]},"getRandomField":{"times":[0.3980329999994865,0.28506800000104704,0.056921999999758555,0.05142200000045705,0.0780720000002475,0.18702500000108557,0.048381000000517815,0.05457200000091689,0.06480200000078185,0.07401200000094832,0.040251999998872634]},"getIndexedTaggingSecretAsSender":{"times":[42.2548769999994]},"incrementAppTaggingSecretIndexAsSender":{"times":[29.31902699999955]}}},{"functionName":"private_kernel_inner","time":114.12176},{"functionName":"SchnorrAccount:entrypoint","time":215.9103180000002,"oracles":{"debugLog":{"times":[0.3108799999990879,0.19303600000057486,0.576097999999547]},"fetchTaggedLogs":{"times":[56.493366999999125]},"loadCapsule":{"times":[0.28717800000049465,0.2387669999989157,0.20100600000114355]},"validateEnqueuedNotesAndEvents":{"times":[7.2727150000009715]},"getNotes":{"times":[2.366453000000547]},"getAuthWitness":{"times":[0.4173129999999219]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.2435679999998683]}}},{"functionName":"private_kernel_inner","time":126.75746099999924},{"functionName":"private_kernel_reset","time":170.37746100000004},{"functionName":"private_kernel_tail","time":64.60637900000074}],"unaccounted":401.6471130000009}}
14:50:52
aztec-1 | [14:50:52.173]
INFO:
node Received tx 0x0247d5562cd108402e3f8c9c5d749679dacecbb4cf4eeeb936845a7a39712fc6
{"txHash":"0x0247d5562cd108402e3f8c9c5d749679dacecbb4cf4eeeb936845a7a39712fc6"}
14:50:52
aztec-1 | [14:50:52.174]
INFO:
pxe:service Sent transaction 0x0247d5562cd108402e3f8c9c5d749679dacecbb4cf4eeeb936845a7a39712fc6
14:50:52
aztec-1 | [14:50:52.283]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04355568700000004s
{"duration":0.04355568700000004,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
14:50:52
aztec-1 | [14:50:52.315]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2246f07855dfd538a5c31381830eaaa6778977bf6c5e3e43e707a7a1220fb471","globalVariables":{"chainId":31337,"version":891987980,"blockNumber":1,"slotNumber":2,"timestamp":1749653740,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x0247d5562cd108402e3f8c9c5d749679dacecbb4cf4eeeb936845a7a39712fc6"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":90.15352799999891,"publicProcessDuration":44.282680000000255,"rollupCircuitsDuration":80.25736300000062,"txCount":1,"blockNumber":1,"blockTimestamp":1749653740,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
14:50:55
aztec-1 | [14:50:54.725]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
14:50:55
aztec-1 | [14:50:54.728]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
14:50:55
aztec-1 | [14:50:54.732]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
14:50:55
aztec-1 | [14:50:54.804]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
14:50:55
aztec-1 | error: "Rollup__SlotAlreadyInChain(2, 2)"
14:50:55
aztec-1 | [14:50:54.804]
WARN:
sequencer Cannot propose block 1 at slot 2 due to failed rollup contract check
14:50:55
aztec-1 | [14:50:54.828]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x2246f07855dfd538a5c31381830eaaa6778977bf6c5e3e43e707a7a1220fb471","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":891987980,"blockNumber":1,"slotNumber":2,"timestamp":1749653740,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2d9a80346ceafc7dc0d7461314f1b3fc229717f961904d3b5823282eee807780","archiveNextLeafIndex":2}
14:50:55
aztec-1 | [14:50:54.835]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
14:50:55
aztec-1 | [14:50:54.917]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":60.78470000000016,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749653740,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
14:50:55
aztec-1 | [14:50:54.926]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
14:50:55
aztec-1 | [14:50:54.927]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:55:40.000Z
{"offset":285074,"timeMs":1749653740000}
14:50:55
aztec-1 | [14:50:54.963]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749653776
14:50:55
aztec-1 | [14:50:54.963]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:56:16.000Z
{"offset":321037,"timeMs":1749653776000}
14:50:55
aztec-1 | [14:50:54.963]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
14:50:55
aztec-1 | [14:50:54.981]
INFO:
pxe:service Registered account 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741
14:50:55
aztec-1 | [14:50:55.124]
INFO:
pxe:service Added contract SchnorrAccount at 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741 with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f
14:50:57
aztec-1 | [14:50:56.664]
INFO:
pxe:service Proving completed in 1505.1521209999992ms
{"timings":{"total":1505.1521209999992,"sync":46.07347599999957,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":89.48493499999677,"oracles":{"callPrivateFunction":{"times":[367.2926719999996,260.63090199999897]}}},{"functionName":"private_kernel_init","time":60.2634939999989},{"functionName":"SchnorrAccount:constructor","time":336.6611750000011,"oracles":{"getContractInstance":{"times":[6.3317950000000565]},"debugLog":{"times":[0.2033259999989241,0.14959499999895343]},"fetchTaggedLogs":{"times":[94.60637700000007]},"loadCapsule":{"times":[0.2333070000004227,0.27623900000071444,0.21748699999989185]},"validateEnqueuedNotesAndEvents":{"times":[16.851900999999998]},"notifyCreatedNullifier":{"times":[0.3425009999991744,0.29375900000013644]},"notifyCreatedNote":{"times":[0.12424399999872549]},"getRandomField":{"times":[0.28591899999992165,0.31996000000071945,0.15116499999930966,0.10426300000108313,0.10507300000062969,0.11463399999956891,0.08833299999969313,0.07811299999957555,0.1354750000009517,0.09656299999915063,0.0608620000002702]},"getIndexedTaggingSecretAsSender":{"times":[49.73022900000069]},"incrementAppTaggingSecretIndexAsSender":{"times":[29.83254300000044]}}},{"functionName":"private_kernel_inner","time":99.2011480000001},{"functionName":"SchnorrAccount:entrypoint","time":235.0356810000012,"oracles":{"debugLog":{"times":[0.3060399999994843,0.128233999999793,0.26033800000004703]},"fetchTaggedLogs":{"times":[90.70372599999973]},"loadCapsule":{"times":[0.20248700000047393,0.17793600000004517,0.15049499999986438]},"validateEnqueuedNotesAndEvents":{"times":[5.353934999999183]},"getNotes":{"times":[3.224518999999418]},"getAuthWitness":{"times":[0.2266570000010688]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6900610000011511]}}},{"functionName":"private_kernel_inner","time":92.97739600000023},{"functionName":"private_kernel_reset","time":185.42065600000024},{"functionName":"private_kernel_tail","time":82.70218899999963}],"unaccounted":277.33197100000143}}
14:50:57
aztec-1 | [14:50:56.726]
INFO:
node Received tx 0x1a3120b4a63aed8afe740005a5620a9ee2a472a978700dd86d64755bc567579a
{"txHash":"0x1a3120b4a63aed8afe740005a5620a9ee2a472a978700dd86d64755bc567579a"}
14:50:57
aztec-1 | [14:50:56.726]
INFO:
pxe:service Sent transaction 0x1a3120b4a63aed8afe740005a5620a9ee2a472a978700dd86d64755bc567579a
14:50:57
aztec-1 | [14:50:56.825]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.019626186999999844s
{"duration":0.019626186999999844,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
14:50:57
aztec-1 | [14:50:56.845]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2fa3c220f8a4eddad647094cb92d7250c9e686daff2bb89deadaa856de43a09b","globalVariables":{"chainId":31337,"version":891987980,"blockNumber":2,"slotNumber":3,"timestamp":1749653776,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x1a3120b4a63aed8afe740005a5620a9ee2a472a978700dd86d64755bc567579a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":46.648402999999234,"publicProcessDuration":19.761771000001318,"rollupCircuitsDuration":41.33345899999949,"txCount":1,"blockNumber":2,"blockTimestamp":1749653776,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
14:50:57
aztec-1 | [14:50:57.017]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
14:50:57
aztec-1 | [14:50:57.024]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749653812
14:50:57
aztec-1 | [14:50:57.024]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:56:52.000Z
{"offset":354976,"timeMs":1749653812000}
14:50:57
aztec-1 | [14:50:57.024]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
14:50:57
aztec-1 | [14:50:57.032]
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":"0x2d9a80346ceafc7dc0d7461314f1b3fc229717f961904d3b5823282eee807780","blocksSynchedTo":25,"currentL1BlockNumber":26,"provenBlockNumber":1,"provenArchive":"0x2d9a80346ceafc7dc0d7461314f1b3fc229717f961904d3b5823282eee807780","pendingBlockNumber":2,"pendingArchive":"0x1da771aee991de2948a20d6b75ac9307cde8a0dfaca7ff9325f42393c30bcf0e"}
14:50:57
aztec-1 | [14:50:57.099]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
14:50:57
aztec-1 | [14:50:57.101]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
14:50:57
aztec-1 | [14:50:57.150]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2fa3c220f8a4eddad647094cb92d7250c9e686daff2bb89deadaa856de43a09b","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":891987980,"blockNumber":2,"slotNumber":3,"timestamp":1749653776,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x1da771aee991de2948a20d6b75ac9307cde8a0dfaca7ff9325f42393c30bcf0e","archiveNextLeafIndex":3}
14:50:57
aztec-1 | [14:50:57.153]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
14:50:57
aztec-1 | [14:50:57.176]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":14.480168000000049,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749653776,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
14:50:57
aztec-1 | [14:50:57.302]
INFO:
pxe:service Registered account 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923
14:50:57
aztec-1 | [14:50:57.411]
INFO:
pxe:service Added contract SchnorrAccount at 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923 with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f
14:50:59
aztec-1 | [14:50:59.117]
INFO:
pxe:service Proving completed in 1698.4127689999987ms
{"timings":{"total":1698.4127689999987,"sync":17.392417999999452,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":105.3422890000038,"oracles":{"callPrivateFunction":{"times":[446.4062990000002,322.1041430000005]}}},{"functionName":"private_kernel_init","time":69.70530599999984},{"functionName":"SchnorrAccount:constructor","time":422.2753829999965,"oracles":{"getContractInstance":{"times":[5.522980000001553]},"debugLog":{"times":[0.22959700000137673,0.10485399999743095]},"fetchTaggedLogs":{"times":[128.90103799999997]},"loadCapsule":{"times":[0.21594700000059674,0.18274599999858765,0.19690600000103586]},"validateEnqueuedNotesAndEvents":{"times":[6.36617699999988]},"notifyCreatedNullifier":{"times":[0.4617440000001807,0.3684820000016771]},"notifyCreatedNote":{"times":[0.2560279999997874]},"getRandomField":{"times":[0.2700180000028922,0.2779679999985092,0.14286400000128197,0.11718399999881512,0.09980300000097486,0.07992300000114483,0.06272200000239536,0.07263199999943026,0.06419199999800185,0.11413399999946705,0.08223200000065845]},"getIndexedTaggingSecretAsSender":{"times":[71.20222300000023]},"incrementAppTaggingSecretIndexAsSender":{"times":[37.11558799999693]}}},{"functionName":"private_kernel_inner","time":143.66270399999848},{"functionName":"SchnorrAccount:entrypoint","time":289.8050750000002,"oracles":{"debugLog":{"times":[0.4375340000005963,0.09174200000052224,0.189806000002136]},"fetchTaggedLogs":{"times":[119.71439299999838]},"loadCapsule":{"times":[0.19492600000012317,0.29973900000186404,0.39741200000207755]},"validateEnqueuedNotesAndEvents":{"times":[6.926034000000072]},"getNotes":{"times":[1.6881719999983034]},"getAuthWitness":{"times":[0.25280800000109593]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6179490000031365]}}},{"functionName":"private_kernel_inner","time":129.65618099999847},{"functionName":"private_kernel_reset","time":145.5553319999999},{"functionName":"private_kernel_tail","time":91.3716459999996}],"unaccounted":283.6464350000024}}
14:50:59
aztec-1 | [14:50:59.200]
INFO:
node Received tx 0x202d2b852ce0f77267953451bc048da029506e2f15f8a68ea87745cb1f4f0883
{"txHash":"0x202d2b852ce0f77267953451bc048da029506e2f15f8a68ea87745cb1f4f0883"}
14:50:59
aztec-1 | [14:50:59.200]
INFO:
pxe:service Sent transaction 0x202d2b852ce0f77267953451bc048da029506e2f15f8a68ea87745cb1f4f0883
14:50:59
aztec-1 | [14:50:59.286]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01905385000000024s
{"duration":0.01905385000000024,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
14:50:59
aztec-1 | [14:50:59.306]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x1c363c66f2edd347ed2201f7909819b25d22a0e42d09d42e09c4ea9782e51ca4","globalVariables":{"chainId":31337,"version":891987980,"blockNumber":3,"slotNumber":4,"timestamp":1749653812,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x202d2b852ce0f77267953451bc048da029506e2f15f8a68ea87745cb1f4f0883"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":46.60595200000171,"publicProcessDuration":19.28344599999764,"rollupCircuitsDuration":40.86166400000002,"txCount":1,"blockNumber":3,"blockTimestamp":1749653812,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
14:50:59
aztec-1 | [14:50:59.526]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
14:50:59
aztec-1 | [14:50:59.531]
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":"0x1da771aee991de2948a20d6b75ac9307cde8a0dfaca7ff9325f42393c30bcf0e","blocksSynchedTo":27,"currentL1BlockNumber":28,"provenBlockNumber":2,"provenArchive":"0x1da771aee991de2948a20d6b75ac9307cde8a0dfaca7ff9325f42393c30bcf0e","pendingBlockNumber":3,"pendingArchive":"0x04f1d82f62cb430771263f746cd6d5b3592935e7c52d897844e73253ef1d332f"}
14:50:59
aztec-1 | [14:50:59.562]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
14:50:59
aztec-1 | [14:50:59.562]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:57:04.000Z
{"offset":364438,"timeMs":1749653824000}
14:50:59
aztec-1 | [14:50:59.568]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
14:50:59
aztec-1 | [14:50:59.569]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
14:50:59
aztec-1 | [14:50:59.588]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
14:50:59
aztec-1 | error: "Rollup__SlotAlreadyInChain(4, 4)"
14:50:59
aztec-1 | [14:50:59.588]
WARN:
sequencer Cannot propose block 3 at slot 4 due to failed rollup contract check
14:50:59
aztec-1 | [14:50:59.601]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749653848
14:50:59
aztec-1 | [14:50:59.601]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:57:28.000Z
{"offset":388399,"timeMs":1749653848000}
14:50:59
aztec-1 | [14:50:59.601]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
14:50:59
aztec-1 | [14:50:59.628]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x1c363c66f2edd347ed2201f7909819b25d22a0e42d09d42e09c4ea9782e51ca4","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":891987980,"blockNumber":3,"slotNumber":4,"timestamp":1749653812,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x04f1d82f62cb430771263f746cd6d5b3592935e7c52d897844e73253ef1d332f","archiveNextLeafIndex":4}
14:50:59
aztec-1 | [14:50:59.631]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
14:50:59
aztec-1 | [14:50:59.693]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":17.87481299999854,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749653812,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
14:50:59
aztec-1 | Initial Accounts:
14:50:59
aztec-1 |
14:50:59
aztec-1 | Address: 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef
14:50:59
aztec-1 | Partial Address: 0x25cdbb7a5be4a2b0e9adb1e87d0b5f372a1fa87051c9bcfee1d2c12805bf4aac
14:50:59
aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
14:50:59
aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
14:50:59
aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
14:50:59
aztec-1 |
14:50:59
aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
14:50:59
aztec-1 |
14:50:59
aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
14:50:59
aztec-1 |
14:50:59
aztec-1 | Address: 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741
14:50:59
aztec-1 | Partial Address: 0x0c7f265c4adbd783aa791ae3f6859e620def9316c9013a9a72c68d3df8514776
14:50:59
aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
14:50:59
aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
14:50:59
aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
14:50:59
aztec-1 |
14:50:59
aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
14:50:59
aztec-1 |
14:50:59
aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
14:50:59
aztec-1 |
14:50:59
aztec-1 | Address: 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923
14:50:59
aztec-1 | Partial Address: 0x26ee9b51c1ec4a4c6810ea237b0a33367ab5d0c7fd08e07761ac9c429a28ef0a
14:50:59
aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
14:50:59
aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
14:50:59
aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
14:50:59
aztec-1 |
14:50:59
aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
14:50:59
aztec-1 |
14:50:59
aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
14:50:59
aztec-1 |
14:50:59
aztec-1 |
14:51:00
aztec-1 | [14:51:00.533]
WARN:
pxe:service No artifact found for contract class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3 when looking for its metadata
14:51:00
aztec-1 | [14:51:00.533]
WARN:
pxe:service No artifact found for contract class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249 when looking for its metadata
14:51:00
aztec-1 | [14:51:00.536]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3 as part of deployment for 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae
14:51:00
aztec-1 | [14:51:00.559]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249 as part of deployment for 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7
14:51:01
aztec-1 | [14:51:01.286]
INFO:
pxe:service Added contract FPC at 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae with class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3
14:51:01
aztec-1 | [14:51:01.290]
INFO:
pxe:service Added contract Token at 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 with class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249
14:51:04
aztec-1 | [14:51:03.830]
INFO:
pxe:service Proving completed in 2453.8124300000018ms
{"timings":{"total":2453.8124300000018,"sync":27.68848699999944,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":389.1447830000034,"oracles":{"debugLog":{"times":[0.24119699999937438,0.10968299999876763,0.13973400000031688,0.27119800000218675,0.14904399999795714,0.10914300000149524,0.10217299999931129,0.2960689999999886]},"fetchTaggedLogs":{"times":[127.19182200000068]},"loadCapsule":{"times":[0.2559679999976652,0.4957350000004226,0.3434010000019043,0.31223900000259164,0.2752580000014859,0.2815580000024056,0.16741499999989173]},"getSharedSecret":{"times":[6.807934000000387]},"aes128Decrypt":{"times":[1.266938000000664,0.9990499999985332]},"getPublicKeysAndPartialAddress":{"times":[2.3719310000014957]},"getKeyValidationRequest":{"times":[2.8426650000001246]},"storeCapsule":{"times":[2.777712999999494,2.7175910000005388,2.5197559999978694]},"deleteCapsule":{"times":[2.818054999999731]},"validateEnqueuedNotesAndEvents":{"times":[28.633256000000983]},"getNotes":{"times":[9.306828000000678]},"getAuthWitness":{"times":[0.24686800000199582]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05846200000087265]},"callPrivateFunction":{"times":[928.3638619999983,151.16062800000145]},"notifyEnqueuedPublicFunctionCall":{"times":[0.4132920000010927]}}},{"functionName":"private_kernel_init","time":80.77629400000296},{"functionName":"ContractClassRegisterer:register","time":913.0166719999943,"oracles":{"loadCapsule":{"times":[3.413172000000486]},"notifyCreatedNullifier":{"times":[0.44057299999985844]},"debugLog":{"times":[0.15839400000186288]},"notifyCreatedContractClassLog":{"times":[6.111283000002004]}}},{"functionName":"private_kernel_inner","time":109.19446500000049},{"functionName":"ContractInstanceDeployer:deploy","time":90.24143799999729,"oracles":{"storeInExecutionCache":{"times":[0.33317000000170083]},"callPrivateFunction":{"times":[61.0277840000017]},"notifyCreatedNullifier":{"times":[0.30286899999919115]},"debugLog":{"times":[0.1622049999969022]}}},{"functionName":"private_kernel_inner","time":92.15280500000154},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":46.99873400000433,"oracles":{}},{"functionName":"private_kernel_inner","time":91.74933199999941},{"functionName":"private_kernel_reset","time":155.70673399999941},{"functionName":"private_kernel_tail","time":72.56084900000133}],"unaccounted":384.5818369999979}}
14:51:04
aztec-1 | [14:51:03.958]
INFO:
node Received tx 0x1cd8925e1291a5b13e536fea81d534070fe8c9c973a36cc39fed0586afbfb824
{"txHash":"0x1cd8925e1291a5b13e536fea81d534070fe8c9c973a36cc39fed0586afbfb824"}
14:51:04
aztec-1 | [14:51:03.958]
INFO:
pxe:service Sent transaction 0x1cd8925e1291a5b13e536fea81d534070fe8c9c973a36cc39fed0586afbfb824
14:51:05
aztec-1 | [14:51:05.753]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.6237007059999997s
{"duration":1.6237007059999997,"rate":21866.0987636474,"totalPublicGas":{"daGas":4096,"l2Gas":35504},"totalBlockGas":{"daGas":166912,"l2Gas":60546},"totalSizeInBytes":10688}
14:51:06
aztec-1 | [14:51:05.972]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 19063.068523507773 mana/s
{"blockHash":"0x13cbe404dc19257a3fe2d11c3b515d5e713a0fb5ec34d5ef71198e3226d537f8","globalVariables":{"chainId":31337,"version":891987980,"blockNumber":4,"slotNumber":5,"timestamp":1749653848,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36260},"txHashes":["0x1cd8925e1291a5b13e536fea81d534070fe8c9c973a36cc39fed0586afbfb824"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1862.3496090000008,"publicProcessDuration":1623.9444429999967,"rollupCircuitsDuration":1853.638767999997,"txCount":1,"blockNumber":4,"blockTimestamp":1749653848,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
14:51:07
aztec-1 | [14:51:06.650]
INFO:
pxe:service Proving completed in 2818.765360999998ms
{"timings":{"total":2818.765360999998,"sync":92.50381500000003,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":462.92880799999693,"oracles":{"debugLog":{"times":[0.20094600000084029,0.09492300000056275,0.07436199999938253,0.2070160000002943,0.09029300000111107,0.08047200000146404,0.0688719999998284,0.15206400000170106]},"fetchTaggedLogs":{"times":[212.12924099999873]},"loadCapsule":{"times":[1.0598209999989194,0.3874610000020766,0.517984999998589,0.2785680000015418,0.2531569999991916,0.19401600000128383,0.13561400000253343]},"getSharedSecret":{"times":[12.056219999998575]},"aes128Decrypt":{"times":[0.319749000002048,0.7113209999988612]},"getPublicKeysAndPartialAddress":{"times":[3.31749900000068]},"getKeyValidationRequest":{"times":[2.1593749999992724]},"storeCapsule":{"times":[2.4848349999992934,18.961606999997457,2.5130950000020675]},"deleteCapsule":{"times":[2.876775999997335]},"validateEnqueuedNotesAndEvents":{"times":[19.516434000001027]},"getNotes":{"times":[5.810143999999127]},"getAuthWitness":{"times":[0.1802349999998114]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06164199999693665]},"callPrivateFunction":{"times":[724.2194779999991,138.09376899999916]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06043200000203797]}}},{"functionName":"private_kernel_init","time":83.32121100000222},{"functionName":"ContractClassRegisterer:register","time":710.5548699999999,"oracles":{"loadCapsule":{"times":[3.7462419999974372]},"notifyCreatedNullifier":{"times":[1.060710999998264]},"debugLog":{"times":[0.15955500000200118]},"notifyCreatedContractClassLog":{"times":[5.4687639999974635]}}},{"functionName":"private_kernel_inner","time":159.82202400000097},{"functionName":"ContractInstanceDeployer:deploy","time":88.81634400000257,"oracles":{"storeInExecutionCache":{"times":[0.0926130000007106]},"callPrivateFunction":{"times":[37.47379000000001]},"notifyCreatedNullifier":{"times":[0.21014700000159792]},"debugLog":{"times":[0.16569499999968684]}}},{"functionName":"private_kernel_inner","time":149.23548700000174},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":27.89098400000148,"oracles":{}},{"functionName":"private_kernel_inner","time":158.90854399999807},{"functionName":"private_kernel_reset","time":255.39274899999873},{"functionName":"private_kernel_tail","time":117.57445299999745}],"unaccounted":511.8160719999978}}
14:51:07
aztec-1 | [14:51:06.963]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
14:51:07
aztec-1 | [14:51:06.964]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:57:40.000Z
{"offset":393036,"timeMs":1749653860000}
14:51:07
aztec-1 | [14:51:06.966]
INFO:
node Received tx 0x005d762a761ef8dc6bd80e2ddd4bfe719682a42331c49dae72ea2d6217b9d0b9
{"txHash":"0x005d762a761ef8dc6bd80e2ddd4bfe719682a42331c49dae72ea2d6217b9d0b9"}
14:51:07
aztec-1 | [14:51:06.966]
INFO:
pxe:service Sent transaction 0x005d762a761ef8dc6bd80e2ddd4bfe719682a42331c49dae72ea2d6217b9d0b9
14:51:07
aztec-1 | [14:51:06.972]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
14:51:07
aztec-1 | [14:51:06.975]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
14:51:07
aztec-1 | [14:51:06.977]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
14:51:07
aztec-1 | [14:51:07.015]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749653884
14:51:07
aztec-1 | [14:51:07.015]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:58:04.000Z
{"offset":416985,"timeMs":1749653884000}
14:51:07
aztec-1 | [14:51:07.015]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
14:51:07
aztec-1 | [14:51:07.117]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x13cbe404dc19257a3fe2d11c3b515d5e713a0fb5ec34d5ef71198e3226d537f8","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":891987980,"blockNumber":4,"slotNumber":5,"timestamp":1749653848,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36260},"archiveRoot":"0x1b3895786cb84296800c6138b7fef0972b4cc3f18f392b1c6ff748ee635b3075","archiveNextLeafIndex":5}
14:51:07
aztec-1 | [14:51:07.124]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
14:51:07
aztec-1 | [14:51:07.148]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":16.438459000000876,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749653848,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296}
14:51:07
aztec-1 | [14:51:07.619]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.36568986600000064s
{"duration":0.36568986600000064,"rate":755418.8006949023,"totalPublicGas":{"daGas":10240,"l2Gas":276249},"totalBlockGas":{"daGas":380928,"l2Gas":301291},"totalSizeInBytes":24064}
14:51:07
aztec-1 | [14:51:07.667]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 657231.3627621122 mana/s
{"blockHash":"0x1ea7a0873c023a209a36645dce8a652e146d5c35410bbfde75d1090924568aea","globalVariables":{"chainId":31337,"version":891987980,"blockNumber":5,"slotNumber":6,"timestamp":1749653884,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36260},"txHashes":["0x005d762a761ef8dc6bd80e2ddd4bfe719682a42331c49dae72ea2d6217b9d0b9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":420.2905119999996,"publicProcessDuration":365.96197400000165,"rollupCircuitsDuration":415.78907799999797,"txCount":1,"blockNumber":5,"blockTimestamp":1749653884,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
14:51:07
aztec-1 | [14:51:07.782]
INFO:
aztecjs:deploy_sent_tx Contract 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae successfully deployed.
14:51:07
aztec-1 | [14:51:07.922]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
14:51:07
aztec-1 | [14:51:07.938]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749653920
14:51:07
aztec-1 | [14:51:07.938]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:58:40.000Z
{"offset":452062,"timeMs":1749653920000}
14:51:07
aztec-1 | [14:51:07.938]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
14:51:08
aztec-1 | [14:51:08.002]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
14:51:08
aztec-1 | [14:51:08.004]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
14:51:08
aztec-1 | [14:51:08.141]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x1ea7a0873c023a209a36645dce8a652e146d5c35410bbfde75d1090924568aea","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":891987980,"blockNumber":5,"slotNumber":6,"timestamp":1749653884,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36260},"archiveRoot":"0x295e85363ac2b474fdb281449a3d82cc67dc0284888a9367a0267d0f8bcf8aec","archiveNextLeafIndex":6}
14:51:08
aztec-1 | [14:51:08.149]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
14:51:08
aztec-1 | [14:51:08.209]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":18.47768999999971,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749653884,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
14:51:09
aztec-1 | BananaCoin: 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7
14:51:09
aztec-1 | FPC: 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae
14:51:09
aztec-1 | [14:51:09.209]
INFO:
aztecjs:deploy_sent_tx Contract 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 successfully deployed.
14:51:09
aztec-1 | [14:51:09.228]
WARN:
pxe:service No artifact found for contract class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523 when looking for its metadata
14:51:09
aztec-1 | [14:51:09.232]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523 as part of deployment for 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc
14:51:09
aztec-1 | [14:51:09.352]
INFO:
pxe:service Added contract SponsoredFPC at 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc with class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523
14:51:12
aztec-1 | [14:51:11.418]
INFO:
pxe:service Proving completed in 2057.8310399999973ms
{"timings":{"total":2057.8310399999973,"sync":44.99426999999923,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":69.32487499999479,"oracles":{"callPrivateFunction":{"times":[682.9097959999999,107.84602299999824,45.589767999998]}}},{"functionName":"private_kernel_init","time":60.83841200000097},{"functionName":"ContractClassRegisterer:register","time":660.5251500000049,"oracles":{"loadCapsule":{"times":[1.749232000001939]},"notifyCreatedNullifier":{"times":[0.35606100000222796]},"debugLog":{"times":[0.15921499999967637]},"notifyCreatedContractClassLog":{"times":[5.376220000001922]}}},{"functionName":"private_kernel_inner","time":93.39199200000076},{"functionName":"ContractInstanceDeployer:deploy","time":69.46680800000104,"oracles":{"storeInExecutionCache":{"times":[0.08400299999993877]},"callPrivateFunction":{"times":[43.724952999997186]},"notifyCreatedNullifier":{"times":[0.19441599999845494]},"debugLog":{"times":[0.10452300000179093]}}},{"functionName":"private_kernel_inner","time":98.82384499999898},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":29.568662000001495,"oracles":{}},{"functionName":"private_kernel_inner","time":112.68475699999908},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":39.33137199999692,"oracles":{"debugLog":{"times":[0.11621300000115298]}}},{"functionName":"private_kernel_inner","time":126.490769},{"functionName":"private_kernel_reset","time":243.13230300000214},{"functionName":"private_kernel_tail","time":95.25794800000222}],"unaccounted":313.99987699999474}}
14:51:12
aztec-1 | [14:51:11.564]
INFO:
node Received tx 0x02279868596c852b7ac6e552967233e96eaef93defe09530ecdd95fc29047926
{"txHash":"0x02279868596c852b7ac6e552967233e96eaef93defe09530ecdd95fc29047926"}
14:51:12
aztec-1 | [14:51:11.564]
INFO:
pxe:service Sent transaction 0x02279868596c852b7ac6e552967233e96eaef93defe09530ecdd95fc29047926
14:51:12
aztec-1 | [14:51:11.697]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.0447675040000031s
{"duration":0.0447675040000031,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
14:51:12
aztec-1 | [14:51:11.730]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x22e91c7b716a1ffde698ce66bd9bf49d559e7aa342fbba0114f0e218b28a4e4d","globalVariables":{"chainId":31337,"version":891987980,"blockNumber":6,"slotNumber":7,"timestamp":1749653920,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36260},"txHashes":["0x02279868596c852b7ac6e552967233e96eaef93defe09530ecdd95fc29047926"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":91.66178100000252,"publicProcessDuration":44.92936899999768,"rollupCircuitsDuration":81.96525199999815,"txCount":1,"blockNumber":6,"blockTimestamp":1749653920,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
14:51:12
aztec-1 | [14:51:11.904]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
14:51:12
aztec-1 | [14:51:11.906]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
14:51:12
aztec-1 | [14:51:11.907]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
14:51:12
aztec-1 | [14:51:11.915]
WARN:
archiver Failed to reach L2 block 6 at 34 (latest is 5). Rolling back last synched L1 block number to 33.
{"latestLocalL2BlockNumber":5,"latestLocalL2BlockArchive":"0x295e85363ac2b474fdb281449a3d82cc67dc0284888a9367a0267d0f8bcf8aec","blocksSynchedTo":33,"currentL1BlockNumber":34,"provenBlockNumber":5,"provenArchive":"0x295e85363ac2b474fdb281449a3d82cc67dc0284888a9367a0267d0f8bcf8aec","pendingBlockNumber":6,"pendingArchive":"0x22d6f6b02afa31f923b05cdbd85f2cf54762f776dc37a31aa74e026822816163"}
14:51:12
aztec-1 | [14:51:11.983]
WARN:
sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain
14:51:12
aztec-1 | error: "Rollup__SlotAlreadyInChain(7, 7)"
14:51:12
aztec-1 | [14:51:11.983]
WARN:
sequencer Cannot propose block 6 at slot 7 due to failed rollup contract check
14:51:12
aztec-1 | [14:51:11.986]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749653956
14:51:12
aztec-1 | [14:51:11.986]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:59:16.000Z
{"offset":484014,"timeMs":1749653956000}
14:51:12
aztec-1 | [14:51:11.986]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
14:51:12
aztec-1 | [14:51:12.032]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x22e91c7b716a1ffde698ce66bd9bf49d559e7aa342fbba0114f0e218b28a4e4d","blockNumber":6,"txCount":1,"globalVariables":{"chainId":31337,"version":891987980,"blockNumber":6,"slotNumber":7,"timestamp":1749653920,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":36260},"archiveRoot":"0x22d6f6b02afa31f923b05cdbd85f2cf54762f776dc37a31aa74e026822816163","archiveNextLeafIndex":7}
14:51:12
aztec-1 | [14:51:12.040]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
14:51:12
aztec-1 | [14:51:12.066]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":17.14230099999986,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749653920,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
14:51:12
aztec-1 | SponsoredFPC: 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc
14:51:12
aztec-1 | [14:51:12.579]
INFO:
aztecjs:deploy_sent_tx Contract 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc successfully deployed.
14:51:12
aztec-1 | [14:51:12.586]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x0d732603a57e7c34762722fdbadcd665ba1dc2a114f202c94ef6020b4353efe0","l2ProtocolContractsTreeRoot":"0x052cc6e2bd1171363e72fb45b9a78fb0ebacedb96c8f1148b3903c3bafa8c458"}
14:51:22
box-1 | \
14:51:22
box-1 | Running 1
test using 1
worker
14:51:22
box-1 |
14:51:22
box-1 | 1 [webkit] › browser.spec.ts:3:1 › test
14:51:48
aztec-1 | [14:51:48.142]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
14:51:48
aztec-1 | [14:51:48.145]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749653993
14:51:48
aztec-1 | [14:51:48.348]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
14:51:48
aztec-1 | [14:51:48.348]
WARN:
foundation:test-date-provider Time set to 2025-06-11T14:59:53.000Z
{"offset":484652,"timeMs":1749653993000}
14:52:23
aztec-1 | [14:52:23.457]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749654028
14:52:23
aztec-1 | [14:52:23.457]
WARN:
foundation:test-date-provider Time set to 2025-06-11T15:00:28.000Z
{"offset":484543,"timeMs":1749654028000}
14:52:23
aztec-1 | [14:52:23.457]
INFO:
aztecjs:utils:watcher Slot 9 was missed, jumped to next slot
14:52:54
✘ 1 [webkit] › browser.spec.ts:3:1 › test (1.5m) 2 [webkit] › browser.spec.ts:3:1 › test (retry #1)
14:52:59
aztec-1 | [14:52:59.476]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
14:52:59
aztec-1 | [14:52:59.480]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749654065
14:52:59
aztec-1 | [14:52:59.683]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
14:52:59
aztec-1 | [14:52:59.683]
WARN:
foundation:test-date-provider Time set to 2025-06-11T15:01:05.000Z
{"offset":485317,"timeMs":1749654065000}
14:53:35
aztec-1 | [14:53:34.711]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749654100
14:53:35
aztec-1 | [14:53:34.711]
WARN:
foundation:test-date-provider Time set to 2025-06-11T15:01:40.000Z
{"offset":485289,"timeMs":1749654100000}
14:53:35
aztec-1 | [14:53:34.711]
INFO:
aztecjs:utils:watcher Slot 11 was missed, jumped to next slot
14:54:11
aztec-1 | [14:54:10.721]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749654136
14:54:11
aztec-1 | [14:54:10.722]
WARN:
foundation:test-date-provider Time set to 2025-06-11T15:02:16.000Z
{"offset":485278,"timeMs":1749654136000}
14:54:11
aztec-1 | [14:54:10.722]
INFO:
aztecjs:utils:watcher Slot 12 was missed, jumped to next slot
14:54:30
✘ 2 [webkit] › browser.spec.ts:3:1 › test (retry #1) (1.6m) 3 [webkit] › browser.spec.ts:3:1 › test (retry #2)
14:54:47
aztec-1 | [14:54:46.833]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
14:54:47
aztec-1 | [14:54:46.838]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749654173
14:54:47
aztec-1 | [14:54:47.040]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
14:54:47
aztec-1 | [14:54:47.040]
WARN:
foundation:test-date-provider Time set to 2025-06-11T15:02:53.000Z
{"offset":485960,"timeMs":1749654173000}
14:55:22
aztec-1 | [14:55:22.087]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749654208
14:55:22
aztec-1 | [14:55:22.087]
WARN:
foundation:test-date-provider Time set to 2025-06-11T15:03:28.000Z
{"offset":485913,"timeMs":1749654208000}
14:55:22
aztec-1 | [14:55:22.087]
INFO:
aztecjs:utils:watcher Slot 14 was missed, jumped to next slot
14:55:58
aztec-1 | [14:55:58.198]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749654244
14:55:58
aztec-1 | [14:55:58.198]
WARN:
foundation:test-date-provider Time set to 2025-06-11T15:04:04.000Z
{"offset":485802,"timeMs":1749654244000}
14:55:58
aztec-1 | [14:55:58.198]
INFO:
aztecjs:utils:watcher Slot 15 was missed, jumped to next slot
14:56:01
✘ 3 [webkit] › browser.spec.ts:3:1 › test (retry #2) (1.5m) 4 [webkit] › browser.spec.ts:3:1 › test (retry #3)
14:56:34
aztec-1 | [14:56:34.231]
WARN:
aztecjs:utils:watcher L1 is more than 1 L2 slot behind wall time. Warping to wall time
14:56:34
aztec-1 | [14:56:34.233]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749654281
14:56:34
aztec-1 | [14:56:34.434]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
14:56:34
aztec-1 | [14:56:34.434]
WARN:
foundation:test-date-provider Time set to 2025-06-11T15:04:41.000Z
{"offset":486566,"timeMs":1749654281000}
14:57:09
aztec-1 | [14:57:09.528]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1749654316
14:57:09
aztec-1 | [14:57:09.528]
WARN:
foundation:test-date-provider Time set to 2025-06-11T15:05:16.000Z
{"offset":486472,"timeMs":1749654316000}
14:57:09
aztec-1 | [14:57:09.528]
INFO:
aztecjs:utils:watcher Slot 17 was missed, jumped to next slot
14:57:32
✘ 4 [webkit] › browser.spec.ts:3:1 › test (retry #3) (1.5m)
14:57:32
box-1 |
14:57:32
box-1 | 1) [webkit] › browser.spec.ts:3:1 › test ─────────────────────────────────────────────────────────
14:57:32
box-1 |
14:57:32
box-1 | Test timeout of 90000ms exceeded.
14:57:32
box-1 |
14:57:32
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
14:57:32
box-1 | Call log:
14:57:32
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
14:57:32
box-1 |
14:57:32
box-1 |
14:57:32
box-1 | 6 |
14:57:32
box-1 | 7 | // Deploy contract
14:57:32
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
14:57:32
box-1 | | ^
14:57:32
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
14:57:32
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
14:57:32
box-1 | 11 |
14:57:32
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
14:57:32
box-1 |
14:57:32
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
14:57:32
box-1 | test-results/browser-test-webkit/test-failed-1.png
14:57:32
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
14:57:32
box-1 |
14:57:32
box-1 | Retry #1 ───────────────────────────────────────────────────────────────────────────────────────
14:57:32
box-1 |
14:57:32
box-1 | Test timeout of 90000ms exceeded.
14:57:32
box-1 |
14:57:32
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
14:57:32
box-1 | Call log:
14:57:32
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
14:57:32
box-1 |
14:57:32
box-1 |
14:57:32
box-1 | 6 |
14:57:32
box-1 | 7 | // Deploy contract
14:57:32
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
14:57:32
box-1 | | ^
14:57:32
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
14:57:32
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
14:57:32
box-1 | 11 |
14:57:32
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
14:57:32
box-1 |
14:57:32
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
14:57:32
box-1 | test-results/browser-test-webkit-retry1/test-failed-1.png
14:57:32
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
14:57:32
box-1 |
14:57:32
box-1 | attachment #2: video (video/webm) ──────────────────────────────────────────────────────────────
14:57:32
box-1 | test-results/browser-test-webkit-retry1/video.webm
14:57:32
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
14:57:32
box-1 |
14:57:32
box-1 | attachment #3: trace (application/zip) ─────────────────────────────────────────────────────────
14:57:32
box-1 | test-results/browser-test-webkit-retry1/trace.zip
14:57:32
box-1 | Usage:
14:57:32
box-1 |
14:57:32
box-1 | yarn playwright show-trace test-results/browser-test-webkit-retry1/trace.zip
14:57:32
box-1 |
14:57:32
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
14:57:32
box-1 |
14:57:32
box-1 | Retry #2 ───────────────────────────────────────────────────────────────────────────────────────
14:57:32
box-1 |
14:57:32
box-1 | Test timeout of 90000ms exceeded.
14:57:32
box-1 |
14:57:32
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
14:57:32
box-1 | Call log:
14:57:32
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
14:57:32
box-1 |
14:57:32
box-1 |
14:57:32
box-1 | 6 |
14:57:32
box-1 | 7 | // Deploy contract
14:57:32
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
14:57:32
box-1 | | ^
14:57:32
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
14:57:32
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
14:57:32
box-1 | 11 |
14:57:32
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
14:57:32
box-1 |
14:57:32
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
14:57:32
box-1 | test-results/browser-test-webkit-retry2/test-failed-1.png
14:57:32
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
14:57:32
box-1 |
14:57:32
box-1 | Retry #3 ───────────────────────────────────────────────────────────────────────────────────────
14:57:32
box-1 |
14:57:32
box-1 | Test timeout of 90000ms exceeded.
14:57:32
box-1 |
14:57:32
box-1 | Error: locator.click: Test timeout of 90000ms exceeded.
14:57:32
box-1 | Call log:
14:57:32
box-1 | - waiting for getByRole('button', { name: 'Deploy dummy contract' })
14:57:32
box-1 |
14:57:32
box-1 |
14:57:32
box-1 | 6 |
14:57:32
box-1 | 7 | // Deploy contract
14:57:32
box-1 | > 8 | await page
.getByRole(
'button', { name
: 'Deploy dummy contract' })
.click()
;
14:57:32
box-1 | | ^
14:57:32
box-1 | 9 | await expect(page
.getByText(
'Deploying contract...'))
.toBeVisible()
;
14:57:32
box-1 | 10 | await expect(page
.getByText(
'Address:'))
.toBeVisible()
;
14:57:32
box-1 | 11 |
14:57:32
box-1 | at /root/aztec-packages/boxes/boxes/vite/tests/browser.spec.ts:8:69
14:57:32
box-1 |
14:57:32
box-1 | attachment #1: screenshot (image/png) ──────────────────────────────────────────────────────────
14:57:32
box-1 | test-results/browser-test-webkit-retry3/test-failed-1.png
14:57:32
box-1 | ────────────────────────────────────────────────────────────────────────────────────────────────
14:57:32
box-1 |
14:57:32
box-1 | 1 failed
14:57:32
box-1 | [webkit] › browser.spec.ts:3:1 › test ──────────────────────────────────────────────────────────
14:57:32
box-1 | \
14:57:32 Aborting on container exit...
14:57:32
box-1 exited with code 1
14:57:32 [?25l[+] Stopping 3/3
14:57:33 ✔ Container vite-webkit-box-1 Stopped0.0s
14:57:33 ✔ Container vite-webkit-aztec-1 Stopped0.9s
14:57:33 ✔ Container vite-webkit-ethereum-1 Stopped0.1s
14:57:33 [?25h