Parent Log: http://ci.aztec-labs.com/38d1899c9cb6c2c4 Command: ab85ca62a97026c0 playground/scripts/run_test.sh webkit Commit: https://github.com/AztecProtocol/aztec-packages/commit/517501b8b3c82d562e946c782c8fe75426951f62 Env: REF_NAME=gh-readonly-queue/next/pr-15016-a8c553f203c98e5ca274e763c8e51daaaaf760d6 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 13 09:56:32 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15016_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_4f5ae3bf6a603dd3_next 09:56:33 Network playground-webkit_default Creating 09:56:33 Network playground-webkit_default Created 09:56:33 Container playground-webkit-ethereum-1 Creating 09:56:34 Container playground-webkit-ethereum-1 Created 09:56:34 Container playground-webkit-aztec-1 Creating 09:56:34 Container playground-webkit-aztec-1 Created 09:56:34 Container playground-webkit-playground-1 Creating 09:56:35 Container playground-webkit-playground-1 Created 09:56:35 Attaching to aztec-1, ethereum-1, playground-1 09:56:40 aztec-1 | 09:56:40 aztec-1 | _ 09:56:40 aztec-1 | /\ | | 09:56:40 aztec-1 | / \ ___| |_ ___ ___ 09:56:40 aztec-1 | / /\ \ |_ / __/ _ \/ __| 09:56:40 aztec-1 | / ____ \ / /| || __/ (__ 09:56:40 aztec-1 | /_/___ \_\/___|\__\___|\___| 09:56:40 aztec-1 | 09:56:40 aztec-1 | https://github.com/AztecProtocol 09:56:40 aztec-1 | 09:56:40 aztec-1 | 09:56:40 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by... 09:56:40 aztec-1 | Setting up test accounts 09:56:42 aztec-1 | [09:56:41.467] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-j4k8Ia/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 09:56:42 aztec-1 | [09:56:41.702] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 09:56:42 aztec-1 | [09:56:41.706] WARN: sandbox Set block interval to 12 09:56:42 aztec-1 | [09:56:41.916] INFO: sandbox Waiting for 7 transactions to be mined... 09:56:42 aztec-1 | [09:56:41.944] INFO: sandbox All transactions mined successfully 09:56:42 aztec-1 | [09:56:42.044] INFO: sandbox Waiting for 9 transactions to be mined... 09:56:42 aztec-1 | [09:56:42.064] INFO: sandbox All transactions mined successfully 09:56:42 aztec-1 | [09:56:42.206] INFO: sandbox Waiting for 11 transactions to be mined... 09:56:42 aztec-1 | [09:56:42.232] INFO: sandbox All transactions mined successfully 09:56:42 aztec-1 | [09:56:42.293] INFO: sandbox Waiting for 12 transactions to be mined... 09:56:42 aztec-1 | [09:56:42.316] INFO: sandbox All transactions mined successfully 09:56:42 aztec-1 | [09:56:42.321] INFO: sandbox Waiting for 12 transactions to be mined... 09:56:42 aztec-1 | [09:56:42.341] INFO: sandbox All transactions mined successfully 09:56:42 aztec-1 | [09:56:42.356] 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:56:42 aztec-1 | [09:56:42.356] INFO: sandbox Handing over to governance 09:56:42 aztec-1 | [09:56:42.363] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x3Aa5ebB10DC797CAC828524e59A333d0A371443c 09:56:42 aztec-1 | [09:56:42.363] INFO: telemetry:client Using NoopTelemetryClient 09:56:42 aztec-1 | [09:56:42.364] INFO: blob-sink:client Creating local blob sink client. 09:56:42 aztec-1 | [09:56:42.367] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:56:42 aztec-1 | [09:56:42.368] WARN: foundation:test-date-provider Time set to 2025-06-13T10:01:24.000Z {"offset":281633,"timeMs":1749808884000} 09:56:42 aztec-1 | [09:56:42.394] INFO: archiver:lmdb Starting data store with maxReaders 16 09:56:42 aztec-1 | [09:56:42.746] INFO: archiver Starting archiver sync to rollup contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c from L1 block 20 to current L1 block 24 with hash 0x20992f974faba71677bee6a426ec52d6a944006bf5be50dc9a05753a1f3aa199 {"blocksSynchedTo":20,"messagesSynchedTo":{"l1BlockHash":"0x3eb172f6c39dbb16816febbc5cda98977a5abe6a2cf709093067a7da624a2b6f","l1BlockNumber":20}} 09:56:42 aztec-1 | [09:56:42.776] INFO: archiver Initial archiver sync to L1 block 24 complete. {"l1BlockNumber":24,"syncPoint":{"blocksSynchedTo":24,"messagesSynchedTo":{"l1BlockHash":"0x20992f974faba71677bee6a426ec52d6a944006bf5be50dc9a05753a1f3aa199","l1BlockNumber":24}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 09:56:43 aztec-1 | [09:56:42.785] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-pZGe4n/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 09:56:43 aztec-1 | [09:56:43.001] INFO: world_state Created world state synchroniser with block history of 64 09:56:43 aztec-1 | [09:56:43.001] WARN: node Aztec node is accepting fake proofs 09:56:43 aztec-1 | [09:56:43.009] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 09:56:43 aztec-1 | [09:56:43.020] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 09:56:43 aztec-1 | [09:56:43.033] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 09:56:43 aztec-1 | [09:56:43.044] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 09:56:43 aztec-1 | [09:56:43.048] INFO: world_state Started world state synchronizer from block 1 09:56:43 aztec-1 | [09:56:43.053] INFO: p2p Starting p2p client from block 0 with empty mempools 09:56:43 aztec-1 | [09:56:43.349] INFO: epoch-prune-watcher EpochPruneWatcher initialized 09:56:43 aztec-1 | [09:56:43.407] INFO: slasher Starting Slasher client... 09:56:43 aztec-1 | [09:56:43.417] INFO: sequencer-client Deploying forwarder contract 09:56:43 aztec-1 | [09:56:43.439] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 09:56:43 aztec-1 | [09:56:43.447] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 09:56:43 aztec-1 | [09:56:43.447] 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:56:43 aztec-1 | [09:56:43.449] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 09:56:43 aztec-1 | [09:56:43.450] INFO: node Aztec Node version: 0.87.6 09:56:43 aztec-1 | [09:56:43.450] 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:56:43 aztec-1 | [09:56:43.453] INFO: pxe:data:lmdb Starting data store with maxReaders 16 09:56:43 aztec-1 | [09:56:43.467] 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:56:43 aztec-1 | [09:56:43.535] 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:56:43 aztec-1 | [09:56:43.694] 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:56:43 aztec-1 | [09:56:43.701] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:56:43 aztec-1 | [09:56:43.701] WARN: foundation:test-date-provider Time set to 2025-06-13T10:01:36.000Z {"offset":292299,"timeMs":1749808896000} 09:56:43 aztec-1 | Setting up funded test accounts... 09:56:43 aztec-1 | [09:56:43.854] INFO: pxe:service Started PXE connected to chain 31337 version 2094187016 09:56:43 aztec-1 | [09:56:43.936] INFO: pxe:service Registered account 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 09:56:44 aztec-1 | [09:56:44.005] WARN: pxe:service No artifact found for contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 when looking for its metadata 09:56:44 aztec-1 | [09:56:44.008] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 as part of deployment for 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 09:56:44 aztec-1 | [09:56:44.168] INFO: pxe:service Added contract SchnorrAccount at 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:56:47 aztec-1 | [09:56:47.119] INFO: pxe:service Proving completed in 2916.042480000001ms {"timings":{"total":2916.042480000001,"sync":4.776839000000109,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":184.91169499999796,"oracles":{"callPrivateFunction":{"times":[871.3080410000002,411.03443700000025,231.18788800000038]}}},{"functionName":"private_kernel_init","time":100.35288000000037},{"functionName":"ContractClassRegisterer:register","time":837.3681860000006,"oracles":{"loadCapsule":{"times":[12.538402000000133]},"notifyCreatedNullifier":{"times":[23.693320000000313]},"debugLog":{"times":[0.991745000001174]},"notifyCreatedContractClassLog":{"times":[9.306022000000667]}}},{"functionName":"private_kernel_inner","time":134.08650899999884},{"functionName":"SchnorrAccount:constructor","time":379.22868599999856,"oracles":{"getContractInstance":{"times":[1.7878340000006574]},"debugLog":{"times":[0.33830899999884423,0.12947299999905226]},"fetchTaggedLogs":{"times":[80.70480099999986]},"loadCapsule":{"times":[0.5071530000004714,0.3235979999990377,0.23459599999841885]},"validateEnqueuedNotesAndEvents":{"times":[8.46270099999856]},"notifyCreatedNullifier":{"times":[0.3720599999996921,0.34111899999879824]},"notifyCreatedNote":{"times":[1.0241659999992407]},"getRandomField":{"times":[0.35829999999987194,0.2366860000001907,0.11222300000008545,0.12451299999884213,0.23687599999902886,0.0868529999988823,0.057031000000279164,0.041771000000153435,0.15784400000120513,0.08037200000035227,0.04889200000070559]},"getIndexedTaggingSecretAsSender":{"times":[60.167677999999796]},"incrementAppTaggingSecretIndexAsSender":{"times":[26.014007999998285]}}},{"functionName":"private_kernel_inner","time":155.52404399999978},{"functionName":"SchnorrAccount:entrypoint","time":204.18204600000172,"oracles":{"debugLog":{"times":[0.3139979999996285,0.10129200000119454,0.4205309999997553]},"fetchTaggedLogs":{"times":[73.59400300000016]},"loadCapsule":{"times":[0.23303500000110944,0.2013650000008056,0.1468639999984589]},"validateEnqueuedNotesAndEvents":{"times":[6.232246000001396]},"getNotes":{"times":[2.5939150000012887]},"getAuthWitness":{"times":[0.34918800000014016]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.2034700000003795]}}},{"functionName":"private_kernel_inner","time":100.58269499999915},{"functionName":"private_kernel_reset","time":230.89454099999966},{"functionName":"private_kernel_tail","time":78.86362399999962}],"unaccounted":505.2707350000046}} 09:56:47 aztec-1 | [09:56:47.229] INFO: node Received tx 0x0d2a3884d9e8af0c4643b54c2d277c2159f5cd7755f74efe7ed1e6a2c14e4485 {"txHash":"0x0d2a3884d9e8af0c4643b54c2d277c2159f5cd7755f74efe7ed1e6a2c14e4485"} 09:56:47 aztec-1 | [09:56:47.229] INFO: pxe:service Sent transaction 0x0d2a3884d9e8af0c4643b54c2d277c2159f5cd7755f74efe7ed1e6a2c14e4485 09:56:47 aztec-1 | [09:56:47.333] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.046833576000000904s {"duration":0.046833576000000904,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 09:56:47 aztec-1 | [09:56:47.368] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x095ee2499e000fbdde2cd31c75914f1a2284052f4d5573b9d4b8e21800d38865","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749808908,"version":2094187016},"txHashes":["0x0d2a3884d9e8af0c4643b54c2d277c2159f5cd7755f74efe7ed1e6a2c14e4485"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":92.4100210000015,"publicProcessDuration":47.60684600000059,"rollupCircuitsDuration":84.66293900000164,"txCount":1,"blockNumber":1,"blockTimestamp":1749808908,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:56:50 aztec-1 | [09:56:50.206] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 09:56:50 aztec-1 | [09:56:50.209] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 09:56:50 aztec-1 | [09:56:50.211] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:56:50 aztec-1 | [09:56:50.285] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:56:50 aztec-1 | error: "Rollup__SlotAlreadyInChain(2, 2)" 09:56:50 aztec-1 | [09:56:50.285] WARN: sequencer Cannot propose block 1 at slot 2 due to failed rollup contract check 09:56:50 aztec-1 | [09:56:50.300] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x095ee2499e000fbdde2cd31c75914f1a2284052f4d5573b9d4b8e21800d38865","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749808908,"version":2094187016},"archiveRoot":"0x1e746ec0b16aa7392572dc0a8c8f75d31ecc263d34aa9426820beda73466ee09","archiveNextLeafIndex":2} 09:56:50 aztec-1 | [09:56:50.309] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 09:56:50 aztec-1 | [09:56:50.367] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":15.90372600000046,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749808908,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:56:50 aztec-1 | [09:56:50.453] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:56:50 aztec-1 | error: "Rollup__SlotAlreadyInChain(2, 2)" 09:56:50 aztec-1 | [09:56:50.453] WARN: sequencer Cannot propose block 2 at slot 2 due to failed rollup contract check 09:56:50 aztec-1 | [09:56:50.459] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:56:50 aztec-1 | [09:56:50.459] WARN: foundation:test-date-provider Time set to 2025-06-13T10:01:48.000Z {"offset":297541,"timeMs":1749808908000} 09:56:50 aztec-1 | [09:56:50.475] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749808944 09:56:50 aztec-1 | [09:56:50.475] WARN: foundation:test-date-provider Time set to 2025-06-13T10:02:24.000Z {"offset":333525,"timeMs":1749808944000} 09:56:50 aztec-1 | [09:56:50.476] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 09:56:50 aztec-1 | [09:56:50.506] INFO: pxe:service Registered account 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f 09:56:50 aztec-1 | [09:56:50.665] INFO: pxe:service Added contract SchnorrAccount at 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:56:52 aztec-1 | [09:56:52.405] INFO: pxe:service Proving completed in 1710.041502ms {"timings":{"total":1710.041502,"sync":20.18046299999878,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":122.91129000000365,"oracles":{"callPrivateFunction":{"times":[424.196476000001,215.6748919999991]}}},{"functionName":"private_kernel_init","time":78.1932080000006},{"functionName":"SchnorrAccount:constructor","time":394.70095199999923,"oracles":{"getContractInstance":{"times":[4.727557000000161]},"debugLog":{"times":[0.2207959999996092,0.15695400000004156]},"fetchTaggedLogs":{"times":[117.01008499999989]},"loadCapsule":{"times":[0.25650599999971746,0.27919699999984005,0.20698500000071363]},"validateEnqueuedNotesAndEvents":{"times":[5.9560789999995905]},"notifyCreatedNullifier":{"times":[0.2781670000003942,0.20389499999873806]},"notifyCreatedNote":{"times":[0.15547399999923073]},"getRandomField":{"times":[0.1900549999991199,0.2386659999992844,0.1300440000013623,0.11670299999968847,0.1462630000005447,0.08408199999939825,0.07547199999862642,0.08324199999879056,0.0695610000002489,0.07536199999958626,0.07227199999942968]},"getIndexedTaggingSecretAsSender":{"times":[60.475845999999365]},"incrementAppTaggingSecretIndexAsSender":{"times":[36.3315249999996]}}},{"functionName":"private_kernel_inner","time":145.56541599999946},{"functionName":"SchnorrAccount:entrypoint","time":191.7234359999984,"oracles":{"debugLog":{"times":[0.19246500000008382,0.0854429999999411,0.19138500000008207]},"fetchTaggedLogs":{"times":[77.2299039999998]},"loadCapsule":{"times":[0.17077400000016496,0.17170500000065658,0.14723400000002584]},"validateEnqueuedNotesAndEvents":{"times":[5.902906999999686]},"getNotes":{"times":[1.368424000000232]},"getAuthWitness":{"times":[0.19296500000018568]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.6117049999993469]}}},{"functionName":"private_kernel_inner","time":143.4571619999988},{"functionName":"private_kernel_reset","time":188.93718600000102},{"functionName":"private_kernel_tail","time":90.93487500000083}],"unaccounted":333.4375139999993}} 09:56:52 aztec-1 | [09:56:52.454] INFO: node Received tx 0x044552cdfb5ff15fdf07381a5208cf3208196c0ced791e8ba4a420a13526d3b2 {"txHash":"0x044552cdfb5ff15fdf07381a5208cf3208196c0ced791e8ba4a420a13526d3b2"} 09:56:52 aztec-1 | [09:56:52.454] INFO: pxe:service Sent transaction 0x044552cdfb5ff15fdf07381a5208cf3208196c0ced791e8ba4a420a13526d3b2 09:56:52 aztec-1 | [09:56:52.528] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.022175041999998937s {"duration":0.022175041999998937,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 09:56:52 aztec-1 | [09:56:52.550] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x13971b5cdb284d1fa1273d2928a325d419a509ec21a24fb8031457cbaaebdfd6","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749808944,"version":2094187016},"txHashes":["0x044552cdfb5ff15fdf07381a5208cf3208196c0ced791e8ba4a420a13526d3b2"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":50.08739700000115,"publicProcessDuration":22.3452070000003,"rollupCircuitsDuration":45.348049000000174,"txCount":1,"blockNumber":2,"blockTimestamp":1749808944,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:56:52 aztec-1 | [09:56:52.785] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:56:52 aztec-1 | [09:56:52.794] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749808980 09:56:52 aztec-1 | [09:56:52.794] WARN: foundation:test-date-provider Time set to 2025-06-13T10:03:00.000Z {"offset":367206,"timeMs":1749808980000} 09:56:52 aztec-1 | [09:56:52.795] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 09:56:52 aztec-1 | [09:56:52.892] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x13971b5cdb284d1fa1273d2928a325d419a509ec21a24fb8031457cbaaebdfd6","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749808944,"version":2094187016},"archiveRoot":"0x02eadb860a5117890bbba2f796573bdba36acad366c19a76aa8b3c164ed3b9b5","archiveNextLeafIndex":3} 09:56:52 aztec-1 | [09:56:52.964] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":23.31230699999651,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749808944,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:56:52 aztec-1 | [09:56:52.976] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 09:56:52 aztec-1 | [09:56:52.977] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 09:56:53 aztec-1 | [09:56:53.050] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 09:56:53 aztec-1 | [09:56:53.072] INFO: pxe:service Registered account 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 09:56:53 aztec-1 | [09:56:53.180] INFO: pxe:service Added contract SchnorrAccount at 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 with class 0x0b89e6f8d5ceea693e15799442ccf7b89aac377f557925144092ccd99080e097 09:56:55 aztec-1 | Initial Accounts: 09:56:55 aztec-1 | 09:56:55 aztec-1 | Address: 0x1935497c24c66f601a7fd9b6b1e6b1f5f667f04034c621bde89755ba273e844e 09:56:55 aztec-1 | Partial Address: 0x27b4888363d0f9eb0d43aa0b2ff08f21fbc6867b8e0baf8ec6062c4623c1eefc 09:56:55 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 09:56:55 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 09:56:55 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 09:56:55 aztec-1 | 09:56:55 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 09:56:55 aztec-1 | 09:56:55 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 09:56:55 aztec-1 | 09:56:55 aztec-1 | Address: 0x103e82c3da93031a6f52a945d8e3bc181f8e104e48672ada425382af022bbb3f 09:56:55 aztec-1 | Partial Address: 0x2e19b56de1617cb3179d81be0173c7301621a2e820da7f2754fcfccdfc4418e0 09:56:55 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 09:56:55 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 09:56:55 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 09:56:55 aztec-1 | 09:56:55 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 09:56:55 aztec-1 | 09:56:55 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 09:56:55 aztec-1 | 09:56:55 aztec-1 | Address: 0x280737c4106e70a3391b796f1a2bbbdcb0b2fea06f75a7a5a4bfcb33c02727b7 09:56:55 aztec-1 | Partial Address: 0x2451b67547512eaaaad5ded43156c5b80220b7d5145ebefdd57295a9e05a610d 09:56:55 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 09:56:55 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 09:56:55 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 09:56:55 aztec-1 | 09:56:55 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 09:56:55 aztec-1 | 09:56:55 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 09:56:55 aztec-1 | 09:56:55 aztec-1 | 09:56:55 aztec-1 | [09:56:54.544] INFO: pxe:service Proving completed in 1356.1930109999994ms {"timings":{"total":1356.1930109999994,"sync":16.33688500000062,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":87.36449300000095,"oracles":{"callPrivateFunction":{"times":[329.4823389999983,259.008933000001]}}},{"functionName":"private_kernel_init","time":55.082383999997546},{"functionName":"SchnorrAccount:constructor","time":309.16957600000023,"oracles":{"getContractInstance":{"times":[2.166184000001522]},"debugLog":{"times":[0.12480399999913061,0.09595300000000861]},"fetchTaggedLogs":{"times":[99.87615300000107]},"loadCapsule":{"times":[0.19720500000039465,0.16027399999802583,0.1495939999986149]},"validateEnqueuedNotesAndEvents":{"times":[5.696901000002981]},"notifyCreatedNullifier":{"times":[0.20604499999899417,0.2984870000000228]},"notifyCreatedNote":{"times":[0.13156399999934365]},"getRandomField":{"times":[0.12550300000293646,0.2153260000013688,0.0816419999973732,0.06797100000039791,0.054771000002801884,0.043791000000055647,0.04466099999990547,0.07396199999857345,0.035920999998779735,0.04562100000111968,0.04197100000237697]},"getIndexedTaggingSecretAsSender":{"times":[49.60967900000105]},"incrementAppTaggingSecretIndexAsSender":{"times":[24.86689500000284]}}},{"functionName":"private_kernel_inner","time":104.96740999999747},{"functionName":"SchnorrAccount:entrypoint","time":231.6494259999963,"oracles":{"debugLog":{"times":[0.13596299999699113,0.10101299999951152,0.1399039999996603]},"fetchTaggedLogs":{"times":[99.9142439999996]},"loadCapsule":{"times":[0.18736499999795342,0.1335929999986547,0.12634299999990617]},"validateEnqueuedNotesAndEvents":{"times":[5.624949000000925]},"getNotes":{"times":[1.3723339999996824]},"getAuthWitness":{"times":[0.21413599999868893]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4768320000002859]}}},{"functionName":"private_kernel_inner","time":96.9435799999992},{"functionName":"private_kernel_reset","time":139.4971740000001},{"functionName":"private_kernel_tail","time":58.159999999999854}],"unaccounted":257.0220830000071}} 09:56:55 aztec-1 | [09:56:54.584] INFO: node Received tx 0x137119b0071916cf6a6cd8d91a9dea5e2d5dd95f2aefe45d90c860c7e2e62000 {"txHash":"0x137119b0071916cf6a6cd8d91a9dea5e2d5dd95f2aefe45d90c860c7e2e62000"} 09:56:55 aztec-1 | [09:56:54.584] INFO: pxe:service Sent transaction 0x137119b0071916cf6a6cd8d91a9dea5e2d5dd95f2aefe45d90c860c7e2e62000 09:56:55 aztec-1 | [09:56:54.665] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02116116400000101s {"duration":0.02116116400000101,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 09:56:55 aztec-1 | [09:56:54.686] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1f227c96670769d3939fd8297743a2dbedbf6046332f43a27ea1f0a761e5f4c2","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749808980,"version":2094187016},"txHashes":["0x137119b0071916cf6a6cd8d91a9dea5e2d5dd95f2aefe45d90c860c7e2e62000"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":51.59003699999812,"publicProcessDuration":21.32344799999919,"rollupCircuitsDuration":44.75517800000307,"txCount":1,"blockNumber":3,"blockTimestamp":1749808980,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:56:55 aztec-1 | [09:56:54.829] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:56:55 aztec-1 | [09:56:54.830] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 09:56:55 aztec-1 | [09:56:54.833] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 09:56:55 aztec-1 | [09:56:54.836] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749809016 09:56:55 aztec-1 | [09:56:54.836] WARN: foundation:test-date-provider Time set to 2025-06-13T10:03:36.000Z {"offset":401164,"timeMs":1749809016000} 09:56:55 aztec-1 | [09:56:54.836] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 09:56:55 aztec-1 | [09:56:54.838] 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":"0x02eadb860a5117890bbba2f796573bdba36acad366c19a76aa8b3c164ed3b9b5","blocksSynchedTo":28,"currentL1BlockNumber":29,"provenBlockNumber":2,"provenArchive":"0x02eadb860a5117890bbba2f796573bdba36acad366c19a76aa8b3c164ed3b9b5","pendingBlockNumber":3,"pendingArchive":"0x286af78945daf14f2cd712156b061ee340346753c22b454809e5d883e30d5a38"} 09:56:55 aztec-1 | [09:56:54.929] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1f227c96670769d3939fd8297743a2dbedbf6046332f43a27ea1f0a761e5f4c2","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749808980,"version":2094187016},"archiveRoot":"0x286af78945daf14f2cd712156b061ee340346753c22b454809e5d883e30d5a38","archiveNextLeafIndex":4} 09:56:55 aztec-1 | [09:56:54.932] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 09:56:55 aztec-1 | [09:56:54.991] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":14.666134000002785,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749808980,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 09:56:56 aztec-1 | [09:56:55.847] WARN: pxe:service No artifact found for contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 when looking for its metadata 09:56:56 aztec-1 | [09:56:55.847] WARN: pxe:service No artifact found for contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 when looking for its metadata 09:56:56 aztec-1 | [09:56:55.853] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 as part of deployment for 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 09:56:56 aztec-1 | [09:56:55.891] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 as part of deployment for 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf 09:56:57 aztec-1 | [09:56:56.883] INFO: pxe:service Added contract FPC at 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 with class 0x151d86e8f05858be4838e2ca89859d01b6f0c70d521866c53ec7b9181b9a60d1 09:56:57 aztec-1 | [09:56:56.887] INFO: pxe:service Added contract Token at 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf with class 0x1ecd38c4c0a093bb1edb23d8d306929d405875fdc7e9c53762c43d19dfb04645 09:57:00 aztec-1 | [09:56:59.610] INFO: pxe:service Proving completed in 2677.447897000002ms {"timings":{"total":2677.447897000002,"sync":27.209423000000243,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":380.4858209999984,"oracles":{"debugLog":{"times":[0.36486999999760883,0.10673200000019278,0.10265300000173738,0.25197599999955855,0.12689300000056392,0.11892300000181422,0.10747300000002724,0.1826050000017858]},"fetchTaggedLogs":{"times":[135.5628370000013]},"loadCapsule":{"times":[0.25773599999956787,0.17381400000158465,0.5136029999994207,0.2704669999984617,0.42867000000114786,0.18643499999961932,3.0015740000017104]},"getSharedSecret":{"times":[6.589622999999847]},"aes128Decrypt":{"times":[1.1482290000021749,0.8283410000003641]},"getPublicKeysAndPartialAddress":{"times":[1.854535999998916]},"getKeyValidationRequest":{"times":[2.4884319999982836]},"storeCapsule":{"times":[2.7275079999999434,2.507472000001144,2.3489880000015546]},"deleteCapsule":{"times":[2.6628060000002733]},"validateEnqueuedNotesAndEvents":{"times":[24.376024000001053]},"getNotes":{"times":[2.4079789999996137]},"getAuthWitness":{"times":[0.21319500000026892]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.050261000000318745]},"callPrivateFunction":{"times":[751.3027629999997,154.11087600000246]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3700590000007651]}}},{"functionName":"private_kernel_init","time":82.58203499999945},{"functionName":"ContractClassRegisterer:register","time":737.8607789999987,"oracles":{"loadCapsule":{"times":[3.660950999998022]},"notifyCreatedNullifier":{"times":[0.2868369999996503]},"debugLog":{"times":[0.08509199999753037]},"notifyCreatedContractClassLog":{"times":[4.8774109999976645]}}},{"functionName":"private_kernel_inner","time":156.7526910000015},{"functionName":"ContractInstanceDeployer:deploy","time":89.83200500000021,"oracles":{"storeInExecutionCache":{"times":[0.31247799999982817]},"callPrivateFunction":{"times":[58.80483599999934]},"notifyCreatedNullifier":{"times":[0.3178589999988617]},"debugLog":{"times":[0.18857500000012806]}}},{"functionName":"private_kernel_inner","time":153.126231000002},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":43.226331000001665,"oracles":{}},{"functionName":"private_kernel_inner","time":158.09675499999867},{"functionName":"private_kernel_reset","time":239.22754300000088},{"functionName":"private_kernel_tail","time":110.60287899999821}],"unaccounted":498.4454040000019}} 09:57:00 aztec-1 | [09:56:59.761] INFO: node Received tx 0x0ae7b9fd3d89082cf23b62e4bc09a1b50450b55b2582880739c7643f7f2b194b {"txHash":"0x0ae7b9fd3d89082cf23b62e4bc09a1b50450b55b2582880739c7643f7f2b194b"} 09:57:00 aztec-1 | [09:56:59.761] INFO: pxe:service Sent transaction 0x0ae7b9fd3d89082cf23b62e4bc09a1b50450b55b2582880739c7643f7f2b194b 09:57:01 aztec-1 | [09:57:01.048] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.127568159999999s {"duration":1.127568159999999,"rate":36595.57041766773,"totalPublicGas":{"daGas":4096,"l2Gas":41264},"totalBlockGas":{"daGas":166912,"l2Gas":66306},"totalSizeInBytes":10688} 09:57:01 aztec-1 | [09:57:01.097] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 34523.365817499696 mana/s {"blockHash":"0x1ee02b1decf2352298453458197bb751e3e31e6c41a768dac9e1b56385f03dc7","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749809016,"version":2094187016},"txHashes":["0x0ae7b9fd3d89082cf23b62e4bc09a1b50450b55b2582880739c7643f7f2b194b"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1195.1774330000007,"publicProcessDuration":1127.7861649999977,"rollupCircuitsDuration":1188.1205090000003,"txCount":1,"blockNumber":4,"blockTimestamp":1749809016,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296} 09:57:01 aztec-1 | [09:57:01.778] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:57:01 aztec-1 | [09:57:01.778] WARN: foundation:test-date-provider Time set to 2025-06-13T10:03:48.000Z {"offset":406222,"timeMs":1749809028000} 09:57:01 aztec-1 | [09:57:01.831] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 09:57:01 aztec-1 | [09:57:01.836] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 09:57:01 aztec-1 | [09:57:01.840] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749809052 09:57:01 aztec-1 | [09:57:01.840] WARN: foundation:test-date-provider Time set to 2025-06-13T10:04:12.000Z {"offset":430160,"timeMs":1749809052000} 09:57:01 aztec-1 | [09:57:01.840] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 09:57:01 aztec-1 | [09:57:01.842] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:57:02 aztec-1 | [09:57:02.250] INFO: pxe:service Proving completed in 2639.2199299999993ms {"timings":{"total":2639.2199299999993,"sync":95.80212200000096,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":441.41068200000154,"oracles":{"debugLog":{"times":[0.16969400000016321,0.07484200000180863,0.11551300000064657,0.11936299999797484,0.13797300000078394,0.10783299999820883,0.06738200000108918,0.1634039999989909]},"fetchTaggedLogs":{"times":[173.93668599999728]},"loadCapsule":{"times":[0.24005600000236882,0.1955649999981688,0.21092499999940628,0.5330629999989469,1.3845240000009653,0.21232499999678112,0.18828500000017812]},"getSharedSecret":{"times":[4.399319000000105]},"aes128Decrypt":{"times":[0.18734499999845866,0.40156000000206404]},"getPublicKeysAndPartialAddress":{"times":[3.9660189999995055]},"getKeyValidationRequest":{"times":[3.382204000001366]},"storeCapsule":{"times":[3.059346000001824,22.035164999997505,2.4391599999980826]},"deleteCapsule":{"times":[4.0614000000023225]},"validateEnqueuedNotesAndEvents":{"times":[27.985163000001194]},"getNotes":{"times":[10.991021999998338]},"getAuthWitness":{"times":[0.14761400000134017]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05263100000229315]},"callPrivateFunction":{"times":[677.1664469999996,125.94147900000098]},"notifyEnqueuedPublicFunctionCall":{"times":[0.12991300000066985]}}},{"functionName":"private_kernel_init","time":76.24363799999992},{"functionName":"ContractClassRegisterer:register","time":664.4671419999977,"oracles":{"loadCapsule":{"times":[2.390489000001253]},"notifyCreatedNullifier":{"times":[0.3986810000023979]},"debugLog":{"times":[0.11055300000225543]},"notifyCreatedContractClassLog":{"times":[4.761048000000301]}}},{"functionName":"private_kernel_inner","time":119.33707499999946},{"functionName":"ContractInstanceDeployer:deploy","time":73.40114700000049,"oracles":{"storeInExecutionCache":{"times":[0.13775299999906565]},"callPrivateFunction":{"times":[47.47666599999866]},"notifyCreatedNullifier":{"times":[0.3833900000026915]},"debugLog":{"times":[0.17126400000051945]}}},{"functionName":"private_kernel_inner","time":101.25062699999762},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":33.189471999998204,"oracles":{}},{"functionName":"private_kernel_inner","time":136.10409000000072},{"functionName":"private_kernel_reset","time":183.30254799999966},{"functionName":"private_kernel_tail","time":82.02723100000003}],"unaccounted":632.684156000003}} 09:57:02 aztec-1 | [09:57:02.443] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x1ee02b1decf2352298453458197bb751e3e31e6c41a768dac9e1b56385f03dc7","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749809016,"version":2094187016},"archiveRoot":"0x16a0a43c4fc3e05f4e5ad1cad95ae6399b01e4b62e150a7a5fee82ccd26eba1f","archiveNextLeafIndex":5} 09:57:02 aztec-1 | [09:57:02.449] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 09:57:02 aztec-1 | [09:57:02.450] INFO: node Received tx 0x1eb59693e6944705a18eb032f905973fadbbc3f548b90a676056ce9942840a14 {"txHash":"0x1eb59693e6944705a18eb032f905973fadbbc3f548b90a676056ce9942840a14"} 09:57:02 aztec-1 | [09:57:02.451] INFO: pxe:service Sent transaction 0x1eb59693e6944705a18eb032f905973fadbbc3f548b90a676056ce9942840a14 09:57:02 aztec-1 | [09:57:02.470] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":14.963061000002199,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749809016,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296} 09:57:02 aztec-1 | [09:57:02.867] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3069061489999986s {"duration":0.3069061489999986,"rate":1079968.586748653,"totalPublicGas":{"daGas":10240,"l2Gas":331449},"totalBlockGas":{"daGas":380928,"l2Gas":356491},"totalSizeInBytes":24064} 09:57:02 aztec-1 | [09:57:02.913] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 919013.2905638156 mana/s {"blockHash":"0x04a827cee42e187658ec45fdfcac5b37c4782e50363a3560fd0320e11c56c4d9","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749809052,"version":2094187016},"txHashes":["0x1eb59693e6944705a18eb032f905973fadbbc3f548b90a676056ce9942840a14"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":360.62788999999975,"publicProcessDuration":307.2124870000007,"rollupCircuitsDuration":354.4775870000012,"txCount":1,"blockNumber":5,"blockTimestamp":1749809052,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 09:57:03 aztec-1 | [09:57:03.120] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:57:03 aztec-1 | [09:57:03.130] WARN: archiver Failed to reach L2 block 5 at 33 (latest is 4). Rolling back last synched L1 block number to 32. {"latestLocalL2BlockNumber":4,"latestLocalL2BlockArchive":"0x16a0a43c4fc3e05f4e5ad1cad95ae6399b01e4b62e150a7a5fee82ccd26eba1f","blocksSynchedTo":32,"currentL1BlockNumber":33,"provenBlockNumber":4,"provenArchive":"0x16a0a43c4fc3e05f4e5ad1cad95ae6399b01e4b62e150a7a5fee82ccd26eba1f","pendingBlockNumber":5,"pendingArchive":"0x2a7a127c857b09ac3fdd3ce56fdd21edc0b948c71daa69d744cc6aba68916398"} 09:57:03 aztec-1 | [09:57:03.161] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 09:57:03 aztec-1 | [09:57:03.161] WARN: foundation:test-date-provider Time set to 2025-06-13T10:04:24.000Z {"offset":440839,"timeMs":1749809064000} 09:57:03 aztec-1 | [09:57:03.167] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 09:57:03 aztec-1 | [09:57:03.169] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 09:57:03 aztec-1 | [09:57:03.184] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 09:57:03 aztec-1 | error: "Rollup__SlotAlreadyInChain(6, 6)" 09:57:03 aztec-1 | [09:57:03.184] WARN: sequencer Cannot propose block 5 at slot 6 due to failed rollup contract check 09:57:03 aztec-1 | [09:57:03.193] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749809088 09:57:03 aztec-1 | [09:57:03.193] WARN: foundation:test-date-provider Time set to 2025-06-13T10:04:48.000Z {"offset":464807,"timeMs":1749809088000} 09:57:03 aztec-1 | [09:57:03.193] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 09:57:03 aztec-1 | [09:57:03.277] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x04a827cee42e187658ec45fdfcac5b37c4782e50363a3560fd0320e11c56c4d9","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749809052,"version":2094187016},"archiveRoot":"0x2a7a127c857b09ac3fdd3ce56fdd21edc0b948c71daa69d744cc6aba68916398","archiveNextLeafIndex":6} 09:57:03 aztec-1 | [09:57:03.282] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 09:57:03 aztec-1 | [09:57:03.321] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":15.595485999998346,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749809052,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 09:57:03 aztec-1 | [09:57:03.351] INFO: aztecjs:deploy_sent_tx Contract 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 successfully deployed. 09:57:03 aztec-1 | BananaCoin: 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf 09:57:03 aztec-1 | FPC: 0x2207862293647848d5c210b37b67e61cee2fec093491b093b4708e95bf3b4b45 09:57:03 aztec-1 | [09:57:03.679] INFO: aztecjs:deploy_sent_tx Contract 0x1fc314b687b4b23399a55ac511deb2e6091f046c7cf5ea375ab5557573e77cbf successfully deployed. 09:57:03 aztec-1 | [09:57:03.710] WARN: pxe:service No artifact found for contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e when looking for its metadata 09:57:03 aztec-1 | [09:57:03.713] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e as part of deployment for 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 09:57:03 aztec-1 | [09:57:03.853] INFO: pxe:service Added contract SponsoredFPC at 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 with class 0x2dacfd02a8775d3a80d4f185f8765bd3af452cf0b5c53a542ff56b271af4e87e 09:57:06 aztec-1 | [09:57:06.037] INFO: pxe:service Proving completed in 2158.6584209999965ms {"timings":{"total":2158.6584209999965,"sync":30.544847000001027,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":79.344135000003,"oracles":{"callPrivateFunction":{"times":[578.3438199999982,115.41630799999984,55.30088899999828]}}},{"functionName":"private_kernel_init","time":75.11945999999807},{"functionName":"ContractClassRegisterer:register","time":569.1338819999983,"oracles":{"loadCapsule":{"times":[1.4178650000030757]},"notifyCreatedNullifier":{"times":[0.34333799999876646]},"debugLog":{"times":[0.11401199999818346]},"notifyCreatedContractClassLog":{"times":[5.3316219999978784]}}},{"functionName":"private_kernel_inner","time":102.05232700000124},{"functionName":"ContractInstanceDeployer:deploy","time":65.98132600000099,"oracles":{"storeInExecutionCache":{"times":[0.054381000001740176]},"callPrivateFunction":{"times":[59.907444000000396]},"notifyCreatedNullifier":{"times":[0.2224050000004354]},"debugLog":{"times":[0.1919850000012957]}}},{"functionName":"private_kernel_inner","time":144.48860799999966},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.79268400000001,"oracles":{}},{"functionName":"private_kernel_inner","time":135.46644399999786},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":41.811555000000226,"oracles":{"debugLog":{"times":[0.14960400000200025]}}},{"functionName":"private_kernel_inner","time":123.03495599999951},{"functionName":"private_kernel_reset","time":219.19138700000258},{"functionName":"private_kernel_tail","time":102.14820000000327}],"unaccounted":430.54860999999073}} 09:57:06 aztec-1 | [09:57:06.169] INFO: node Received tx 0x0a74933498126a267da42cb09ff5617124e65e592e998ded43782f9fb0be84aa {"txHash":"0x0a74933498126a267da42cb09ff5617124e65e592e998ded43782f9fb0be84aa"} 09:57:06 aztec-1 | [09:57:06.169] INFO: pxe:service Sent transaction 0x0a74933498126a267da42cb09ff5617124e65e592e998ded43782f9fb0be84aa 09:57:06 aztec-1 | [09:57:06.293] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.042278097000002166s {"duration":0.042278097000002166,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 09:57:06 aztec-1 | [09:57:06.320] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x15a6a66beb062cb00cd72fb49dd470f5d98b94416e95e7612965b4fc60047ca8","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749809088,"version":2094187016},"txHashes":["0x0a74933498126a267da42cb09ff5617124e65e592e998ded43782f9fb0be84aa"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":76.13503599999967,"publicProcessDuration":42.461341000001994,"rollupCircuitsDuration":71.9131899999993,"txCount":1,"blockNumber":6,"blockTimestamp":1749809088,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:57:06 aztec-1 | [09:57:06.531] WARN: ethereum:cheat_codes Set L1 storage for contract 0x3aa5ebb10dc797cac828524e59a333d0a371443c at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 09:57:06 aztec-1 | [09:57:06.533] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 09:57:06 aztec-1 | [09:57:06.534] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 09:57:06 aztec-1 | [09:57:06.540] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749809124 09:57:06 aztec-1 | [09:57:06.541] WARN: foundation:test-date-provider Time set to 2025-06-13T10:05:24.000Z {"offset":497460,"timeMs":1749809124000} 09:57:06 aztec-1 | [09:57:06.541] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 09:57:06 aztec-1 | [09:57:06.547] 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":"0x2a7a127c857b09ac3fdd3ce56fdd21edc0b948c71daa69d744cc6aba68916398","blocksSynchedTo":34,"currentL1BlockNumber":35,"provenBlockNumber":5,"provenArchive":"0x2a7a127c857b09ac3fdd3ce56fdd21edc0b948c71daa69d744cc6aba68916398","pendingBlockNumber":6,"pendingArchive":"0x043bacaf1c68b3df53a2e957ccd8389b5289280af8642c64bc993b5aa44c135f"} 09:57:06 aztec-1 | [09:57:06.653] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x15a6a66beb062cb00cd72fb49dd470f5d98b94416e95e7612965b4fc60047ca8","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":32180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749809088,"version":2094187016},"archiveRoot":"0x043bacaf1c68b3df53a2e957ccd8389b5289280af8642c64bc993b5aa44c135f","archiveNextLeafIndex":7} 09:57:06 aztec-1 | [09:57:06.658] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 09:57:06 aztec-1 | [09:57:06.704] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":25.391568999999436,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749809088,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 09:57:07 aztec-1 | SponsoredFPC: 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 09:57:07 aztec-1 | [09:57:07.182] INFO: aztecjs:deploy_sent_tx Contract 0x0e68a7c0b68b13ddc5b1413195d70fd0611642afefe799a41314e1c70ade6354 successfully deployed. 09:57:07 aztec-1 | [09:57:07.187] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x2d2655c513c2e8feb8c7411b7e807c66287b57bb60572ce85ce1fe0a1e0c925d","l2ProtocolContractsTreeRoot":"0x222b5a95b10e0a2dfba4648739629a01cecd69a0bef23a9fc22f846735d7cc71"} 09:57:17 playground-1 | \ 09:57:17 playground-1 | Running 1 test using 1 worker 09:57:17 playground-1 | 09:57:18 playground-1 | ✓ 1 [webkit] › browser.spec.ts:3:1 › test (11.5s) 09:57:30 playground-1 | 1 passed (15.8s) 09:57:31 playground-1 | \ 09:57:31 playground-1 exited with code 0 09:57:31 Aborting on container exit... 09:57:31 Container playground-webkit-playground-1 Stopping 09:57:31 Container playground-webkit-playground-1 Stopped 09:57:31 Container playground-webkit-aztec-1 Stopping 09:57:32 Container playground-webkit-aztec-1 Stopped 09:57:32 Container playground-webkit-ethereum-1 Stopping 09:57:32 Container playground-webkit-ethereum-1 Stopped