Parent Log: http://ci.aztec-labs.com/79a066b826d51d55 Command: c0136391379d1261 playground/scripts/run_test.sh chromium Commit: https://github.com/AztecProtocol/aztec-packages/commit/1650b3d017a2a4fa5182c8787e79cc108e24e1f4 Env: REF_NAME=gh-readonly-queue/next/pr-14990-77a00686be4080a71b03d68671da6c8b270b62aa CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Thu Jun 12 10:53:07 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14990_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_3af8716c4dfeb01b_next 10:53:07 Network playground-chromium_default Creating 10:53:08 Network playground-chromium_default Created 10:53:08 Container playground-chromium-ethereum-1 Creating 10:53:08 Container playground-chromium-ethereum-1 Created 10:53:08 Container playground-chromium-aztec-1 Creating 10:53:09 Container playground-chromium-aztec-1 Created 10:53:09 Container playground-chromium-playground-1 Creating 10:53:09 Container playground-chromium-playground-1 Created 10:53:09 Attaching to aztec-1, ethereum-1, playground-1 10:53:14 aztec-1 | 10:53:14 aztec-1 | _ 10:53:14 aztec-1 | /\ | | 10:53:14 aztec-1 | / \ ___| |_ ___ ___ 10:53:14 aztec-1 | / /\ \ |_ / __/ _ \/ __| 10:53:14 aztec-1 | / ____ \ / /| || __/ (__ 10:53:14 aztec-1 | /_/___ \_\/___|\__\___|\___| 10:53:14 aztec-1 | 10:53:14 aztec-1 | https://github.com/AztecProtocol 10:53:14 aztec-1 | 10:53:14 aztec-1 | 10:53:14 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by... 10:53:14 aztec-1 | Setting up test accounts 10:53:16 aztec-1 | [10:53:15.335] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-r3gXJn/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 10:53:16 aztec-1 | [10:53:15.668] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 10:53:16 aztec-1 | [10:53:15.673] WARN: sandbox Set block interval to 12 10:53:16 aztec-1 | [10:53:15.906] INFO: sandbox Waiting for 7 transactions to be mined... 10:53:16 aztec-1 | [10:53:15.934] INFO: sandbox All transactions mined successfully 10:53:16 aztec-1 | [10:53:16.022] INFO: sandbox Waiting for 9 transactions to be mined... 10:53:16 aztec-1 | [10:53:16.041] INFO: sandbox All transactions mined successfully 10:53:16 aztec-1 | [10:53:16.188] INFO: sandbox Waiting for 11 transactions to be mined... 10:53:16 aztec-1 | [10:53:16.212] INFO: sandbox All transactions mined successfully 10:53:16 aztec-1 | [10:53:16.301] INFO: sandbox Waiting for 12 transactions to be mined... 10:53:16 aztec-1 | [10:53:16.325] INFO: sandbox All transactions mined successfully 10:53:16 aztec-1 | [10:53:16.330] INFO: sandbox Waiting for 12 transactions to be mined... 10:53:16 aztec-1 | [10:53:16.361] INFO: sandbox All transactions mined successfully 10:53:16 aztec-1 | [10:53:16.380] 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"} 10:53:16 aztec-1 | [10:53:16.381] INFO: sandbox Handing over to governance 10:53:16 aztec-1 | [10:53:16.390] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x68B1D87F95878fE05B998F19b66F4baba5De1aed 10:53:16 aztec-1 | [10:53:16.391] INFO: telemetry:client Using NoopTelemetryClient 10:53:16 aztec-1 | [10:53:16.391] INFO: blob-sink:client Creating local blob sink client. 10:53:16 aztec-1 | [10:53:16.395] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 10:53:16 aztec-1 | [10:53:16.395] WARN: foundation:test-date-provider Time set to 2025-06-12T10:57:45.000Z {"offset":268605,"timeMs":1749725865000} 10:53:16 aztec-1 | [10:53:16.411] INFO: archiver:lmdb Starting data store with maxReaders 16 10:53:16 aztec-1 | [10:53:16.793] INFO: archiver Starting archiver sync to rollup contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed from L1 block 19 to current L1 block 23 with hash 0x2ee15aafc2a37bffd7e07d56189d027a8d0de89538cc491599dee4190c749fb8 {"blocksSynchedTo":19,"messagesSynchedTo":{"l1BlockHash":"0xc5abb2b569c001b012ff9b5d212f9c8fcb4f0aa201229b4bda6c8d7c2c3a6b42","l1BlockNumber":19}} 10:53:16 aztec-1 | [10:53:16.821] INFO: archiver Initial archiver sync to L1 block 23 complete. {"l1BlockNumber":23,"syncPoint":{"blocksSynchedTo":23,"messagesSynchedTo":{"l1BlockHash":"0x2ee15aafc2a37bffd7e07d56189d027a8d0de89538cc491599dee4190c749fb8","l1BlockNumber":23}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 10:53:17 aztec-1 | [10:53:16.833] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-UfDV65/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 10:53:17 aztec-1 | [10:53:17.081] INFO: world_state Created world state synchroniser with block history of 64 10:53:17 aztec-1 | [10:53:17.081] WARN: node Aztec node is accepting fake proofs 10:53:17 aztec-1 | [10:53:17.092] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 10:53:17 aztec-1 | [10:53:17.109] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 10:53:17 aztec-1 | [10:53:17.129] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 10:53:17 aztec-1 | [10:53:17.145] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 10:53:17 aztec-1 | [10:53:17.149] INFO: world_state Started world state synchronizer from block 1 10:53:17 aztec-1 | [10:53:17.152] INFO: p2p Starting p2p client from block 0 with empty mempools 10:53:17 aztec-1 | [10:53:17.372] INFO: epoch-prune-watcher EpochPruneWatcher initialized 10:53:17 aztec-1 | [10:53:17.428] INFO: slasher Starting Slasher client... 10:53:17 aztec-1 | [10:53:17.439] INFO: sequencer-client Deploying forwarder contract 10:53:17 aztec-1 | [10:53:17.460] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 10:53:17 aztec-1 | [10:53:17.468] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 10:53:17 aztec-1 | [10:53:17.469] 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} 10:53:17 aztec-1 | [10:53:17.471] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 10:53:17 aztec-1 | [10:53:17.472] INFO: node Aztec Node version: 0.87.6 10:53:17 aztec-1 | [10:53:17.472] 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"} 10:53:17 aztec-1 | [10:53:17.477] INFO: pxe:data:lmdb Starting data store with maxReaders 16 10:53:17 aztec-1 | [10:53:17.490] 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} 10:53:17 aztec-1 | [10:53:17.562] 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} 10:53:17 aztec-1 | [10:53:17.628] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 10:53:17 aztec-1 | [10:53:17.628] WARN: foundation:test-date-provider Time set to 2025-06-12T10:57:57.000Z {"offset":279372,"timeMs":1749725877000} 10:53:17 aztec-1 | [10:53:17.629] 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} 10:53:17 aztec-1 | Setting up funded test accounts... 10:53:18 aztec-1 | [10:53:17.902] INFO: pxe:service Started PXE connected to chain 31337 version 3573608979 10:53:18 aztec-1 | [10:53:17.991] INFO: pxe:service Registered account 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef 10:53:18 aztec-1 | [10:53:18.048] WARN: pxe:service No artifact found for contract class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f when looking for its metadata 10:53:18 aztec-1 | [10:53:18.050] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f as part of deployment for 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef 10:53:18 aztec-1 | [10:53:18.206] INFO: pxe:service Added contract SchnorrAccount at 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f 10:53:21 aztec-1 | [10:53:20.887] INFO: pxe:service Proving completed in 2646.3815160000004ms {"timings":{"total":2646.3815160000004,"sync":8.111847000000125,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":160.2045530000005,"oracles":{"callPrivateFunction":{"times":[857.0614830000004,341.5411100000001,213.66613499999949]}}},{"functionName":"private_kernel_init","time":87.6641180000006},{"functionName":"ContractClassRegisterer:register","time":834.170368000001,"oracles":{"loadCapsule":{"times":[22.752470999999787]},"notifyCreatedNullifier":{"times":[30.341003999999884]},"debugLog":{"times":[0.7425290000010136]},"notifyCreatedContractClassLog":{"times":[6.0679350000009435]}}},{"functionName":"private_kernel_inner","time":111.88007599999946},{"functionName":"SchnorrAccount:constructor","time":321.41904599999907,"oracles":{"getContractInstance":{"times":[1.2050209999997605]},"debugLog":{"times":[0.21989599999869824,0.09801299999890034]},"fetchTaggedLogs":{"times":[58.3069689999993]},"loadCapsule":{"times":[0.361960000000181,0.23454599999968195,0.20568500000081258]},"validateEnqueuedNotesAndEvents":{"times":[6.551516999999876]},"notifyCreatedNullifier":{"times":[0.4545720000005531,0.21762500000113505]},"notifyCreatedNote":{"times":[0.7986700000001292]},"getRandomField":{"times":[0.2964670000001206,0.20953499999995984,0.04367100000126811,0.05624100000022736,0.1946540000008099,0.0538909999995667,0.04692100000102073,0.04616100000021106,0.049661000000924105,0.06101200000011886,0.04052100000080827]},"getIndexedTaggingSecretAsSender":{"times":[60.49762499999997]},"incrementAppTaggingSecretIndexAsSender":{"times":[27.54775399999926]}}},{"functionName":"private_kernel_inner","time":109.8553150000007},{"functionName":"SchnorrAccount:entrypoint","time":188.6933169999993,"oracles":{"debugLog":{"times":[0.22063499999967462,0.09075200000006589,0.33303800000066985]},"fetchTaggedLogs":{"times":[62.33540200000061]},"loadCapsule":{"times":[0.21382599999924423,0.31353800000033516,0.20021499999893422]},"validateEnqueuedNotesAndEvents":{"times":[5.622102999999697]},"getNotes":{"times":[1.758335000000443]},"getAuthWitness":{"times":[0.24067599999943923]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.9526139999998122]}}},{"functionName":"private_kernel_inner","time":150.20970500000112},{"functionName":"private_kernel_reset","time":240.9166210000003},{"functionName":"private_kernel_tail","time":82.51999700000124}],"unaccounted":350.736552999997}} 10:53:21 aztec-1 | [10:53:21.059] INFO: node Received tx 0x06e9056fab1ca63feaae9b8313f53eeced68eccd9f4e071c77161c30ff518a1a {"txHash":"0x06e9056fab1ca63feaae9b8313f53eeced68eccd9f4e071c77161c30ff518a1a"} 10:53:21 aztec-1 | [10:53:21.059] INFO: pxe:service Sent transaction 0x06e9056fab1ca63feaae9b8313f53eeced68eccd9f4e071c77161c30ff518a1a 10:53:21 aztec-1 | [10:53:21.169] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04884181699999863s {"duration":0.04884181699999863,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 10:53:21 aztec-1 | [10:53:21.207] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x1fc055f2ae407afd1564a296737b077e4111f8e68ea279d69bfa55a5bc35bd02","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749725889,"version":3573608979},"txHashes":["0x06e9056fab1ca63feaae9b8313f53eeced68eccd9f4e071c77161c30ff518a1a"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":98.5695969999997,"publicProcessDuration":50.06095800000003,"rollupCircuitsDuration":89.80199299999913,"txCount":1,"blockNumber":1,"blockTimestamp":1749725889,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 10:53:24 aztec-1 | [10:53:24.227] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 10:53:24 aztec-1 | [10:53:24.230] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 10:53:24 aztec-1 | [10:53:24.232] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:53:24 aztec-1 | [10:53:24.235] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749725925 10:53:24 aztec-1 | [10:53:24.235] WARN: foundation:test-date-provider Time set to 2025-06-12T10:58:45.000Z {"offset":320765,"timeMs":1749725925000} 10:53:24 aztec-1 | [10:53:24.235] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 10:53:24 aztec-1 | [10:53:24.331] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1fc055f2ae407afd1564a296737b077e4111f8e68ea279d69bfa55a5bc35bd02","blockNumber":1,"txCount":1,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749725889,"version":3573608979},"archiveRoot":"0x27ad6044b01fc4a0214180b7c70d87f89a4a2fc22bd09cc4b443c5e1ec234876","archiveNextLeafIndex":2} 10:53:24 aztec-1 | [10:53:24.341] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 10:53:24 aztec-1 | [10:53:24.438] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":19.50236799999948,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749725889,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 10:53:24 aztec-1 | [10:53:24.489] INFO: pxe:service Registered account 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741 10:53:24 aztec-1 | [10:53:24.616] INFO: pxe:service Added contract SchnorrAccount at 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741 with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f 10:53:26 aztec-1 | [10:53:26.150] INFO: pxe:service Proving completed in 1508.2081870000002ms {"timings":{"total":1508.2081870000002,"sync":28.230851000000257,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":97.4850189999961,"oracles":{"callPrivateFunction":{"times":[350.75950600000033,212.9771980000005]}}},{"functionName":"private_kernel_init","time":64.81689400000141},{"functionName":"SchnorrAccount:constructor","time":322.940254000001,"oracles":{"getContractInstance":{"times":[4.215697999999975]},"debugLog":{"times":[0.3073869999989256,0.07699200000024575]},"fetchTaggedLogs":{"times":[95.44222700000137]},"loadCapsule":{"times":[0.21337499999935972,0.2728769999994256,0.1996049999997922]},"validateEnqueuedNotesAndEvents":{"times":[6.111645999999382]},"notifyCreatedNullifier":{"times":[0.4753319999999803,0.26432699999895704]},"notifyCreatedNote":{"times":[0.18821500000012747]},"getRandomField":{"times":[0.14485400000012305,0.14530400000148802,0.03640099999938684,0.05817100000058417,0.03544099999999162,0.02686100000028091,0.04202099999929487,0.053130999998757034,0.035390999999435735,0.03476099999897997,0.0258109999995213]},"getIndexedTaggingSecretAsSender":{"times":[55.382114]},"incrementAppTaggingSecretIndexAsSender":{"times":[24.53687600000012]}}},{"functionName":"private_kernel_inner","time":105.14500399999997},{"functionName":"SchnorrAccount:entrypoint","time":189.30516400000124,"oracles":{"debugLog":{"times":[0.22993599999972503,0.09835200000088662,0.20604499999899417]},"fetchTaggedLogs":{"times":[70.68551500000103]},"loadCapsule":{"times":[0.19984499999918626,0.15296399999897403,0.12975299999925483]},"validateEnqueuedNotesAndEvents":{"times":[5.6625850000000355]},"getNotes":{"times":[1.1114679999991495]},"getAuthWitness":{"times":[0.1455340000011347]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.4564119999995455]}}},{"functionName":"private_kernel_inner","time":130.01872899999944},{"functionName":"private_kernel_reset","time":203.0801449999999},{"functionName":"private_kernel_tail","time":76.85841299999993}],"unaccounted":290.3277140000009}} 10:53:26 aztec-1 | [10:53:26.219] INFO: node Received tx 0x050ff8f2de009825899618b7a94460f0f227fac3aa7e70a2ce793433d9e5d60f {"txHash":"0x050ff8f2de009825899618b7a94460f0f227fac3aa7e70a2ce793433d9e5d60f"} 10:53:26 aztec-1 | [10:53:26.219] INFO: pxe:service Sent transaction 0x050ff8f2de009825899618b7a94460f0f227fac3aa7e70a2ce793433d9e5d60f 10:53:26 aztec-1 | [10:53:26.330] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.019983070000000224s {"duration":0.019983070000000224,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 10:53:26 aztec-1 | [10:53:26.351] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x27210f0f0f06598707413b2db66489183fe549ab1fbfcf0cf11bcf6729740b58","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749725925,"version":3573608979},"txHashes":["0x050ff8f2de009825899618b7a94460f0f227fac3aa7e70a2ce793433d9e5d60f"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":48.235522000000856,"publicProcessDuration":20.13631499999974,"rollupCircuitsDuration":43.3909679999997,"txCount":1,"blockNumber":2,"blockTimestamp":1749725925,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:53:26 aztec-1 | [10:53:26.591] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 10:53:26 aztec-1 | [10:53:26.591] WARN: foundation:test-date-provider Time set to 2025-06-12T10:58:57.000Z {"offset":330409,"timeMs":1749725937000} 10:53:26 aztec-1 | [10:53:26.593] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:53:26 aztec-1 | [10:53:26.601] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 10:53:26 aztec-1 | [10:53:26.603] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 10:53:26 aztec-1 | [10:53:26.611] WARN: archiver Failed to reach L2 block 2 at 26 (latest is 1). Rolling back last synched L1 block number to 25. {"latestLocalL2BlockNumber":1,"latestLocalL2BlockArchive":"0x27ad6044b01fc4a0214180b7c70d87f89a4a2fc22bd09cc4b443c5e1ec234876","blocksSynchedTo":25,"currentL1BlockNumber":26,"provenBlockNumber":1,"provenArchive":"0x27ad6044b01fc4a0214180b7c70d87f89a4a2fc22bd09cc4b443c5e1ec234876","pendingBlockNumber":2,"pendingArchive":"0x243d092a7ec450e3ecd9460111cd993571848a57de4baa779ba53cec4adf0445"} 10:53:26 aztec-1 | [10:53:26.661] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749725961 10:53:26 aztec-1 | [10:53:26.661] WARN: foundation:test-date-provider Time set to 2025-06-12T10:59:21.000Z {"offset":354339,"timeMs":1749725961000} 10:53:26 aztec-1 | [10:53:26.661] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 10:53:26 aztec-1 | [10:53:26.682] WARN: sequencer:publisher Failed canProposeAtTime check with InvalidArchive 10:53:26 aztec-1 | error: "Rollup__InvalidArchive(0x243d092a7ec450e3ecd9460111cd993571848a57de4baa779ba53cec4adf0445, 0x27ad6044b01fc4a0214180b7c70d87f89a4a2fc22bd09cc4b443c5e1ec234876)" 10:53:26 aztec-1 | [10:53:26.682] WARN: sequencer Cannot propose block 2 at slot 3 due to failed rollup contract check 10:53:26 aztec-1 | [10:53:26.737] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x27210f0f0f06598707413b2db66489183fe549ab1fbfcf0cf11bcf6729740b58","blockNumber":2,"txCount":1,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749725925,"version":3573608979},"archiveRoot":"0x243d092a7ec450e3ecd9460111cd993571848a57de4baa779ba53cec4adf0445","archiveNextLeafIndex":3} 10:53:26 aztec-1 | [10:53:26.748] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 10:53:26 aztec-1 | [10:53:26.767] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":17.51797699999952,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749725925,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:53:26 aztec-1 | [10:53:26.882] INFO: pxe:service Registered account 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923 10:53:27 aztec-1 | [10:53:27.010] INFO: pxe:service Added contract SchnorrAccount at 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923 with class 0x2e017ccab24f7995c8c2ec64e81af3047767dca754005fcddf81093b54ed2a4f 10:53:29 aztec-1 | [10:53:28.581] INFO: pxe:service Proving completed in 1562.1372640000009ms {"timings":{"total":1562.1372640000009,"sync":30.44720700000107,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":72.82847000000766,"oracles":{"callPrivateFunction":{"times":[370.1935009999979,267.12295000000086]}}},{"functionName":"private_kernel_init","time":58.28852800000095},{"functionName":"SchnorrAccount:constructor","time":345.973152999999,"oracles":{"getContractInstance":{"times":[1.048887000000832]},"debugLog":{"times":[0.16105500000048778,0.06447099999786587]},"fetchTaggedLogs":{"times":[138.394733000001]},"loadCapsule":{"times":[0.1647740000007616,0.12798299999849405,0.13125299999956042]},"validateEnqueuedNotesAndEvents":{"times":[10.094088000001648]},"notifyCreatedNullifier":{"times":[0.33074800000031246,0.3039269999972021]},"notifyCreatedNote":{"times":[0.23700599999938277]},"getRandomField":{"times":[0.20962499999950523,0.23246600000129547,0.03670099999726517,0.03319099999862374,0.04069100000197068,0.030210999997507315,0.03605099999913364,0.03436099999817088,0.04961100000218721,0.038400999997975305,0.06710100000054808]},"getIndexedTaggingSecretAsSender":{"times":[41.292944000000716]},"incrementAppTaggingSecretIndexAsSender":{"times":[28.078906000002462]}}},{"functionName":"private_kernel_inner","time":160.5060080000003},{"functionName":"SchnorrAccount:entrypoint","time":250.61628899999778,"oracles":{"debugLog":{"times":[0.20565600000190898,0.09738199999992503,0.10949299999992945]},"fetchTaggedLogs":{"times":[126.93502100000114]},"loadCapsule":{"times":[0.12303299999985029,0.1118720000013127,0.12053300000115996]},"validateEnqueuedNotesAndEvents":{"times":[6.8623049999987416]},"getNotes":{"times":[4.525785000001633]},"getAuthWitness":{"times":[0.23150600000008126]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.3049579999969865]}}},{"functionName":"private_kernel_inner","time":118.67819999999847},{"functionName":"private_kernel_reset","time":190.76151000000027},{"functionName":"private_kernel_tail","time":74.2433060000003}],"unaccounted":259.7945929999951}} 10:53:29 aztec-1 | [10:53:28.646] INFO: node Received tx 0x2478c65bda27001d4e8b3f2cef4558ba1d31f452043602535b61ec8c3d5437af {"txHash":"0x2478c65bda27001d4e8b3f2cef4558ba1d31f452043602535b61ec8c3d5437af"} 10:53:29 aztec-1 | [10:53:28.646] INFO: pxe:service Sent transaction 0x2478c65bda27001d4e8b3f2cef4558ba1d31f452043602535b61ec8c3d5437af 10:53:29 aztec-1 | [10:53:28.733] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.03987554799999998s {"duration":0.03987554799999998,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 10:53:29 aztec-1 | [10:53:28.769] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x09c17c86ebb0b1ce95fee30c44300544a3bfd0efea09bbdaeba9a75f12846ca5","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749725961,"version":3573608979},"txHashes":["0x2478c65bda27001d4e8b3f2cef4558ba1d31f452043602535b61ec8c3d5437af"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":86.10669899999994,"publicProcessDuration":40.15796599999885,"rollupCircuitsDuration":77.97243100000196,"txCount":1,"blockNumber":3,"blockTimestamp":1749725961,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:53:29 aztec-1 | [10:53:28.970] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:53:29 aztec-1 | [10:53:29.017] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 10:53:29 aztec-1 | [10:53:29.017] WARN: foundation:test-date-provider Time set to 2025-06-12T10:59:33.000Z {"offset":363983,"timeMs":1749725973000} 10:53:29 aztec-1 | [10:53:29.022] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 10:53:29 aztec-1 | [10:53:29.024] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 10:53:29 aztec-1 | [10:53:29.037] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:53:29 aztec-1 | error: "Rollup__SlotAlreadyInChain(4, 4)" 10:53:29 aztec-1 | [10:53:29.038] WARN: sequencer Cannot propose block 3 at slot 4 due to failed rollup contract check 10:53:29 aztec-1 | [10:53:29.048] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749725997 10:53:29 aztec-1 | [10:53:29.048] WARN: foundation:test-date-provider Time set to 2025-06-12T10:59:57.000Z {"offset":387952,"timeMs":1749725997000} 10:53:29 aztec-1 | [10:53:29.048] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 10:53:29 aztec-1 | [10:53:29.078] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x09c17c86ebb0b1ce95fee30c44300544a3bfd0efea09bbdaeba9a75f12846ca5","blockNumber":3,"txCount":1,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":332260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749725961,"version":3573608979},"archiveRoot":"0x2e8e75a456a7af472dfbc6722e06971f6b41943b79e5e99960593169167b1dd0","archiveNextLeafIndex":4} 10:53:29 aztec-1 | [10:53:29.082] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 10:53:29 aztec-1 | [10:53:29.108] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":14.157272000000376,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749725961,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:53:29 aztec-1 | Initial Accounts: 10:53:29 aztec-1 | 10:53:29 aztec-1 | Address: 0x2098b7a51b5545e6dcbf3d1f703b1fa961aee3fd4afa74cfc5fcdaaf9473ddef 10:53:29 aztec-1 | Partial Address: 0x25cdbb7a5be4a2b0e9adb1e87d0b5f372a1fa87051c9bcfee1d2c12805bf4aac 10:53:29 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 10:53:29 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 10:53:29 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 10:53:29 aztec-1 | 10:53:29 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 10:53:29 aztec-1 | 10:53:29 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 10:53:29 aztec-1 | 10:53:29 aztec-1 | Address: 0x0ab5671f409a3df349e09dcdba57de3eab9811dbb53fdc7040509b7f514dd741 10:53:29 aztec-1 | Partial Address: 0x0c7f265c4adbd783aa791ae3f6859e620def9316c9013a9a72c68d3df8514776 10:53:29 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 10:53:29 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 10:53:29 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 10:53:29 aztec-1 | 10:53:29 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 10:53:29 aztec-1 | 10:53:29 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 10:53:29 aztec-1 | 10:53:29 aztec-1 | Address: 0x14e6e67f5fc67ae70f2e78fe6cd60b034b690c8d3f90eab69609bfb283fdc923 10:53:29 aztec-1 | Partial Address: 0x26ee9b51c1ec4a4c6810ea237b0a33367ab5d0c7fd08e07761ac9c429a28ef0a 10:53:29 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 10:53:29 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 10:53:29 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 10:53:29 aztec-1 | 10:53:29 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 10:53:29 aztec-1 | 10:53:29 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 10:53:29 aztec-1 | 10:53:29 aztec-1 | 10:53:30 aztec-1 | [10:53:29.910] WARN: pxe:service No artifact found for contract class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3 when looking for its metadata 10:53:30 aztec-1 | [10:53:29.910] WARN: pxe:service No artifact found for contract class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249 when looking for its metadata 10:53:30 aztec-1 | [10:53:29.918] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3 as part of deployment for 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae 10:53:30 aztec-1 | [10:53:29.949] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249 as part of deployment for 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 10:53:31 aztec-1 | [10:53:30.786] INFO: pxe:service Added contract FPC at 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae with class 0x2183e5f752f839cfb2ba67a84dc13934d6d807278ff767a694fe49778e7ce0b3 10:53:31 aztec-1 | [10:53:30.791] INFO: pxe:service Added contract Token at 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 with class 0x20e76625b255753931a4abe202b444d4fcd0107fe0372bbed9061ac25dbff249 10:53:34 aztec-1 | [10:53:33.535] INFO: pxe:service Proving completed in 2686.910416999999ms {"timings":{"total":2686.910416999999,"sync":41.7263950000015,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":394.75850899999205,"oracles":{"debugLog":{"times":[0.1845549999998184,0.17218399999910616,0.06790199999886681,0.1496530000003986,0.1027219999996305,0.0983429999978398,0.18079500000021653,0.24521699999968405]},"fetchTaggedLogs":{"times":[144.02241700000013]},"loadCapsule":{"times":[0.4929519999968761,0.28168799999912153,0.5878750000010768,0.40734100000190665,0.3843699999997625,1.2605819999989762,0.7165080000013404]},"getSharedSecret":{"times":[5.7030460000023595]},"aes128Decrypt":{"times":[0.8883920000007492,0.7209579999980633]},"getPublicKeysAndPartialAddress":{"times":[1.8613379999987956]},"getKeyValidationRequest":{"times":[3.155790999997407]},"storeCapsule":{"times":[2.583865999997215,2.44437299999845,2.538424999998824]},"deleteCapsule":{"times":[2.911764000000403]},"validateEnqueuedNotesAndEvents":{"times":[46.448316000001796]},"getNotes":{"times":[2.859002999997756]},"getAuthWitness":{"times":[0.25791600000229664]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.053500999998504994]},"callPrivateFunction":{"times":[944.4065320000009,125.82887299999857]},"notifyEnqueuedPublicFunctionCall":{"times":[0.3621500000008382]}}},{"functionName":"private_kernel_init","time":75.86744299999918},{"functionName":"ContractClassRegisterer:register","time":928.3358320000043,"oracles":{"loadCapsule":{"times":[3.5080699999998615]},"notifyCreatedNullifier":{"times":[0.33021800000278745]},"debugLog":{"times":[0.14881400000012945]},"notifyCreatedContractClassLog":{"times":[5.692756000000372]}}},{"functionName":"private_kernel_inner","time":149.10543700000198},{"functionName":"ContractInstanceDeployer:deploy","time":82.46668399999908,"oracles":{"storeInExecutionCache":{"times":[0.2602770000012242]},"callPrivateFunction":{"times":[47.14141400000153]},"notifyCreatedNullifier":{"times":[0.2994280000020808]},"debugLog":{"times":[0.16004400000019814]}}},{"functionName":"private_kernel_inner","time":148.05232999999862},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":31.85481400000208,"oracles":{}},{"functionName":"private_kernel_inner","time":92.84965799999918},{"functionName":"private_kernel_reset","time":221.92740199999753},{"functionName":"private_kernel_tail","time":91.74435900000026}],"unaccounted":428.2215540000034}} 10:53:34 aztec-1 | [10:53:33.675] INFO: node Received tx 0x26247d081f63ca212c1ae9204c6f85fdfa94cfe56aee163a01ae4b821fdbb5bc {"txHash":"0x26247d081f63ca212c1ae9204c6f85fdfa94cfe56aee163a01ae4b821fdbb5bc"} 10:53:34 aztec-1 | [10:53:33.675] INFO: pxe:service Sent transaction 0x26247d081f63ca212c1ae9204c6f85fdfa94cfe56aee163a01ae4b821fdbb5bc 10:53:36 aztec-1 | [10:53:35.584] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 1.7469259200000016s {"duration":1.7469259200000016,"rate":20323.700961515282,"totalPublicGas":{"daGas":4096,"l2Gas":35504},"totalBlockGas":{"daGas":166912,"l2Gas":60546},"totalSizeInBytes":10688} 10:53:36 aztec-1 | [10:53:35.785] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 18104.359500396036 mana/s {"blockHash":"0x0131a37f1cff92fc22b88a3cdaa8f5fdbeea02bba0373f2190705b92b6a2568a","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749725997,"version":3573608979},"txHashes":["0x26247d081f63ca212c1ae9204c6f85fdfa94cfe56aee163a01ae4b821fdbb5bc"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":1960.9932520000002,"publicProcessDuration":1747.0973950000007,"rollupCircuitsDuration":1951.256401999999,"txCount":1,"blockNumber":4,"blockTimestamp":1749725997,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296} 10:53:36 aztec-1 | [10:53:36.265] INFO: pxe:service Proving completed in 2729.194292999997ms {"timings":{"total":2729.194292999997,"sync":106.70855300000039,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":436.12593600000037,"oracles":{"debugLog":{"times":[0.1934049999981653,0.11642299999948591,0.06512099999963539,0.11649300000135554,0.1794350000018312,0.12384299999757786,0.14701399999830755,0.12256300000080955]},"fetchTaggedLogs":{"times":[178.89500100000078]},"loadCapsule":{"times":[1.371354999999312,6.478655999999319,1.6369720000002417,2.0966740000003483,0.182264999999461,17.221550999998726,0.5533640000030573]},"getSharedSecret":{"times":[12.503830000001471]},"aes128Decrypt":{"times":[0.21345500000097672,0.7990099999988161]},"getPublicKeysAndPartialAddress":{"times":[4.758711999998923]},"getKeyValidationRequest":{"times":[10.737205000001268]},"storeCapsule":{"times":[2.550425000001269,2.3390500000023167,1.8842490000024554]},"deleteCapsule":{"times":[2.7821009999970556]},"validateEnqueuedNotesAndEvents":{"times":[14.617404000000533]},"getNotes":{"times":[3.533449999998993]},"getAuthWitness":{"times":[0.22552599999835365]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06904199999917182]},"callPrivateFunction":{"times":[889.9156360000015,152.9824170000029]},"notifyEnqueuedPublicFunctionCall":{"times":[0.07537100000263308]}}},{"functionName":"private_kernel_init","time":58.56656899999871},{"functionName":"ContractClassRegisterer:register","time":873.4099040000001,"oracles":{"loadCapsule":{"times":[2.5738259999998263]},"notifyCreatedNullifier":{"times":[0.7695500000008906]},"debugLog":{"times":[0.17155500000080792]},"notifyCreatedContractClassLog":{"times":[9.500783000003139]}}},{"functionName":"private_kernel_inner","time":118.06594400000176},{"functionName":"ContractInstanceDeployer:deploy","time":98.54843400000391,"oracles":{"storeInExecutionCache":{"times":[0.10746300000027986]},"callPrivateFunction":{"times":[53.10823000000164]},"notifyCreatedNullifier":{"times":[0.2911080000012589]},"debugLog":{"times":[0.19786500000191154]}}},{"functionName":"private_kernel_inner","time":97.78030299999955},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.20068399999582,"oracles":{}},{"functionName":"private_kernel_inner","time":124.6287400000001},{"functionName":"private_kernel_reset","time":206.17633900000146},{"functionName":"private_kernel_tail","time":110.96692100000291}],"unaccounted":459.01596599999175}} 10:53:36 aztec-1 | [10:53:36.471] INFO: node Received tx 0x04efb0d7e2f0eef1d1444b215760004e5fc358af5a0f9aa0ac472a85fd936534 {"txHash":"0x04efb0d7e2f0eef1d1444b215760004e5fc358af5a0f9aa0ac472a85fd936534"} 10:53:36 aztec-1 | [10:53:36.471] INFO: pxe:service Sent transaction 0x04efb0d7e2f0eef1d1444b215760004e5fc358af5a0f9aa0ac472a85fd936534 10:53:36 aztec-1 | [10:53:36.611] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 10:53:36 aztec-1 | [10:53:36.614] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:53:36 aztec-1 | [10:53:36.616] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 10:53:36 aztec-1 | [10:53:36.644] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749726033 10:53:36 aztec-1 | [10:53:36.644] WARN: foundation:test-date-provider Time set to 2025-06-12T11:00:33.000Z {"offset":416356,"timeMs":1749726033000} 10:53:36 aztec-1 | [10:53:36.644] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 10:53:36 aztec-1 | [10:53:36.755] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x0131a37f1cff92fc22b88a3cdaa8f5fdbeea02bba0373f2190705b92b6a2568a","blockNumber":4,"txCount":1,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749725997,"version":3573608979},"archiveRoot":"0x0ee07e7925ed926386bc3c899ad314188fda12be9902983d355e92b4e86c1ec9","archiveNextLeafIndex":5} 10:53:36 aztec-1 | [10:53:36.763] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 10:53:36 aztec-1 | [10:53:36.827] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":16.42208000000028,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749725997,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296} 10:53:37 aztec-1 | [10:53:37.279] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.39172481100000006s {"duration":0.39172481100000006,"rate":705211.9044866932,"totalPublicGas":{"daGas":10240,"l2Gas":276249},"totalBlockGas":{"daGas":380928,"l2Gas":301291},"totalSizeInBytes":24064} 10:53:37 aztec-1 | [10:53:37.340] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 594848.0383426581 mana/s {"blockHash":"0x0d00e92052e25231100d2b39f52042024228fd8319a404e4b891dbaceb5e9389","globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749726033,"version":3573608979},"txHashes":["0x04efb0d7e2f0eef1d1444b215760004e5fc358af5a0f9aa0ac472a85fd936534"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":464.36083000000144,"publicProcessDuration":392.1303310000003,"rollupCircuitsDuration":458.07984900000156,"txCount":1,"blockNumber":5,"blockTimestamp":1749726033,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 10:53:37 aztec-1 | [10:53:37.446] INFO: aztecjs:deploy_sent_tx Contract 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae successfully deployed. 10:53:37 aztec-1 | [10:53:37.640] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:53:37 aztec-1 | [10:53:37.647] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749726069 10:53:37 aztec-1 | [10:53:37.647] WARN: foundation:test-date-provider Time set to 2025-06-12T11:01:09.000Z {"offset":451353,"timeMs":1749726069000} 10:53:37 aztec-1 | [10:53:37.647] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 10:53:37 aztec-1 | [10:53:37.707] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 10:53:37 aztec-1 | [10:53:37.709] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 10:53:37 aztec-1 | [10:53:37.831] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x0d00e92052e25231100d2b39f52042024228fd8319a404e4b891dbaceb5e9389","blockNumber":5,"txCount":1,"globalVariables":{"blockNumber":5,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":6,"timestamp":1749726033,"version":3573608979},"archiveRoot":"0x148cf90a703eb9143e7f62ac1e54fe67555dab4cf418049df4a884cfa8d06abe","archiveNextLeafIndex":6} 10:53:37 aztec-1 | [10:53:37.836] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 10:53:37 aztec-1 | [10:53:37.905] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":16.677647000000434,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749726033,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 10:53:38 aztec-1 | BananaCoin: 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 10:53:38 aztec-1 | FPC: 0x2c3af751391c30b4ff51722fb1c59d9380a64d0a06990f1810963afda65b9cae 10:53:38 aztec-1 | [10:53:38.719] INFO: aztecjs:deploy_sent_tx Contract 0x16b930d76fe7a01a12e8f5fa8bfd7f6350e3383b4f34620955e665fa15ac51d7 successfully deployed. 10:53:38 aztec-1 | [10:53:38.739] WARN: pxe:service No artifact found for contract class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523 when looking for its metadata 10:53:38 aztec-1 | [10:53:38.742] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523 as part of deployment for 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc 10:53:38 aztec-1 | [10:53:38.862] INFO: pxe:service Added contract SponsoredFPC at 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc with class 0x04193fd6314e8d0af283de6f2769212e2122e260c6e55154e9d94857c84e9523 10:53:41 aztec-1 | [10:53:41.038] INFO: pxe:service Proving completed in 2150.8850039999998ms {"timings":{"total":2150.8850039999998,"sync":36.06821299999865,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":69.9036809999925,"oracles":{"callPrivateFunction":{"times":[829.5286509999969,104.87274500000058,48.80421000000206]}}},{"functionName":"private_kernel_init","time":74.41728599999988},{"functionName":"ContractClassRegisterer:register","time":809.6182000000044,"oracles":{"loadCapsule":{"times":[2.6737189999985276]},"notifyCreatedNullifier":{"times":[0.3994700000002922]},"debugLog":{"times":[0.1380230000031588]},"notifyCreatedContractClassLog":{"times":[5.191902999999002]}}},{"functionName":"private_kernel_inner","time":134.79488199999832},{"functionName":"ContractInstanceDeployer:deploy","time":65.19255899999916,"oracles":{"storeInExecutionCache":{"times":[0.08191199999782839]},"callPrivateFunction":{"times":[43.645776999997906]},"notifyCreatedNullifier":{"times":[0.2787179999977525]},"debugLog":{"times":[0.14860399999815854]}}},{"functionName":"private_kernel_inner","time":97.37160300000323},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":29.764952000001358,"oracles":{}},{"functionName":"private_kernel_inner","time":83.22457099999883},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":39.39433900000222,"oracles":{"debugLog":{"times":[0.1461540000018431]}}},{"functionName":"private_kernel_inner","time":126.67260399999941},{"functionName":"private_kernel_reset","time":178.2191329999987},{"functionName":"private_kernel_tail","time":67.55705999999918}],"unaccounted":338.6859210000039}} 10:53:41 aztec-1 | [10:53:41.137] INFO: node Received tx 0x2ad05ce636bf0d863342ee272a05d5bb39f8c045c3ebc28eeb54214ae763f60e {"txHash":"0x2ad05ce636bf0d863342ee272a05d5bb39f8c045c3ebc28eeb54214ae763f60e"} 10:53:41 aztec-1 | [10:53:41.137] INFO: pxe:service Sent transaction 0x2ad05ce636bf0d863342ee272a05d5bb39f8c045c3ebc28eeb54214ae763f60e 10:53:41 aztec-1 | [10:53:41.268] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.0372315529999978s {"duration":0.0372315529999978,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 10:53:41 aztec-1 | [10:53:41.309] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x021a6e59e5ba5830903bd9b7341c3b15cb14a0648176b7a07c1c1a0d9974f504","globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749726069,"version":3573608979},"txHashes":["0x2ad05ce636bf0d863342ee272a05d5bb39f8c045c3ebc28eeb54214ae763f60e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":91.16349499999706,"publicProcessDuration":37.41892799999914,"rollupCircuitsDuration":82.03254100000049,"txCount":1,"blockNumber":6,"blockTimestamp":1749726069,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 10:53:41 aztec-1 | [10:53:41.482] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:53:41 aztec-1 | [10:53:41.495] 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":"0x148cf90a703eb9143e7f62ac1e54fe67555dab4cf418049df4a884cfa8d06abe","blocksSynchedTo":33,"currentL1BlockNumber":34,"provenBlockNumber":5,"provenArchive":"0x148cf90a703eb9143e7f62ac1e54fe67555dab4cf418049df4a884cfa8d06abe","pendingBlockNumber":6,"pendingArchive":"0x08253e1eb511eb1e1c1884bd10f38cac1058b398ed3237c958573eb664d1e38f"} 10:53:41 aztec-1 | [10:53:41.501] WARN: ethereum:cheat_codes Set L1 storage for contract 0x68b1d87f95878fe05b998f19b66f4baba5de1aed at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 10:53:41 aztec-1 | [10:53:41.502] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 10:53:41 aztec-1 | [10:53:41.560] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:53:41 aztec-1 | error: "Rollup__SlotAlreadyInChain(7, 7)" 10:53:41 aztec-1 | [10:53:41.560] WARN: sequencer Cannot propose block 6 at slot 7 due to failed rollup contract check 10:53:41 aztec-1 | [10:53:41.563] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749726105 10:53:41 aztec-1 | [10:53:41.563] WARN: foundation:test-date-provider Time set to 2025-06-12T11:01:45.000Z {"offset":483437,"timeMs":1749726105000} 10:53:41 aztec-1 | [10:53:41.563] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 10:53:41 aztec-1 | [10:53:41.607] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x021a6e59e5ba5830903bd9b7341c3b15cb14a0648176b7a07c1c1a0d9974f504","blockNumber":6,"txCount":1,"globalVariables":{"blockNumber":6,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":36260,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":7,"timestamp":1749726069,"version":3573608979},"archiveRoot":"0x08253e1eb511eb1e1c1884bd10f38cac1058b398ed3237c958573eb664d1e38f","archiveNextLeafIndex":7} 10:53:41 aztec-1 | [10:53:41.615] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 10:53:41 aztec-1 | [10:53:41.650] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":14.02328900000066,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749726069,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 10:53:42 aztec-1 | SponsoredFPC: 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc 10:53:42 aztec-1 | [10:53:42.161] INFO: aztecjs:deploy_sent_tx Contract 0x22932b1f5008b7d2e5562a9f582fe1caf230663d744283f1e92ff8a41544cbfc successfully deployed. 10:53:42 aztec-1 | [10:53:42.168] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x08c6b24bd9c265f8c6596b12f540d93a53f5bcd1502d78957c8614575c61c9f4","l2ProtocolContractsTreeRoot":"0x052cc6e2bd1171363e72fb45b9a78fb0ebacedb96c8f1148b3903c3bafa8c458"} 10:53:51 playground-1 | \ 10:53:51 playground-1 | Running 1 test using 1 worker 10:53:51 playground-1 | 10:53:52 playground-1 | 1 [chromium] › browser.spec.ts:3:1 › test (9.1s) 10:54:02 playground-1 | 1 passed (12.6s) 10:54:02 playground-1 | \ 10:54:02 playground-1 exited with code 0 10:54:02 Aborting on container exit... 10:54:02 Container playground-chromium-playground-1 Stopping 10:54:02 Container playground-chromium-playground-1 Stopped 10:54:02 Container playground-chromium-aztec-1 Stopping 10:54:04 Container playground-chromium-aztec-1 Stopped 10:54:04 Container playground-chromium-ethereum-1 Stopping 10:54:04 Container playground-chromium-ethereum-1 Stopped