Parent Log: http://ci.aztec-labs.com/cc97b3c911040387 Command: 19cd52a08db6411f playground/scripts/run_test.sh chromium Commit: https://github.com/AztecProtocol/aztec-packages/commit/f880f14c946fb8464186d4178c5d49e391041988 Env: REF_NAME=gh-readonly-queue/next/pr-14967-b608f9359219731d3c03407689a4fadaaa5a0d45 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Thu Jun 12 14:11:50 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14967_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_3af8716c4dfeb01b_next 14:11:50 Network playground-chromium_default Creating 14:11:50 Network playground-chromium_default Created 14:11:50 Container playground-chromium-ethereum-1 Creating 14:11:51 Container playground-chromium-ethereum-1 Created 14:11:51 Container playground-chromium-aztec-1 Creating 14:11:52 Container playground-chromium-aztec-1 Created 14:11:52 Container playground-chromium-playground-1 Creating 14:11:52 Container playground-chromium-playground-1 Created 14:11:52 Attaching to aztec-1, ethereum-1, playground-1 14:11:57 aztec-1 | 14:11:57 aztec-1 | _ 14:11:57 aztec-1 | /\ | | 14:11:57 aztec-1 | / \ ___| |_ ___ ___ 14:11:57 aztec-1 | / /\ \ |_ / __/ _ \/ __| 14:11:57 aztec-1 | / ____ \ / /| || __/ (__ 14:11:57 aztec-1 | /_/___ \_\/___|\__\___|\___| 14:11:57 aztec-1 | 14:11:57 aztec-1 | https://github.com/AztecProtocol 14:11:57 aztec-1 | 14:11:57 aztec-1 | 14:11:57 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by... 14:11:57 aztec-1 | Setting up test accounts 14:11:59 aztec-1 | [14:11:58.586] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-nAOT0s/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 14:11:59 aztec-1 | [14:11:58.897] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 14:11:59 aztec-1 | [14:11:58.901] WARN: sandbox Set block interval to 12 14:11:59 aztec-1 | [14:11:59.107] INFO: sandbox Waiting for 7 transactions to be mined... 14:11:59 aztec-1 | [14:11:59.137] INFO: sandbox All transactions mined successfully 14:11:59 aztec-1 | [14:11:59.260] INFO: sandbox Waiting for 9 transactions to be mined... 14:11:59 aztec-1 | [14:11:59.283] INFO: sandbox All transactions mined successfully 14:11:59 aztec-1 | [14:11:59.451] INFO: sandbox Waiting for 11 transactions to be mined... 14:11:59 aztec-1 | [14:11:59.476] INFO: sandbox All transactions mined successfully 14:11:59 aztec-1 | [14:11:59.541] INFO: sandbox Waiting for 12 transactions to be mined... 14:11:59 aztec-1 | [14:11:59.563] INFO: sandbox All transactions mined successfully 14:11:59 aztec-1 | [14:11:59.573] INFO: sandbox Waiting for 12 transactions to be mined... 14:11:59 aztec-1 | [14:11:59.612] INFO: sandbox All transactions mined successfully 14:11:59 aztec-1 | [14:11:59.635] INFO: sandbox Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x68b1d87f95878fe05b998f19b66f4baba5de1aed","inboxAddress":"0xa12ffa0b9f159bb4c54bce579611927addc51610","outboxAddress":"0x53839913417ebc7171723489f29b9b54f49b4eea","feeJuicePortalAddress":"0x67671478a98e62381bf90cdd328cffcddd26c83a","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 14:11:59 aztec-1 | [14:11:59.636] INFO: sandbox Handing over to governance 14:11:59 aztec-1 | [14:11:59.645] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x68B1D87F95878fE05B998F19b66F4baba5De1aed 14:11:59 aztec-1 | [14:11:59.646] INFO: telemetry:client Using NoopTelemetryClient 14:11:59 aztec-1 | [14:11:59.646] INFO: blob-sink:client Creating local blob sink client. 14:11:59 aztec-1 | [14:11:59.653] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 14:11:59 aztec-1 | [14:11:59.653] WARN: foundation:test-date-provider Time set to 2025-06-12T14:16:29.000Z {"offset":269347,"timeMs":1749737789000} 14:11:59 aztec-1 | [14:11:59.675] INFO: archiver:lmdb Starting data store with maxReaders 16 14:12:00 aztec-1 | [14:12:00.102] INFO: archiver Starting archiver sync to rollup contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed from L1 block 19 to current L1 block 23 with hash 0x104a695d520aa13e31b59c914227bfc59ba404403badfa4f3933d77cfbd5c4e3 {"blocksSynchedTo":19,"messagesSynchedTo":{"l1BlockHash":"0x4d828f44e23bca55a7a058dc228079ae0983659eb3c5d7c248ba9230a76e8e80","l1BlockNumber":19}} 14:12:00 aztec-1 | [14:12:00.133] INFO: archiver Initial archiver sync to L1 block 23 complete. {"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0x104a695d520aa13e31b59c914227bfc59ba404403badfa4f3933d77cfbd5c4e3","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 14:12:00 aztec-1 | [14:12:00.141] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-Mh7uwe/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 14:12:00 aztec-1 | [14:12:00.346] INFO: world_state Created world state synchroniser with block history of 64 14:12:00 aztec-1 | [14:12:00.346] WARN: node Aztec node is accepting fake proofs 14:12:00 aztec-1 | [14:12:00.357] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 14:12:00 aztec-1 | [14:12:00.370] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 14:12:00 aztec-1 | [14:12:00.383] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 14:12:00 aztec-1 | [14:12:00.395] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 14:12:00 aztec-1 | [14:12:00.399] INFO: world_state Started world state synchronizer from block 1 14:12:00 aztec-1 | [14:12:00.402] INFO: p2p Starting p2p client from block 0 with empty mempools 14:12:00 aztec-1 | [14:12:00.695] INFO: epoch-prune-watcher EpochPruneWatcher initialized 14:12:00 aztec-1 | [14:12:00.756] INFO: slasher Starting Slasher client... 14:12:00 aztec-1 | [14:12:00.765] INFO: sequencer-client Deploying forwarder contract 14:12:00 aztec-1 | [14:12:00.786] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 14:12:00 aztec-1 | [14:12:00.792] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:12:00 aztec-1 | [14:12:00.793] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":50,"maxTxsPerBlock":32,"minTxsPerBlock":1,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":12,"enforceTimeTable":true} 14:12:00 aztec-1 | [14:12:00.795] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 14:12:00 aztec-1 | [14:12:00.795] INFO: node Aztec Node version: 0.87.6 14:12:00 aztec-1 | [14:12:00.795] INFO: node Aztec Node started on chain 0x7a69 {"rollupAddress":"0x68b1d87f95878fe05b998f19b66f4baba5de1aed","registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","inboxAddress":"0xa12ffa0b9f159bb4c54bce579611927addc51610","outboxAddress":"0x53839913417ebc7171723489f29b9b54f49b4eea","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","feeJuicePortalAddress":"0x67671478a98e62381bf90cdd328cffcddd26c83a","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","slashFactoryAddress":"0xc6e7df5e7b4f2a278906862b61205850344d4e7d","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 14:12:00 aztec-1 | [14:12:00.800] INFO: pxe:data:lmdb Starting data store with maxReaders 16 14:12:00 aztec-1 | [14:12:00.806] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 14:12:00 aztec-1 | [14:12:00.881] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 14:12:01 aztec-1 | [14:12:01.052] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 14:12:01 aztec-1 | [14:12:01.052] WARN: foundation:test-date-provider Time set to 2025-06-12T14:16:41.000Z {"offset":279948,"timeMs":1749737801000} 14:12:01 aztec-1 | [14:12:01.055] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 14:12:01 aztec-1 | Setting up funded test accounts... 14:12:01 aztec-1 | [14:12:01.195] INFO: pxe:service Started PXE connected to chain 31337 version 3573608979 14:12:01 aztec-1 | [14:12:01.290] INFO: pxe:service Registered account 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef 14:12:01 aztec-1 | [14:12:01.369] WARN: pxe:service No artifact found for contract class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f when looking for its metadata 14:12:01 aztec-1 | [14:12:01.372] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f as part of deployment for 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef 14:12:01 aztec-1 | [14:12:01.508] INFO: pxe:service Added contract SchnorrAccount at 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f 14:12:04 aztec-1 | [14:12:04.459] INFO: pxe:service Proving completed in 2922.530304000001ms {"timings":{"total":2922.530304000001,"sync":5.242536999999174,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":180.3159370000012,"oracles":{"callPrivateFunction":{"times":[939.6803949999994,406.0550510000012,218.83250399999997]}}},{"functionName":"private_kernel_init","time":131.72618499999953},{"functionName":"ContractClassRegisterer:register","time":920.2377059999999,"oracles":{"loadCapsule":{"times":[13.728752999999415]},"notifyCreatedNullifier":{"times":[40.849294999999984]},"debugLog":{"times":[0.827765999998519]},"notifyCreatedContractClassLog":{"times":[8.942442999999912]}}},{"functionName":"private_kernel_inner","time":121.29502400000092},{"functionName":"SchnorrAccount:constructor","time":379.45240099999864,"oracles":{"getContractInstance":{"times":[1.7261379999999917]},"debugLog":{"times":[0.30348400000002584,0.14666200000101526]},"fetchTaggedLogs":{"times":[81.66200600000047]},"loadCapsule":{"times":[0.49646000000029744,0.25339100000019243,0.23175799999989977]},"validateEnqueuedNotesAndEvents":{"times":[7.18387199999961]},"notifyCreatedNullifier":{"times":[0.6660930000016378,0.26254100000005565]},"notifyCreatedNote":{"times":[0.9961899999998423]},"getRandomField":{"times":[0.4078429999990476,0.46431699999993725,0.15507200000138255,0.10989900000095076,0.26738099999965925,0.13017000000036205,0.09100799999941955,0.11373900000035064,0.0924379999996745,0.13530100000025413,0.05710399999952642]},"getIndexedTaggingSecretAsSender":{"times":[47.152696999999534]},"incrementAppTaggingSecretIndexAsSender":{"times":[30.32207600000038]}}},{"functionName":"private_kernel_inner","time":112.57096599999932},{"functionName":"SchnorrAccount:entrypoint","time":192.60626500000035,"oracles":{"debugLog":{"times":[0.22163800000089395,0.12875999999960186,0.5628249999990658]},"fetchTaggedLogs":{"times":[49.999674000000596]},"loadCapsule":{"times":[0.29828400000042166,0.19569599999886123,0.24521000000095228]},"validateEnqueuedNotesAndEvents":{"times":[7.796411999999691]},"getNotes":{"times":[2.776031999999759]},"getAuthWitness":{"times":[0.44056499999896914]},"notifySetMinRevertibleSideEffectCounter":{"times":[1.4683079999995243]}}},{"functionName":"private_kernel_inner","time":115.51344900000004},{"functionName":"private_kernel_reset","time":204.73005999999987},{"functionName":"private_kernel_tail","time":70.76942899999995}],"unaccounted":488.0703450000019}} 14:12:04 aztec-1 | [14:12:04.561] INFO: node Received tx 0x2d3e3ea69efbbd47b3da06746c2aba2fc5237f5d5a1d5fdd9d88b9f6b533f469 {"txHash":"0x2d3e3ea69efbbd47b3da06746c2aba2fc5237f5d5a1d5fdd9d88b9f6b533f469"} 14:12:04 aztec-1 | [14:12:04.561] INFO: pxe:service Sent transaction 0x2d3e3ea69efbbd47b3da06746c2aba2fc5237f5d5a1d5fdd9d88b9f6b533f469 14:12:04 aztec-1 | [14:12:04.663] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03908949500000017s {"duration":0.03908949500000017,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 14:12:04 aztec-1 | [14:12:04.714] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2ed5c64f58b6a811681f0d9ed5a7423f09cfc89d7922b5a6b4147f8358218b48","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749737813,"version":3573608979},"txHashes":["0x2d3e3ea69efbbd47b3da06746c2aba2fc5237f5d5a1d5fdd9d88b9f6b533f469"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":101.26238800000101,"publicProcessDuration":39.85144500000024,"rollupCircuitsDuration":92.15018000000055,"txCount":1,"blockNumber":1,"blockTimestamp":1749737813,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:12:08 aztec-1 | [14:12:07.879] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 14:12:08 aztec-1 | [14:12:07.882] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 14:12:08 aztec-1 | [14:12:07.885] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:12:08 aztec-1 | [14:12:07.889] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749737849 14:12:08 aztec-1 | [14:12:07.889] WARN: foundation:test-date-provider Time set to 2025-06-12T14:17:29.000Z {"offset":321111,"timeMs":1749737849000} 14:12:08 aztec-1 | [14:12:07.889] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 14:12:08 aztec-1 | [14:12:07.976] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2ed5c64f58b6a811681f0d9ed5a7423f09cfc89d7922b5a6b4147f8358218b48","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749737813,"version":3573608979},"archiveRoot":"0x00de1321a7209a7fa00f388447a14f3e7d169be50386d2d4ffe2f6bd1feff559","archiveNextLeafIndex":2} 14:12:08 aztec-1 | [14:12:07.985] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 14:12:08 aztec-1 | [14:12:08.086] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":24.106276999998954,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749737813,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:12:08 aztec-1 | [14:12:08.120] INFO: pxe:service Registered account 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741 14:12:08 aztec-1 | [14:12:08.240] INFO: pxe:service Added contract SchnorrAccount at 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741 with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f 14:12:10 aztec-1 | [14:12:09.975] INFO: pxe:service Proving completed in 1704.131797ms {"timings":{"total":1704.131797,"sync":22.348127999999633,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":101.14262400000189,"oracles":{"callPrivateFunction":{"times":[457.9103040000009,227.21644500000002]}}},{"functionName":"private_kernel_init","time":54.176400000000285},{"functionName":"SchnorrAccount:constructor","time":428.80431899999894,"oracles":{"getContractInstance":{"times":[10.257064999999784]},"debugLog":{"times":[0.21430700000018987,0.35777799999959825]},"fetchTaggedLogs":{"times":[156.73570599999948]},"loadCapsule":{"times":[2.045079999999871,0.8348059999989346,0.5140709999996034]},"validateEnqueuedNotesAndEvents":{"times":[7.069385000000693]},"notifyCreatedNullifier":{"times":[0.3787190000002738,0.2849530000003142]},"notifyCreatedNote":{"times":[0.1394910000017262]},"getRandomField":{"times":[0.14019100000041362,0.27964199999951234,0.05830499999865424,0.050094000000171945,0.04140299999926356,0.06649499999912223,0.047313999999460066,0.05124400000022433,0.042843000001084874,0.046513000001141336,0.04695299999912095]},"getIndexedTaggingSecretAsSender":{"times":[48.58211099999971]},"incrementAppTaggingSecretIndexAsSender":{"times":[34.326263000000836]}}},{"functionName":"private_kernel_inner","time":130.62505799999963},{"functionName":"SchnorrAccount:entrypoint","time":202.3993190000001,"oracles":{"debugLog":{"times":[0.20153600000048755,0.09599800000069081,0.19535499999983585]},"fetchTaggedLogs":{"times":[78.20493499999975]},"loadCapsule":{"times":[0.25477999999930034,0.17394400000011956,0.20504600000094797]},"validateEnqueuedNotesAndEvents":{"times":[5.779164000001401]},"getNotes":{"times":[9.246365000000878]},"getAuthWitness":{"times":[0.21107599999959348]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.633719999999812]}}},{"functionName":"private_kernel_inner","time":148.41563400000086},{"functionName":"private_kernel_reset","time":227.3219629999985},{"functionName":"private_kernel_tail","time":91.01707999999962}],"unaccounted":297.88127200000054}} 14:12:10 aztec-1 | [14:12:10.029] INFO: node Received tx 0x2d2cc60eeff23ded9574097d893e98172fad1ce33dcff2ef25d49afe482dc6e7 {"txHash":"0x2d2cc60eeff23ded9574097d893e98172fad1ce33dcff2ef25d49afe482dc6e7"} 14:12:10 aztec-1 | [14:12:10.029] INFO: pxe:service Sent transaction 0x2d2cc60eeff23ded9574097d893e98172fad1ce33dcff2ef25d49afe482dc6e7 14:12:10 aztec-1 | [14:12:10.129] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02657831499999884s {"duration":0.02657831499999884,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 14:12:10 aztec-1 | [14:12:10.159] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x112071d7b129672a991bd47fb780638658a7b69bee17fae9548ba23c440f749d","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749737849,"version":3573608979},"txHashes":["0x2d2cc60eeff23ded9574097d893e98172fad1ce33dcff2ef25d49afe482dc6e7"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":68.09299200000169,"publicProcessDuration":26.731948000000557,"rollupCircuitsDuration":61.80490899999859,"txCount":1,"blockNumber":2,"blockTimestamp":1749737849,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:12:10 aztec-1 | [14:12:10.388] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:12:10 aztec-1 | [14:12:10.412] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 14:12:10 aztec-1 | [14:12:10.412] WARN: foundation:test-date-provider Time set to 2025-06-12T14:17:41.000Z {"offset":330588,"timeMs":1749737861000} 14:12:10 aztec-1 | [14:12:10.419] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 14:12:10 aztec-1 | [14:12:10.420] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 14:12:10 aztec-1 | [14:12:10.462] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 14:12:10 aztec-1 | error: "Rollup__SlotAlreadyInChain(3, 3)" 14:12:10 aztec-1 | [14:12:10.462] WARN: sequencer Cannot propose block 2 at slot 3 due to failed rollup contract check 14:12:10 aztec-1 | [14:12:10.472] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749737885 14:12:10 aztec-1 | [14:12:10.472] WARN: foundation:test-date-provider Time set to 2025-06-12T14:18:05.000Z {"offset":354528,"timeMs":1749737885000} 14:12:10 aztec-1 | [14:12:10.472] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 14:12:10 aztec-1 | [14:12:10.507] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x112071d7b129672a991bd47fb780638658a7b69bee17fae9548ba23c440f749d","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749737849,"version":3573608979},"archiveRoot":"0x1e5be8f408de71213e706ae434455779718330efef9a27429af1c9be42ecfeaf","archiveNextLeafIndex":3} 14:12:10 aztec-1 | [14:12:10.511] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 14:12:10 aztec-1 | [14:12:10.551] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":16.347161999998207,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749737849,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:12:10 aztec-1 | [14:12:10.681] INFO: pxe:service Registered account 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923 14:12:10 aztec-1 | [14:12:10.807] INFO: pxe:service Added contract SchnorrAccount at 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923 with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f 14:12:12 aztec-1 | [14:12:12.514] INFO: pxe:service Proving completed in 1695.6354930000016ms {"timings":{"total":1695.6354930000016,"sync":24.9549279999992,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":94.92834899999798,"oracles":{"callPrivateFunction":{"times":[414.22354599999744,305.48881600000095]}}},{"functionName":"private_kernel_init","time":79.49786699999822},{"functionName":"SchnorrAccount:constructor","time":390.31375899999694,"oracles":{"getContractInstance":{"times":[1.4243710000009742]},"debugLog":{"times":[0.16997300000002724,0.0735850000019127]},"fetchTaggedLogs":{"times":[122.83826699999918]},"loadCapsule":{"times":[0.22849800000039977,0.20365600000150152,0.1641830000007758]},"validateEnqueuedNotesAndEvents":{"times":[7.041252000002714]},"notifyCreatedNullifier":{"times":[0.3164150000011432,0.2197070000001986]},"notifyCreatedNote":{"times":[0.15600300000005518]},"getRandomField":{"times":[0.1116890000012063,0.24317899999732617,0.08926699999938137,0.07808599999771104,0.09698800000114716,0.06639499999801046,0.08130600000004051,0.058813999999983935,0.05560500000137836,0.039453000001230976,0.08371700000134297]},"getIndexedTaggingSecretAsSender":{"times":[67.63115499999913]},"incrementAppTaggingSecretIndexAsSender":{"times":[38.17987499999799]}}},{"functionName":"private_kernel_inner","time":154.54090399999768},{"functionName":"SchnorrAccount:entrypoint","time":277.2630510000017,"oracles":{"debugLog":{"times":[0.22052699999767356,0.09047700000155601,0.1658129999996163]},"fetchTaggedLogs":{"times":[104.5560430000005]},"loadCapsule":{"times":[0.22051699999792618,0.1387200000026496,0.24914999999964493]},"validateEnqueuedNotesAndEvents":{"times":[6.143732000000455]},"getNotes":{"times":[4.504603000001225]},"getAuthWitness":{"times":[0.1937550000002375]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.47496699999828706]}}},{"functionName":"private_kernel_inner","time":150.16078000000198},{"functionName":"private_kernel_reset","time":163.5833930000008},{"functionName":"private_kernel_tail","time":65.17126199999984}],"unaccounted":295.22120000000723}} 14:12:12 aztec-1 | [14:12:12.569] INFO: node Received tx 0x0aa09f594c5aafa3fe6d9485fb4818c37ad08c57b7e279cb8ce005bc0a88506a {"txHash":"0x0aa09f594c5aafa3fe6d9485fb4818c37ad08c57b7e279cb8ce005bc0a88506a"} 14:12:12 aztec-1 | [14:12:12.569] INFO: pxe:service Sent transaction 0x0aa09f594c5aafa3fe6d9485fb4818c37ad08c57b7e279cb8ce005bc0a88506a 14:12:12 aztec-1 | [14:12:12.640] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.018036035000000995s {"duration":0.018036035000000995,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 14:12:12 aztec-1 | [14:12:12.662] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x05ae584eabdba08952bad2fd8359ce4d8f49f5f8c58e0bb5d7cbb28d2583f51c","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749737885,"version":3573608979},"txHashes":["0x0aa09f594c5aafa3fe6d9485fb4818c37ad08c57b7e279cb8ce005bc0a88506a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":48.51543599999786,"publicProcessDuration":18.199168000002828,"rollupCircuitsDuration":42.49262400000225,"txCount":1,"blockNumber":3,"blockTimestamp":1749737885,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:12:12 aztec-1 | [14:12:12.880] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:12:12 aztec-1 | [14:12:12.887] WARN: archiver Failed to reach L2 block 3 at 28 (latest is 2). Rolling back last synched L1 block number to 27. {"latestLocalL2BlockNumber":2,"latestLocalL2BlockArchive":"0x1e5be8f408de71213e706ae434455779718330efef9a27429af1c9be42ecfeaf","blocksSynchedTo":27,"currentL1BlockNumber":28,"provenBlockNumber":2,"provenArchive":"0x1e5be8f408de71213e706ae434455779718330efef9a27429af1c9be42ecfeaf","pendingBlockNumber":3,"pendingArchive":"0x2ab2ac8df61d740df2eb0b688634f96c45c8f6a8b1ee1a035c73d944a4f57775"} 14:12:12 aztec-1 | [14:12:12.937] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 14:12:12 aztec-1 | [14:12:12.937] WARN: foundation:test-date-provider Time set to 2025-06-12T14:18:17.000Z {"offset":364063,"timeMs":1749737897000} 14:12:12 aztec-1 | [14:12:12.947] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 14:12:12 aztec-1 | [14:12:12.952] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 14:12:12 aztec-1 | [14:12:12.958] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 14:12:12 aztec-1 | error: "Rollup__SlotAlreadyInChain(4, 4)" 14:12:12 aztec-1 | [14:12:12.958] WARN: sequencer Cannot propose block 3 at slot 4 due to failed rollup contract check 14:12:13 aztec-1 | [14:12:13.009] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x05ae584eabdba08952bad2fd8359ce4d8f49f5f8c58e0bb5d7cbb28d2583f51c","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749737885,"version":3573608979},"archiveRoot":"0x2ab2ac8df61d740df2eb0b688634f96c45c8f6a8b1ee1a035c73d944a4f57775","archiveNextLeafIndex":4} 14:12:13 aztec-1 | [14:12:13.021] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 14:12:13 aztec-1 | [14:12:13.039] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":13.965035999997781,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749737885,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 14:12:13 aztec-1 | Initial Accounts: 14:12:13 aztec-1 | 14:12:13 aztec-1 | Address: 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef 14:12:13 aztec-1 | Partial Address: 0x25cdbb7a5be4a2b0e9adb1e87d0b5f372a1fa87051c9bcfee1d2c12805bf4aac 14:12:13 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 14:12:13 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 14:12:13 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 14:12:13 aztec-1 | 14:12:13 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 14:12:13 aztec-1 | 14:12:13 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 14:12:13 aztec-1 | 14:12:13 aztec-1 | Address: 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741 14:12:13 aztec-1 | Partial Address: 0x0c7f265c4adbd783aa791ae3f6859e620def9316c9013a9a72c68d3df8514776 14:12:13 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 14:12:13 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 14:12:13 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 14:12:13 aztec-1 | 14:12:13 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 14:12:13 aztec-1 | 14:12:13 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 14:12:13 aztec-1 | 14:12:13 aztec-1 | Address: 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923 14:12:13 aztec-1 | Partial Address: 0x26ee9b51c1ec4a4c6810ea237b0a33367ab5d0c7fd08e07761ac9c429a28ef0a 14:12:13 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 14:12:13 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 14:12:13 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 14:12:13 aztec-1 | 14:12:13 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 14:12:13 aztec-1 | 14:12:13 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 14:12:13 aztec-1 | 14:12:13 aztec-1 | 14:12:13 aztec-1 | [14:12:13.087] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 14:12:13 aztec-1 | error: "Rollup__SlotAlreadyInChain(4, 4)" 14:12:13 aztec-1 | [14:12:13.087] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 14:12:14 aztec-1 | [14:12:13.903] WARN: pxe:service No artifact found for contract class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3 when looking for its metadata 14:12:14 aztec-1 | [14:12:13.903] WARN: pxe:service No artifact found for contract class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249 when looking for its metadata 14:12:14 aztec-1 | [14:12:13.905] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749737921 14:12:14 aztec-1 | [14:12:13.905] WARN: foundation:test-date-provider Time set to 2025-06-12T14:18:41.000Z {"offset":387095,"timeMs":1749737921000} 14:12:14 aztec-1 | [14:12:13.905] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 14:12:14 aztec-1 | [14:12:13.906] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3 as part of deployment for 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae 14:12:14 aztec-1 | [14:12:13.939] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249 as part of deployment for 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 14:12:15 aztec-1 | [14:12:14.881] INFO: pxe:service Added contract FPC at 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae with class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3 14:12:15 aztec-1 | [14:12:14.918] INFO: pxe:service Added contract Token at 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 with class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249 14:12:18 aztec-1 | [14:12:17.592] INFO: pxe:service Proving completed in 2632.0464150000007ms {"timings":{"total":2632.0464150000007,"sync":29.970162000001437,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":359.5152620000008,"oracles":{"debugLog":{"times":[0.2697420000004058,0.10903900000266731,0.09213799999997718,0.22024799999780953,0.10818899999867426,0.12009000000034575,0.10401899999851594,0.17584399999759626]},"fetchTaggedLogs":{"times":[115.01032199999827]},"loadCapsule":{"times":[0.2549199999994016,0.17728399999759858,0.32389600000169594,0.9209020000016608,0.22505799999999,3.2105420000007143,3.844891999997344]},"getSharedSecret":{"times":[6.954445999999734]},"aes128Decrypt":{"times":[1.1422399999974004,0.7613890000029642]},"getPublicKeysAndPartialAddress":{"times":[3.8342110000012326]},"getKeyValidationRequest":{"times":[5.5466750000014144]},"storeCapsule":{"times":[3.579740999997739,3.0513690000007045,3.9666509999988193]},"deleteCapsule":{"times":[3.4363999999986845]},"validateEnqueuedNotesAndEvents":{"times":[22.600012999999308]},"getNotes":{"times":[2.1011650000000373]},"getAuthWitness":{"times":[0.20874600000024657]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04012299999885727]},"callPrivateFunction":{"times":[911.694233000002,113.39290600000095]},"notifyEnqueuedPublicFunctionCall":{"times":[0.35152800000287243]}}},{"functionName":"private_kernel_init","time":76.88764199999787},{"functionName":"ContractClassRegisterer:register","time":892.414800999999,"oracles":{"loadCapsule":{"times":[3.4361489999973855]},"notifyCreatedNullifier":{"times":[0.7250370000001567]},"debugLog":{"times":[0.23185799999919254]},"notifyCreatedContractClassLog":{"times":[6.364869000000908]}}},{"functionName":"private_kernel_inner","time":145.79521699999896},{"functionName":"ContractInstanceDeployer:deploy","time":72.41599100000167,"oracles":{"storeInExecutionCache":{"times":[0.33054600000104983]},"callPrivateFunction":{"times":[38.89527100000123]},"notifyCreatedNullifier":{"times":[0.19205499999952735]},"debugLog":{"times":[0.09589799999957904]}}},{"functionName":"private_kernel_inner","time":146.6931489999988},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":26.382579999997688,"oracles":{}},{"functionName":"private_kernel_inner","time":146.29296700000123},{"functionName":"private_kernel_reset","time":221.47796400000152},{"functionName":"private_kernel_tail","time":116.5557140000019}],"unaccounted":397.64496599999984}} 14:12:18 aztec-1 | [14:12:17.789] INFO: node Received tx 0x07b6bda3c7db80e32a62c9de5e3f2a4df57fb1f0906acdfd1151b74e807df30d {"txHash":"0x07b6bda3c7db80e32a62c9de5e3f2a4df57fb1f0906acdfd1151b74e807df30d"} 14:12:18 aztec-1 | [14:12:17.789] INFO: pxe:service Sent transaction 0x07b6bda3c7db80e32a62c9de5e3f2a4df57fb1f0906acdfd1151b74e807df30d 14:12:20 aztec-1 | [14:12:19.760] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.798316648s {"duration":1.798316648,"rate":19742.90792418889,"totalPublicGas":{"daGas":4096,"l2Gas":35504},"totalBlockGas":{"daGas":166912,"l2Gas":60546},"totalSizeInBytes":10688} 14:12:20 aztec-1 | [14:12:19.958] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 17629.83977262336 mana/s {"blockHash":"0x082f9f1e70413ffd5de75b1674c11d4020c911f75e8f9f0e2434242ba2aa6663","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749737921,"version":3573608979},"txHashes":["0x07b6bda3c7db80e32a62c9de5e3f2a4df57fb1f0906acdfd1151b74e807df30d"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2013.7679610000014,"publicProcessDuration":1798.5058529999988,"rollupCircuitsDuration":2007.1746429999985,"txCount":1,"blockNumber":4,"blockTimestamp":1749737921,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296} 14:12:20 aztec-1 | [14:12:20.499] INFO: pxe:service Proving completed in 2905.3312939999996ms {"timings":{"total":2905.3312939999996,"sync":151.35251399999834,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":475.5363359999974,"oracles":{"debugLog":{"times":[0.34102700000221375,0.14212100000077044,0.08988699999827077,0.24501900000177557,0.1092480000006617,0.10546799999792711,0.0940969999974186,0.227257999998983]},"fetchTaggedLogs":{"times":[197.8825340000003]},"loadCapsule":{"times":[0.4834980000014184,0.39555100000143284,0.8558869999978924,0.437644999998156,1.9557839999979478,0.7974730000023555,1.253658000001451]},"getSharedSecret":{"times":[11.534615000000485]},"aes128Decrypt":{"times":[0.2872429999988526,0.6497810000000754]},"getPublicKeysAndPartialAddress":{"times":[1.9119799999971292]},"getKeyValidationRequest":{"times":[2.411269000000175]},"storeCapsule":{"times":[2.4728030000005674,24.745381000000634,4.428126999999222]},"deleteCapsule":{"times":[4.652545000000828]},"validateEnqueuedNotesAndEvents":{"times":[20.588424999998097]},"getNotes":{"times":[6.6320100000011735]},"getAuthWitness":{"times":[0.3195549999982177]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05791500000123051]},"callPrivateFunction":{"times":[979.2816539999985,157.55383000000074]},"notifyEnqueuedPublicFunctionCall":{"times":[0.05080399999860674]}}},{"functionName":"private_kernel_init","time":60.79666899999938},{"functionName":"ContractClassRegisterer:register","time":959.3852039999983,"oracles":{"loadCapsule":{"times":[2.90484799999831]},"notifyCreatedNullifier":{"times":[0.5112599999993108]},"debugLog":{"times":[0.1549120000017865]},"notifyCreatedContractClassLog":{"times":[5.887441999999282]}}},{"functionName":"private_kernel_inner","time":122.06217599999945},{"functionName":"ContractInstanceDeployer:deploy","time":100.33193100000062,"oracles":{"storeInExecutionCache":{"times":[0.11054900000090129]},"callPrivateFunction":{"times":[53.51378900000054]},"notifyCreatedNullifier":{"times":[0.3052239999997255]},"debugLog":{"times":[0.15937299999859533]}}},{"functionName":"private_kernel_inner","time":135.40614300000016},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":42.10095300000103,"oracles":{}},{"functionName":"private_kernel_inner","time":122.99910900000032},{"functionName":"private_kernel_reset","time":185.03708600000027},{"functionName":"private_kernel_tail","time":88.81346699999995}],"unaccounted":461.50970600000437}} 14:12:20 aztec-1 | [14:12:20.792] INFO: node Received tx 0x1afb2cb3f2d2fbb474012ffd18f327e246643500cd8af0fd87383ac51abe4ecb {"txHash":"0x1afb2cb3f2d2fbb474012ffd18f327e246643500cd8af0fd87383ac51abe4ecb"} 14:12:20 aztec-1 | [14:12:20.792] INFO: pxe:service Sent transaction 0x1afb2cb3f2d2fbb474012ffd18f327e246643500cd8af0fd87383ac51abe4ecb 14:12:20 aztec-1 | [14:12:20.812] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 14:12:20 aztec-1 | [14:12:20.815] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 14:12:20 aztec-1 | [14:12:20.817] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:12:20 aztec-1 | [14:12:20.851] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749737957 14:12:20 aztec-1 | [14:12:20.851] WARN: foundation:test-date-provider Time set to 2025-06-12T14:19:17.000Z {"offset":416149,"timeMs":1749737957000} 14:12:20 aztec-1 | [14:12:20.851] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 14:12:20 aztec-1 | [14:12:20.957] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x082f9f1e70413ffd5de75b1674c11d4020c911f75e8f9f0e2434242ba2aa6663","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749737921,"version":3573608979},"archiveRoot":"0x076655d53902f8a810c187a417266751e565a626399c5b66dfc589bca741db09","archiveNextLeafIndex":5} 14:12:20 aztec-1 | [14:12:20.969] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 14:12:21 aztec-1 | [14:12:21.031] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":16.789247000000614,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749737921,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296} 14:12:21 aztec-1 | [14:12:21.464] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.3698449839999994s {"duration":0.3698449839999994,"rate":746931.8551039223,"totalPublicGas":{"daGas":10240,"l2Gas":276249},"totalBlockGas":{"daGas":380928,"l2Gas":301291},"totalSizeInBytes":24064} 14:12:21 aztec-1 | [14:12:21.510] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 645972.0873246416 mana/s {"blockHash":"0x1e929109beff01855c746a4162156fbea4f43b8cc18a6c748191806a7fd5a6d7","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749737957,"version":3573608979},"txHashes":["0x1afb2cb3f2d2fbb474012ffd18f327e246643500cd8af0fd87383ac51abe4ecb"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":427.61565699999846,"publicProcessDuration":370.08312300000034,"rollupCircuitsDuration":419.4172230000004,"txCount":1,"blockNumber":5,"blockTimestamp":1749737957,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 14:12:21 aztec-1 | [14:12:21.612] INFO: aztecjs:deploy_sent_tx Contract 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae successfully deployed. 14:12:21 aztec-1 | [14:12:21.760] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:12:21 aztec-1 | [14:12:21.772] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749737993 14:12:21 aztec-1 | [14:12:21.772] WARN: foundation:test-date-provider Time set to 2025-06-12T14:19:53.000Z {"offset":451228,"timeMs":1749737993000} 14:12:21 aztec-1 | [14:12:21.772] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 14:12:21 aztec-1 | [14:12:21.776] WARN: archiver Failed to reach L2 block 5 at 32 (latest is 4). Rolling back last synched L1 block number to 31. {"latestLocalL2BlockNumber":4,"latestLocalL2BlockArchive":"0x076655d53902f8a810c187a417266751e565a626399c5b66dfc589bca741db09","blocksSynchedTo":31,"currentL1BlockNumber":32,"provenBlockNumber":4,"provenArchive":"0x076655d53902f8a810c187a417266751e565a626399c5b66dfc589bca741db09","pendingBlockNumber":5,"pendingArchive":"0x2e42dc7eec9120deb3f57da71892d8c0d1bcc90562307d25d5d3ed8253fdf2b5"} 14:12:21 aztec-1 | [14:12:21.841] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 14:12:21 aztec-1 | [14:12:21.846] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 14:12:22 aztec-1 | [14:12:21.976] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x1e929109beff01855c746a4162156fbea4f43b8cc18a6c748191806a7fd5a6d7","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749737957,"version":3573608979},"archiveRoot":"0x2e42dc7eec9120deb3f57da71892d8c0d1bcc90562307d25d5d3ed8253fdf2b5","archiveNextLeafIndex":6} 14:12:22 aztec-1 | [14:12:21.988] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 14:12:22 aztec-1 | [14:12:22.051] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":20.814362000000983,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749737957,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 14:12:23 aztec-1 | BananaCoin: 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 14:12:23 aztec-1 | FPC: 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae 14:12:24 aztec-1 | [14:12:23.098] INFO: aztecjs:deploy_sent_tx Contract 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 successfully deployed. 14:12:24 aztec-1 | [14:12:23.131] WARN: pxe:service No artifact found for contract class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523 when looking for its metadata 14:12:24 aztec-1 | [14:12:23.135] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523 as part of deployment for 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc 14:12:24 aztec-1 | [14:12:23.280] INFO: pxe:service Added contract SponsoredFPC at 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc with class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523 14:12:26 aztec-1 | [14:12:25.641] INFO: pxe:service Proving completed in 2329.2290170000015ms {"timings":{"total":2329.2290170000015,"sync":37.50487200000134,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":81.67532900000151,"oracles":{"callPrivateFunction":{"times":[784.0171760000012,150.10209499999837,50.54358499999944]}}},{"functionName":"private_kernel_init","time":84.26169999999911},{"functionName":"ContractClassRegisterer:register","time":771.3182610000003,"oracles":{"loadCapsule":{"times":[1.521348999998736]},"notifyCreatedNullifier":{"times":[0.7413379999998142]},"debugLog":{"times":[0.13088000000061584]},"notifyCreatedContractClassLog":{"times":[3.5877520000030927]}}},{"functionName":"private_kernel_inner","time":150.69878700000118},{"functionName":"ContractInstanceDeployer:deploy","time":88.88061300000118,"oracles":{"storeInExecutionCache":{"times":[0.084936999999627]},"callPrivateFunction":{"times":[57.356049999998504]},"notifyCreatedNullifier":{"times":[0.20519599999897764]},"debugLog":{"times":[0.14406199999939417]}}},{"functionName":"private_kernel_inner","time":118.68320499999754},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":43.587438999998994,"oracles":{}},{"functionName":"private_kernel_inner","time":118.58305699999983},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":41.2081419999995,"oracles":{"debugLog":{"times":[0.13257099999827915]}}},{"functionName":"private_kernel_inner","time":126.30030400000032},{"functionName":"private_kernel_reset","time":191.09858499999973},{"functionName":"private_kernel_tail","time":79.9653130000006}],"unaccounted":395.4634100000003}} 14:12:26 aztec-1 | [14:12:25.767] INFO: node Received tx 0x2d5fa82f849cd78d2e15afeb2eedc55d62f6981d7fecc2414d6cbba95bf0ffd5 {"txHash":"0x2d5fa82f849cd78d2e15afeb2eedc55d62f6981d7fecc2414d6cbba95bf0ffd5"} 14:12:26 aztec-1 | [14:12:25.767] INFO: pxe:service Sent transaction 0x2d5fa82f849cd78d2e15afeb2eedc55d62f6981d7fecc2414d6cbba95bf0ffd5 14:12:26 aztec-1 | [14:12:25.904] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.041977138000002016s {"duration":0.041977138000002016,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 14:12:26 aztec-1 | [14:12:25.939] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1e66585f91d8567be53fce42e9766e23a361b2f5f4f69ea26d4aa3345799ef68","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749737993,"version":3573608979},"txHashes":["0x2d5fa82f849cd78d2e15afeb2eedc55d62f6981d7fecc2414d6cbba95bf0ffd5"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":85.25423800000135,"publicProcessDuration":42.360657999997784,"rollupCircuitsDuration":79.06716200000301,"txCount":1,"blockNumber":6,"blockTimestamp":1749737993,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:12:26 aztec-1 | [14:12:26.120] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 14:12:26 aztec-1 | [14:12:26.122] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 14:12:26 aztec-1 | [14:12:26.125] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 14:12:26 aztec-1 | [14:12:26.138] WARN: archiver Failed to reach L2 block 6 at 34 (latest is 5). Rolling back last synched L1 block number to 33. {"latestLocalL2BlockNumber":5,"latestLocalL2BlockArchive":"0x2e42dc7eec9120deb3f57da71892d8c0d1bcc90562307d25d5d3ed8253fdf2b5","blocksSynchedTo":33,"currentL1BlockNumber":34,"provenBlockNumber":5,"provenArchive":"0x2e42dc7eec9120deb3f57da71892d8c0d1bcc90562307d25d5d3ed8253fdf2b5","pendingBlockNumber":6,"pendingArchive":"0x050ed212a44acbdbb5190cfe81e164f116123ce2775a577808b212a0f9df624d"} 14:12:26 aztec-1 | [14:12:26.182] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749738029 14:12:26 aztec-1 | [14:12:26.182] WARN: foundation:test-date-provider Time set to 2025-06-12T14:20:29.000Z {"offset":482818,"timeMs":1749738029000} 14:12:26 aztec-1 | [14:12:26.182] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 14:12:26 aztec-1 | [14:12:26.185] WARN: sequencer:publisher Failed canProposeAtTime check with InvalidArchive 14:12:26 aztec-1 | error: "Rollup__InvalidArchive(0x050ed212a44acbdbb5190cfe81e164f116123ce2775a577808b212a0f9df624d, 0x2e42dc7eec9120deb3f57da71892d8c0d1bcc90562307d25d5d3ed8253fdf2b5)" 14:12:26 aztec-1 | [14:12:26.185] WARN: sequencer Cannot propose block 6 at slot 7 due to failed rollup contract check 14:12:26 aztec-1 | [14:12:26.244] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x1e66585f91d8567be53fce42e9766e23a361b2f5f4f69ea26d4aa3345799ef68","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749737993,"version":3573608979},"archiveRoot":"0x050ed212a44acbdbb5190cfe81e164f116123ce2775a577808b212a0f9df624d","archiveNextLeafIndex":7} 14:12:26 aztec-1 | [14:12:26.251] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 14:12:26 aztec-1 | [14:12:26.277] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":13.919554000000062,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749737993,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 14:12:26 aztec-1 | SponsoredFPC: 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc 14:12:26 aztec-1 | [14:12:26.789] INFO: aztecjs:deploy_sent_tx Contract 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc successfully deployed. 14:12:26 aztec-1 | [14:12:26.797] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x08c6b24bd9c265f8c6596b12f540d93a53f5bcd1502d78957c8614575c61c9f4","l2ProtocolContractsTreeRoot":"0x052cc6e2bd1171363e72fb45b9a78fb0ebacedb96c8f1148b3903c3bafa8c458"} 14:12:33 playground-1 | \ 14:12:33 playground-1 | Running 1 test using 1 worker 14:12:33 playground-1 | 14:12:34 playground-1 | ✓ 1 [chromium] › browser.spec.ts:3:1 › test (6.9s) 14:12:41 playground-1 | 1 passed (9.0s) 14:12:42 playground-1 | \ 14:12:42 playground-1 exited with code 0 14:12:42 Aborting on container exit... 14:12:42 Container playground-chromium-playground-1 Stopping 14:12:42 Container playground-chromium-playground-1 Stopped 14:12:42 Container playground-chromium-aztec-1 Stopping 14:12:43 Container playground-chromium-aztec-1 Stopped 14:12:43 Container playground-chromium-ethereum-1 Stopping 14:12:43 Container playground-chromium-ethereum-1 Stopped