Parent Log: http://ci.aztec-labs.com/f7f41d385a4341ce Command: 86eb7e6c27a52f1a:ONLY_TERM_PARENT=1 BOX=vite BROWSER=chromium run_compose_test vite-chromium 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:59 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14963_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: [?25l[+] Running 4/4 18:44:59 Network vite-chromium_default Created0.1s 18:44:59 Container vite-chromium-ethereum-1 Created0.1s 18:44:59 Container vite-chromium-aztec-1 Created0.1s 18:44:59 Container vite-chromium-box-1 Created0.1s 18:44:59 [?25hAttaching to aztec-1, box-1, ethereum-1 18:45:05 aztec-1 | 18:45:05 aztec-1 | _ 18:45:05 aztec-1 | /\ | | 18:45:05 aztec-1 | / \ ___| |_ ___ ___ 18:45:05 aztec-1 | / /\ \ |_ / __/ _ \/ __| 18:45:05 aztec-1 | / ____ \ / /| || __/ (__ 18:45:05 aztec-1 | /_/___ \_\/___|\__\___|\___| 18:45:05 aztec-1 | 18:45:05 aztec-1 | https://github.com/AztecProtocol 18:45:05 aztec-1 | 18:45:05 aztec-1 | 18:45:05 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by... 18:45:05 aztec-1 | Setting up test accounts 18:45:06 aztec-1 | [18:45:05.996] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-yOJSyX/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 18:45:06 aztec-1 | [18:45:06.274] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 18:45:06 aztec-1 | [18:45:06.279] WARN: sandbox Set block interval to 12 18:45:06 aztec-1 | [18:45:06.489] INFO: sandbox Waiting for 7 transactions to be mined... 18:45:06 aztec-1 | [18:45:06.514] INFO: sandbox All transactions mined successfully 18:45:06 aztec-1 | [18:45:06.610] INFO: sandbox Waiting for 9 transactions to be mined... 18:45:06 aztec-1 | [18:45:06.636] INFO: sandbox All transactions mined successfully 18:45:06 aztec-1 | [18:45:06.800] INFO: sandbox Waiting for 11 transactions to be mined... 18:45:06 aztec-1 | [18:45:06.827] INFO: sandbox All transactions mined successfully 18:45:06 aztec-1 | [18:45:06.900] INFO: sandbox Waiting for 12 transactions to be mined... 18:45:06 aztec-1 | [18:45:06.928] INFO: sandbox All transactions mined successfully 18:45:06 aztec-1 | [18:45:06.935] INFO: sandbox Waiting for 12 transactions to be mined... 18:45:06 aztec-1 | [18:45:06.962] INFO: sandbox All transactions mined successfully 18:45:06 aztec-1 | [18:45:06.980] 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:06 aztec-1 | [18:45:06.980] INFO: sandbox Handing over to governance 18:45:06 aztec-1 | [18:45:06.989] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 18:45:06 aztec-1 | [18:45:06.989] INFO: telemetry:client Using NoopTelemetryClient 18:45:06 aztec-1 | [18:45:06.990] INFO: blob-sink:client Creating local blob sink client. 18:45:06 aztec-1 | [18:45:06.994] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:45:06 aztec-1 | [18:45:06.995] WARN: foundation:test-date-provider Time set to 2025-06-16T18:49:48.000Z {"offset":281006,"timeMs":1750099788000} 18:45:07 aztec-1 | [18:45:07.018] INFO: archiver:lmdb Starting data store with maxReaders 16 18:45:07 aztec-1 | [18:45:07.480] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xa8c8b0eb157d82c6760746010f570dd271143bf1665881978feb2973cffa3e30 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0xc17d361a568220441da725f9b08be26199dbb02894a34fb1d5b196f6bcbe5529","l1BlockNumber":20}} 18:45:07 aztec-1 | [18:45:07.511] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xa8c8b0eb157d82c6760746010f570dd271143bf1665881978feb2973cffa3e30","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 18:45:07 aztec-1 | [18:45:07.519] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-XwSUXy/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 18:45:07 aztec-1 | [18:45:07.783] INFO: world_state Created world state synchroniser with block history of 64 18:45:07 aztec-1 | [18:45:07.783] WARN: node Aztec node is accepting fake proofs 18:45:07 aztec-1 | [18:45:07.795] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 18:45:07 aztec-1 | [18:45:07.817] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 18:45:07 aztec-1 | [18:45:07.835] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 18:45:07 aztec-1 | [18:45:07.856] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 18:45:07 aztec-1 | [18:45:07.862] INFO: world_state Started world state synchronizer from block 1 18:45:08 aztec-1 | [18:45:07.866] INFO: p2p Starting p2p client from block 0 with empty mempools 18:45:08 aztec-1 | [18:45:08.203] INFO: epoch-prune-watcher EpochPruneWatcher initialized 18:45:08 aztec-1 | [18:45:08.286] INFO: slasher Starting Slasher client... 18:45:08 aztec-1 | [18:45:08.298] INFO: sequencer-client Deploying forwarder contract 18:45:08 aztec-1 | [18:45:08.323] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 18:45:08 aztec-1 | [18:45:08.334] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 18:45:08 aztec-1 | [18:45:08.334] 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:08 aztec-1 | [18:45:08.337] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 18:45:08 aztec-1 | [18:45:08.338] INFO: node Aztec Node version: 0.87.6 18:45:08 aztec-1 | [18:45:08.338] 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:08 aztec-1 | [18:45:08.363] INFO: pxe:data:lmdb Starting data store with maxReaders 16 18:45:08 aztec-1 | [18:45:08.379] 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":1750099789,"syncedToL1Ts":1750099788,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750099776,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750099812},"newBlockNumber":1,"expectedSlot":1} 18:45:08 aztec-1 | [18:45:08.444] 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":1750099789,"syncedToL1Ts":1750099788,"syncedToL2Slot":1,"nextL2Slot":1,"nextL2SlotTs":1750099776,"l1SlotDuration":12,"rollup":{"blockNumber":1,"slot":2,"timeOfNextL1Slot":1750099812},"newBlockNumber":1,"expectedSlot":1} 18:45:08 aztec-1 | [18:45:08.504] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:45:08 aztec-1 | [18:45:08.505] WARN: foundation:test-date-provider Time set to 2025-06-16T18:50:00.000Z {"offset":291495,"timeMs":1750099800000} 18:45:08 aztec-1 | Setting up funded test accounts... 18:45:09 aztec-1 | [18:45:08.784] INFO: pxe:service Started PXE connected to chain 31337 version 3676816240 18:45:09 aztec-1 | [18:45:08.890] INFO: pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 18:45:09 aztec-1 | [18:45:08.975] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 18:45:09 aztec-1 | [18:45:08.979] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 18:45:09 aztec-1 | [18:45:09.162] INFO: pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 18:45:12 aztec-1 | [18:45:12.033] INFO: pxe:service Proving completed in 2830.5050760000004ms {"timings":{"total":2830.5050760000004,"sync":8.703136000000086,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":188.7917230000021,"oracles":{"callPrivateFunction":{"times":[766.8435769999996,415.1847830000006,208.3926190000002]}}},{"functionName":"private_kernel_init","time":130.0701420000005},{"functionName":"ContractClassRegisterer:register","time":739.8896639999984,"oracles":{"loadCapsule":{"times":[40.75701400000071]},"notifyCreatedNullifier":{"times":[1.8988639999988663]},"debugLog":{"times":[0.8226340000001073]},"notifyCreatedContractClassLog":{"times":[9.302102999999988]}}},{"functionName":"private_kernel_inner","time":161.01429800000005},{"functionName":"SchnorrAccount:constructor","time":380.74102800000037,"oracles":{"getContractInstance":{"times":[9.155459000001429]},"debugLog":{"times":[0.28013800000007905,0.1873649999997724]},"fetchTaggedLogs":{"times":[89.47050300000046]},"loadCapsule":{"times":[0.5953169999993406,0.3310189999992872,0.3411690000011731]},"validateEnqueuedNotesAndEvents":{"times":[7.659366999998383]},"notifyCreatedNullifier":{"times":[0.33218999999917287,0.2893179999991844]},"notifyCreatedNote":{"times":[0.7010900000004767]},"getRandomField":{"times":[0.4938139999994746,0.2520779999995284,0.15270400000008522,0.13058300000011513,0.09576199999901291,0.21196599999893806,0.08874199999991106,0.059992000000420376,0.07285199999932956,0.08948299999974552,0.05708199999935459]},"getIndexedTaggingSecretAsSender":{"times":[48.75496000000021]},"incrementAppTaggingSecretIndexAsSender":{"times":[19.378428999998505]}}},{"functionName":"private_kernel_inner","time":111.62055999999939},{"functionName":"SchnorrAccount:entrypoint","time":182.69259199999942,"oracles":{"debugLog":{"times":[0.2049960000003921,0.09510299999965355,0.2657370000015362]},"fetchTaggedLogs":{"times":[55.54204199999913]},"loadCapsule":{"times":[0.32257900000149675,0.7352200000004814,0.15471500000057858]},"validateEnqueuedNotesAndEvents":{"times":[6.770660999998654]},"getNotes":{"times":[2.4027770000011515]},"getAuthWitness":{"times":[0.2422969999988709]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0106790000008914]}}},{"functionName":"private_kernel_inner","time":127.5759820000003},{"functionName":"private_kernel_reset","time":255.42151000000013},{"functionName":"private_kernel_tail","time":73.43111899999894}],"unaccounted":470.55332200000066}} 18:45:12 aztec-1 | [18:45:12.136] INFO: node Received tx 0x2e8f068f50d4744dea6347181acfd049a7d7f179461024b23c15422818991e04 {"txHash":"0x2e8f068f50d4744dea6347181acfd049a7d7f179461024b23c15422818991e04"} 18:45:12 aztec-1 | [18:45:12.136] INFO: pxe:service Sent transaction 0x2e8f068f50d4744dea6347181acfd049a7d7f179461024b23c15422818991e04 18:45:12 aztec-1 | [18:45:12.242] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04115733600000021s {"duration":0.04115733600000021,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 18:45:12 aztec-1 | [18:45:12.268] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x00323b4b1ff58649bc29931913999fe85b14b720e2585c1ef39b42d293228099","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750099812,"version":3676816240},"txHashes":["0x2e8f068f50d4744dea6347181acfd049a7d7f179461024b23c15422818991e04"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":79.3111540000009,"publicProcessDuration":41.79127300000073,"rollupCircuitsDuration":70.3595920000007,"txCount":1,"blockNumber":1,"blockTimestamp":1750099812,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:45:15 aztec-1 | [18:45:15.296] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 18:45:15 aztec-1 | [18:45:15.300] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 18:45:15 aztec-1 | [18:45:15.304] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:15 aztec-1 | [18:45:15.392] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x00323b4b1ff58649bc29931913999fe85b14b720e2585c1ef39b42d293228099","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750099812,"version":3676816240},"archiveRoot":"0x00e5372cc30121938364f9f003576f6e205f0624aee30c77a087aeaeaee0e9e3","archiveNextLeafIndex":2} 18:45:15 aztec-1 | [18:45:15.398] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 18:45:15 aztec-1 | [18:45:15.498] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:45:15 aztec-1 | [18:45:15.498] WARN: foundation:test-date-provider Time set to 2025-06-16T18:50:12.000Z {"offset":296502,"timeMs":1750099812000} 18:45:15 aztec-1 | [18:45:15.527] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":21.4419969999999,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1750099812,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:45:15 aztec-1 | [18:45:15.533] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750099848 18:45:15 aztec-1 | [18:45:15.533] WARN: foundation:test-date-provider Time set to 2025-06-16T18:50:48.000Z {"offset":332467,"timeMs":1750099848000} 18:45:15 aztec-1 | [18:45:15.533] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 18:45:15 aztec-1 | [18:45:15.556] INFO: pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f 18:45:15 aztec-1 | [18:45:15.704] INFO: pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 18:45:17 aztec-1 | [18:45:17.153] INFO: pxe:service Proving completed in 1428.458767ms {"timings":{"total":1428.458767,"sync":45.250850000000355,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":113.57336600000053,"oracles":{"callPrivateFunction":{"times":[345.788579,258.30632199999854]}}},{"functionName":"private_kernel_init","time":47.41985199999908},{"functionName":"SchnorrAccount:constructor","time":318.77733400000034,"oracles":{"getContractInstance":{"times":[6.980567000000519]},"debugLog":{"times":[0.12750299999970593,0.08970299999964482]},"fetchTaggedLogs":{"times":[80.28341199999886]},"loadCapsule":{"times":[0.2538169999988895,0.3002680000008695,0.2261660000003758]},"validateEnqueuedNotesAndEvents":{"times":[6.244675999998435]},"notifyCreatedNullifier":{"times":[0.37345099999947706,0.279287999999724]},"notifyCreatedNote":{"times":[0.30109900000024936]},"getRandomField":{"times":[0.24486700000124983,0.25753699999950186,0.11223299999983283,0.061881999999968684,0.052181999999447726,0.04279099999985192,0.054480999999213964,0.04594100000031176,0.035010999999940395,0.04675099999985832,0.04188199999953213]},"getIndexedTaggingSecretAsSender":{"times":[72.48532199999863]},"incrementAppTaggingSecretIndexAsSender":{"times":[41.440002999999706]}}},{"functionName":"private_kernel_inner","time":98.2672220000004},{"functionName":"SchnorrAccount:entrypoint","time":226.80252999999902,"oracles":{"debugLog":{"times":[0.20847599999979138,0.122893000001568,0.15669500000149128]},"fetchTaggedLogs":{"times":[92.50934799999959]},"loadCapsule":{"times":[0.5822970000008354,0.2905380000011064,0.16418500000145286]},"validateEnqueuedNotesAndEvents":{"times":[10.84737800000039]},"getNotes":{"times":[1.1645819999994274]},"getAuthWitness":{"times":[0.13438400000086403]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4230520000000979]}}},{"functionName":"private_kernel_inner","time":94.607809000001},{"functionName":"private_kernel_reset","time":151.0405350000001},{"functionName":"private_kernel_tail","time":66.65112600000066}],"unaccounted":266.0681429999986}} 18:45:17 aztec-1 | [18:45:17.203] INFO: node Received tx 0x05ba5d7eb22f19340162c7fc6e6416ed2e31846dc5e9548839757bc480a2c836 {"txHash":"0x05ba5d7eb22f19340162c7fc6e6416ed2e31846dc5e9548839757bc480a2c836"} 18:45:17 aztec-1 | [18:45:17.203] INFO: pxe:service Sent transaction 0x05ba5d7eb22f19340162c7fc6e6416ed2e31846dc5e9548839757bc480a2c836 18:45:17 aztec-1 | [18:45:17.287] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01911070099999961s {"duration":0.01911070099999961,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 18:45:17 aztec-1 | [18:45:17.313] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x269cd32796e6d91e56ee9bf762ed997a5edecf299596ac51c67ade7f838faf1b","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750099848,"version":3676816240},"txHashes":["0x05ba5d7eb22f19340162c7fc6e6416ed2e31846dc5e9548839757bc480a2c836"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":52.017393000000084,"publicProcessDuration":19.297176000000036,"rollupCircuitsDuration":46.349081999998816,"txCount":1,"blockNumber":2,"blockTimestamp":1750099848,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:45:17 aztec-1 | [18:45:17.539] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:17 aztec-1 | [18:45:17.589] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 18:45:17 aztec-1 | [18:45:17.589] WARN: foundation:test-date-provider Time set to 2025-06-16T18:51:00.000Z {"offset":342411,"timeMs":1750099860000} 18:45:17 aztec-1 | [18:45:17.596] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 18:45:17 aztec-1 | [18:45:17.603] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 18:45:17 aztec-1 | [18:45:17.615] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750099884 18:45:17 aztec-1 | [18:45:17.615] WARN: foundation:test-date-provider Time set to 2025-06-16T18:51:24.000Z {"offset":366385,"timeMs":1750099884000} 18:45:17 aztec-1 | [18:45:17.615] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 18:45:17 aztec-1 | [18:45:17.649] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x269cd32796e6d91e56ee9bf762ed997a5edecf299596ac51c67ade7f838faf1b","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750099848,"version":3676816240},"archiveRoot":"0x033fde9d04463d358fbc0e03a7c3e4ceadbd66ddb8a7860386581450805bc27f","archiveNextLeafIndex":3} 18:45:17 aztec-1 | [18:45:17.654] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 18:45:17 aztec-1 | [18:45:17.682] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":15.534490000000005,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1750099848,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:45:17 aztec-1 | [18:45:17.820] INFO: pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 18:45:18 aztec-1 | [18:45:17.960] INFO: pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 18:45:20 aztec-1 | [18:45:19.591] INFO: pxe:service Proving completed in 1619.3009390000007ms {"timings":{"total":1619.3009390000007,"sync":27.706554000000324,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":101.04644199999893,"oracles":{"callPrivateFunction":{"times":[420.8243430000002,255.52372399999877]}}},{"functionName":"private_kernel_init","time":61.04364800000258},{"functionName":"SchnorrAccount:constructor","time":392.5331809999989,"oracles":{"getContractInstance":{"times":[9.032426000001578]},"debugLog":{"times":[0.2190359999985958,0.10183300000062445]},"fetchTaggedLogs":{"times":[120.93303300000116]},"loadCapsule":{"times":[0.21582599999965169,0.16132500000094296,0.23246600000129547]},"validateEnqueuedNotesAndEvents":{"times":[6.669088999999076]},"notifyCreatedNullifier":{"times":[0.4688240000032238,0.17766499999925145]},"notifyCreatedNote":{"times":[0.1592350000028091]},"getRandomField":{"times":[0.16400500000236207,0.2366470000015397,0.09443299999838928,0.04618100000152481,0.03428100000019185,0.03498100000069826,0.04942200000004959,0.04121099999974831,0.1160730000010517,0.04211100000247825,0.03778199999942444]},"getIndexedTaggingSecretAsSender":{"times":[57.224340000000666]},"incrementAppTaggingSecretIndexAsSender":{"times":[28.4395540000005]}}},{"functionName":"private_kernel_inner","time":154.18298399999912},{"functionName":"SchnorrAccount:entrypoint","time":229.69433200000276,"oracles":{"debugLog":{"times":[0.14373499999783235,0.0860130000000936,0.18179500000042026]},"fetchTaggedLogs":{"times":[87.0129429999979]},"loadCapsule":{"times":[0.17853499999910127,0.8446040000017092,0.12200300000040443]},"validateEnqueuedNotesAndEvents":{"times":[5.224787999999535]},"getNotes":{"times":[12.177394999998796]},"getAuthWitness":{"times":[0.2126749999988533]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5606459999980871]}}},{"functionName":"private_kernel_inner","time":111.34371199999805},{"functionName":"private_kernel_reset","time":144.63705400000254},{"functionName":"private_kernel_tail","time":82.74319299999843}],"unaccounted":314.36983899999905}} 18:45:20 aztec-1 | [18:45:19.639] INFO: node Received tx 0x05bd6529254366d3fc82b1686c5c07320c1a59d533bce1a02c67fe8d208ba312 {"txHash":"0x05bd6529254366d3fc82b1686c5c07320c1a59d533bce1a02c67fe8d208ba312"} 18:45:20 aztec-1 | [18:45:19.639] INFO: pxe:service Sent transaction 0x05bd6529254366d3fc82b1686c5c07320c1a59d533bce1a02c67fe8d208ba312 18:45:20 aztec-1 | [18:45:19.703] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01733186100000239s {"duration":0.01733186100000239,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 18:45:20 aztec-1 | [18:45:19.725] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0ca73e520fd565e754acd8362c4b013a1ded70b4255419841ebbe2ef6df9a78b","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750099884,"version":3676816240},"txHashes":["0x05bd6529254366d3fc82b1686c5c07320c1a59d533bce1a02c67fe8d208ba312"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":46.49954699999944,"publicProcessDuration":17.543077000002086,"rollupCircuitsDuration":41.052592000000004,"txCount":1,"blockNumber":3,"blockTimestamp":1750099884,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:45:20 aztec-1 | [18:45:19.885] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:20 aztec-1 | [18:45:19.887] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 18:45:20 aztec-1 | [18:45:19.890] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 18:45:20 aztec-1 | [18:45:19.893] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750099920 18:45:20 aztec-1 | [18:45:19.893] WARN: foundation:test-date-provider Time set to 2025-06-16T18:52:00.000Z {"offset":400107,"timeMs":1750099920000} 18:45:20 aztec-1 | [18:45:19.893] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 18:45:20 aztec-1 | [18:45:19.896] 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":"0x033fde9d04463d358fbc0e03a7c3e4ceadbd66ddb8a7860386581450805bc27f","blocksSynchedTo":28,"currentL1BlockNumber":29,"provenBlockNumber":2,"provenArchive":"0x033fde9d04463d358fbc0e03a7c3e4ceadbd66ddb8a7860386581450805bc27f","pendingBlockNumber":3,"pendingArchive":"0x0d5567d0f83ed6090c46b569575a06bedbf0540f67128e186bc29edd8a2deadb"} 18:45:20 aztec-1 | [18:45:20.000] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x0ca73e520fd565e754acd8362c4b013a1ded70b4255419841ebbe2ef6df9a78b","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750099884,"version":3676816240},"archiveRoot":"0x0d5567d0f83ed6090c46b569575a06bedbf0540f67128e186bc29edd8a2deadb","archiveNextLeafIndex":4} 18:45:20 aztec-1 | [18:45:20.003] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 18:45:20 aztec-1 | [18:45:20.059] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":15.0913670000009,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1750099884,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 18:45:20 aztec-1 | Initial Accounts: 18:45:20 aztec-1 | 18:45:20 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 18:45:20 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc 18:45:20 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 18:45:20 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 18:45:20 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 18:45:20 aztec-1 | 18:45:20 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 18:45:20 aztec-1 | 18:45:20 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 18:45:20 aztec-1 | 18:45:20 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f 18:45:20 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0 18:45:20 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 18:45:20 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 18:45:20 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 18:45:20 aztec-1 | 18:45:20 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 18:45:20 aztec-1 | 18:45:20 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 18:45:20 aztec-1 | 18:45:20 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 18:45:20 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d 18:45:20 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 18:45:20 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 18:45:20 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 18:45:20 aztec-1 | 18:45:20 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 18:45:20 aztec-1 | 18:45:20 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 18:45:20 aztec-1 | 18:45:20 aztec-1 | 18:45:21 aztec-1 | [18:45:20.843] WARN: pxe:service No artifact found for contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 when looking for its metadata 18:45:21 aztec-1 | [18:45:20.843] WARN: pxe:service No artifact found for contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 when looking for its metadata 18:45:21 aztec-1 | [18:45:20.849] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 as part of deployment for 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 18:45:21 aztec-1 | [18:45:20.885] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 as part of deployment for 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 18:45:22 aztec-1 | [18:45:21.742] INFO: pxe:service Added contract FPC at 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 with class 0x29dcd4953013697442c3dd70078007da6d27e978e725c3471dcafb67969f2164 18:45:22 aztec-1 | [18:45:21.745] INFO: pxe:service Added contract Token at 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 with class 0x02c03e14465d82e13534072f58c1e39d320b13cf92255a90ff4c99e1fca555a2 18:45:25 aztec-1 | [18:45:24.336] INFO: pxe:service Proving completed in 2554.0915830000013ms {"timings":{"total":2554.0915830000013,"sync":62.03257599999779,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":333.65073400000256,"oracles":{"debugLog":{"times":[0.19998499999928754,0.12252299999818206,0.1076229999998759,0.2730279999996128,0.09522199999992154,0.10482299999785027,0.10020200000144541,0.21512600000278326]},"fetchTaggedLogs":{"times":[108.48429100000067]},"loadCapsule":{"times":[0.2267759999995178,0.167924999997922,0.35718000000269967,0.15473500000007334,0.1757949999991979,0.19334499999968102,0.18978600000264123]},"getSharedSecret":{"times":[4.626360999998724]},"aes128Decrypt":{"times":[1.2184849999975995,0.8877649999994901]},"getPublicKeysAndPartialAddress":{"times":[4.44262499999968]},"getKeyValidationRequest":{"times":[1.8403619999990042]},"storeCapsule":{"times":[2.568652000001748,2.2277830000020913,2.1429499999976542]},"deleteCapsule":{"times":[2.3892179999966174]},"validateEnqueuedNotesAndEvents":{"times":[12.947147000002587]},"getNotes":{"times":[8.577141999998275]},"getAuthWitness":{"times":[0.182264999999461]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06894199999806006]},"callPrivateFunction":{"times":[878.2524809999995,146.31129200000214]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3784410000007483]}}},{"functionName":"private_kernel_init","time":65.88021500000104},{"functionName":"ContractClassRegisterer:register","time":862.5142459999988,"oracles":{"loadCapsule":{"times":[3.7182060000013735]},"notifyCreatedNullifier":{"times":[0.688640000000305]},"debugLog":{"times":[0.1987360000020999]},"notifyCreatedContractClassLog":{"times":[5.391371999998228]}}},{"functionName":"private_kernel_inner","time":131.13409200000024},{"functionName":"ContractInstanceDeployer:deploy","time":88.61269800000082,"oracles":{"storeInExecutionCache":{"times":[0.2978079999993497]},"callPrivateFunction":{"times":[60.82985199999894]},"notifyCreatedNullifier":{"times":[0.272517000001244]},"debugLog":{"times":[0.1410329999998794]}}},{"functionName":"private_kernel_inner","time":120.97637500000201},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":42.93757600000026,"oracles":{}},{"functionName":"private_kernel_inner","time":125.09387200000128},{"functionName":"private_kernel_reset","time":198.88995499999874},{"functionName":"private_kernel_tail","time":98.35133599999972}],"unaccounted":424.017907999998}} 18:45:25 aztec-1 | [18:45:24.487] INFO: node Received tx 0x18d690fb3a29c4c5497180d1b407012abd3465d79a847d7726ed5529287eb46e {"txHash":"0x18d690fb3a29c4c5497180d1b407012abd3465d79a847d7726ed5529287eb46e"} 18:45:25 aztec-1 | [18:45:24.487] INFO: pxe:service Sent transaction 0x18d690fb3a29c4c5497180d1b407012abd3465d79a847d7726ed5529287eb46e 18:45:26 aztec-1 | [18:45:26.260] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.6138533779999997s {"duration":1.6138533779999997,"rate":24655.895351107916,"totalPublicGas":{"daGas":4096,"l2Gas":39791},"totalBlockGas":{"daGas":136192,"l2Gas":64833},"totalSizeInBytes":8768} 18:45:26 aztec-1 | [18:45:26.481] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 21474.84893120279 mana/s {"blockHash":"0x1a8c75dd9ed359ffab177a97c4f303bb9097f38a321e10c1c9097d88f19c9cb5","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750099920,"version":3676816240},"txHashes":["0x18d690fb3a29c4c5497180d1b407012abd3465d79a847d7726ed5529287eb46e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1852.8416519999992,"publicProcessDuration":1613.9765019999977,"rollupCircuitsDuration":1847.7334159999991,"txCount":1,"blockNumber":4,"blockTimestamp":1750099920,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 18:45:27 aztec-1 | [18:45:26.966] INFO: pxe:service Proving completed in 2628.560572999999ms {"timings":{"total":2628.560572999999,"sync":109.72860099999889,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":448.5905139999959,"oracles":{"debugLog":{"times":[0.2796780000026047,0.10348300000259769,0.10335299999860581,0.196936000000278,0.11401299999852199,0.11652300000059768,0.09206300000005285,0.2033159999991767]},"fetchTaggedLogs":{"times":[199.18199399999867]},"loadCapsule":{"times":[1.304388000000472,1.3599689999973634,0.4015610000024026,0.3188689999988128,17.48403099999996,0.2546679999977641,0.1752650000016729]},"getSharedSecret":{"times":[7.6857600000003]},"aes128Decrypt":{"times":[0.49314400000002934,0.7201809999969555]},"getPublicKeysAndPartialAddress":{"times":[6.303691000000981]},"getKeyValidationRequest":{"times":[3.739895999999135]},"storeCapsule":{"times":[2.5868740000005346,2.788078999998106,4.461038000001281]},"deleteCapsule":{"times":[2.5096020000019053]},"validateEnqueuedNotesAndEvents":{"times":[13.103735000000597]},"getNotes":{"times":[10.403957999998966]},"getAuthWitness":{"times":[0.19523499999922933]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05624099999840837]},"callPrivateFunction":{"times":[750.2821120000008,147.11546199999793]},"notifyEnqueuedPublicFunctionCall":{"times":[0.06788199999937206]}}},{"functionName":"private_kernel_init","time":65.89123600000312},{"functionName":"ContractClassRegisterer:register","time":732.6172270000025,"oracles":{"loadCapsule":{"times":[2.557133000002068]},"notifyCreatedNullifier":{"times":[0.5387750000008964]},"debugLog":{"times":[0.16969499999686377]},"notifyCreatedContractClassLog":{"times":[4.976392000000487]}}},{"functionName":"private_kernel_inner","time":126.40005000000019},{"functionName":"ContractInstanceDeployer:deploy","time":89.82264199999918,"oracles":{"storeInExecutionCache":{"times":[0.08391199999823584]},"callPrivateFunction":{"times":[50.62939000000188]},"notifyCreatedNullifier":{"times":[0.2588080000023183]},"debugLog":{"times":[0.15396400000099675]}}},{"functionName":"private_kernel_inner","time":109.92503800000122},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":38.82946200000151,"oracles":{}},{"functionName":"private_kernel_inner","time":117.64133900000161},{"functionName":"private_kernel_reset","time":223.0608370000009},{"functionName":"private_kernel_tail","time":94.47819499999969}],"unaccounted":471.5754319999942}} 18:45:27 aztec-1 | [18:45:27.143] INFO: node Received tx 0x05c2b669a14898802016dbbeaf4b9f5c5d69b2e6e3e1d4192f4cd26f52c03f88 {"txHash":"0x05c2b669a14898802016dbbeaf4b9f5c5d69b2e6e3e1d4192f4cd26f52c03f88"} 18:45:27 aztec-1 | [18:45:27.143] INFO: pxe:service Sent transaction 0x05c2b669a14898802016dbbeaf4b9f5c5d69b2e6e3e1d4192f4cd26f52c03f88 18:45:27 aztec-1 | [18:45:27.261] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 18:45:27 aztec-1 | [18:45:27.263] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:27 aztec-1 | [18:45:27.265] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 18:45:27 aztec-1 | [18:45:27.272] 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":"0x0d5567d0f83ed6090c46b569575a06bedbf0540f67128e186bc29edd8a2deadb","blocksSynchedTo":30,"currentL1BlockNumber":31,"provenBlockNumber":3,"provenArchive":"0x0d5567d0f83ed6090c46b569575a06bedbf0540f67128e186bc29edd8a2deadb","pendingBlockNumber":4,"pendingArchive":"0x234af63da7e177f469f462db0c40e0144bd10031c318a73e2c2b0d3c307211e5"} 18:45:27 aztec-1 | [18:45:27.332] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750099956 18:45:27 aztec-1 | [18:45:27.332] WARN: foundation:test-date-provider Time set to 2025-06-16T18:52:36.000Z {"offset":428668,"timeMs":1750099956000} 18:45:27 aztec-1 | [18:45:27.332] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 18:45:27 aztec-1 | [18:45:27.412] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x1a8c75dd9ed359ffab177a97c4f303bb9097f38a321e10c1c9097d88f19c9cb5","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1750099920,"version":3676816240},"archiveRoot":"0x234af63da7e177f469f462db0c40e0144bd10031c318a73e2c2b0d3c307211e5","archiveNextLeafIndex":5} 18:45:27 aztec-1 | [18:45:27.424] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 18:45:27 aztec-1 | [18:45:27.442] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":18.45444800000041,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1750099920,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":236} 18:45:27 aztec-1 | [18:45:27.859] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.31529223699999787s {"duration":0.31529223699999787,"rate":1003678.3747390588,"totalPublicGas":{"daGas":10240,"l2Gas":316452},"totalBlockGas":{"daGas":380928,"l2Gas":341494},"totalSizeInBytes":24064} 18:45:27 aztec-1 | [18:45:27.924] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 809914.7848854713 mana/s {"blockHash":"0x2dd21e2cac09c786410da06d0d829c1a9f89d8ce9d8273ae4cc450e63ce9ee55","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750099956,"version":3676816240},"txHashes":["0x05c2b669a14898802016dbbeaf4b9f5c5d69b2e6e3e1d4192f4cd26f52c03f88"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":390.6537350000035,"publicProcessDuration":315.6916590000001,"rollupCircuitsDuration":385.06005500000174,"txCount":1,"blockNumber":5,"blockTimestamp":1750099956,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 18:45:28 aztec-1 | [18:45:28.084] INFO: aztecjs:deploy_sent_tx Contract 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 successfully deployed. 18:45:28 aztec-1 | [18:45:28.260] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 18:45:28 aztec-1 | [18:45:28.264] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 18:45:28 aztec-1 | [18:45:28.266] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:28 aztec-1 | [18:45:28.269] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750099992 18:45:28 aztec-1 | [18:45:28.269] WARN: foundation:test-date-provider Time set to 2025-06-16T18:53:12.000Z {"offset":463731,"timeMs":1750099992000} 18:45:28 aztec-1 | [18:45:28.269] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 18:45:28 aztec-1 | [18:45:28.476] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x2dd21e2cac09c786410da06d0d829c1a9f89d8ce9d8273ae4cc450e63ce9ee55","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1750099956,"version":3676816240},"archiveRoot":"0x145a965e020133913d4d03dc6e14e361fcfb4af3ac661471db67873127f3a8a6","archiveNextLeafIndex":6} 18:45:28 aztec-1 | [18:45:28.487] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 18:45:28 aztec-1 | [18:45:28.546] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":20.48835699999836,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1750099956,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 18:45:29 aztec-1 | BananaCoin: 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 18:45:29 aztec-1 | FPC: 0x0723941b267b3ced905d304c517042f5c3f85d0f13232460da9a9f4d2a6b1c13 18:45:29 aztec-1 | [18:45:29.522] INFO: aztecjs:deploy_sent_tx Contract 0x131b1ba6febb2758f11effaa18660d879c3614cb411076276dfd197b94530547 successfully deployed. 18:45:29 aztec-1 | [18:45:29.558] WARN: pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata 18:45:29 aztec-1 | [18:45:29.562] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 18:45:29 aztec-1 | [18:45:29.697] INFO: pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e 18:45:32 aztec-1 | [18:45:32.086] INFO: pxe:service Proving completed in 2368.6679909999984ms {"timings":{"total":2368.6679909999984,"sync":30.464452000000165,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":75.0451490000014,"oracles":{"callPrivateFunction":{"times":[731.4251030000014,100.25677999999971,45.91402399999788]}}},{"functionName":"private_kernel_init","time":75.26845500000127},{"functionName":"ContractClassRegisterer:register","time":716.1134139999958,"oracles":{"loadCapsule":{"times":[2.618865000000369]},"notifyCreatedNullifier":{"times":[0.4231930000023567]},"debugLog":{"times":[0.14889499999844702]},"notifyCreatedContractClassLog":{"times":[8.538554999999178]}}},{"functionName":"private_kernel_inner","time":149.8599209999993},{"functionName":"ContractInstanceDeployer:deploy","time":56.818526000006386,"oracles":{"storeInExecutionCache":{"times":[0.05530199999702745]},"callPrivateFunction":{"times":[40.186791000000085]},"notifyCreatedNullifier":{"times":[0.15570500000103493]},"debugLog":{"times":[0.0915129999993951]}}},{"functionName":"private_kernel_inner","time":147.91947599999912},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":28.413983999995253,"oracles":{}},{"functionName":"private_kernel_inner","time":152.4341650000024},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":35.70688300000256,"oracles":{"debugLog":{"times":[0.08775300000343123]}}},{"functionName":"private_kernel_inner","time":114.48013699999865},{"functionName":"private_kernel_reset","time":240.1112060000014},{"functionName":"private_kernel_tail","time":98.16440000000148}],"unaccounted":447.8678229999932}} 18:45:32 aztec-1 | [18:45:32.220] INFO: node Received tx 0x1bdd7245b522c8564016844e17d37336384bc0f4df2e1477639be8b9e5c8487a {"txHash":"0x1bdd7245b522c8564016844e17d37336384bc0f4df2e1477639be8b9e5c8487a"} 18:45:32 aztec-1 | [18:45:32.220] INFO: pxe:service Sent transaction 0x1bdd7245b522c8564016844e17d37336384bc0f4df2e1477639be8b9e5c8487a 18:45:32 aztec-1 | [18:45:32.331] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03149155099999916s {"duration":0.03149155099999916,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 18:45:32 aztec-1 | [18:45:32.363] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x0e5f51a2ff290517ad590f4640442112540a00ba3fa855cad22fe14d2b7d808f","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750099992,"version":3676816240},"txHashes":["0x1bdd7245b522c8564016844e17d37336384bc0f4df2e1477639be8b9e5c8487a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":71.71209400000225,"publicProcessDuration":31.633585999999923,"rollupCircuitsDuration":65.36341199999879,"txCount":1,"blockNumber":6,"blockTimestamp":1750099992,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:45:32 aztec-1 | [18:45:32.589] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 18:45:32 aztec-1 | [18:45:32.591] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 18:45:32 aztec-1 | [18:45:32.593] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 18:45:32 aztec-1 | [18:45:32.603] WARN: archiver Failed to reach L2 block 6 at 35 (latest is 5). Rolling back last synched L1 block number to 34. {"latestLocalL2BlockNumber":5,"latestLocalL2BlockArchive":"0x145a965e020133913d4d03dc6e14e361fcfb4af3ac661471db67873127f3a8a6","blocksSynchedTo":34,"currentL1BlockNumber":35,"provenBlockNumber":5,"provenArchive":"0x145a965e020133913d4d03dc6e14e361fcfb4af3ac661471db67873127f3a8a6","pendingBlockNumber":6,"pendingArchive":"0x188976b46799cc51d822fbc5839d1ca92b23eae54e840caa38a3f36ff4cea2fc"} 18:45:32 aztec-1 | [18:45:32.626] WARN: ethereum:cheat_codes Warped L1 timestamp to 1750100028 18:45:32 aztec-1 | [18:45:32.627] WARN: foundation:test-date-provider Time set to 2025-06-16T18:53:48.000Z {"offset":495373,"timeMs":1750100028000} 18:45:32 aztec-1 | [18:45:32.627] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 18:45:32 aztec-1 | [18:45:32.723] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x0e5f51a2ff290517ad590f4640442112540a00ba3fa855cad22fe14d2b7d808f","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1750099992,"version":3676816240},"archiveRoot":"0x188976b46799cc51d822fbc5839d1ca92b23eae54e840caa38a3f36ff4cea2fc","archiveNextLeafIndex":7} 18:45:32 aztec-1 | [18:45:32.728] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 18:45:32 aztec-1 | [18:45:32.759] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":21.905867000001308,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1750099992,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 18:45:33 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 18:45:33 aztec-1 | [18:45:33.236] INFO: aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed. 18:45:33 aztec-1 | [18:45:33.242] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x1364306bc239ce640d30bd96c0c11b8e465dc7cb1c11babdeed8256c84934bdc","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"} 18:45:42 box-1 | \ 18:45:42 box-1 | Running 1 test using 1 worker 18:45:42 box-1 | 18:45:42 box-1 | 1 [chromium] › browser.spec.ts:3:1 › test