Parent Log:
http://ci.aztec-labs.com/810a77e866dce8f5
Command: 86eb7e6c27a52f1a:ONLY_TERM_PARENT=1 BOX=vite BROWSER=webkit run_compose_test vite-webkit box boxes
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/721a41c449eb0c4538a26180f6061f326128cf78
Env: REF_NAME=gh-readonly-queue/next/pr-14963-60e60f99f2634ad75a76b6e103858ff9ccd041d5 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Mon Jun 16 18:44:53 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14963_amd64_x3-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History: [?25l
[+] Running 4/4
18:44:54
✔ Network vite-webkit_default
Created0.2s
18:44:54
✔ Container vite-webkit-ethereum-1
Created0.2s
18:44:54
✔ Container vite-webkit-aztec-1
Created0.2s
18:44:54
✔ Container vite-webkit-box-1
Created0.7s
18:44:54 [?25hAttaching to aztec-1, box-1, ethereum-1
18:44:59
aztec-1 |
18:44:59
aztec-1 | _
18:44:59
aztec-1 | /\ | |
18:44:59
aztec-1 | / \ ___| |_ ___ ___
18:44:59
aztec-1 | / /\ \ |_ / __/ _ \/ __|
18:44:59
aztec-1 | / ____ \ / /| || __/ (__
18:44:59
aztec-1 | /_/___ \_\/___|\__\___|\___|
18:44:59
aztec-1 |
18:44:59
aztec-1 | https://github.com/AztecProtocol
18:44:59
aztec-1 |
18:44:59
aztec-1 |
18:44:59
aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by...
18:44:59
aztec-1 | Setting up test accounts
18:45:01
aztec-1 | [18:45:00.594]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-ytiiey/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
18:45:01
aztec-1 | [18:45:00.852]
INFO:
sandbox Calling anvil_setBlockTimestampInterval with params: [12]
18:45:01
aztec-1 | [18:45:00.858]
WARN:
sandbox Set block interval to 12
18:45:01
aztec-1 | [18:45:01.061]
INFO:
sandbox Waiting for 7 transactions to be mined...
18:45:01
aztec-1 | [18:45:01.087]
INFO:
sandbox All transactions mined successfully
18:45:01
aztec-1 | [18:45:01.176]
INFO:
sandbox Waiting for 9 transactions to be mined...
18:45:01
aztec-1 | [18:45:01.195]
INFO:
sandbox All transactions mined successfully
18:45:01
aztec-1 | [18:45:01.356]
INFO:
sandbox Waiting for 11 transactions to be mined...
18:45:01
aztec-1 | [18:45:01.382]
INFO:
sandbox All transactions mined successfully
18:45:01
aztec-1 | [18:45:01.468]
INFO:
sandbox Waiting for 12 transactions to be mined...
18:45:01
aztec-1 | [18:45:01.495]
INFO:
sandbox All transactions mined successfully
18:45:01
aztec-1 | [18:45:01.502]
INFO:
sandbox Waiting for 12 transactions to be mined...
18:45:01
aztec-1 | [18:45:01.528]
INFO:
sandbox All transactions mined successfully
18:45:01
aztec-1 | [18:45:01.547]
INFO:
sandbox Aztec L1 contracts initialized
{"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"}
18:45:01
aztec-1 | [18:45:01.548]
INFO:
sandbox Handing over to governance
18:45:01
aztec-1 | [18:45:01.557]
INFO:
aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c
18:45:01
aztec-1 | [18:45:01.558]
INFO:
telemetry:client Using NoopTelemetryClient
18:45:01
aztec-1 | [18:45:01.558]
INFO:
blob-sink:client Creating local blob sink client.
18:45:01
aztec-1 | [18:45:01.563]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
18:45:01
aztec-1 | [18:45:01.563]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:49:43.000Z
{"offset":281437,"timeMs":1750099783000}
18:45:01
aztec-1 | [18:45:01.590]
INFO:
archiver:lmdb Starting data store with maxReaders 16
18:45:02
aztec-1 | [18:45:02.022]
INFO:
archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x185f673cfb09eaa21e59f58b650ec6fde6347eab7174438efea755efbca116a1
{"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x8de62c75239df79713dd8a864ef9434e0a5c02a27575f3720c81847b8bf944b0","l1BlockNumber":20}}
18:45:02
aztec-1 | [18:45:02.046]
INFO:
archiver Initial archiver sync to L1 block 24 complete.
{"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x185f673cfb09eaa21e59f58b650ec6fde6347eab7174438efea755efbca116a1","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
18:45:02
aztec-1 | [18:45:02.055]
INFO:
world-state:database Creating world state data store at directory /tmp/aztec-world-state-SiNDty/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads.
18:45:02
aztec-1 | [18:45:02.303]
INFO:
world_state Created world state synchroniser with block history of 64
18:45:02
aztec-1 | [18:45:02.303]
WARN:
node Aztec node is accepting fake proofs
18:45:02
aztec-1 | [18:45:02.314]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
18:45:02
aztec-1 | [18:45:02.330]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
18:45:02
aztec-1 | [18:45:02.349]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
18:45:02
aztec-1 | [18:45:02.365]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
18:45:02
aztec-1 | [18:45:02.368]
INFO:
world_state Started world state synchronizer from block 1
18:45:02
aztec-1 | [18:45:02.371]
INFO:
p2p Starting p2p client from block 0 with empty mempools
18:45:02
aztec-1 | [18:45:02.618]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
18:45:02
aztec-1 | [18:45:02.659]
INFO:
slasher Starting Slasher client...
18:45:02
aztec-1 | [18:45:02.667]
INFO:
sequencer-client Deploying forwarder contract
18:45:02
aztec-1 | [18:45:02.684]
INFO:
sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac
18:45:02
aztec-1 | [18:45:02.690]
INFO:
validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
18:45:02
aztec-1 | [18:45:02.691]
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}
18:45:02
aztec-1 | [18:45:02.693]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
18:45:02
aztec-1 | [18:45:02.694]
INFO:
node Aztec Node version: 0.87.6
18:45:02
aztec-1 | [18:45:02.694]
INFO:
node Aztec Node started on chain 0x7a69
{"rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","slashFactoryAddress":"0x59b670e9fa9d0a427751af201d676719a970857b","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"}
18:45:02
aztec-1 | [18:45:02.697]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
18:45:02
aztec-1 | [18:45:02.706]
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.
{"now":1750099784,"syncedToL1Ts":1750099783,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750099771,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750099807},"newBlockNumber":1,"expectedSlot":1}
18:45:02
aztec-1 | [18:45:02.779]
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.
{"now":1750099784,"syncedToL1Ts":1750099783,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750099771,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750099807},"newBlockNumber":1,"expectedSlot":1}
18:45:03
aztec-1 | [18:45:02.975]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
18:45:03
aztec-1 | [18:45:02.975]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:49:55.000Z
{"offset":292025,"timeMs":1750099795000}
18:45:03
aztec-1 | [18:45:02.978]
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.
{"now":1750099784,"syncedToL1Ts":1750099783,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750099771,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750099807},"newBlockNumber":1,"expectedSlot":1}
18:45:03
aztec-1 | Setting up funded test accounts...
18:45:03
aztec-1 | [18:45:03.124]
INFO:
pxe:service Started PXE connected to chain 31337 version 3676816240
18:45:03
aztec-1 | [18:45:03.228]
INFO:
pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
18:45:03
aztec-1 | [18:45:03.305]
WARN:
pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata
18:45:03
aztec-1 | [18:45:03.309]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
18:45:03
aztec-1 | [18:45:03.504]
INFO:
pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
18:45:06
aztec-1 | [18:45:06.231]
INFO:
pxe:service Proving completed in 2681.815191999999ms
{"timings":{"total":2681.815191999999,"sync":7.6686149999995905,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":173.65661099999943,"oracles":{"callPrivateFunction":{"times":[843.0719419999996,297.140496,161.20658600000024]}}},{"functionName":"private_kernel_init","time":81.64606599999934},{"functionName":"ContractClassRegisterer:register","time":813.7561369999994,"oracles":{"loadCapsule":{"times":[30.80053500000122]},"notifyCreatedNullifier":{"times":[0.8067019999998593]},"debugLog":{"times":[0.4661420000011276]},"notifyCreatedContractClassLog":{"times":[5.89090700000088]}}},{"functionName":"private_kernel_inner","time":157.07873599999948},{"functionName":"SchnorrAccount:constructor","time":275.04597400000057,"oracles":{"getContractInstance":{"times":[6.824053000000276]},"debugLog":{"times":[0.24588700000094832,0.13182400000005146]},"fetchTaggedLogs":{"times":[57.025486999998975]},"loadCapsule":{"times":[0.3835299999991548,0.2333070000004227,0.23194599999987986]},"validateEnqueuedNotesAndEvents":{"times":[6.03095200000098]},"notifyCreatedNullifier":{"times":[0.21341600000050676,0.23226599999907194]},"notifyCreatedNote":{"times":[0.48158300000068266]},"getRandomField":{"times":[0.24045699999987846,0.18632500000057917,0.10671200000069803,0.07593199999973876,0.18901500000174565,0.06524200000058045,0.044891999999890686,0.04082100000050559,0.042140999999901396,0.061202000000776025,0.03680999999960477]},"getIndexedTaggingSecretAsSender":{"times":[49.44708399999945]},"incrementAppTaggingSecretIndexAsSender":{"times":[21.651319999999032]}}},{"functionName":"private_kernel_inner","time":123.97190899999987},{"functionName":"SchnorrAccount:entrypoint","time":142.84445400000004,"oracles":{"debugLog":{"times":[0.21012599999994563,0.13080400000035297,0.3611089999994874]},"fetchTaggedLogs":{"times":[41.8524010000001]},"loadCapsule":{"times":[0.21970599999986007,0.1690440000002127,0.1805450000010751]},"validateEnqueuedNotesAndEvents":{"times":[7.909662000000026]},"getNotes":{"times":[2.5371279999999388]},"getAuthWitness":{"times":[0.26136700000097335]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.871062999998685]}}},{"functionName":"private_kernel_inner","time":139.9060360000003},{"functionName":"private_kernel_reset","time":167.24111799999991},{"functionName":"private_kernel_tail","time":98.57334900000023}],"unaccounted":500.42618700000094}}
18:45:06
aztec-1 | [18:45:06.363]
INFO:
node Received tx 0x1f84c04b880c28036f80f2899f5e2f34453783fa5e59617e39d4180f27639bc8
{"txHash":"0x1f84c04b880c28036f80f2899f5e2f34453783fa5e59617e39d4180f27639bc8"}
18:45:06
aztec-1 | [18:45:06.363]
INFO:
pxe:service Sent transaction 0x1f84c04b880c28036f80f2899f5e2f34453783fa5e59617e39d4180f27639bc8
18:45:06
aztec-1 | [18:45:06.464]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04771383799999967s
{"duration":0.04771383799999967,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344}
18:45:06
aztec-1 | [18:45:06.496]
INFO:
sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x15750e4656b32bc654b866448a19dee138ba39d6f82bdc5738c3fc7cbb0ccd39","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750099807,"version":3676816240},"txHashes":["0x1f84c04b880c28036f80f2899f5e2f34453783fa5e59617e39d4180f27639bc8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":88.88007000000107,"publicProcessDuration":48.33925400000044,"rollupCircuitsDuration":82.12912900000083,"txCount":1,"blockNumber":1,"blockTimestamp":1750099807,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
18:45:09
aztec-1 | [18:45:09.597]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1
18:45:09
aztec-1 | [18:45:09.600]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:45:09
aztec-1 | [18:45:09.602]
INFO:
aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1.
18:45:09
aztec-1 | [18:45:09.690]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x15750e4656b32bc654b866448a19dee138ba39d6f82bdc5738c3fc7cbb0ccd39","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750099807,"version":3676816240},"archiveRoot":"0x2fd2352b48a02b8105a0b9cf8d3247749ade67acaec20e4539ec16782805619b","archiveNextLeafIndex":2}
18:45:09
aztec-1 | [18:45:09.699]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
18:45:09
aztec-1 | [18:45:09.739]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":17.385284999998476,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750099807,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
18:45:09
aztec-1 | [18:45:09.803]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
18:45:09
aztec-1 | [18:45:09.803]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:50:07.000Z
{"offset":297197,"timeMs":1750099807000}
18:45:09
aztec-1 | [18:45:09.823]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750099843
18:45:09
aztec-1 | [18:45:09.823]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:50:43.000Z
{"offset":333177,"timeMs":1750099843000}
18:45:09
aztec-1 | [18:45:09.823]
INFO:
aztecjs:utils:watcher Slot 2 was filled, jumped to next slot
18:45:09
aztec-1 | [18:45:09.848]
INFO:
pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
18:45:09
aztec-1 | [18:45:09.988]
INFO:
pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
18:45:12
aztec-1 | [18:45:11.559]
INFO:
pxe:service Proving completed in 1546.3437720000002ms
{"timings":{"total":1546.3437720000002,"sync":47.09985199999937,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":123.56685800000196,"oracles":{"callPrivateFunction":{"times":[443.9106649999994,243.8565490000001]}}},{"functionName":"private_kernel_init","time":54.29456300000129},{"functionName":"SchnorrAccount:constructor","time":403.3469589999986,"oracles":{"getContractInstance":{"times":[4.055088000000978]},"debugLog":{"times":[0.22726600000169128,0.07536199999958626]},"fetchTaggedLogs":{"times":[108.97101800000019]},"loadCapsule":{"times":[0.27977800000007846,0.2969180000000051,0.2605069999990519]},"validateEnqueuedNotesAndEvents":{"times":[5.960338999999294]},"notifyCreatedNullifier":{"times":[0.21571600000061153,0.22106499999972584]},"notifyCreatedNote":{"times":[0.10937299999932293]},"getRandomField":{"times":[0.13596400000096764,0.15268400000059046,0.06337100000018836,0.0487410000005184,0.06178099999851838,0.04728199999954086,0.038400999999794294,0.03047100000003411,0.027369999999791617,0.047522000000753906,0.027970999999524793]},"getIndexedTaggingSecretAsSender":{"times":[44.499651999998605]},"incrementAppTaggingSecretIndexAsSender":{"times":[66.03606799999943]}}},{"functionName":"private_kernel_inner","time":95.41260400000101},{"functionName":"SchnorrAccount:entrypoint","time":215.89671100000123,"oracles":{"debugLog":{"times":[0.20643500000005588,0.1772450000007666,0.2171359999993001]},"fetchTaggedLogs":{"times":[78.38270900000134]},"loadCapsule":{"times":[0.23272600000018429,0.1791849999990518,0.16931499999918742]},"validateEnqueuedNotesAndEvents":{"times":[6.081323000000339]},"getNotes":{"times":[6.327839000001404]},"getAuthWitness":{"times":[0.2440970000006928]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6219060000003083]}}},{"functionName":"private_kernel_inner","time":99.48781299999973},{"functionName":"private_kernel_reset","time":145.58276699999988},{"functionName":"private_kernel_tail","time":67.43864500000018}],"unaccounted":294.2169999999969}}
18:45:12
aztec-1 | [18:45:11.619]
INFO:
node Received tx 0x06974b20c48b1bb38f0f9e3b88d82c107052e2c4a9482f32d1c019bc713ab7d4
{"txHash":"0x06974b20c48b1bb38f0f9e3b88d82c107052e2c4a9482f32d1c019bc713ab7d4"}
18:45:12
aztec-1 | [18:45:11.619]
INFO:
pxe:service Sent transaction 0x06974b20c48b1bb38f0f9e3b88d82c107052e2c4a9482f32d1c019bc713ab7d4
18:45:12
aztec-1 | [18:45:11.710]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.017074547000000165s
{"duration":0.017074547000000165,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
18:45:12
aztec-1 | [18:45:11.727]
INFO:
sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x188e1d183c89d76647900b204ad911744e2441addba63a48dfd775c2fbc58e19","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750099843,"version":3676816240},"txHashes":["0x06974b20c48b1bb38f0f9e3b88d82c107052e2c4a9482f32d1c019bc713ab7d4"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":41.81435899999997,"publicProcessDuration":17.177628999999797,"rollupCircuitsDuration":36.139147000001685,"txCount":1,"blockNumber":2,"blockTimestamp":1750099843,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
18:45:12
aztec-1 | [18:45:11.967]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:45:12
aztec-1 | [18:45:11.977]
WARN:
archiver Failed to reach L2 block 2 at 27 (latest is 1). Rolling back last synched L1 block number to 26.
{"latestLocalL2BlockNumber":1,"latestLocalL2BlockArchive":"0x2fd2352b48a02b8105a0b9cf8d3247749ade67acaec20e4539ec16782805619b","blocksSynchedTo":26,"currentL1BlockNumber":27,"provenBlockNumber":1,"provenArchive":"0x2fd2352b48a02b8105a0b9cf8d3247749ade67acaec20e4539ec16782805619b","pendingBlockNumber":2,"pendingArchive":"0x23236368a62c61c07b695645316abc568f55c5d9e7caa3115dcbd4f413b530c0"}
18:45:12
aztec-1 | [18:45:11.989]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
18:45:12
aztec-1 | [18:45:11.989]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:50:55.000Z
{"offset":343011,"timeMs":1750099855000}
18:45:12
aztec-1 | [18:45:11.996]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2
18:45:12
aztec-1 | [18:45:11.998]
INFO:
aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2.
18:45:12
aztec-1 | [18:45:12.019]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750099879
18:45:12
aztec-1 | [18:45:12.019]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:51:19.000Z
{"offset":366981,"timeMs":1750099879000}
18:45:12
aztec-1 | [18:45:12.019]
INFO:
aztecjs:utils:watcher Slot 3 was filled, jumped to next slot
18:45:12
aztec-1 | [18:45:12.074]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x188e1d183c89d76647900b204ad911744e2441addba63a48dfd775c2fbc58e19","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750099843,"version":3676816240},"archiveRoot":"0x23236368a62c61c07b695645316abc568f55c5d9e7caa3115dcbd4f413b530c0","archiveNextLeafIndex":3}
18:45:12
aztec-1 | [18:45:12.082]
INFO:
archiver Updated proven chain to block 2
{"provenBlockNumber":2}
18:45:12
aztec-1 | [18:45:12.141]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":18.270439999998416,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750099843,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
18:45:12
aztec-1 | [18:45:12.276]
INFO:
pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
18:45:12
aztec-1 | [18:45:12.407]
INFO:
pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097
18:45:14
aztec-1 | [18:45:14.082]
INFO:
pxe:service Proving completed in 1662.907002ms
{"timings":{"total":1662.907002,"sync":38.07492899999852,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":106.9955059999993,"oracles":{"callPrivateFunction":{"times":[390.950377000001,301.4027590000005]}}},{"functionName":"private_kernel_init","time":53.44813100000101},{"functionName":"SchnorrAccount:constructor","time":364.91115000000354,"oracles":{"getContractInstance":{"times":[6.02288100000078]},"debugLog":{"times":[0.1658239999997022,0.13724400000137393]},"fetchTaggedLogs":{"times":[115.15783399999782]},"loadCapsule":{"times":[0.19321499999932712,0.13989399999991292,0.12885299999834388]},"validateEnqueuedNotesAndEvents":{"times":[6.640067000000272]},"notifyCreatedNullifier":{"times":[0.4487020000015036,0.2804570000007516]},"notifyCreatedNote":{"times":[0.27068700000018]},"getRandomField":{"times":[0.2759970000006433,0.2470869999997376,0.1089429999992717,0.0842320000010659,0.0638409999992291,0.06617199999891454,0.06105100000058883,0.06672099999923375,0.043361000000004424,0.08271199999944656,0.043791000000055647]},"getIndexedTaggingSecretAsSender":{"times":[55.502465999998094]},"incrementAppTaggingSecretIndexAsSender":{"times":[34.90470400000049]}}},{"functionName":"private_kernel_inner","time":122.7282660000019},{"functionName":"SchnorrAccount:entrypoint","time":268.0040349999981,"oracles":{"debugLog":{"times":[0.1705050000018673,0.06672199999957229,0.3102179999987129]},"fetchTaggedLogs":{"times":[115.15929300000062]},"loadCapsule":{"times":[0.1728450000009616,0.13468300000022282,0.13155299999925774]},"validateEnqueuedNotesAndEvents":{"times":[7.1203610000011395]},"getNotes":{"times":[2.0348750000011933]},"getAuthWitness":{"times":[0.19140499999775784]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.3923700000013923]}}},{"functionName":"private_kernel_inner","time":102.74588099999892},{"functionName":"private_kernel_reset","time":209.07797800000117},{"functionName":"private_kernel_tail","time":82.80678700000135}],"unaccounted":314.1143389999961}}
18:45:14
aztec-1 | [18:45:14.144]
INFO:
node Received tx 0x2ee8959b11c020c1e8ec0fdf78188d9d52f71ab2861c394f9080d9607df504d3
{"txHash":"0x2ee8959b11c020c1e8ec0fdf78188d9d52f71ab2861c394f9080d9607df504d3"}
18:45:14
aztec-1 | [18:45:14.144]
INFO:
pxe:service Sent transaction 0x2ee8959b11c020c1e8ec0fdf78188d9d52f71ab2861c394f9080d9607df504d3
18:45:14
aztec-1 | [18:45:14.198]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.016000958000000537s
{"duration":0.016000958000000537,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992}
18:45:14
aztec-1 | [18:45:14.216]
INFO:
sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2399cf901bb5ead23bb292015ca6e559906ce64befba3d1bf57ca8b49aa52203","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750099879,"version":3676816240},"txHashes":["0x2ee8959b11c020c1e8ec0fdf78188d9d52f71ab2861c394f9080d9607df504d3"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":40.42862299999979,"publicProcessDuration":16.105561000000307,"rollupCircuitsDuration":36.441696000001684,"txCount":1,"blockNumber":3,"blockTimestamp":1750099879,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
18:45:14
aztec-1 | [18:45:14.436]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3
18:45:14
aztec-1 | [18:45:14.439]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:45:14
aztec-1 | [18:45:14.441]
INFO:
aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3.
18:45:14
aztec-1 | [18:45:14.447]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750099915
18:45:14
aztec-1 | [18:45:14.447]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:51:55.000Z
{"offset":400553,"timeMs":1750099915000}
18:45:14
aztec-1 | [18:45:14.447]
INFO:
aztecjs:utils:watcher Slot 4 was filled, jumped to next slot
18:45:14
aztec-1 | [18:45:14.458]
WARN:
archiver Failed to reach L2 block 3 at 29 (latest is 2). Rolling back last synched L1 block number to 28.
{"latestLocalL2BlockNumber":2,"latestLocalL2BlockArchive":"0x23236368a62c61c07b695645316abc568f55c5d9e7caa3115dcbd4f413b530c0","blocksSynchedTo":28,"currentL1BlockNumber":29,"provenBlockNumber":2,"provenArchive":"0x23236368a62c61c07b695645316abc568f55c5d9e7caa3115dcbd4f413b530c0","pendingBlockNumber":3,"pendingArchive":"0x2b25f8b9fd8623c85b25c822ddacc904cb0a563d9be50bcbabcd97b59f3a2514"}
18:45:14
aztec-1 | [18:45:14.567]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x2399cf901bb5ead23bb292015ca6e559906ce64befba3d1bf57ca8b49aa52203","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750099879,"version":3676816240},"archiveRoot":"0x2b25f8b9fd8623c85b25c822ddacc904cb0a563d9be50bcbabcd97b59f3a2514","archiveNextLeafIndex":4}
18:45:14
aztec-1 | [18:45:14.571]
INFO:
archiver Updated proven chain to block 3
{"provenBlockNumber":3}
18:45:14
aztec-1 | [18:45:14.602]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":18.212338000001182,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750099879,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
18:45:14
aztec-1 | Initial Accounts:
18:45:14
aztec-1 |
18:45:14
aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e
18:45:14
aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc
18:45:14
aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281
18:45:14
aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f
18:45:14
aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f
18:45:14
aztec-1 |
18:45:14
aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5
18:45:14
aztec-1 |
18:45:14
aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89
18:45:14
aztec-1 |
18:45:14
aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f
18:45:14
aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0
18:45:14
aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae
18:45:14
aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57
18:45:14
aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d
18:45:14
aztec-1 |
18:45:14
aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e
18:45:14
aztec-1 |
18:45:14
aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d
18:45:14
aztec-1 |
18:45:14
aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7
18:45:14
aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d
18:45:14
aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c
18:45:14
aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3
18:45:14
aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae
18:45:14
aztec-1 |
18:45:14
aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da
18:45:14
aztec-1 |
18:45:14
aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba
18:45:14
aztec-1 |
18:45:14
aztec-1 |
18:45:15
aztec-1 | [18:45:15.369]
WARN:
pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata
18:45:15
aztec-1 | [18:45:15.369]
WARN:
pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata
18:45:15
aztec-1 | [18:45:15.373]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
18:45:15
aztec-1 | [18:45:15.401]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
18:45:16
aztec-1 | [18:45:16.221]
INFO:
pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164
18:45:16
aztec-1 | [18:45:16.288]
INFO:
pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2
18:45:19
aztec-1 | [18:45:18.872]
INFO:
pxe:service Proving completed in 2542.7120560000003ms
{"timings":{"total":2542.7120560000003,"sync":27.95890800000052,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":397.9428450000014,"oracles":{"debugLog":{"times":[0.20870600000125705,0.1376639999980398,0.12509399999908055,0.23918599999888102,0.15300399999978254,0.14913300000262097,0.0967930000006163,0.2001460000028601]},"fetchTaggedLogs":{"times":[143.81914099999995]},"loadCapsule":{"times":[0.346929999999702,0.1908949999997276,0.4607219999998051,0.3136679999988701,0.2792670000017097,0.21966600000087055,0.1615940000010596]},"getSharedSecret":{"times":[5.831795999998576]},"aes128Decrypt":{"times":[1.228012999999919,0.9380659999987984]},"getPublicKeysAndPartialAddress":{"times":[4.845559999997931]},"getKeyValidationRequest":{"times":[2.852896000000328]},"storeCapsule":{"times":[3.346858999997494,3.801961000001029,2.6278200000015204]},"deleteCapsule":{"times":[3.5186140000005253]},"validateEnqueuedNotesAndEvents":{"times":[32.32685599999968]},"getNotes":{"times":[8.604811000001064]},"getAuthWitness":{"times":[0.18176500000117812]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.050931000001583016]},"callPrivateFunction":{"times":[937.551582,134.8556699999972]},"notifyEnqueuedPublicFunctionCall":{"times":[0.2701869999982591]}}},{"functionName":"private_kernel_init","time":71.86038600000029},{"functionName":"ContractClassRegisterer:register","time":917.7420009999987,"oracles":{"loadCapsule":{"times":[3.3844409999983327]},"notifyCreatedNullifier":{"times":[1.0365480000000389]},"debugLog":{"times":[0.22626600000148755]},"notifyCreatedContractClassLog":{"times":[11.695713000000978]}}},{"functionName":"private_kernel_inner","time":98.52657499999987},{"functionName":"ContractInstanceDeployer:deploy","time":83.19972800000323,"oracles":{"storeInExecutionCache":{"times":[0.27833800000007614]},"callPrivateFunction":{"times":[42.84651699999813]},"notifyCreatedNullifier":{"times":[0.1972249999998894]},"debugLog":{"times":[0.10544299999673967]}}},{"functionName":"private_kernel_inner","time":112.63534499999878},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":30.964468999995006,"oracles":{}},{"functionName":"private_kernel_inner","time":104.62720900000204},{"functionName":"private_kernel_reset","time":215.83918500000073},{"functionName":"private_kernel_tail","time":112.48664100000315}],"unaccounted":368.9287639999966}}
18:45:19
aztec-1 | [18:45:19.048]
INFO:
node Received tx 0x1ed2c4cbd424598e2e0d9f067701f381b85db5b36e00e3969811f41c5cff68fd
{"txHash":"0x1ed2c4cbd424598e2e0d9f067701f381b85db5b36e00e3969811f41c5cff68fd"}
18:45:19
aztec-1 | [18:45:19.048]
INFO:
pxe:service Sent transaction 0x1ed2c4cbd424598e2e0d9f067701f381b85db5b36e00e3969811f41c5cff68fd
18:45:21
aztec-1 | [18:45:20.901]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.6787289309999978s
{"duration":1.6787289309999978,"rate":23703.05250907721,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768}
18:45:21
aztec-1 | [18:45:21.181]
INFO:
sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 20111.271946251778 mana/s
{"blockHash":"0x1880416dccfb420c3597939d85cc8b2a7231f09903e0416919a43fa7e378e0ba","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750099915,"version":3676816240},"txHashes":["0x1ed2c4cbd424598e2e0d9f067701f381b85db5b36e00e3969811f41c5cff68fd"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1978.4533359999987,"publicProcessDuration":1678.8991349999997,"rollupCircuitsDuration":1969.4781349999976,"txCount":1,"blockNumber":4,"blockTimestamp":1750099915,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
18:45:21
aztec-1 | [18:45:21.727]
INFO:
pxe:service Proving completed in 2853.663346999998ms
{"timings":{"total":2853.663346999998,"sync":131.9360940000006,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":502.763934000006,"oracles":{"debugLog":{"times":[0.19270500000129687,0.08575199999904726,0.09824300000036601,0.11683400000038091,0.15205299999797717,0.15623499999855994,0.10154300000067451,0.14904399999795714]},"fetchTaggedLogs":{"times":[170.82220199999938]},"loadCapsule":{"times":[0.44983199999842327,0.17422500000247965,13.61987699999736,4.473740999997972,1.4045469999982743,20.404718999998295,0.3302089999997406]},"getSharedSecret":{"times":[7.5149620000011055]},"aes128Decrypt":{"times":[0.26385799999843584,0.4494620000004943]},"getPublicKeysAndPartialAddress":{"times":[2.590749999999389]},"getKeyValidationRequest":{"times":[13.843173000001116]},"storeCapsule":{"times":[9.384193000001687,4.092800000002171,3.0574820000001637]},"deleteCapsule":{"times":[3.683538999997836]},"validateEnqueuedNotesAndEvents":{"times":[18.594011000001046]},"getNotes":{"times":[9.235058999998728]},"getAuthWitness":{"times":[0.2731070000008913]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06041199999890523]},"callPrivateFunction":{"times":[717.5407320000013,200.6766970000026]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06919199999902048]}}},{"functionName":"private_kernel_init","time":71.77149400000053},{"functionName":"ContractClassRegisterer:register","time":698.0980799999998,"oracles":{"loadCapsule":{"times":[2.6750209999991057]},"notifyCreatedNullifier":{"times":[1.060167999999976]},"debugLog":{"times":[0.22108599999774015]},"notifyCreatedContractClassLog":{"times":[5.5636000000013155]}}},{"functionName":"private_kernel_inner","time":135.88776199999847},{"functionName":"ContractInstanceDeployer:deploy","time":111.27834799999982,"oracles":{"storeInExecutionCache":{"times":[0.12990300000092248]},"callPrivateFunction":{"times":[66.35462800000096]},"notifyCreatedNullifier":{"times":[0.24854699999923469]},"debugLog":{"times":[0.12808399999994435]}}},{"functionName":"private_kernel_inner","time":144.7918720000016},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":43.35223899999619,"oracles":{}},{"functionName":"private_kernel_inner","time":144.49903300000005},{"functionName":"private_kernel_reset","time":235.41905300000144},{"functionName":"private_kernel_tail","time":116.19419099999868}],"unaccounted":517.6712469999948}}
18:45:22
aztec-1 | [18:45:21.952]
INFO:
node Received tx 0x2726066b6ee919b8c023fd1647e5f494088977feff88e949146fe144788d1a42
{"txHash":"0x2726066b6ee919b8c023fd1647e5f494088977feff88e949146fe144788d1a42"}
18:45:22
aztec-1 | [18:45:21.953]
INFO:
pxe:service Sent transaction 0x2726066b6ee919b8c023fd1647e5f494088977feff88e949146fe144788d1a42
18:45:22
aztec-1 | [18:45:22.071]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4
18:45:22
aztec-1 | [18:45:22.075]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:45:22
aztec-1 | [18:45:22.078]
INFO:
aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4.
18:45:22
aztec-1 | [18:45:22.091]
WARN:
archiver Failed to reach L2 block 4 at 31 (latest is 3). Rolling back last synched L1 block number to 30.
{"latestLocalL2BlockNumber":3,"latestLocalL2BlockArchive":"0x2b25f8b9fd8623c85b25c822ddacc904cb0a563d9be50bcbabcd97b59f3a2514","blocksSynchedTo":30,"currentL1BlockNumber":31,"provenBlockNumber":3,"provenArchive":"0x2b25f8b9fd8623c85b25c822ddacc904cb0a563d9be50bcbabcd97b59f3a2514","pendingBlockNumber":4,"pendingArchive":"0x1b6f3fbe49d6fcbb00314b215a9a53cf1a677f865e0c5e34d4e095770a0c3bb7"}
18:45:22
aztec-1 | [18:45:22.128]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750099951
18:45:22
aztec-1 | [18:45:22.129]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:52:31.000Z
{"offset":428871,"timeMs":1750099951000}
18:45:22
aztec-1 | [18:45:22.129]
INFO:
aztecjs:utils:watcher Slot 5 was filled, jumped to next slot
18:45:22
aztec-1 | [18:45:22.244]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x1880416dccfb420c3597939d85cc8b2a7231f09903e0416919a43fa7e378e0ba","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750099915,"version":3676816240},"archiveRoot":"0x1b6f3fbe49d6fcbb00314b215a9a53cf1a677f865e0c5e34d4e095770a0c3bb7","archiveNextLeafIndex":5}
18:45:22
aztec-1 | [18:45:22.251]
INFO:
archiver Updated proven chain to block 4
{"provenBlockNumber":4}
18:45:22
aztec-1 | [18:45:22.325]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":19.480374999999185,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750099915,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236}
18:45:22
aztec-1 | [18:45:22.422]
INFO:
aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed.
18:45:23
aztec-1 | [18:45:22.863]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.4020757230000017s
{"duration":0.4020757230000017,"rate":787045.7774442618,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064}
18:45:23
aztec-1 | [18:45:22.900]
INFO:
sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 708790.9449248875 mana/s
{"blockHash":"0x1759433278d6cc6fff8f272fa0fcb6b37b27124cd1a64dd7d5eff0e74b9e3358","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750099951,"version":3676816240},"txHashes":["0x2726066b6ee919b8c023fd1647e5f494088977feff88e949146fe144788d1a42"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":446.441479000001,"publicProcessDuration":402.324270000001,"rollupCircuitsDuration":440.91661999999997,"txCount":1,"blockNumber":5,"blockTimestamp":1750099951,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
18:45:23
aztec-1 | [18:45:23.102]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:45:23
aztec-1 | [18:45:23.105]
WARN:
aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time
18:45:23
aztec-1 | [18:45:23.105]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:52:43.000Z
{"offset":439895,"timeMs":1750099963000}
18:45:23
aztec-1 | [18:45:23.115]
WARN:
archiver Failed to reach L2 block 5 at 33 (latest is 4). Rolling back last synched L1 block number to 32.
{"latestLocalL2BlockNumber":4,"latestLocalL2BlockArchive":"0x1b6f3fbe49d6fcbb00314b215a9a53cf1a677f865e0c5e34d4e095770a0c3bb7","blocksSynchedTo":32,"currentL1BlockNumber":33,"provenBlockNumber":4,"provenArchive":"0x1b6f3fbe49d6fcbb00314b215a9a53cf1a677f865e0c5e34d4e095770a0c3bb7","pendingBlockNumber":5,"pendingArchive":"0x1b10df47f201f4123e9a28daaf16e913f3061423fa01dc077358892d5cd31e65"}
18:45:23
aztec-1 | [18:45:23.140]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5
18:45:23
aztec-1 | [18:45:23.144]
INFO:
aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5.
18:45:23
aztec-1 | [18:45:23.308]
INFO:
archiver Downloaded L2 block 5
{"blockHash":"0x1759433278d6cc6fff8f272fa0fcb6b37b27124cd1a64dd7d5eff0e74b9e3358","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750099951,"version":3676816240},"archiveRoot":"0x1b10df47f201f4123e9a28daaf16e913f3061423fa01dc077358892d5cd31e65","archiveNextLeafIndex":6}
18:45:23
aztec-1 | [18:45:23.309]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750099987
18:45:23
aztec-1 | [18:45:23.309]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:53:07.000Z
{"offset":463691,"timeMs":1750099987000}
18:45:23
aztec-1 | [18:45:23.309]
INFO:
aztecjs:utils:watcher Slot 6 was filled, jumped to next slot
18:45:23
aztec-1 | [18:45:23.315]
INFO:
archiver Updated proven chain to block 5
{"provenBlockNumber":5}
18:45:23
aztec-1 | [18:45:23.383]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":15.152878999997483,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750099951,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702}
18:45:24
aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547
18:45:24
aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13
18:45:24
aztec-1 | [18:45:24.373]
INFO:
aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed.
18:45:24
aztec-1 | [18:45:24.407]
WARN:
pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata
18:45:24
aztec-1 | [18:45:24.412]
INFO:
aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
18:45:24
aztec-1 | [18:45:24.570]
INFO:
pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e
18:45:27
aztec-1 | [18:45:26.931]
INFO:
pxe:service Proving completed in 2338.3783440000007ms
{"timings":{"total":2338.3783440000007,"sync":30.846070999999938,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":128.29150600000503,"oracles":{"callPrivateFunction":{"times":[913.969046000002,145.60435399999915,43.2521949999973]}}},{"functionName":"private_kernel_init","time":65.63576900000044},{"functionName":"ContractClassRegisterer:register","time":892.8017349999973,"oracles":{"loadCapsule":{"times":[2.578929999999673]},"notifyCreatedNullifier":{"times":[0.42513099999996484]},"debugLog":{"times":[0.1846350000014354]},"notifyCreatedContractClassLog":{"times":[9.664359999998851]}}},{"functionName":"private_kernel_inner","time":117.28570000000036},{"functionName":"ContractInstanceDeployer:deploy","time":75.71901099999741,"oracles":{"storeInExecutionCache":{"times":[0.09179200000289711]},"callPrivateFunction":{"times":[60.43479799999841]},"notifyCreatedNullifier":{"times":[0.2460270000010496]},"debugLog":{"times":[0.14429400000153692]}}},{"functionName":"private_kernel_inner","time":87.813345999999},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":46.69905700000163,"oracles":{}},{"functionName":"private_kernel_inner","time":98.05936199999996},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":32.014061999998376,"oracles":{"debugLog":{"times":[0.103622999999061]}}},{"functionName":"private_kernel_inner","time":106.97486199999912},{"functionName":"private_kernel_reset","time":200.24684600000182},{"functionName":"private_kernel_tail","time":72.00650999999925}],"unaccounted":383.98450700000103}}
18:45:27
aztec-1 | [18:45:27.040]
INFO:
node Received tx 0x263e271969b03d01066d3f5e4434c8cde1512d4b85cf16e551ff02c0a55227eb
{"txHash":"0x263e271969b03d01066d3f5e4434c8cde1512d4b85cf16e551ff02c0a55227eb"}
18:45:27
aztec-1 | [18:45:27.040]
INFO:
pxe:service Sent transaction 0x263e271969b03d01066d3f5e4434c8cde1512d4b85cf16e551ff02c0a55227eb
18:45:27
aztec-1 | [18:45:27.155]
INFO:
simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03852825799999846s
{"duration":0.03852825799999846,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152}
18:45:27
aztec-1 | [18:45:27.194]
INFO:
sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s
{"blockHash":"0x2a73ac9baccac7b9fa6a278d2a8b4c8e317cb11ce2bbcf6cf20aa6dede7fb1ba","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750099987,"version":3676816240},"txHashes":["0x263e271969b03d01066d3f5e4434c8cde1512d4b85cf16e551ff02c0a55227eb"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":83.94184200000018,"publicProcessDuration":38.66177199999947,"rollupCircuitsDuration":79.14644199999748,"txCount":1,"blockNumber":6,"blockTimestamp":1750099987,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
18:45:27
aztec-1 | [18:45:27.435]
WARN:
ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6
18:45:27
aztec-1 | [18:45:27.440]
INFO:
aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6.
18:45:27
aztec-1 | [18:45:27.444]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
18:45:27
aztec-1 | [18:45:27.452]
WARN:
ethereum:cheat_codes Warped L1 timestamp to 1750100023
18:45:27
aztec-1 | [18:45:27.452]
WARN:
foundation:test-date-provider Time set to 2025-06-16T18:53:43.000Z
{"offset":495548,"timeMs":1750100023000}
18:45:27
aztec-1 | [18:45:27.452]
INFO:
aztecjs:utils:watcher Slot 7 was filled, jumped to next slot
18:45:27
aztec-1 | [18:45:27.558]
INFO:
archiver Downloaded L2 block 6
{"blockHash":"0x2a73ac9baccac7b9fa6a278d2a8b4c8e317cb11ce2bbcf6cf20aa6dede7fb1ba","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750099987,"version":3676816240},"archiveRoot":"0x0fcbfc6e2e76dcbddffd499384fc89d113ff13ca0d1d4f40afa99cd823e1cdfe","archiveNextLeafIndex":7}
18:45:27
aztec-1 | [18:45:27.564]
INFO:
archiver Updated proven chain to block 6
{"provenBlockNumber":6}
18:45:27
aztec-1 | [18:45:27.625]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":34.375857000002725,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750099987,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7}
18:45:28
aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354
18:45:28
aztec-1 | [18:45:28.059]
INFO:
aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed.
18:45:28
aztec-1 | [18:45:28.064]
INFO:
cli Aztec Server listening on port 8080
{"l2CircuitsVkTreeRoot":"0x1364306bc239ce640d30bd96c0c11b8e465dc7cb1c11babdeed8256c84934bdc","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"}
18:45:37
box-1 | \
18:45:37
box-1 | Running 1
test using 1
worker
18:45:37
box-1 |
18:45:38
box-1 | 1 [webkit] › browser.spec.ts:3:1 › test