Parent Log: http://ci.aztec-labs.com/308e04cfcea07bcf Command: 804ef67700b4328b playground/scripts/run_test.sh firefox Commit: https://github.com/AztecProtocol/aztec-packages/commit/30660269b33bab8cca354c41659533acf4d48e07 Env: REF_NAME=gh-readonly-queue/next/pr-15026-d96baf1c44329e8b2e3a432ad803f702f5184a62 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 13 09:38:59 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15026_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_23123200780498f7_next 09:38:59 Network playground-firefox_default Creating 09:38:59 Network playground-firefox_default Created 09:38:59 Container playground-firefox-ethereum-1 Creating 09:39:00 Container playground-firefox-ethereum-1 Created 09:39:00 Container playground-firefox-aztec-1 Creating 09:39:00 Container playground-firefox-aztec-1 Created 09:39:00 Container playground-firefox-playground-1 Creating 09:39:00 Container playground-firefox-playground-1 Created 09:39:00 Attaching to aztec-1, ethereum-1, playground-1 09:39:05 aztec-1 | 09:39:05 aztec-1 | _ 09:39:05 aztec-1 | /\ | | 09:39:05 aztec-1 | / \ ___| |_ ___ ___ 09:39:05 aztec-1 | / /\ \ |_ / __/ _ \/ __| 09:39:05 aztec-1 | / ____ \ / /| || __/ (__ 09:39:05 aztec-1 | /_/___ \_\/___|\__\___|\___| 09:39:05 aztec-1 | 09:39:05 aztec-1 | https://github.com/AztecProtocol 09:39:05 aztec-1 | 09:39:05 aztec-1 | 09:39:05 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by... 09:39:05 aztec-1 | Setting up test accounts 09:39:07 aztec-1 | [09:39:06.365] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-LcVfhq/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 09:39:07 aztec-1 | [09:39:06.640] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 09:39:07 aztec-1 | [09:39:06.644] WARN: sandbox Set block interval to 12 09:39:07 aztec-1 | [09:39:06.835] INFO: sandbox Waiting for 7 transactions to be mined... 09:39:07 aztec-1 | [09:39:06.857] INFO: sandbox All transactions mined successfully 09:39:07 aztec-1 | [09:39:06.944] INFO: sandbox Waiting for 9 transactions to be mined... 09:39:07 aztec-1 | [09:39:06.971] INFO: sandbox All transactions mined successfully 09:39:07 aztec-1 | [09:39:07.110] INFO: sandbox Waiting for 11 transactions to be mined... 09:39:07 aztec-1 | [09:39:07.138] INFO: sandbox All transactions mined successfully 09:39:07 aztec-1 | [09:39:07.214] INFO: sandbox Waiting for 12 transactions to be mined... 09:39:07 aztec-1 | [09:39:07.240] INFO: sandbox All transactions mined successfully 09:39:07 aztec-1 | [09:39:07.245] INFO: sandbox Waiting for 12 transactions to be mined... 09:39:07 aztec-1 | [09:39:07.268] INFO: sandbox All transactions mined successfully 09:39:07 aztec-1 | [09:39:07.286] INFO: sandbox Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 09:39:07 aztec-1 | [09:39:07.286] INFO: sandbox Handing over to governance 09:39:07 aztec-1 | [09:39:07.294] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 09:39:07 aztec-1 | [09:39:07.295] INFO: telemetry:client Using NoopTelemetryClient 09:39:07 aztec-1 | [09:39:07.295] INFO: blob-sink:client Creating local blob sink client. 09:39:07 aztec-1 | [09:39:07.300] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:39:07 aztec-1 | [09:39:07.300] WARN: foundation:test-date-provider Time set to 2025-06-13T09:43:49.000Z {"offset":281700,"timeMs":1749807829000} 09:39:07 aztec-1 | [09:39:07.328] INFO: archiver:lmdb Starting data store with maxReaders 16 09:39:07 aztec-1 | [09:39:07.740] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0xe25a31366c26a0223c31cfd519abac4a0af570242108452dbaffa3027dc2f3a6 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x38c5e2addaa1c1c9580e021805e038aa6154897618ff24f95911c4073bfe836b","l1BlockNumber":20}} 09:39:07 aztec-1 | [09:39:07.759] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0xe25a31366c26a0223c31cfd519abac4a0af570242108452dbaffa3027dc2f3a6","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 09:39:07 aztec-1 | [09:39:07.766] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-uNnHQR/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 09:39:07 aztec-1 | [09:39:07.958] INFO: world_state Created world state synchroniser with block history of 64 09:39:07 aztec-1 | [09:39:07.958] WARN: node Aztec node is accepting fake proofs 09:39:07 aztec-1 | [09:39:07.967] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 09:39:07 aztec-1 | [09:39:07.980] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 09:39:07 aztec-1 | [09:39:07.992] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 09:39:08 aztec-1 | [09:39:08.004] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 09:39:08 aztec-1 | [09:39:08.007] INFO: world_state Started world state synchronizer from block 1 09:39:08 aztec-1 | [09:39:08.012] INFO: p2p Starting p2p client from block 0 with empty mempools 09:39:08 aztec-1 | [09:39:08.284] INFO: epoch-prune-watcher EpochPruneWatcher initialized 09:39:08 aztec-1 | [09:39:08.351] INFO: slasher Starting Slasher client... 09:39:08 aztec-1 | [09:39:08.366] INFO: sequencer-client Deploying forwarder contract 09:39:08 aztec-1 | [09:39:08.396] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 09:39:08 aztec-1 | [09:39:08.407] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 09:39:08 aztec-1 | [09:39:08.408] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":50,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":true} 09:39:08 aztec-1 | [09:39:08.410] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 09:39:08 aztec-1 | [09:39:08.411] INFO: node Aztec Node version: 0.87.6 09:39:08 aztec-1 | [09:39:08.411] INFO: node Aztec Node started on chain 0x7a69 {"rollupAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","inboxAddress":"0x4374eecaad0dcaa149cffc160d5a0552b1d092b0","outboxAddress":"0x44bf2a9217a2970a1bcc7529bf1d40828c594320","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","feeJuicePortalAddress":"0xa0719ec6accbac2301f88bc71e2f5ddc8c29149b","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","slashFactoryAddress":"0x59b670e9fa9d0a427751af201d676719a970857b","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 09:39:08 aztec-1 | [09:39:08.416] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:39:08 aztec-1 | [09:39:08.432] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 09:39:08 aztec-1 | [09:39:08.499] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 09:39:08 aztec-1 | [09:39:08.549] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:39:08 aztec-1 | [09:39:08.549] WARN: foundation:test-date-provider Time set to 2025-06-13T09:44:01.000Z {"offset":292451,"timeMs":1749807841000} 09:39:08 aztec-1 | Setting up funded test accounts... 09:39:08 aztec-1 | [09:39:08.783] INFO: pxe:service Started PXE connected to chain 31337 version 2094187016 09:39:08 aztec-1 | [09:39:08.860] INFO: pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 09:39:08 aztec-1 | [09:39:08.933] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 09:39:08 aztec-1 | [09:39:08.935] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 09:39:09 aztec-1 | [09:39:09.082] INFO: pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:39:12 aztec-1 | [09:39:11.595] INFO: pxe:service Proving completed in 2482.1221259999993ms {"timings":{"total":2482.1221259999993,"sync":4.791291999999885,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":141.3816450000004,"oracles":{"callPrivateFunction":{"times":[838.1573630000003,355.5049429999999,170.54355700000087]}}},{"functionName":"private_kernel_init","time":86.29371800000081},{"functionName":"ContractClassRegisterer:register","time":818.5544149999996,"oracles":{"loadCapsule":{"times":[38.879611999999725]},"notifyCreatedNullifier":{"times":[1.659931999998662]},"debugLog":{"times":[0.8198260000008304]},"notifyCreatedContractClassLog":{"times":[7.533575999999812]}}},{"functionName":"private_kernel_inner","time":129.6909969999997},{"functionName":"SchnorrAccount:constructor","time":325.28974799999924,"oracles":{"getContractInstance":{"times":[2.694381000001158]},"debugLog":{"times":[0.18603299999995215,0.20110399999975925]},"fetchTaggedLogs":{"times":[74.64840299999923]},"loadCapsule":{"times":[1.2002030000003288,0.35764600000038627,0.2978460000013001]},"validateEnqueuedNotesAndEvents":{"times":[6.262181000000055]},"notifyCreatedNullifier":{"times":[0.22332400000050256,0.23179499999969266]},"notifyCreatedNote":{"times":[0.5348709999998391]},"getRandomField":{"times":[0.4495090000000346,0.23686500000076194,0.1246129999999539,0.09903200000007928,0.10449200000039127,0.25556499999947846,0.09010200000011537,0.04691099999945436,0.11441200000081153,0.14167300000008254,0.047190999999656924]},"getIndexedTaggingSecretAsSender":{"times":[40.73062799999934]},"incrementAppTaggingSecretIndexAsSender":{"times":[20.29453199999989]}}},{"functionName":"private_kernel_inner","time":112.9498339999991},{"functionName":"SchnorrAccount:entrypoint","time":149.967799,"oracles":{"debugLog":{"times":[0.1854830000011134,0.0924219999997149,0.3250269999989541]},"fetchTaggedLogs":{"times":[42.30779799999982]},"loadCapsule":{"times":[0.20106399999895075,0.17976400000043213,0.1710240000011254]},"validateEnqueuedNotesAndEvents":{"times":[5.690010000000257]},"getNotes":{"times":[2.202143000000433]},"getAuthWitness":{"times":[0.3131970000013098]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.0181990000000951]}}},{"functionName":"private_kernel_inner","time":99.66997699999956},{"functionName":"private_kernel_reset","time":160.65686600000117},{"functionName":"private_kernel_tail","time":62.69781200000034}],"unaccounted":390.1780229999995}} 09:39:12 aztec-1 | [09:39:11.700] INFO: node Received tx 0x281ef66857e6465f2d385c0a8ae86da503b64d4b79e74adb9a96a1f2055a44d0 {"txHash":"0x281ef66857e6465f2d385c0a8ae86da503b64d4b79e74adb9a96a1f2055a44d0"} 09:39:12 aztec-1 | [09:39:11.700] INFO: pxe:service Sent transaction 0x281ef66857e6465f2d385c0a8ae86da503b64d4b79e74adb9a96a1f2055a44d0 09:39:12 aztec-1 | [09:39:11.814] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.049700769999999464s {"duration":0.049700769999999464,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 09:39:12 aztec-1 | [09:39:11.849] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x3040c1b77f151b622aff21d1722f30e46e7f10b08694cd170679ec8cf5d10c7d","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807853,"version":2094187016},"txHashes":["0x281ef66857e6465f2d385c0a8ae86da503b64d4b79e74adb9a96a1f2055a44d0"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":96.3630630000007,"publicProcessDuration":50.47488599999997,"rollupCircuitsDuration":87.80376699999943,"txCount":1,"blockNumber":1,"blockTimestamp":1749807853,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:39:15 aztec-1 | [09:39:14.277] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 09:39:15 aztec-1 | [09:39:14.280] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 09:39:15 aztec-1 | [09:39:14.282] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:15 aztec-1 | [09:39:14.284] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749807889 09:39:15 aztec-1 | [09:39:14.284] WARN: foundation:test-date-provider Time set to 2025-06-13T09:44:49.000Z {"offset":334716,"timeMs":1749807889000} 09:39:15 aztec-1 | [09:39:14.284] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 09:39:15 aztec-1 | [09:39:14.367] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x3040c1b77f151b622aff21d1722f30e46e7f10b08694cd170679ec8cf5d10c7d","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749807853,"version":2094187016},"archiveRoot":"0x186b2ac82f82b510b95dafa2358be084b754291d2626d73da5b8051825905bdc","archiveNextLeafIndex":2} 09:39:15 aztec-1 | [09:39:14.373] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 09:39:15 aztec-1 | [09:39:14.442] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":20.35934400000042,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749807853,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:39:15 aztec-1 | [09:39:14.552] INFO: pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f 09:39:15 aztec-1 | [09:39:14.664] INFO: pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:39:17 aztec-1 | [09:39:16.232] INFO: pxe:service Proving completed in 1547.9713470000006ms {"timings":{"total":1547.9713470000006,"sync":21.93871500000023,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":104.27642899999955,"oracles":{"callPrivateFunction":{"times":[414.6604759999991,282.6871650000012]}}},{"functionName":"private_kernel_init","time":70.28245900000002},{"functionName":"SchnorrAccount:constructor","time":378.6981199999991,"oracles":{"getContractInstance":{"times":[10.82383899999877]},"debugLog":{"times":[0.13779299999987416,0.1364929999999731]},"fetchTaggedLogs":{"times":[119.4668989999991]},"loadCapsule":{"times":[0.6204830000006041,0.42947800000001735,0.26713500000005297]},"validateEnqueuedNotesAndEvents":{"times":[5.8356130000011035]},"notifyCreatedNullifier":{"times":[0.37731799999892246,0.19303299999955925]},"notifyCreatedNote":{"times":[0.20551400000113063]},"getRandomField":{"times":[0.3167359999988548,0.2619350000004488,0.06988199999977951,0.0581320000001142,0.09111200000006647,0.07247099999949569,0.09162199999991572,0.10483199999907811,0.06281099999978323,0.06916099999943981,0.056570999999166816]},"getIndexedTaggingSecretAsSender":{"times":[60.75146400000085]},"incrementAppTaggingSecretIndexAsSender":{"times":[46.301996000000145]}}},{"functionName":"private_kernel_inner","time":102.74336599999879},{"functionName":"SchnorrAccount:entrypoint","time":252.69806400000198,"oracles":{"debugLog":{"times":[0.2516749999995227,0.11954299999888462,0.19830399999955262]},"fetchTaggedLogs":{"times":[94.24671200000012]},"loadCapsule":{"times":[0.20214300000043295,0.1461619999990944,0.16354300000057265]},"validateEnqueuedNotesAndEvents":{"times":[6.208049999999275]},"getNotes":{"times":[1.2003029999996215]},"getAuthWitness":{"times":[0.23976500000026135]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.5242899999993824]}}},{"functionName":"private_kernel_inner","time":147.75754699999925},{"functionName":"private_kernel_reset","time":156.80211099999906},{"functionName":"private_kernel_tail","time":63.494276999999784}],"unaccounted":249.28025900000284}} 09:39:17 aztec-1 | [09:39:16.283] INFO: node Received tx 0x1c424a1e402eef627d40fd42dfd87637670dc510244b193952926526330a5a3c {"txHash":"0x1c424a1e402eef627d40fd42dfd87637670dc510244b193952926526330a5a3c"} 09:39:17 aztec-1 | [09:39:16.283] INFO: pxe:service Sent transaction 0x1c424a1e402eef627d40fd42dfd87637670dc510244b193952926526330a5a3c 09:39:17 aztec-1 | [09:39:16.372] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01666857300000083s {"duration":0.01666857300000083,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 09:39:17 aztec-1 | [09:39:16.397] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x27315deabeeff2e6420e1040cb468b409f10fcb58da34efcaeb6abad19d11512","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807889,"version":2094187016},"txHashes":["0x1c424a1e402eef627d40fd42dfd87637670dc510244b193952926526330a5a3c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":48.11406999999963,"publicProcessDuration":16.838776000000507,"rollupCircuitsDuration":43.647963999999774,"txCount":1,"blockNumber":2,"blockTimestamp":1749807889,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:17 aztec-1 | [09:39:16.646] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:17 aztec-1 | [09:39:16.665] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:39:17 aztec-1 | [09:39:16.665] WARN: foundation:test-date-provider Time set to 2025-06-13T09:45:01.000Z {"offset":344335,"timeMs":1749807901000} 09:39:17 aztec-1 | [09:39:16.671] 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":"0x186b2ac82f82b510b95dafa2358be084b754291d2626d73da5b8051825905bdc","blocksSynchedTo":26,"currentL1BlockNumber":27,"provenBlockNumber":1,"provenArchive":"0x186b2ac82f82b510b95dafa2358be084b754291d2626d73da5b8051825905bdc","pendingBlockNumber":2,"pendingArchive":"0x1f86f73b958003ec8024c4cce4b53882056b2d541ddaef35bff8916a0ec4b598"} 09:39:17 aztec-1 | [09:39:16.671] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 09:39:17 aztec-1 | [09:39:16.673] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 09:39:17 aztec-1 | [09:39:16.699] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749807925 09:39:17 aztec-1 | [09:39:16.699] WARN: foundation:test-date-provider Time set to 2025-06-13T09:45:25.000Z {"offset":368301,"timeMs":1749807925000} 09:39:17 aztec-1 | [09:39:16.699] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 09:39:17 aztec-1 | [09:39:16.779] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x27315deabeeff2e6420e1040cb468b409f10fcb58da34efcaeb6abad19d11512","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749807889,"version":2094187016},"archiveRoot":"0x1f86f73b958003ec8024c4cce4b53882056b2d541ddaef35bff8916a0ec4b598","archiveNextLeafIndex":3} 09:39:17 aztec-1 | [09:39:16.782] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 09:39:17 aztec-1 | [09:39:16.808] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":18.161340999999084,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749807889,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:17 aztec-1 | [09:39:16.930] INFO: pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 09:39:17 aztec-1 | [09:39:17.068] INFO: pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:39:19 aztec-1 | Initial Accounts: 09:39:19 aztec-1 | 09:39:19 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 09:39:19 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc 09:39:19 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 09:39:19 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 09:39:19 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 09:39:19 aztec-1 | 09:39:19 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 09:39:19 aztec-1 | 09:39:19 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 09:39:19 aztec-1 | 09:39:19 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f 09:39:19 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0 09:39:19 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 09:39:19 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 09:39:19 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 09:39:19 aztec-1 | 09:39:19 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 09:39:19 aztec-1 | 09:39:19 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 09:39:19 aztec-1 | 09:39:19 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 09:39:19 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d 09:39:19 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 09:39:19 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 09:39:19 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 09:39:19 aztec-1 | 09:39:19 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 09:39:19 aztec-1 | 09:39:19 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 09:39:19 aztec-1 | 09:39:19 aztec-1 | 09:39:19 aztec-1 | [09:39:18.648] INFO: pxe:service Proving completed in 1572.4967510000006ms {"timings":{"total":1572.4967510000006,"sync":21.43727399999989,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":110.31776399999944,"oracles":{"callPrivateFunction":{"times":[415.23350799999935,270.7116440000009]}}},{"functionName":"private_kernel_init","time":65.83909299999868},{"functionName":"SchnorrAccount:constructor","time":386.01149199999963,"oracles":{"getContractInstance":{"times":[5.748390999999174]},"debugLog":{"times":[0.13631200000054378,0.10537099999964994]},"fetchTaggedLogs":{"times":[120.59632099999908]},"loadCapsule":{"times":[0.2204650000003312,0.24203399999896646,0.17923400000108813]},"validateEnqueuedNotesAndEvents":{"times":[6.027726000000257]},"notifyCreatedNullifier":{"times":[0.31565600000067207,0.33984699999928125]},"notifyCreatedNote":{"times":[0.14078299999891897]},"getRandomField":{"times":[0.22475400000075751,0.2835660000000644,0.04851099999905273,0.049191999998583924,0.04569100000117032,0.044541000001117936,0.046141000000716303,0.05920200000036857,0.045390999999654014,0.04431099999965227,0.045161000000007334]},"getIndexedTaggingSecretAsSender":{"times":[65.63954899999953]},"incrementAppTaggingSecretIndexAsSender":{"times":[32.73730400000022]}}},{"functionName":"private_kernel_inner","time":93.08265000000029},{"functionName":"SchnorrAccount:entrypoint","time":235.51332300000104,"oracles":{"debugLog":{"times":[0.16385300000001735,0.06806200000028184,0.16954299999997602]},"fetchTaggedLogs":{"times":[91.00182900000073]},"loadCapsule":{"times":[0.1851330000008602,0.13386300000092888,0.16895300000032876]},"validateEnqueuedNotesAndEvents":{"times":[5.969075999999404]},"getNotes":{"times":[10.889709999999468]},"getAuthWitness":{"times":[0.1281330000001617]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.3999370000001363]}}},{"functionName":"private_kernel_inner","time":149.95263899999918},{"functionName":"private_kernel_reset","time":187.0865470000026},{"functionName":"private_kernel_tail","time":66.56928699999844}],"unaccounted":256.6866820000014}} 09:39:19 aztec-1 | [09:39:18.705] INFO: node Received tx 0x2fa2c1c26a5aa781e704185350420d2f69ab0df9132e0fb2073dea2f57ed88b3 {"txHash":"0x2fa2c1c26a5aa781e704185350420d2f69ab0df9132e0fb2073dea2f57ed88b3"} 09:39:19 aztec-1 | [09:39:18.705] INFO: pxe:service Sent transaction 0x2fa2c1c26a5aa781e704185350420d2f69ab0df9132e0fb2073dea2f57ed88b3 09:39:19 aztec-1 | [09:39:18.782] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01878065300000162s {"duration":0.01878065300000162,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 09:39:19 aztec-1 | [09:39:18.805] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2fa9ddeddc355ee491ce6f0ef2b4d51df6f63da1108cc3f7852dac590daca200","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749807925,"version":2094187016},"txHashes":["0x2fa2c1c26a5aa781e704185350420d2f69ab0df9132e0fb2073dea2f57ed88b3"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":48.27004400000078,"publicProcessDuration":18.882375000001048,"rollupCircuitsDuration":43.755355999997846,"txCount":1,"blockNumber":3,"blockTimestamp":1749807925,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:19 aztec-1 | [09:39:18.960] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 09:39:19 aztec-1 | [09:39:18.964] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 09:39:19 aztec-1 | [09:39:18.970] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:19 aztec-1 | [09:39:18.971] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749807961 09:39:19 aztec-1 | [09:39:18.971] WARN: foundation:test-date-provider Time set to 2025-06-13T09:46:01.000Z {"offset":402029,"timeMs":1749807961000} 09:39:19 aztec-1 | [09:39:18.971] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 09:39:19 aztec-1 | [09:39:19.063] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x2fa9ddeddc355ee491ce6f0ef2b4d51df6f63da1108cc3f7852dac590daca200","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749807925,"version":2094187016},"archiveRoot":"0x231e407b5682c9e6c63bb394284a8bb9e89309111529d6fce509c4810453a4b5","archiveNextLeafIndex":4} 09:39:19 aztec-1 | [09:39:19.067] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 09:39:19 aztec-1 | [09:39:19.092] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":15.382047000002785,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749807925,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:39:20 aztec-1 | [09:39:19.984] WARN: pxe:service No artifact found for contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 when looking for its metadata 09:39:20 aztec-1 | [09:39:19.985] WARN: pxe:service No artifact found for contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 when looking for its metadata 09:39:20 aztec-1 | [09:39:19.988] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 as part of deployment for 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 09:39:20 aztec-1 | [09:39:20.021] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 as part of deployment for 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf 09:39:21 aztec-1 | [09:39:20.949] INFO: pxe:service Added contract FPC at 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 with class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 09:39:21 aztec-1 | [09:39:20.955] INFO: pxe:service Added contract Token at 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf with class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 09:39:23 aztec-1 | [09:39:23.068] INFO: pxe:service Proving completed in 2074.5368879999987ms {"timings":{"total":2074.5368879999987,"sync":21.464123000001564,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":327.634401000003,"oracles":{"debugLog":{"times":[0.15835299999889685,0.0711620000001858,0.07984199999918928,0.1657340000019758,0.15421199999764212,0.11919200000193086,0.07117099999959464,0.19586400000116555]},"fetchTaggedLogs":{"times":[111.05248500000016]},"loadCapsule":{"times":[0.21853299999929732,0.14579299999968498,0.2180240000016056,0.19242300000041723,0.22160399999847868,0.16260300000067218,2.4361250000001746]},"getSharedSecret":{"times":[5.610142999998061]},"aes128Decrypt":{"times":[0.8760360000014771,0.4968399999997928]},"getPublicKeysAndPartialAddress":{"times":[1.5592689999975846]},"getKeyValidationRequest":{"times":[1.7689729999983683]},"storeCapsule":{"times":[3.280399999999645,2.944024000000354,2.454424999999901]},"deleteCapsule":{"times":[2.7869619999983115]},"validateEnqueuedNotesAndEvents":{"times":[15.147467000002507]},"getNotes":{"times":[11.471850000001723]},"getAuthWitness":{"times":[0.17667299999811803]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05375199999980396]},"callPrivateFunction":{"times":[653.0558249999995,146.4414230000002]},"notifyEnqueuedPublicFunctionCall":{"times":[0.30135599999994156]}}},{"functionName":"private_kernel_init","time":50.576436999999714},{"functionName":"ContractClassRegisterer:register","time":635.4400129999995,"oracles":{"loadCapsule":{"times":[2.6275280000008934]},"notifyCreatedNullifier":{"times":[0.3843669999987469]},"debugLog":{"times":[0.09771200000250246]},"notifyCreatedContractClassLog":{"times":[5.068522999998095]}}},{"functionName":"private_kernel_inner","time":100.44374999999854},{"functionName":"ContractInstanceDeployer:deploy","time":89.74965399999928,"oracles":{"storeInExecutionCache":{"times":[0.39155699999901117]},"callPrivateFunction":{"times":[47.711035000000265]},"notifyCreatedNullifier":{"times":[0.2197840000008]},"debugLog":{"times":[0.10422200000175508]}}},{"functionName":"private_kernel_inner","time":90.99668700000257},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":38.17153999999937,"oracles":{}},{"functionName":"private_kernel_inner","time":129.55227399999785},{"functionName":"private_kernel_reset","time":175.7559199999996},{"functionName":"private_kernel_tail","time":72.21954300000289}],"unaccounted":342.5325459999949}} 09:39:23 aztec-1 | [09:39:23.190] INFO: node Received tx 0x18f7b5c69acbbb8e3569cad9fece92f961eecd70083bacf01f21c3822aa83ea8 {"txHash":"0x18f7b5c69acbbb8e3569cad9fece92f961eecd70083bacf01f21c3822aa83ea8"} 09:39:23 aztec-1 | [09:39:23.190] INFO: pxe:service Sent transaction 0x18f7b5c69acbbb8e3569cad9fece92f961eecd70083bacf01f21c3822aa83ea8 09:39:24 aztec-1 | [09:39:24.351] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.0563361430000004s {"duration":1.0563361430000004,"rate":39063.32304678131,"totalPublicGas":{"daGas":4096,"l2Gas":41264},"totalBlockGas":{"daGas":166912,"l2Gas":66306},"totalSizeInBytes":10688} 09:39:24 aztec-1 | [09:39:24.517] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 33538.898316163584 mana/s {"blockHash":"0x12b258f10f317f8546918b5092f08fe27de5be40e2ac22aad6296ab9e0ef1046","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749807961,"version":2094187016},"txHashes":["0x18f7b5c69acbbb8e3569cad9fece92f961eecd70083bacf01f21c3822aa83ea8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1230.2641089999997,"publicProcessDuration":1056.5190760000005,"rollupCircuitsDuration":1223.616987999998,"txCount":1,"blockNumber":4,"blockTimestamp":1749807961,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296} 09:39:25 aztec-1 | [09:39:25.347] INFO: pxe:service Proving completed in 2277.7936519999967ms {"timings":{"total":2277.7936519999967,"sync":93.9188209999993,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":304.4813389999945,"oracles":{"debugLog":{"times":[0.15649199999825214,0.07319099999949685,0.09468100000231061,0.1152220000003581,0.0688910000026226,0.10291200000210665,0.0891620000002149,0.1107719999999972]},"fetchTaggedLogs":{"times":[117.79266800000187]},"loadCapsule":{"times":[0.1808130000026722,0.6015210000005027,0.24144400000295718,0.24242400000002817,0.834685999998328,0.1628729999974894,0.17662299999938114]},"getSharedSecret":{"times":[3.8169699999998556]},"aes128Decrypt":{"times":[0.23992399999769987,0.7182839999986754]},"getPublicKeysAndPartialAddress":{"times":[2.3503430000018852]},"getKeyValidationRequest":{"times":[1.9873660000012023]},"storeCapsule":{"times":[18.02520000000004,3.3248810000004596,2.444564999997965]},"deleteCapsule":{"times":[2.7367900000026566]},"validateEnqueuedNotesAndEvents":{"times":[11.73513499999899]},"getNotes":{"times":[1.568967999999586]},"getAuthWitness":{"times":[0.1843529999969178]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.041321000000607455]},"callPrivateFunction":{"times":[561.1658719999978,109.62597900000037]},"notifyEnqueuedPublicFunctionCall":{"times":[0.0671409999995376]}}},{"functionName":"private_kernel_init","time":67.08223899999939},{"functionName":"ContractClassRegisterer:register","time":548.7584940000015,"oracles":{"loadCapsule":{"times":[1.5482879999981378]},"notifyCreatedNullifier":{"times":[0.34155599999940023]},"debugLog":{"times":[0.10565299999871058]},"notifyCreatedContractClassLog":{"times":[2.9149539999998524]}}},{"functionName":"private_kernel_inner","time":100.93868999999904},{"functionName":"ContractInstanceDeployer:deploy","time":67.28927199999816,"oracles":{"storeInExecutionCache":{"times":[0.07020099999863305]},"callPrivateFunction":{"times":[47.29035600000134]},"notifyCreatedNullifier":{"times":[0.42864799999733805]},"debugLog":{"times":[0.14543199999752687]}}},{"functionName":"private_kernel_inner","time":122.64379800000097},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":28.264238000003388,"oracles":{}},{"functionName":"private_kernel_inner","time":118.01961200000005},{"functionName":"private_kernel_reset","time":244.10022299999764},{"functionName":"private_kernel_tail","time":118.28374800000165}],"unaccounted":464.01317800000106}} 09:39:25 aztec-1 | [09:39:25.679] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:25 aztec-1 | [09:39:25.681] INFO: node Received tx 0x0b824c6d258654e3ce59f480193e17875b14e3602b3c3dd158ddde3747cb29d9 {"txHash":"0x0b824c6d258654e3ce59f480193e17875b14e3602b3c3dd158ddde3747cb29d9"} 09:39:25 aztec-1 | [09:39:25.681] INFO: pxe:service Sent transaction 0x0b824c6d258654e3ce59f480193e17875b14e3602b3c3dd158ddde3747cb29d9 09:39:25 aztec-1 | [09:39:25.747] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:39:25 aztec-1 | error: "Rollup__SlotAlreadyInChain(5, 5)" 09:39:25 aztec-1 | [09:39:25.747] WARN: sequencer Cannot propose block 4 at slot 5 due to failed rollup contract check 09:39:25 aztec-1 | [09:39:25.814] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:39:25 aztec-1 | error: "Rollup__SlotAlreadyInChain(5, 5)" 09:39:25 aztec-1 | [09:39:25.814] WARN: sequencer Cannot propose block 4 at slot 5 due to failed rollup contract check 09:39:25 aztec-1 | [09:39:25.814] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x12b258f10f317f8546918b5092f08fe27de5be40e2ac22aad6296ab9e0ef1046","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749807961,"version":2094187016},"archiveRoot":"0x19f33e0eaa4d14170f907074a463ddc9675b70ca20c5d91628057579f031df4a","archiveNextLeafIndex":5} 09:39:25 aztec-1 | [09:39:25.852] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:39:25 aztec-1 | [09:39:25.852] WARN: foundation:test-date-provider Time set to 2025-06-13T09:46:13.000Z {"offset":407148,"timeMs":1749807973000} 09:39:25 aztec-1 | [09:39:25.853] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 09:39:25 aztec-1 | [09:39:25.855] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 09:39:25 aztec-1 | [09:39:25.857] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749807997 09:39:25 aztec-1 | [09:39:25.857] WARN: foundation:test-date-provider Time set to 2025-06-13T09:46:37.000Z {"offset":431143,"timeMs":1749807997000} 09:39:25 aztec-1 | [09:39:25.858] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 09:39:25 aztec-1 | [09:39:25.882] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":19.60403899999801,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749807961,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296} 09:39:25 aztec-1 | [09:39:25.895] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 09:39:26 aztec-1 | [09:39:26.214] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.27595778599999904s {"duration":0.27595778599999904,"rate":1201085.8791279083,"totalPublicGas":{"daGas":10240,"l2Gas":331449},"totalBlockGas":{"daGas":380928,"l2Gas":356491},"totalSizeInBytes":24064} 09:39:26 aztec-1 | [09:39:26.274] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 967353.7284296503 mana/s {"blockHash":"0x1470e8ad80a21c99b64042e4b814901c94e8b6cfcfe94eef107225d37b5a4054","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749807997,"version":2094187016},"txHashes":["0x0b824c6d258654e3ce59f480193e17875b14e3602b3c3dd158ddde3747cb29d9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":342.60514700000203,"publicProcessDuration":276.17969000000085,"rollupCircuitsDuration":338.2539880000004,"txCount":1,"blockNumber":5,"blockTimestamp":1749807997,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 09:39:26 aztec-1 | [09:39:26.558] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 09:39:26 aztec-1 | [09:39:26.561] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 09:39:26 aztec-1 | [09:39:26.599] INFO: aztecjs:deploy_sent_tx Contract 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 successfully deployed. 09:39:26 aztec-1 | [09:39:26.601] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:26 aztec-1 | [09:39:26.607] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749808033 09:39:26 aztec-1 | [09:39:26.607] WARN: foundation:test-date-provider Time set to 2025-06-13T09:47:13.000Z {"offset":466393,"timeMs":1749808033000} 09:39:26 aztec-1 | [09:39:26.607] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 09:39:26 aztec-1 | [09:39:26.732] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x1470e8ad80a21c99b64042e4b814901c94e8b6cfcfe94eef107225d37b5a4054","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749807997,"version":2094187016},"archiveRoot":"0x238faa8925e8c66b96e306a2506859b3278dc13e10f1ca67f6e5614695488c1f","archiveNextLeafIndex":6} 09:39:26 aztec-1 | [09:39:26.737] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 09:39:26 aztec-1 | [09:39:26.803] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":18.965768000001844,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749807997,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 09:39:27 aztec-1 | BananaCoin: 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf 09:39:27 aztec-1 | FPC: 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 09:39:28 aztec-1 | [09:39:27.933] INFO: aztecjs:deploy_sent_tx Contract 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf successfully deployed. 09:39:28 aztec-1 | [09:39:27.957] WARN: pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata 09:39:28 aztec-1 | [09:39:27.959] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 09:39:28 aztec-1 | [09:39:28.076] INFO: pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e 09:39:30 aztec-1 | [09:39:30.263] INFO: pxe:service Proving completed in 2174.3658170000017ms {"timings":{"total":2174.3658170000017,"sync":36.56941999999981,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":61.80339500000264,"oracles":{"callPrivateFunction":{"times":[731.9854110000015,99.24961800000165,57.3179999999993]}}},{"functionName":"private_kernel_init","time":75.92523099999744},{"functionName":"ContractClassRegisterer:register","time":721.8376549999994,"oracles":{"loadCapsule":{"times":[2.7050190000009025]},"notifyCreatedNullifier":{"times":[0.33851599999979953]},"debugLog":{"times":[0.1548129999973753]},"notifyCreatedContractClassLog":{"times":[5.112863999998808]}}},{"functionName":"private_kernel_inner","time":121.76619100000244},{"functionName":"ContractInstanceDeployer:deploy","time":59.61680200000046,"oracles":{"storeInExecutionCache":{"times":[0.05516100000022561]},"callPrivateFunction":{"times":[48.003600000000006]},"notifyCreatedNullifier":{"times":[0.2778250000010303]},"debugLog":{"times":[0.1376120000022638]}}},{"functionName":"private_kernel_inner","time":104.82674100000077},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":30.912115999999514,"oracles":{}},{"functionName":"private_kernel_inner","time":95.34188699999868},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":47.822165000001405,"oracles":{"debugLog":{"times":[0.14764300000024377]}}},{"functionName":"private_kernel_inner","time":111.44330099999934},{"functionName":"private_kernel_reset","time":202.55683099999806},{"functionName":"private_kernel_tail","time":81.80278799999724}],"unaccounted":422.14129400000456}} 09:39:30 aztec-1 | [09:39:30.365] INFO: node Received tx 0x29622f880061abfa1a44dc0ad256ba0b66020fa372d007402c7750514a26f266 {"txHash":"0x29622f880061abfa1a44dc0ad256ba0b66020fa372d007402c7750514a26f266"} 09:39:30 aztec-1 | [09:39:30.365] INFO: pxe:service Sent transaction 0x29622f880061abfa1a44dc0ad256ba0b66020fa372d007402c7750514a26f266 09:39:30 aztec-1 | [09:39:30.470] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.032129758999999466s {"duration":0.032129758999999466,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 09:39:30 aztec-1 | [09:39:30.496] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x17f6961ff85e9db4972a80c913972b14dad4bf0321252ca788821718a28fdd9d","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749808033,"version":2094187016},"txHashes":["0x29622f880061abfa1a44dc0ad256ba0b66020fa372d007402c7750514a26f266"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":64.95686999999816,"publicProcessDuration":32.28295100000105,"rollupCircuitsDuration":59.58520200000203,"txCount":1,"blockNumber":6,"blockTimestamp":1749808033,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:39:30 aztec-1 | [09:39:30.727] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 09:39:30 aztec-1 | [09:39:30.731] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 09:39:30 aztec-1 | [09:39:30.732] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:39:30 aztec-1 | [09:39:30.787] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749808069 09:39:30 aztec-1 | [09:39:30.787] WARN: foundation:test-date-provider Time set to 2025-06-13T09:47:49.000Z {"offset":498213,"timeMs":1749808069000} 09:39:30 aztec-1 | [09:39:30.787] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 09:39:30 aztec-1 | [09:39:30.852] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x17f6961ff85e9db4972a80c913972b14dad4bf0321252ca788821718a28fdd9d","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749808033,"version":2094187016},"archiveRoot":"0x26ffc1cf12e4948d7bf8ab9df924661fe7a5f434ffefdd5b3f522e5465e49bd0","archiveNextLeafIndex":7} 09:39:30 aztec-1 | [09:39:30.857] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 09:39:30 aztec-1 | [09:39:30.884] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":18.632510999999795,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749808033,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:39:31 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 09:39:31 aztec-1 | [09:39:31.380] INFO: aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed. 09:39:31 aztec-1 | [09:39:31.389] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x2d2655c513c2e8feb8c7411b7e807c66287b57bb60572ce85ce1fe0a1e0c925d","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"} 09:39:36 playground-1 | \ 09:39:36 playground-1 | Running 1 test using 1 worker 09:39:36 playground-1 | 09:39:36 playground-1 | ✓ 1 [firefox] › browser.spec.ts:3:1 › test (13.4s) 09:39:54 playground-1 | 1 passed (18.9s) 09:39:54 playground-1 | \ 09:39:54 playground-1 exited with code 0 09:39:54 Aborting on container exit... 09:39:54 Container playground-firefox-playground-1 Stopping 09:39:54 Container playground-firefox-playground-1 Stopped 09:39:54 Container playground-firefox-aztec-1 Stopping 09:39:55 Container playground-firefox-aztec-1 Stopped 09:39:55 Container playground-firefox-ethereum-1 Stopping 09:39:55 Container playground-firefox-ethereum-1 Stopped