Parent Log: http://ci.aztec-labs.com/4540e5adaf93f482 Command: 58702efee383322f:ONLY_TERM_PARENT=1 BOX=react BROWSER=webkit run_compose_test react-webkit box boxes Commit: https://github.com/AztecProtocol/aztec-packages/commit/fa758d3c1666c0baa197c2610e2af9babbfc888a Env: REF_NAME=gh-readonly-queue/next/pr-14705-639e98fe3dedbf394bfe94a44d7eadc6aaf36502 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Wed Jun 4 22:33:59 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14705_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/b59b5f406a1a4252 22:33:59 Network react-webkit_default Creating 22:33:59 Network react-webkit_default Created 22:33:59 Container react-webkit-ethereum-1 Creating 22:34:00 Container react-webkit-ethereum-1 Created 22:34:00 Container react-webkit-aztec-1 Creating 22:34:00 Container react-webkit-aztec-1 Created 22:34:00 Container react-webkit-box-1 Creating 22:34:00 Container react-webkit-box-1 Created 22:34:00 Attaching to aztec-1, box-1, ethereum-1 22:34:06 aztec-1 | 22:34:06 aztec-1 | _ 22:34:06 aztec-1 | /\ | | 22:34:06 aztec-1 | / \ ___| |_ ___ ___ 22:34:06 aztec-1 | / /\ \ |_ / __/ _ \/ __| 22:34:06 aztec-1 | / ____ \ / /| || __/ (__ 22:34:06 aztec-1 | /_/___ \_\/___|\__\___|\___| 22:34:06 aztec-1 | 22:34:06 aztec-1 | https://github.com/AztecProtocol 22:34:06 aztec-1 | 22:34:06 aztec-1 | 22:34:06 aztec-1 | Setting up Aztec Sandbox 0.87.6, please stand by... 22:34:06 aztec-1 | Setting up test accounts 22:34:07 aztec-1 | [22:34:06.939] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-B3E7Xm/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 22:34:07 aztec-1 | [22:34:07.245] INFO: sandbox Calling anvil_setBlockTimestampInterval with params: [12] 22:34:07 aztec-1 | [22:34:07.250] WARN: sandbox Set block interval to 12 22:34:07 aztec-1 | [22:34:07.457] INFO: sandbox Waiting for 7 transactions to be mined... 22:34:07 aztec-1 | [22:34:07.481] INFO: sandbox All transactions mined successfully 22:34:07 aztec-1 | [22:34:07.586] INFO: sandbox Waiting for 9 transactions to be mined... 22:34:07 aztec-1 | [22:34:07.613] INFO: sandbox All transactions mined successfully 22:34:07 aztec-1 | [22:34:07.753] INFO: sandbox Waiting for 10 transactions to be mined... 22:34:07 aztec-1 | [22:34:07.781] INFO: sandbox All transactions mined successfully 22:34:07 aztec-1 | [22:34:07.857] INFO: sandbox Waiting for 11 transactions to be mined... 22:34:07 aztec-1 | [22:34:07.888] INFO: sandbox All transactions mined successfully 22:34:07 aztec-1 | [22:34:07.895] INFO: sandbox Waiting for 11 transactions to be mined... 22:34:07 aztec-1 | [22:34:07.916] INFO: sandbox All transactions mined successfully 22:34:07 aztec-1 | [22:34:07.934] INFO: sandbox Aztec L1 contracts initialized {"registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","rollupAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","inboxAddress":"0xd2e813c297f3cf9985baa5331cec80778755bf2a","outboxAddress":"0x9cba1bd8bfe8f5376d45f0ba25287c16fdbe0268","feeJuicePortalAddress":"0x6034162d05782a3e836948e76bb048e3bbda726c","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 22:34:07 aztec-1 | [22:34:07.934] INFO: sandbox Handing over to governance 22:34:07 aztec-1 | [22:34:07.939] INFO: ethereum:cheat_codes Calling anvil_getAutomine with params: [] on http://ethereum:8545 22:34:07 aztec-1 | [22:34:07.941] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:07 aztec-1 | [22:34:07.942] INFO: aztecjs:utils:watcher Watcher started for rollup at 0x9A9f2CCfdE556A7E9Ff0848998Aa4a0CFD8863AE 22:34:07 aztec-1 | [22:34:07.942] INFO: telemetry:client Using NoopTelemetryClient 22:34:07 aztec-1 | [22:34:07.942] INFO: blob-sink:client Creating local blob sink client. 22:34:07 aztec-1 | [22:34:07.946] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:34:07 aztec-1 | [22:34:07.946] WARN: foundation:test-date-provider Time set to 2025-06-04T22:38:24.000Z {"offset":256054,"timeMs":1749076704000} 22:34:07 aztec-1 | [22:34:07.972] INFO: archiver:lmdb Starting data store with maxReaders 16 22:34:08 aztec-1 | [22:34:08.213] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:08 aztec-1 | [22:34:08.401] INFO: archiver Starting archiver sync to rollup contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae from L1 block 18 to current L1 block 22 with hash 0xa4bf4ff85147e2fc8dd7191bb696d607c85cceec4c777afde9bbd3c5d688edf3 {"blocksSynchedTo":18,"messagesSynchedTo":{"l1BlockHash":"0x5feeeab51deff070815ab87ec4cb0457039d5e8bd2570b9fe53f8c12208a50af","l1BlockNumber":18}} 22:34:08 aztec-1 | [22:34:08.417] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:08 aztec-1 | [22:34:08.460] INFO: archiver Initial archiver sync to L1 block 22 complete. {"l1BlockNumber":22,"syncPoint":{"blocksSynchedTo":22,"messagesSynchedTo":{"l1BlockHash":"0xa4bf4ff85147e2fc8dd7191bb696d607c85cceec4c777afde9bbd3c5d688edf3","l1BlockNumber":22}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 22:34:08 aztec-1 | [22:34:08.474] INFO: world-state:database Creating world state data store at directory /tmp/aztec-world-state-QKEMxv/world_state with map sizes {"archiveTreeMapSizeKb":10485760,"nullifierTreeMapSizeKb":10485760,"noteHashTreeMapSizeKb":10485760,"messageTreeMapSizeKb":10485760,"publicDataTreeMapSizeKb":10485760} and 4 threads. 22:34:08 aztec-1 | [22:34:08.757] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:08 aztec-1 | [22:34:08.764] INFO: world_state Created world state synchroniser with block history of 64 22:34:08 aztec-1 | [22:34:08.764] WARN: node Aztec node is accepting fake proofs 22:34:08 aztec-1 | [22:34:08.775] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 22:34:08 aztec-1 | [22:34:08.790] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 22:34:08 aztec-1 | [22:34:08.802] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 22:34:08 aztec-1 | [22:34:08.819] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 22:34:08 aztec-1 | [22:34:08.832] INFO: world_state Started world state synchronizer from block 1 22:34:08 aztec-1 | [22:34:08.845] INFO: p2p Starting p2p client from block 0 with empty mempools 22:34:08 aztec-1 | [22:34:08.846] INFO: epoch-prune-watcher EpochPruneWatcher initialized 22:34:08 aztec-1 | [22:34:08.853] INFO: slasher Starting Slasher client... 22:34:08 aztec-1 | [22:34:08.911] INFO: sequencer-client Deploying forwarder contract 22:34:08 aztec-1 | [22:34:08.954] INFO: sequencer-client Forwarder contract deployed at 0x83ac846879c81f414bdf47961839f4e842ead017 22:34:09 aztec-1 | [22:34:08.963] INFO: validator Started validator with addresses: 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 22:34:09 aztec-1 | [22:34:08.964] 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} 22:34:09 aztec-1 | [22:34:09.268] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 22:34:09 aztec-1 | [22:34:09.269] INFO: node Aztec Node version: 0.87.6 22:34:09 aztec-1 | [22:34:09.269] INFO: node Aztec Node started on chain 0x7a69 {"rollupAddress":"0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","registryAddress":"0xcf7ed3acca5a467e9e704c703e8d87f634fb0fc9","inboxAddress":"0xd2e813c297f3cf9985baa5331cec80778755bf2a","outboxAddress":"0x9cba1bd8bfe8f5376d45f0ba25287c16fdbe0268","feeJuiceAddress":"0x5fbdb2315678afecb367f032d93f642f64180aa3","stakingAssetAddress":"0xe7f1725e7734ce288f8367e1bb143e90bb3f0512","feeJuicePortalAddress":"0x6034162d05782a3e836948e76bb048e3bbda726c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","rewardDistributorAddress":"0xd8058efe0198ae9dd7d563e1b4938dcbc86a1f81","governanceProposerAddress":"0xdc64a140aa3e981100a9beca4e685f962f0cf6c9","governanceAddress":"0x5fc8d32690cc91d4c39d9d3abcbd16989f875707","slashFactoryAddress":"0x3aa5ebb10dc797cac828524e59a333d0a371443c","feeAssetHandlerAddress":"0x610178da211fef7d417bc0e6fed39f05609ad788","stakingAssetHandlerAddress":"0xa51c1fc2f0d1a1b8494ed1fe312d7c3a78ed91c0","gseAddress":"0x9fe46736679d2d9a65f0992f2272de9f3c7fa6e0"} 22:34:09 aztec-1 | [22:34:09.272] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:09 aztec-1 | [22:34:09.277] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:34:09 aztec-1 | [22:34:09.277] WARN: foundation:test-date-provider Time set to 2025-06-04T22:38:36.000Z {"offset":266723,"timeMs":1749076716000} 22:34:09 aztec-1 | [22:34:09.279] INFO: pxe:data:lmdb Starting data store with maxReaders 16 22:34:09 aztec-1 | [22:34:09.538] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:09 aztec-1 | Setting up funded test accounts... 22:34:09 aztec-1 | [22:34:09.694] INFO: pxe:service Started PXE connected to chain 31337 version 3190523442 22:34:09 aztec-1 | [22:34:09.746] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:09 aztec-1 | [22:34:09.792] INFO: pxe:service Registered account 0x1065095cd2253de2b69f3be3498a7f0d44456a2eec84e5612c4f22592a338e08 22:34:09 aztec-1 | [22:34:09.865] WARN: pxe:service No artifact found for contract class 0x2800c0c31ccfd0de88844246a7c10695475edfeef5c7d03dd31524e1486fe851 when looking for its metadata 22:34:09 aztec-1 | [22:34:09.867] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2800c0c31ccfd0de88844246a7c10695475edfeef5c7d03dd31524e1486fe851 as part of deployment for 0x1065095cd2253de2b69f3be3498a7f0d44456a2eec84e5612c4f22592a338e08 22:34:10 aztec-1 | [22:34:09.952] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:10 aztec-1 | [22:34:10.002] INFO: pxe:service Added contract SchnorrAccount at 0x1065095cd2253de2b69f3be3498a7f0d44456a2eec84e5612c4f22592a338e08 with class 0x2800c0c31ccfd0de88844246a7c10695475edfeef5c7d03dd31524e1486fe851 22:34:11 aztec-1 | [22:34:10.883] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:11 aztec-1 | [22:34:11.099] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:11 aztec-1 | [22:34:11.315] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:11 aztec-1 | [22:34:11.682] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:12 aztec-1 | [22:34:12.005] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:12 aztec-1 | [22:34:12.319] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:12 aztec-1 | [22:34:12.874] INFO: pxe:service Proving completed in 2829.049046ms {"timings":{"total":2829.049046,"sync":10.431206999999631,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":155.47986499999934,"oracles":{"callPrivateFunction":{"times":[737.0752169999996,371.85082599999987,243.62982199999897]}}},{"functionName":"private_kernel_init","time":119.43341599999985},{"functionName":"ContractClassRegisterer:register","time":722.0538649999999,"oracles":{"loadCapsule":{"times":[11.651813000000402]},"notifyCreatedNullifier":{"times":[26.373256999999285]},"debugLog":{"times":[1.7176400000007561]},"notifyCreatedContractClassLog":{"times":[5.270615999999791]}}},{"functionName":"private_kernel_inner","time":180.55922499999906},{"functionName":"SchnorrAccount:constructor","time":340.191245,"oracles":{"getContractInstance":{"times":[2.550924999999552]},"debugLog":{"times":[0.30496900000071037,0.16017500000089058]},"fetchTaggedLogs":{"times":[79.44893899999988]},"loadCapsule":{"times":[0.4974050000000716,0.33432899999934307,0.2749579999999696]},"validateEnqueuedNotesAndEvents":{"times":[8.809589000000415]},"notifyCreatedNullifier":{"times":[0.27775800000017625,0.3199690000001283]},"notifyCreatedNote":{"times":[0.5864970000002359]},"getRandomField":{"times":[0.25798699999904784,0.23647600000003877,0.10404299999936484,0.12624399999913294,0.20645599999988917,0.09218300000065938,0.05956200000036915,0.09520300000076531,0.05851099999927101,0.08465199999955075,0.046881000000212225]},"getIndexedTaggingSecretAsSender":{"times":[39.767501000000266]},"incrementAppTaggingSecretIndexAsSender":{"times":[28.34967400000096]}}},{"functionName":"private_kernel_inner","time":139.6160089999994},{"functionName":"SchnorrAccount:entrypoint","time":218.31232600000112,"oracles":{"debugLog":{"times":[0.2495969999999943,0.08710299999984272,0.37266100000124425]},"fetchTaggedLogs":{"times":[67.57048900000154]},"loadCapsule":{"times":[0.20112599999993108,0.15633400000115216,0.15198400000008405]},"validateEnqueuedNotesAndEvents":{"times":[8.149420000001555]},"getNotes":{"times":[1.8420139999998355]},"getAuthWitness":{"times":[0.36664100000052713]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.9258369999988645]}}},{"functionName":"private_kernel_inner","time":162.27824800000053},{"functionName":"private_kernel_reset","time":201.7733500000013},{"functionName":"private_kernel_tail","time":86.8927679999997}],"unaccounted":492.0275220000003}} 22:34:12 aztec-1 | [22:34:12.894] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:13 aztec-1 | [22:34:13.012] INFO: node Received tx 0x30528c448695b52a55fe714455506b35e35fd13e2f9847ca2879f1c5128e279e {"txHash":"0x30528c448695b52a55fe714455506b35e35fd13e2f9847ca2879f1c5128e279e"} 22:34:13 aztec-1 | [22:34:13.012] INFO: pxe:service Sent transaction 0x30528c448695b52a55fe714455506b35e35fd13e2f9847ca2879f1c5128e279e 22:34:13 aztec-1 | [22:34:13.099] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04530586299999959s {"duration":0.04530586299999959,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":16896,"l2Gas":6324},"totalSizeInBytes":1344} 22:34:13 aztec-1 | [22:34:13.100] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:13 aztec-1 | [22:34:13.254] INFO: sequencer Built block 1 for slot 2 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x07eba53444fe5f796ece46d6c67a3323d97c2340e5b9d0077197b776fbda6399","globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":1,"slotNumber":2,"timestamp":1749076728,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x30528c448695b52a55fe714455506b35e35fd13e2f9847ca2879f1c5128e279e"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":211.50947599999927,"publicProcessDuration":46.101887000000715,"rollupCircuitsDuration":205.22785099999965,"txCount":1,"blockNumber":1,"blockTimestamp":1749076728,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:34:13 aztec-1 | [22:34:13.392] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:13 aztec-1 | [22:34:13.648] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:13 aztec-1 | [22:34:13.665] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000001"] on http://ethereum:8545 22:34:13 aztec-1 | [22:34:13.668] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:34:13 aztec-1 | [22:34:13.671] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 1 22:34:13 aztec-1 | [22:34:13.674] INFO: aztecjs:cheat_codes Proven tip moved: 0 -> 1. Pending tip: 1. 22:34:13 aztec-1 | [22:34:13.794] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x07eba53444fe5f796ece46d6c67a3323d97c2340e5b9d0077197b776fbda6399","blockNumber":1,"txCount":1,"globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":1,"slotNumber":2,"timestamp":1749076728,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2cb5daa596973acaf146be9be39bb41794f6d9af8cf63e0da4eb7e9f5bb1c333","archiveNextLeafIndex":2} 22:34:13 aztec-1 | [22:34:13.801] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 22:34:13 aztec-1 | [22:34:13.856] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:13 aztec-1 | [22:34:13.858] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":32.558968999999706,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":1,"blockTimestamp":1749076728,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:34:13 aztec-1 | [22:34:13.864] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:34:13 aztec-1 | [22:34:13.865] WARN: foundation:test-date-provider Time set to 2025-06-04T22:38:48.000Z {"offset":274136,"timeMs":1749076728000} 22:34:13 aztec-1 | [22:34:13.925] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749076764] on http://ethereum:8545 22:34:13 aztec-1 | [22:34:13.926] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://ethereum:8545 22:34:13 aztec-1 | [22:34:13.930] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749076764 22:34:13 aztec-1 | [22:34:13.930] WARN: foundation:test-date-provider Time set to 2025-06-04T22:39:24.000Z {"offset":310070,"timeMs":1749076764000} 22:34:13 aztec-1 | [22:34:13.930] INFO: aztecjs:utils:watcher Slot 2 was filled, jumped to next slot 22:34:14 aztec-1 | [22:34:13.973] INFO: pxe:service Registered account 0x07af08e3fe299bc2b95734554f24646a0b350e5153dd79fd3b7996351e15d4c0 22:34:14 aztec-1 | [22:34:14.087] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:14 aztec-1 | [22:34:14.106] INFO: pxe:service Added contract SchnorrAccount at 0x07af08e3fe299bc2b95734554f24646a0b350e5153dd79fd3b7996351e15d4c0 with class 0x2800c0c31ccfd0de88844246a7c10695475edfeef5c7d03dd31524e1486fe851 22:34:14 aztec-1 | [22:34:14.322] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:14 aztec-1 | [22:34:14.606] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:14 aztec-1 | [22:34:14.829] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:15 aztec-1 | [22:34:15.092] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:15 aztec-1 | [22:34:15.405] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:15 aztec-1 | [22:34:15.862] INFO: pxe:service Proving completed in 1722.8243629999997ms {"timings":{"total":1722.8243629999997,"sync":35.81823499999882,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":101.06486399999994,"oracles":{"callPrivateFunction":{"times":[454.2244499999997,289.26403500000015]}}},{"functionName":"private_kernel_init","time":72.8063430000002},{"functionName":"SchnorrAccount:constructor","time":421.8042370000003,"oracles":{"getContractInstance":{"times":[5.437099999999191]},"debugLog":{"times":[0.20476599999892642,0.10933300000033341]},"fetchTaggedLogs":{"times":[115.71724600000016]},"loadCapsule":{"times":[3.564765000000989,1.35186000000067,0.4233120000008057]},"validateEnqueuedNotesAndEvents":{"times":[6.595814000000246]},"notifyCreatedNullifier":{"times":[0.3823110000012093,0.1980359999997745]},"notifyCreatedNote":{"times":[0.17723500000101922]},"getRandomField":{"times":[0.2720079999999143,0.4036019999985001,0.06549199999972188,0.08421199999975215,0.11331299999983457,0.06294199999865668,0.07544200000120327,0.04965199999969627,0.047850999999354826,0.08831199999985984,0.06458199999906356]},"getIndexedTaggingSecretAsSender":{"times":[55.054731000000174]},"incrementAppTaggingSecretIndexAsSender":{"times":[41.14103100000102]}}},{"functionName":"private_kernel_inner","time":166.7436179999986},{"functionName":"SchnorrAccount:entrypoint","time":265.58073800000057,"oracles":{"debugLog":{"times":[0.5971070000014151,0.1243240000003425,0.1872350000012375]},"fetchTaggedLogs":{"times":[89.28874799999903]},"loadCapsule":{"times":[0.2239559999998164,0.1584949999996752,0.2156360000008135]},"validateEnqueuedNotesAndEvents":{"times":[7.460758999999598]},"getNotes":{"times":[12.613980999998603]},"getAuthWitness":{"times":[0.19070599999940896]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.7243309999994381]}}},{"functionName":"private_kernel_inner","time":101.35999399999855},{"functionName":"private_kernel_reset","time":172.69238300000143},{"functionName":"private_kernel_tail","time":67.21486800000093}],"unaccounted":317.7390830000004}} 22:34:15 aztec-1 | [22:34:15.876] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:15 aztec-1 | [22:34:15.912] INFO: node Received tx 0x07f75ac35205a97e2fe1025a28e3f811ce259772bdf4e6ce46ebffee97af6d48 {"txHash":"0x07f75ac35205a97e2fe1025a28e3f811ce259772bdf4e6ce46ebffee97af6d48"} 22:34:15 aztec-1 | [22:34:15.912] INFO: pxe:service Sent transaction 0x07f75ac35205a97e2fe1025a28e3f811ce259772bdf4e6ce46ebffee97af6d48 22:34:16 aztec-1 | [22:34:15.998] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02497413499999857s {"duration":0.02497413499999857,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 22:34:16 aztec-1 | [22:34:16.081] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:16 aztec-1 | [22:34:16.120] INFO: sequencer Built block 2 for slot 3 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x09c6757ad714bf6115ac87d38d0c41d4d3ca26e9c8be0d7e5e8b19cbb8dd720e","globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":2,"slotNumber":3,"timestamp":1749076764,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x07f75ac35205a97e2fe1025a28e3f811ce259772bdf4e6ce46ebffee97af6d48"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":154.65878200000043,"publicProcessDuration":25.197831999999835,"rollupCircuitsDuration":149.27642300000116,"txCount":1,"blockNumber":2,"blockTimestamp":1749076764,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:34:16 aztec-1 | [22:34:16.370] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:16 aztec-1 | [22:34:16.389] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:34:16 aztec-1 | [22:34:16.417] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749076800] on http://ethereum:8545 22:34:16 aztec-1 | [22:34:16.418] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://ethereum:8545 22:34:16 aztec-1 | [22:34:16.419] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749076800 22:34:16 aztec-1 | [22:34:16.419] WARN: foundation:test-date-provider Time set to 2025-06-04T22:40:00.000Z {"offset":343581,"timeMs":1749076800000} 22:34:16 aztec-1 | [22:34:16.419] INFO: aztecjs:utils:watcher Slot 3 was filled, jumped to next slot 22:34:16 aztec-1 | [22:34:16.491] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x09c6757ad714bf6115ac87d38d0c41d4d3ca26e9c8be0d7e5e8b19cbb8dd720e","blockNumber":2,"txCount":1,"globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":2,"slotNumber":3,"timestamp":1749076764,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x224b78d01bb0c4f5a48151989d528f09e6696240896ea2b582237568ba1f3c6e","archiveNextLeafIndex":3} 22:34:16 aztec-1 | [22:34:16.558] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":18.78091300000051,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":2,"blockTimestamp":1749076764,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:34:16 aztec-1 | [22:34:16.573] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:16 aztec-1 | [22:34:16.579] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000002"] on http://ethereum:8545 22:34:16 aztec-1 | [22:34:16.580] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 2 22:34:16 aztec-1 | [22:34:16.581] INFO: aztecjs:cheat_codes Proven tip moved: 1 -> 2. Pending tip: 2. 22:34:16 aztec-1 | [22:34:16.634] INFO: archiver Updated proven chain to block 2 {"provenBlockNumber":2} 22:34:16 aztec-1 | [22:34:16.657] INFO: pxe:service Registered account 0x0ac2c253d760dd3e2b3c2e2892bb082c2096e8fe83a8a7a3a1a72ebeaa90fbe0 22:34:16 aztec-1 | [22:34:16.760] INFO: pxe:service Added contract SchnorrAccount at 0x0ac2c253d760dd3e2b3c2e2892bb082c2096e8fe83a8a7a3a1a72ebeaa90fbe0 with class 0x2800c0c31ccfd0de88844246a7c10695475edfeef5c7d03dd31524e1486fe851 22:34:16 aztec-1 | [22:34:16.776] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:17 aztec-1 | [22:34:16.980] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:17 aztec-1 | [22:34:17.192] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:17 aztec-1 | [22:34:17.477] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:17 aztec-1 | [22:34:17.729] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:18 aztec-1 | [22:34:18.048] INFO: pxe:service Proving completed in 1280.7236189999985ms {"timings":{"total":1280.7236189999985,"sync":25.26628300000084,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":75.20666299999539,"oracles":{"callPrivateFunction":{"times":[321.5427639999998,226.8019459999996]}}},{"functionName":"private_kernel_init","time":56.27252700000099},{"functionName":"SchnorrAccount:constructor","time":298.50754700000107,"oracles":{"getContractInstance":{"times":[1.2108159999988857]},"debugLog":{"times":[0.12985399999888614,0.07672199999979057]},"fetchTaggedLogs":{"times":[100.07692599999973]},"loadCapsule":{"times":[0.16543499999897904,0.16660500000034517,0.14135399999941]},"validateEnqueuedNotesAndEvents":{"times":[5.9319350000005215]},"notifyCreatedNullifier":{"times":[0.2752780000009807,0.2994890000009036]},"notifyCreatedNote":{"times":[0.15956399999959103]},"getRandomField":{"times":[0.15531499999997322,0.18765600000006089,0.09694300000046496,0.08925300000009884,0.06329100000039034,0.05854200000067067,0.08350200000131736,0.03588099999979022,0.04728100000102131,0.061220999999932246,0.036151000000245403]},"getIndexedTaggingSecretAsSender":{"times":[51.05688299999929]},"incrementAppTaggingSecretIndexAsSender":{"times":[29.265262000000803]}}},{"functionName":"private_kernel_inner","time":106.49493500000062},{"functionName":"SchnorrAccount:entrypoint","time":202.82685100000162,"oracles":{"debugLog":{"times":[0.2578369999991992,0.07208199999877252,0.19233600000006845]},"fetchTaggedLogs":{"times":[88.75651199999993]},"loadCapsule":{"times":[0.30942900000081863,0.15132400000038615,0.16512499999953434]},"validateEnqueuedNotesAndEvents":{"times":[6.160130999998728]},"getNotes":{"times":[1.7396110000008775]},"getAuthWitness":{"times":[0.22296600000117905]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.454834000000119]}}},{"functionName":"private_kernel_inner","time":99.65518299999894},{"functionName":"private_kernel_reset","time":149.6718349999992},{"functionName":"private_kernel_tail","time":59.358186999999816}],"unaccounted":207.46360800000002}} 22:34:18 aztec-1 | [22:34:18.061] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:18 aztec-1 | [22:34:18.095] INFO: node Received tx 0x213464df3c775ab4dc18a7805471f06c00414c5e95fa77396dd7e956271b1274 {"txHash":"0x213464df3c775ab4dc18a7805471f06c00414c5e95fa77396dd7e956271b1274"} 22:34:18 aztec-1 | [22:34:18.095] INFO: pxe:service Sent transaction 0x213464df3c775ab4dc18a7805471f06c00414c5e95fa77396dd7e956271b1274 22:34:18 aztec-1 | [22:34:18.166] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.01865120900000329s {"duration":0.01865120900000329,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 22:34:18 aztec-1 | [22:34:18.252] INFO: sequencer Built block 3 for slot 4 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x198a4f731c02d642aed4d444e9e40ca326b50033626797a0ee4345fd659c8d00","globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":3,"slotNumber":4,"timestamp":1749076800,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"txHashes":["0x213464df3c775ab4dc18a7805471f06c00414c5e95fa77396dd7e956271b1274"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":111.73171999999977,"publicProcessDuration":18.83764400000291,"rollupCircuitsDuration":106.99993999999788,"txCount":1,"blockNumber":3,"blockTimestamp":1749076800,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:34:18 aztec-1 | [22:34:18.329] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:18 aztec-1 | [22:34:18.532] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:18 aztec-1 | [22:34:18.555] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000003"] on http://ethereum:8545 22:34:18 aztec-1 | [22:34:18.560] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 3 22:34:18 aztec-1 | [22:34:18.564] INFO: aztecjs:cheat_codes Proven tip moved: 2 -> 3. Pending tip: 3. 22:34:18 aztec-1 | [22:34:18.567] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:34:18 aztec-1 | [22:34:18.569] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749076836] on http://ethereum:8545 22:34:18 aztec-1 | [22:34:18.570] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://ethereum:8545 22:34:18 aztec-1 | [22:34:18.572] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749076836 22:34:18 aztec-1 | [22:34:18.572] WARN: foundation:test-date-provider Time set to 2025-06-04T22:40:36.000Z {"offset":377428,"timeMs":1749076836000} 22:34:18 aztec-1 | [22:34:18.572] INFO: aztecjs:utils:watcher Slot 4 was filled, jumped to next slot 22:34:18 aztec-1 | [22:34:18.656] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x198a4f731c02d642aed4d444e9e40ca326b50033626797a0ee4345fd659c8d00","blockNumber":3,"txCount":1,"globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":3,"slotNumber":4,"timestamp":1749076800,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":332260},"archiveRoot":"0x2288283949d3f03ad5e9330d15293f5c7cfe50c814bf949360269ffeb31b0efa","archiveNextLeafIndex":4} 22:34:18 aztec-1 | [22:34:18.659] INFO: archiver Updated proven chain to block 3 {"provenBlockNumber":3} 22:34:18 aztec-1 | [22:34:18.695] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":15.078133999999409,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":3,"blockTimestamp":1749076800,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:34:18 aztec-1 | Initial Accounts: 22:34:18 aztec-1 | 22:34:18 aztec-1 | Address: 0x1065095cd2253de2b69f3be3498a7f0d44456a2eec84e5612c4f22592a338e08 22:34:18 aztec-1 | Partial Address: 0x079d2099d4e1c229bbb0365e69815cef98d08ec33dcb9b2cbf8259eded5a22ff 22:34:18 aztec-1 | Secret Key: 0x2153536ff6628eee01cf4024889ff977a18d9fa61d0e414422f7681cf085c281 22:34:18 aztec-1 | Master nullifier public key: 0x1997041f7bef378b53f778a7e6dbe318581a74046c6d89d2a5c3541d3bd6499f2756b249eea865f51139100ec94a5f52e4e818dd0ebf4e276353fbd54d26047f 22:34:18 aztec-1 | Master incoming viewing public key: 0x16f717457ac6823102f11889f50751329847d5aeeb3ba846b7f0c337cc66de97154f56206fb1079022acad62e1b9af9392baca2c9f995d302b37923ee598025f 22:34:18 aztec-1 | 22:34:18 aztec-1 | Master outgoing viewing public key: 0x04d3de24dac85211b9726c43b7029e039491f5e9f60551f30eaa37956ad74f2f2b8e64db900901c2b5c0f6e6e6644f480e31387dc5769078e16a937e08f2d1c5 22:34:18 aztec-1 | 22:34:18 aztec-1 | Master tagging public key: 0x1bdebe239b3152cbfba5b6b1ea7e5ad98736d9ef92b6ccef8129e9ea59dbed4a0599b2ab4ed94c01fdddc06c4b8115a24e3dae480fb0e182c17cb5cfa545cb89 22:34:18 aztec-1 | 22:34:18 aztec-1 | Address: 0x07af08e3fe299bc2b95734554f24646a0b350e5153dd79fd3b7996351e15d4c0 22:34:18 aztec-1 | Partial Address: 0x2988747c3278e0a5572a4bf410599d96a46f0ba9856f6bea4ccb3e4d70cf8bdb 22:34:18 aztec-1 | Secret Key: 0x0aebd1b4be76efa44f5ee655c20bf9ea60f7ae44b9a7fd1fd9f189c7a0b0cdae 22:34:18 aztec-1 | Master nullifier public key: 0x0dfb2c1f9425ac05d57c24a0aaf313ab9abb70def4c7fa973b5695a877528de8058c109f9c8851f67ff1a34e81683fb20baf87182ab8cc0b44bcddf3f705da57 22:34:18 aztec-1 | Master incoming viewing public key: 0x118abb6cbfb12f6d61f7c837d3a38a00938073002990388406714e3a30ef000e272f398119b8635dd875c8b35a0d5c2e7a739eefebf89e9172951b92abfb1f4d 22:34:18 aztec-1 | 22:34:18 aztec-1 | Master outgoing viewing public key: 0x07b57b36fb6585f72636d7741cb49fcbe6d49c2151fee2098859c1f5c94113ce197e3bdc18ff96f058ff0d9b77e741a17e257e6ff1fc03b8753ead015757de4e 22:34:18 aztec-1 | 22:34:18 aztec-1 | Master tagging public key: 0x05c11aef8517bdfa57b1ad0e12fccd75f7a6225eb651c8dafa894a87768863ad213d2de9a62211c1651f8ecb5638d4bcecefa23631b87b901c3e5f8869c0708d 22:34:18 aztec-1 | 22:34:18 aztec-1 | Address: 0x0ac2c253d760dd3e2b3c2e2892bb082c2096e8fe83a8a7a3a1a72ebeaa90fbe0 22:34:18 aztec-1 | Partial Address: 0x119a231ebd2c8fa8c75806acf0ccf006d727de061b996448a098e3dc0232581e 22:34:18 aztec-1 | Secret Key: 0x0f6addf0da06c33293df974a565b03d1ab096090d907d98055a8b7f4954e120c 22:34:18 aztec-1 | Master nullifier public key: 0x12087794c56b60efc7d90af9cc366b4a53f702ff08e18c2839a384dffc0afa2a21da640447f79013922b5028da3b3461c601d66a2f723d36b7437a709a02b3b3 22:34:18 aztec-1 | Master incoming viewing public key: 0x26ba3ba4980fb7b0d09936aec4b50839a652151afbb6eaac03a017132d41dae52f2ec73c5fa77d24999da6b4b5a5c98bdd9609dd940de6ea1b397bb21c2edbae 22:34:18 aztec-1 | 22:34:18 aztec-1 | Master outgoing viewing public key: 0x046da42846259b1e229fb0675b7848186ebdc5df9a6d05808338142737a8accd11fc12819daaa9ba316e79412da522a2805dc6ceee04e22f666f1d54694f05da 22:34:18 aztec-1 | 22:34:18 aztec-1 | Master tagging public key: 0x0d7423bb9647cebcbbf1a4212e9cf3e2d56dfcd9b5b7300814ec4513734e6d6230365eb863aedc1e62de64d0f14479cf8ac23e461530acc6e7f9dfc0528e32ba 22:34:18 aztec-1 | 22:34:18 aztec-1 | 22:34:18 aztec-1 | [22:34:18.742] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:19 aztec-1 | [22:34:19.508] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:19 aztec-1 | [22:34:19.510] WARN: pxe:service No artifact found for contract class 0x1d67ec95e53a19062e838f31a622b933858e54ae8efe1aa2572dd7692691c9b0 when looking for its metadata 22:34:19 aztec-1 | [22:34:19.510] WARN: pxe:service No artifact found for contract class 0x2b0850a4e7ff148a55b27ce003d2713401b9f3bd4484d4d53c1aeecd5ca27126 when looking for its metadata 22:34:19 aztec-1 | [22:34:19.511] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x1d67ec95e53a19062e838f31a622b933858e54ae8efe1aa2572dd7692691c9b0 as part of deployment for 0x1560f2078ff2bcb9c1a96e10ad090cf7ed2c2096982d8670579e2003fd7c692c 22:34:19 aztec-1 | [22:34:19.543] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x2b0850a4e7ff148a55b27ce003d2713401b9f3bd4484d4d53c1aeecd5ca27126 as part of deployment for 0x0a6e6c60fc4ee85a5647e44c32b88fc1ef53a55328c554bc726a4452b5e981ca 22:34:19 aztec-1 | [22:34:19.823] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:20 aztec-1 | [22:34:20.048] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:20 aztec-1 | [22:34:20.569] INFO: pxe:service Added contract Token at 0x0a6e6c60fc4ee85a5647e44c32b88fc1ef53a55328c554bc726a4452b5e981ca with class 0x2b0850a4e7ff148a55b27ce003d2713401b9f3bd4484d4d53c1aeecd5ca27126 22:34:20 aztec-1 | [22:34:20.572] INFO: pxe:service Added contract FPC at 0x1560f2078ff2bcb9c1a96e10ad090cf7ed2c2096982d8670579e2003fd7c692c with class 0x1d67ec95e53a19062e838f31a622b933858e54ae8efe1aa2572dd7692691c9b0 22:34:20 aztec-1 | [22:34:20.764] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:21 aztec-1 | [22:34:20.978] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:22 aztec-1 | [22:34:21.993] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:22 aztec-1 | [22:34:22.337] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:22 aztec-1 | [22:34:22.578] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:23 aztec-1 | [22:34:23.064] INFO: pxe:service Proving completed in 2475.2829329999986ms {"timings":{"total":2475.2829329999986,"sync":22.5937359999989,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":374.59169600000314,"oracles":{"debugLog":{"times":[0.26724800000010873,0.10611299999800394,0.10585300000093412,0.2201070000010077,0.11911300000065239,0.10232299999915995,0.08642200000031153,0.24016699999992852]},"fetchTaggedLogs":{"times":[117.28630200000043]},"loadCapsule":{"times":[0.26324700000259327,0.20207600000139792,0.33962999999857857,0.2555079999983718,0.3141390000018873,0.19030599999678088,0.3018190000002505]},"getSharedSecret":{"times":[6.761859000002005]},"aes128Decrypt":{"times":[1.1116719999990892,0.8112939999991795]},"getPublicKeysAndPartialAddress":{"times":[8.91696199999933]},"getKeyValidationRequest":{"times":[6.238333000001148]},"storeCapsule":{"times":[3.1705430000001797,2.7290399999983492,2.772401999998692]},"deleteCapsule":{"times":[2.7821420000000217]},"validateEnqueuedNotesAndEvents":{"times":[12.988203000000794]},"getNotes":{"times":[2.7027390000002924]},"getAuthWitness":{"times":[0.25625700000091456]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.05588100000022678]},"callPrivateFunction":{"times":[807.6697840000015,126.07950100000016]},"notifyEnqueuedPublicFunctionCall":{"times":[0.4023320000014792]}}},{"functionName":"private_kernel_init","time":82.83809799999653},{"functionName":"ContractClassRegisterer:register","time":787.7510790000015,"oracles":{"loadCapsule":{"times":[5.576153999998496]},"notifyCreatedNullifier":{"times":[0.35077000000092085]},"debugLog":{"times":[0.14291400000001886]},"notifyCreatedContractClassLog":{"times":[5.792140000001382]}}},{"functionName":"private_kernel_inner","time":155.125165999998},{"functionName":"ContractInstanceDeployer:deploy","time":66.24635899999703,"oracles":{"storeInExecutionCache":{"times":[0.2732479999976931]},"callPrivateFunction":{"times":[52.33379099999729]},"notifyCreatedNullifier":{"times":[0.2148959999976796]},"debugLog":{"times":[0.15014399999927264]}}},{"functionName":"private_kernel_inner","time":145.0457200000019},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":39.157882999999856,"oracles":{}},{"functionName":"private_kernel_inner","time":109.21029499999713},{"functionName":"private_kernel_reset","time":190.80881699999736},{"functionName":"private_kernel_tail","time":104.80592500000057}],"unaccounted":397.1081590000067}} 22:34:23 aztec-1 | [22:34:23.105] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:23 aztec-1 | [22:34:23.275] INFO: node Received tx 0x2b5edcb997fca866d3108626410b3b73535037401ec17e124cecc5459546a65c {"txHash":"0x2b5edcb997fca866d3108626410b3b73535037401ec17e124cecc5459546a65c"} 22:34:23 aztec-1 | [22:34:23.275] INFO: pxe:service Sent transaction 0x2b5edcb997fca866d3108626410b3b73535037401ec17e124cecc5459546a65c 22:34:23 aztec-1 | [22:34:23.367] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:23 aztec-1 | [22:34:23.576] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:23 aztec-1 | [22:34:23.783] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:24 aztec-1 | [22:34:24.628] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:24 aztec-1 | [22:34:24.861] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:25 aztec-1 | [22:34:25.205] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:25 aztec-1 | [22:34:25.464] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:25 aztec-1 | [22:34:25.920] INFO: pxe:service Proving completed in 2855.026217999999ms {"timings":{"total":2855.026217999999,"sync":168.89460099999997,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":518.5112030000055,"oracles":{"debugLog":{"times":[0.18202599999858649,0.0971529999987979,0.09209199999895645,0.11707300000125542,0.12391399999978603,0.09508300000015879,0.08274200000232668,0.17807499999980791]},"fetchTaggedLogs":{"times":[228.25070899999992]},"loadCapsule":{"times":[0.23736700000154087,0.2488069999999425,0.3793210000003455,1.6860090000009222,0.7545119999995222,0.6286090000030526,0.29145900000003166]},"getSharedSecret":{"times":[4.609605999998166]},"aes128Decrypt":{"times":[0.22928699999829405,0.40673099999912665]},"getPublicKeysAndPartialAddress":{"times":[1.0816420000010112]},"getKeyValidationRequest":{"times":[74.44255200000043]},"storeCapsule":{"times":[4.90510500000164,2.9145060000009835,2.1863740000007965]},"deleteCapsule":{"times":[3.0316990000028454]},"validateEnqueuedNotesAndEvents":{"times":[10.998983999998018]},"getNotes":{"times":[2.1717740000021877]},"getAuthWitness":{"times":[0.26018699999985984]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.04679100000066683]},"callPrivateFunction":{"times":[891.4798330000012,150.6190260000003]},"notifyEnqueuedPublicFunctionCall":{"times":[0.10200299999996787]}}},{"functionName":"private_kernel_init","time":78.03035799999998},{"functionName":"ContractClassRegisterer:register","time":877.6087439999974,"oracles":{"loadCapsule":{"times":[5.8900830000020505]},"notifyCreatedNullifier":{"times":[1.070200999998633]},"debugLog":{"times":[0.18355499999961467]},"notifyCreatedContractClassLog":{"times":[6.17866199999844]}}},{"functionName":"private_kernel_inner","time":160.66366099999868},{"functionName":"ContractInstanceDeployer:deploy","time":85.09040600000299,"oracles":{"storeInExecutionCache":{"times":[0.08105199999772594]},"callPrivateFunction":{"times":[62.86738100000002]},"notifyCreatedNullifier":{"times":[0.32609900000170455]},"debugLog":{"times":[0.1648849999983213]}}},{"functionName":"private_kernel_inner","time":101.27738300000055},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":47.55541099999755,"oracles":{}},{"functionName":"private_kernel_inner","time":142.19663800000126},{"functionName":"private_kernel_reset","time":220.9719870000008},{"functionName":"private_kernel_tail","time":77.18024299999888}],"unaccounted":377.04558299999553}} 22:34:25 aztec-1 | [22:34:25.942] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:25 aztec-1 | [22:34:25.955] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 2.54796385s {"duration":2.54796385,"rate":108419.51309474034,"totalPublicGas":{"daGas":10240,"l2Gas":276249},"totalBlockGas":{"daGas":380928,"l2Gas":301291},"totalSizeInBytes":24064} 22:34:26 aztec-1 | [22:34:26.148] INFO: sequencer Built block 4 for slot 5 with 1 txs and 0 messages. 100433.03109660717 mana/s {"blockHash":"0x20161fe82916115c1333bc4085626a35dc693bdacfedeb7c4f00fef22038230f","globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":4,"slotNumber":5,"timestamp":1749076836,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x2b5edcb997fca866d3108626410b3b73535037401ec17e124cecc5459546a65c"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":2750.518505,"publicProcessDuration":2548.069993000001,"rollupCircuitsDuration":2745.364794000001,"txCount":1,"blockNumber":4,"blockTimestamp":1749076836,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 22:34:26 aztec-1 | [22:34:26.244] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:26 aztec-1 | [22:34:26.246] INFO: node Received tx 0x2d3d2a225d47239b73d04eb9d6488774fbcccca4de3de5c6de7c4678838f03e0 {"txHash":"0x2d3d2a225d47239b73d04eb9d6488774fbcccca4de3de5c6de7c4678838f03e0"} 22:34:26 aztec-1 | [22:34:26.246] INFO: pxe:service Sent transaction 0x2d3d2a225d47239b73d04eb9d6488774fbcccca4de3de5c6de7c4678838f03e0 22:34:26 aztec-1 | [22:34:26.434] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:34:26 aztec-1 | [22:34:26.448] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:26 aztec-1 | [22:34:26.452] WARN: aztecjs:utils:watcher L1 is ahead of wall time. Syncing wall time to L1 time 22:34:26 aztec-1 | [22:34:26.452] WARN: foundation:test-date-provider Time set to 2025-06-04T22:40:48.000Z {"offset":381548,"timeMs":1749076848000} 22:34:26 aztec-1 | [22:34:26.456] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000004"] on http://ethereum:8545 22:34:26 aztec-1 | [22:34:26.458] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 4 22:34:26 aztec-1 | [22:34:26.459] INFO: aztecjs:cheat_codes Proven tip moved: 3 -> 4. Pending tip: 4. 22:34:26 aztec-1 | [22:34:26.463] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749076872] on http://ethereum:8545 22:34:26 aztec-1 | [22:34:26.463] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://ethereum:8545 22:34:26 aztec-1 | [22:34:26.465] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749076872 22:34:26 aztec-1 | [22:34:26.465] WARN: foundation:test-date-provider Time set to 2025-06-04T22:41:12.000Z {"offset":405535,"timeMs":1749076872000} 22:34:26 aztec-1 | [22:34:26.465] INFO: aztecjs:utils:watcher Slot 5 was filled, jumped to next slot 22:34:26 aztec-1 | [22:34:26.602] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x20161fe82916115c1333bc4085626a35dc693bdacfedeb7c4f00fef22038230f","blockNumber":4,"txCount":1,"globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":4,"slotNumber":5,"timestamp":1749076836,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x136cc4e7236acfe3bd2a4b11588d7db75a5734b8784d50d63f7a83a8ce83fe56","archiveNextLeafIndex":5} 22:34:26 aztec-1 | [22:34:26.610] INFO: archiver Updated proven chain to block 4 {"provenBlockNumber":4} 22:34:26 aztec-1 | [22:34:26.652] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:26 aztec-1 | [22:34:26.669] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":21.194664000002376,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":4,"blockTimestamp":1749076836,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":702} 22:34:26 aztec-1 | [22:34:26.860] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:26 aztec-1 | [22:34:26.937] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.20510971000000064s {"duration":0.20510971000000064,"rate":173097.6071293743,"totalPublicGas":{"daGas":4096,"l2Gas":35504},"totalBlockGas":{"daGas":166912,"l2Gas":60546},"totalSizeInBytes":10688} 22:34:27 aztec-1 | [22:34:27.063] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:27 aztec-1 | [22:34:27.075] INFO: sequencer Built block 5 for slot 6 with 1 txs and 0 messages. 101503.88045212411 mana/s {"blockHash":"0x0cd909ca3489b9cc0e898d40f9e56a0225e260bbb2f40b9d1a0f632d0c32c301","globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":5,"slotNumber":6,"timestamp":1749076872,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x2d3d2a225d47239b73d04eb9d6488774fbcccca4de3de5c6de7c4678838f03e0"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":349.747159999999,"publicProcessDuration":205.5143019999996,"rollupCircuitsDuration":344.1797860000006,"txCount":1,"blockNumber":5,"blockTimestamp":1749076872,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296} 22:34:27 aztec-1 | [22:34:27.398] INFO: aztecjs:deploy_sent_tx Contract 0x0a6e6c60fc4ee85a5647e44c32b88fc1ef53a55328c554bc726a4452b5e981ca successfully deployed. 22:34:27 aztec-1 | [22:34:27.400] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:27 aztec-1 | [22:34:27.613] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:27 aztec-1 | [22:34:27.632] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000005"] on http://ethereum:8545 22:34:27 aztec-1 | [22:34:27.634] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 5 22:34:27 aztec-1 | [22:34:27.635] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749076908] on http://ethereum:8545 22:34:27 aztec-1 | [22:34:27.636] INFO: aztecjs:cheat_codes Proven tip moved: 4 -> 5. Pending tip: 5. 22:34:27 aztec-1 | [22:34:27.636] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://ethereum:8545 22:34:27 aztec-1 | [22:34:27.638] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:34:27 aztec-1 | [22:34:27.640] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749076908 22:34:27 aztec-1 | [22:34:27.640] WARN: foundation:test-date-provider Time set to 2025-06-04T22:41:48.000Z {"offset":440360,"timeMs":1749076908000} 22:34:27 aztec-1 | [22:34:27.640] INFO: aztecjs:utils:watcher Slot 6 was filled, jumped to next slot 22:34:27 aztec-1 | [22:34:27.740] INFO: archiver Downloaded L2 block 5 {"blockHash":"0x0cd909ca3489b9cc0e898d40f9e56a0225e260bbb2f40b9d1a0f632d0c32c301","blockNumber":5,"txCount":1,"globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":5,"slotNumber":6,"timestamp":1749076872,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0998b27bb6cdedb8fb211723ed8b70db2abd2e1b794bb2c500273391e6850832","archiveNextLeafIndex":6} 22:34:27 aztec-1 | [22:34:27.745] INFO: archiver Updated proven chain to block 5 {"provenBlockNumber":5} 22:34:27 aztec-1 | [22:34:27.805] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":16.943359000000783,"unfinalisedBlockNumber":5,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":5,"blockTimestamp":1749076872,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":296} 22:34:27 aztec-1 | [22:34:27.820] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:28 aztec-1 | [22:34:28.022] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:28 aztec-1 | [22:34:28.225] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:28 aztec-1 | BananaCoin: 0x0a6e6c60fc4ee85a5647e44c32b88fc1ef53a55328c554bc726a4452b5e981ca 22:34:28 aztec-1 | FPC: 0x1560f2078ff2bcb9c1a96e10ad090cf7ed2c2096982d8670579e2003fd7c692c 22:34:28 aztec-1 | [22:34:28.436] INFO: aztecjs:deploy_sent_tx Contract 0x1560f2078ff2bcb9c1a96e10ad090cf7ed2c2096982d8670579e2003fd7c692c successfully deployed. 22:34:28 aztec-1 | [22:34:28.461] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:28 aztec-1 | [22:34:28.463] WARN: pxe:service No artifact found for contract class 0x24a9a4a4049a6581f90063e4f21249818910656a02f3db1a66053619934f2607 when looking for its metadata 22:34:28 aztec-1 | [22:34:28.465] INFO: aztecjs:contract_interaction Creating request for registering contract class 0x24a9a4a4049a6581f90063e4f21249818910656a02f3db1a66053619934f2607 as part of deployment for 0x1b68d0dca4758ca920955e1fa6cbfdc9d0947e4237fce12ab315a76f29a780b2 22:34:28 aztec-1 | [22:34:28.582] INFO: pxe:service Added contract SponsoredFPC at 0x1b68d0dca4758ca920955e1fa6cbfdc9d0947e4237fce12ab315a76f29a780b2 with class 0x24a9a4a4049a6581f90063e4f21249818910656a02f3db1a66053619934f2607 22:34:28 aztec-1 | [22:34:28.687] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:29 aztec-1 | [22:34:29.628] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:29 aztec-1 | [22:34:29.838] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:30 aztec-1 | [22:34:30.046] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:30 aztec-1 | [22:34:30.261] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:30 aztec-1 | [22:34:30.484] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:31 aztec-1 | [22:34:31.155] INFO: pxe:service Proving completed in 2558.849195999999ms {"timings":{"total":2558.849195999999,"sync":41.06507000000056,"perFunction":[{"functionName":"MultiCallEntrypoint:entrypoint","time":91.39079099999799,"oracles":{"callPrivateFunction":{"times":[944.0413410000001,149.1127520000009,40.742019999997865]}}},{"functionName":"private_kernel_init","time":76.64066599999933},{"functionName":"ContractClassRegisterer:register","time":924.259779,"oracles":{"loadCapsule":{"times":[2.8100020000019867]},"notifyCreatedNullifier":{"times":[0.378141000001051]},"debugLog":{"times":[0.15569400000094902]},"notifyCreatedContractClassLog":{"times":[5.952355000001262]}}},{"functionName":"private_kernel_inner","time":126.61758900000132},{"functionName":"ContractInstanceDeployer:deploy","time":81.6227230000004,"oracles":{"storeInExecutionCache":{"times":[0.10267300000123214]},"callPrivateFunction":{"times":[71.19306599999982]},"notifyCreatedNullifier":{"times":[0.29370899999776157]},"debugLog":{"times":[0.14647499999773572]}}},{"functionName":"private_kernel_inner","time":129.34734899999967},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":53.28707000000213,"oracles":{}},{"functionName":"private_kernel_inner","time":130.9108550000019},{"functionName":"SponsoredFPC:sponsor_unconditionally","time":31.09419600000183,"oracles":{"debugLog":{"times":[0.13945400000011432]}}},{"functionName":"private_kernel_inner","time":144.88153699999748},{"functionName":"private_kernel_reset","time":233.9507799999992},{"functionName":"private_kernel_tail","time":91.99934999999823}],"unaccounted":401.7814409999992}} 22:34:31 aztec-1 | [22:34:31.172] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:31 aztec-1 | [22:34:31.290] INFO: node Received tx 0x249516a4cc8b7b9fbcdde2628cb784c2f7452d3f802230b23dc86ac06fbfb8e9 {"txHash":"0x249516a4cc8b7b9fbcdde2628cb784c2f7452d3f802230b23dc86ac06fbfb8e9"} 22:34:31 aztec-1 | [22:34:31.290] INFO: pxe:service Sent transaction 0x249516a4cc8b7b9fbcdde2628cb784c2f7452d3f802230b23dc86ac06fbfb8e9 22:34:31 aztec-1 | [22:34:31.379] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:31 aztec-1 | [22:34:31.394] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04453751199999897s {"duration":0.04453751199999897,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":14336,"l2Gas":3532},"totalSizeInBytes":1152} 22:34:31 aztec-1 | [22:34:31.538] INFO: sequencer Built block 6 for slot 7 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2d7f53ed5872537b2ce31b67d94494b89b3fdd8531c545bd6718d391728eb415","globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":6,"slotNumber":7,"timestamp":1749076908,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x249516a4cc8b7b9fbcdde2628cb784c2f7452d3f802230b23dc86ac06fbfb8e9"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":198.63649000000078,"publicProcessDuration":44.70430699999997,"rollupCircuitsDuration":193.20771999999852,"txCount":1,"blockNumber":6,"blockTimestamp":1749076908,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:34:31 aztec-1 | [22:34:31.671] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:31 aztec-1 | [22:34:31.881] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:31 aztec-1 | [22:34:31.899] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000006"] on http://ethereum:8545 22:34:31 aztec-1 | [22:34:31.900] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 6 22:34:31 aztec-1 | [22:34:31.902] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:34:31 aztec-1 | [22:34:31.903] INFO: aztecjs:cheat_codes Proven tip moved: 5 -> 6. Pending tip: 6. 22:34:31 aztec-1 | [22:34:31.903] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749076944] on http://ethereum:8545 22:34:31 aztec-1 | [22:34:31.904] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://ethereum:8545 22:34:31 aztec-1 | [22:34:31.905] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749076944 22:34:31 aztec-1 | [22:34:31.905] WARN: foundation:test-date-provider Time set to 2025-06-04T22:42:24.000Z {"offset":472095,"timeMs":1749076944000} 22:34:31 aztec-1 | [22:34:31.905] INFO: aztecjs:utils:watcher Slot 7 was filled, jumped to next slot 22:34:32 aztec-1 | [22:34:31.993] INFO: archiver Downloaded L2 block 6 {"blockHash":"0x2d7f53ed5872537b2ce31b67d94494b89b3fdd8531c545bd6718d391728eb415","blockNumber":6,"txCount":1,"globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":6,"slotNumber":7,"timestamp":1749076908,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0cca588e01e11eb86f90e53d4b45a6e55eb984057a7a612fbd04fa7d86a7fe14","archiveNextLeafIndex":7} 22:34:32 aztec-1 | [22:34:32.001] INFO: archiver Updated proven chain to block 6 {"provenBlockNumber":6} 22:34:32 aztec-1 | [22:34:32.033] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":12.918949999999313,"unfinalisedBlockNumber":6,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":6,"blockTimestamp":1749076908,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:34:32 aztec-1 | [22:34:32.089] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:32 aztec-1 | SponsoredFPC: 0x1b68d0dca4758ca920955e1fa6cbfdc9d0947e4237fce12ab315a76f29a780b2 22:34:32 aztec-1 | [22:34:32.291] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:32 aztec-1 | [22:34:32.322] INFO: aztecjs:deploy_sent_tx Contract 0x1b68d0dca4758ca920955e1fa6cbfdc9d0947e4237fce12ab315a76f29a780b2 successfully deployed. 22:34:32 aztec-1 | [22:34:32.333] INFO: cli Aztec Server listening on port 8080 {"l2CircuitsVkTreeRoot":"0x2c82f2325a782c12336d5b53a295b00b0db8e7fa0c7f7abcbf03c3fb34cda325","l2ProtocolContractsTreeRoot":"0x2ac63ff403134c0f1c985b1d437ecd20003c7c8ff442842422d271f60ff74744"} 22:34:32 aztec-1 | [22:34:32.493] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:32 aztec-1 | [22:34:32.695] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:33 aztec-1 | [22:34:32.902] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:33 aztec-1 | [22:34:33.106] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:33 aztec-1 | [22:34:33.309] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:33 aztec-1 | [22:34:33.511] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:33 aztec-1 | [22:34:33.719] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:34 aztec-1 | [22:34:33.922] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:34 aztec-1 | [22:34:34.124] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:34 aztec-1 | [22:34:34.326] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:34 aztec-1 | [22:34:34.527] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:34 aztec-1 | [22:34:34.731] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:34 aztec-1 | [22:34:34.934] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:35 aztec-1 | [22:34:35.137] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:35 box-1 | Determining test suites to run... 22:34:35 aztec-1 | [22:34:35.340] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:35 aztec-1 | [22:34:35.542] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:35 22:34:35 box-1 | RUNS ... 22:34:35 aztec-1 | [22:34:35.747] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:35 aztec-1 | [22:34:35.951] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:36 aztec-1 | [22:34:36.154] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:36 aztec-1 | [22:34:36.358] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:36 aztec-1 | [22:34:36.560] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:36 aztec-1 | [22:34:36.762] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:37 aztec-1 | [22:34:36.963] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:37 aztec-1 | [22:34:37.166] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:37 aztec-1 | [22:34:37.368] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:37 aztec-1 | [22:34:37.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:37 aztec-1 | [22:34:37.772] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:38 aztec-1 | [22:34:37.975] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:38 aztec-1 | [22:34:38.176] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:38 aztec-1 | [22:34:38.379] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:38 aztec-1 | [22:34:38.580] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:38 aztec-1 | [22:34:38.782] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:39 aztec-1 | [22:34:38.988] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:39 aztec-1 | [22:34:39.190] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:39 aztec-1 | [22:34:39.398] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:39 aztec-1 | [22:34:39.603] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:39 aztec-1 | [22:34:39.808] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:40 aztec-1 | [22:34:40.017] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:40 aztec-1 | [22:34:40.219] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:40 aztec-1 | [22:34:40.421] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:40 aztec-1 | [22:34:40.624] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:40 aztec-1 | [22:34:40.826] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:41 aztec-1 | [22:34:41.028] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:41 aztec-1 | [22:34:41.230] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:41 aztec-1 | [22:34:41.434] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:41 aztec-1 | [22:34:41.636] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:41 aztec-1 | [22:34:41.839] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:42 aztec-1 | [22:34:42.042] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:42 aztec-1 | [22:34:42.244] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:42 aztec-1 | [22:34:42.445] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:42 aztec-1 | [22:34:42.647] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:42 aztec-1 | [22:34:42.850] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:42 22:34:42 box-1 | RUNS ... 22:34:43 22:34:43 box-1 | RUNS ... 22:34:43 aztec-1 | [22:34:43.053] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:43 aztec-1 | [22:34:43.261] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:43 aztec-1 | [22:34:43.466] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:43 aztec-1 | [22:34:43.670] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:43 aztec-1 | [22:34:43.873] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:43 aztec-1 | [22:34:43.895] WARN: pxe:service No artifact found for contract class 0x2cfc352e256c0cf875ccda6bdd1c5908d80a1000041910ea821bd5d2afd6ac29 when looking for its metadata 22:34:44 22:34:44 box-1 | RUNS ... 22:34:44 aztec-1 | [22:34:44.075] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:44 aztec-1 | [22:34:44.342] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:44 aztec-1 | [22:34:44.359] INFO: pxe:service Added contract BoxReact at 0x07c2eb34354bc97df1d7fa999fd6f3b074e2284a750d58f35ac010f8297a932a with class 0x2cfc352e256c0cf875ccda6bdd1c5908d80a1000041910ea821bd5d2afd6ac29 22:34:44 aztec-1 | [22:34:44.648] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:44 aztec-1 | [22:34:44.853] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:45 22:34:45 box-1 | RUNS ... 22:34:45 aztec-1 | [22:34:45.760] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:46 aztec-1 | [22:34:46.013] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:46 22:34:46 box-1 | RUNS ... 22:34:46 aztec-1 | [22:34:46.222] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:46 aztec-1 | [22:34:46.433] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:46 aztec-1 | [22:34:46.689] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:47 aztec-1 | [22:34:46.932] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:47 22:34:47 box-1 | RUNS ... 22:34:47 aztec-1 | [22:34:47.182] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:47 aztec-1 | [22:34:47.444] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:47 aztec-1 | [22:34:47.760] INFO: pxe:service Proving completed in 3343.573473000004ms {"timings":{"total":3343.573473000004,"sync":50.89712200000213,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":485.800430999996,"oracles":{"debugLog":{"times":[0.20586599999660393,0.11018300000432646,0.1667139999990468,0.20208599999750732,0.10166300000128103,0.1040530000027502,0.1092339999959222,0.198156000005838]},"fetchTaggedLogs":{"times":[170.294081]},"loadCapsule":{"times":[0.29349899999942863,0.2023170000029495,0.38197099999524653,0.7535220000063418,4.42323999999644,5.516620999995212,2.482363000002806]},"getSharedSecret":{"times":[10.448786000000837]},"aes128Decrypt":{"times":[0.37125100000412203,0.5841870000003837]},"getPublicKeysAndPartialAddress":{"times":[3.1438019999986864]},"getKeyValidationRequest":{"times":[7.843540000001667]},"storeCapsule":{"times":[2.6770180000021355,5.09274899999582,3.429520000005141]},"deleteCapsule":{"times":[6.602503000001889]},"validateEnqueuedNotesAndEvents":{"times":[20.414928999998665]},"getNotes":{"times":[4.4038389999986975]},"getAuthWitness":{"times":[0.17446599999675527]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.07769199999893317]},"callPrivateFunction":{"times":[837.0640149999963,135.4819209999987,337.1131419999947]}}},{"functionName":"private_kernel_init","time":75.7816410000014},{"functionName":"ContractClassRegisterer:register","time":816.6587560000044,"oracles":{"loadCapsule":{"times":[2.6239070000010543]},"notifyCreatedNullifier":{"times":[0.44971399999485584]},"debugLog":{"times":[0.19621500000357628]},"notifyCreatedContractClassLog":{"times":[5.06496899999911]}}},{"functionName":"private_kernel_inner","time":143.56513799999811},{"functionName":"ContractInstanceDeployer:deploy","time":71.55630699999165,"oracles":{"storeInExecutionCache":{"times":[0.11235299999680137]},"callPrivateFunction":{"times":[52.43815699999686]},"notifyCreatedNullifier":{"times":[0.21719699999812292]},"debugLog":{"times":[0.13825399999768706]}}},{"functionName":"private_kernel_inner","time":132.0454099999988},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":42.63952000000427,"oracles":{}},{"functionName":"private_kernel_inner","time":137.9270419999957},{"functionName":"BoxReact:constructor","time":314.38914400000067,"oracles":{"getContractInstance":{"times":[3.952956000000995]},"debugLog":{"times":[0.1323530000008759,0.13251400000444846]},"fetchTaggedLogs":{"times":[115.42003199999453]},"loadCapsule":{"times":[0.22260600000299746,0.28327799999533454,0.30820899999525864]},"validateEnqueuedNotesAndEvents":{"times":[7.821750000002794]},"getRandomField":{"times":[0.16670499999599997,0.17280500000197208,0.21302599999762606,0.05967199999577133,0.05442200000106823,0.04082100000232458,0.08257300000695977,0.05199200000060955,0.05511099999421276,0.042521000003034715,0.04709200000070268,0.030851000003167428]},"notifyCreatedNullifier":{"times":[0.24052699999447213,0.20486600000003818]},"notifyCreatedNote":{"times":[0.15318399999523535]},"getIndexedTaggingSecretAsSender":{"times":[33.149702000002435]},"incrementAppTaggingSecretIndexAsSender":{"times":[23.707414999997127]}}},{"functionName":"private_kernel_inner","time":145.35209999999643},{"functionName":"private_kernel_reset","time":227.01052399999753},{"functionName":"private_kernel_tail","time":89.29436700000224}],"unaccounted":610.6559710000147}} 22:34:48 aztec-1 | [22:34:48.031] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:48 aztec-1 | [22:34:48.239] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:48 aztec-1 | [22:34:48.445] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:48 22:34:48 box-1 | RUNS ... 22:34:48 aztec-1 | [22:34:48.655] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:48 aztec-1 | [22:34:48.710] INFO: node Received tx 0x0155a2e086a24fd8a115a1624a3782d47289c2fd813900ca8f0c8d9c74404071 {"txHash":"0x0155a2e086a24fd8a115a1624a3782d47289c2fd813900ca8f0c8d9c74404071"} 22:34:48 aztec-1 | [22:34:48.710] INFO: pxe:service Sent transaction 0x0155a2e086a24fd8a115a1624a3782d47289c2fd813900ca8f0c8d9c74404071 22:34:48 aztec-1 | [22:34:48.802] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.04850264099999913s {"duration":0.04850264099999913,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":26112,"l2Gas":9344},"totalSizeInBytes":1920} 22:34:48 aztec-1 | [22:34:48.904] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:48 aztec-1 | [22:34:48.921] INFO: sequencer Built block 7 for slot 8 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x09aa3fb64f7d05202cdf99b06d795745bc6ed10d23f25b151f531b68fd63c31f","globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":7,"slotNumber":8,"timestamp":1749076944,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x0155a2e086a24fd8a115a1624a3782d47289c2fd813900ca8f0c8d9c74404071"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":176.36827999999514,"publicProcessDuration":48.64431599999807,"rollupCircuitsDuration":169.84887800000433,"txCount":1,"blockNumber":7,"blockTimestamp":1749076944,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:34:49 aztec-1 | [22:34:49.107] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:49 aztec-1 | [22:34:49.286] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749076980] on http://ethereum:8545 22:34:49 aztec-1 | [22:34:49.289] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:34:49 aztec-1 | [22:34:49.294] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://ethereum:8545 22:34:49 aztec-1 | [22:34:49.296] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749076980 22:34:49 aztec-1 | [22:34:49.296] WARN: foundation:test-date-provider Time set to 2025-06-04T22:43:00.000Z {"offset":490704,"timeMs":1749076980000} 22:34:49 aztec-1 | [22:34:49.296] INFO: aztecjs:utils:watcher Slot 8 was filled, jumped to next slot 22:34:49 aztec-1 | [22:34:49.310] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:49 aztec-1 | [22:34:49.315] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000007"] on http://ethereum:8545 22:34:49 aztec-1 | [22:34:49.316] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 7 22:34:49 aztec-1 | [22:34:49.317] INFO: aztecjs:cheat_codes Proven tip moved: 6 -> 7. Pending tip: 7. 22:34:49 aztec-1 | [22:34:49.432] INFO: archiver Downloaded L2 block 7 {"blockHash":"0x09aa3fb64f7d05202cdf99b06d795745bc6ed10d23f25b151f531b68fd63c31f","blockNumber":7,"txCount":1,"globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":7,"slotNumber":8,"timestamp":1749076944,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x2d28e49000ddd383c2cbba4c2492eb71cc34db0506ee4fb697875d4db8e2a552","archiveNextLeafIndex":8} 22:34:49 aztec-1 | [22:34:49.442] INFO: archiver Updated proven chain to block 7 {"provenBlockNumber":7} 22:34:49 aztec-1 | [22:34:49.465] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":20.084049000004597,"unfinalisedBlockNumber":7,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":7,"blockTimestamp":1749076944,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":1,"contractClassLogSize":7} 22:34:49 aztec-1 | [22:34:49.513] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:49 22:34:49 box-1 | RUNS ... 22:34:49 aztec-1 | [22:34:49.717] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:50 aztec-1 | [22:34:49.927] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:50 aztec-1 | [22:34:50.200] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:50 aztec-1 | [22:34:50.404] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:50 22:34:50 box-1 | RUNS ... 22:34:50 aztec-1 | [22:34:50.635] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:50 aztec-1 | [22:34:50.848] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:51 aztec-1 | [22:34:51.065] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:51 aztec-1 | [22:34:51.406] INFO: pxe:service Proving completed in 1566.7328219999981ms {"timings":{"total":1566.7328219999981,"sync":32.18331299999409,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":338.8736130000034,"oracles":{"debugLog":{"times":[0.17994500000349944,0.0968219999995199,0.09307299999636598,0.18904599999950733,0.12428299999737646,0.09779300000082003,0.08790199999930337,0.20718599999963772]},"fetchTaggedLogs":{"times":[119.62679699999717]},"loadCapsule":{"times":[0.165804999996908,0.844905000005383,0.3231089999972028,0.4588530000037281,0.21658600000228034,0.34568099999887636,0.7432019999978365]},"getSharedSecret":{"times":[4.0430580000029295]},"aes128Decrypt":{"times":[0.22988700000132667,0.6939610000044922]},"getPublicKeysAndPartialAddress":{"times":[11.970840999994834]},"getKeyValidationRequest":{"times":[7.631322999994154]},"storeCapsule":{"times":[2.6301869999952032,2.420891000001575,3.2656559999959427]},"deleteCapsule":{"times":[2.744501000001037]},"validateEnqueuedNotesAndEvents":{"times":[16.9126449999967]},"getNotes":{"times":[2.497644000002765]},"getAuthWitness":{"times":[0.1296539999966626]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06357199999911245]},"callPrivateFunction":{"times":[451.6262480000005]}}},{"functionName":"private_kernel_init","time":56.95018899999559},{"functionName":"BoxReact:setNumber","time":434.9588289999956,"oracles":{"debugLog":{"times":[0.17193499999848427,0.1579249999995227,0.1588950000004843,0.18449500000133412,0.12452399999892805,0.09610300000349525,0.11149299999669893]},"fetchTaggedLogs":{"times":[142.25614000000496]},"loadCapsule":{"times":[0.2515170000042417,0.1950250000008964,0.5458359999975073,0.2353170000060345,0.19291599999996834,2.382050000000163,4.476890999998432]},"getSharedSecret":{"times":[4.9868659999992815]},"aes128Decrypt":{"times":[0.7356820000059088,1.0405709999977262]},"getPublicKeysAndPartialAddress":{"times":[2.925435999997717,1.5393450000046869]},"getKeyValidationRequest":{"times":[3.2846370000042953,2.935226000001421]},"storeCapsule":{"times":[2.5336739999984275,2.394090000001597,3.390618999997969]},"deleteCapsule":{"times":[6.170600999997987]},"validateEnqueuedNotesAndEvents":{"times":[28.10319399999571]},"getRandomField":{"times":[0.09180300000298303,0.16907500000525033,0.16135500000382308,0.03295100000104867,0.0351410000002943,0.02898099999583792,0.026421000002301298,0.04840200000035111,0.04151099999580765,0.025720999998156913,0.026099999995494727,0.0324010000040289]},"getNotes":{"times":[2.6208969999934197]},"notifyNullifiedNote":{"times":[0.49340400000073714]},"notifyCreatedNote":{"times":[0.10222300000168616]},"getIndexedTaggingSecretAsSender":{"times":[36.957462999998825]},"incrementAppTaggingSecretIndexAsSender":{"times":[33.367497999999614]}}},{"functionName":"private_kernel_inner","time":134.38449899999978},{"functionName":"private_kernel_reset","time":250.58729499999754},{"functionName":"private_kernel_tail","time":92.8540309999953}],"unaccounted":225.94105300001684}} 22:34:51 aztec-1 | [22:34:51.423] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:51 aztec-1 | [22:34:51.618] INFO: node Received tx 0x218b670a7ee488ec9e99c0831000041fbe4d6d52facf3aec9b426ee26f6bedb8 {"txHash":"0x218b670a7ee488ec9e99c0831000041fbe4d6d52facf3aec9b426ee26f6bedb8"} 22:34:51 aztec-1 | [22:34:51.619] INFO: pxe:service Sent transaction 0x218b670a7ee488ec9e99c0831000041fbe4d6d52facf3aec9b426ee26f6bedb8 22:34:51 aztec-1 | [22:34:51.629] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:51 22:34:51 box-1 | RUNS ... 22:34:51 aztec-1 | [22:34:51.701] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.024935011000001395s {"duration":0.024935011000001395,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 22:34:51 aztec-1 | [22:34:51.807] INFO: sequencer Built block 8 for slot 9 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x24d02f60f6a29c9618e122e9890f19947c99ed58e6a8fc4bbd7a43415c757631","globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":8,"slotNumber":9,"timestamp":1749076980,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"txHashes":["0x218b670a7ee488ec9e99c0831000041fbe4d6d52facf3aec9b426ee26f6bedb8"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":140.28095200000098,"publicProcessDuration":25.039905000005092,"rollupCircuitsDuration":133.37355899999966,"txCount":1,"blockNumber":8,"blockTimestamp":1749076980,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:34:51 aztec-1 | [22:34:51.903] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:52 aztec-1 | [22:34:52.108] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:52 aztec-1 | [22:34:52.128] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:34:52 aztec-1 | [22:34:52.143] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749077016] on http://ethereum:8545 22:34:52 aztec-1 | [22:34:52.144] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://ethereum:8545 22:34:52 aztec-1 | [22:34:52.146] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749077016 22:34:52 aztec-1 | [22:34:52.146] WARN: foundation:test-date-provider Time set to 2025-06-04T22:43:36.000Z {"offset":523854,"timeMs":1749077016000} 22:34:52 aztec-1 | [22:34:52.146] INFO: aztecjs:utils:watcher Slot 9 was filled, jumped to next slot 22:34:52 aztec-1 | [22:34:52.236] INFO: archiver Downloaded L2 block 8 {"blockHash":"0x24d02f60f6a29c9618e122e9890f19947c99ed58e6a8fc4bbd7a43415c757631","blockNumber":8,"txCount":1,"globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":8,"slotNumber":9,"timestamp":1749076980,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":40820},"archiveRoot":"0x0f453ac7f10f534b80d4bd8f0579018e0c46c4ab9d3401f327d09c10f8fa5432","archiveNextLeafIndex":9} 22:34:52 aztec-1 | [22:34:52.301] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":17.50410300000658,"unfinalisedBlockNumber":8,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":8,"blockTimestamp":1749076980,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:34:52 aztec-1 | [22:34:52.317] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:52 aztec-1 | [22:34:52.322] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000008"] on http://ethereum:8545 22:34:52 aztec-1 | [22:34:52.323] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 8 22:34:52 aztec-1 | [22:34:52.325] INFO: aztecjs:cheat_codes Proven tip moved: 7 -> 8. Pending tip: 8. 22:34:52 aztec-1 | [22:34:52.381] INFO: archiver Updated proven chain to block 8 {"provenBlockNumber":8} 22:34:52 aztec-1 | [22:34:52.519] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:52 22:34:52 box-1 | RUNS ... 22:34:52 22:34:52 box-1 | RUNS ... 22:34:53 aztec-1 | [22:34:52.776] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:53 aztec-1 | [22:34:52.985] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:53 22:34:53 box-1 | RUNS ... 22:34:53 PASS tests/node.test.ts (17.366 s) 22:34:53 box-1 | 22:34:53 box-1 | RUNS ... 22:34:53 BoxReact Contract Tests 22:34:53 box-1 | 22:34:53 box-1 | RUNS ... 22:34:53 ✓ Can set a number (2864 ms) 22:34:53 box-1 | 22:34:53 box-1 | RUNS ... 22:34:53 ✓ Can read a number (509 ms) 22:34:53 box-1 | 22:34:53 box-1 | RUNS ... 22:34:53 22:34:53 box-1 | 22:34:53 box-1 | RUNS ... 22:34:53 Test Suites: 1 passed, 1 total 22:34:53 box-1 | Tests: 2 passed, 2 total 22:34:53 box-1 | Snapshots: 0 total 22:34:53 box-1 | Time: 17.734 s 22:34:53 box-1 | Ran all test suites. 22:34:53 aztec-1 | [22:34:53.188] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:53 aztec-1 | [22:34:53.389] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:53 aztec-1 | [22:34:53.592] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:53 aztec-1 | [22:34:53.794] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:54 aztec-1 | [22:34:53.997] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:54 aztec-1 | [22:34:54.200] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:54 aztec-1 | [22:34:54.402] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:54 aztec-1 | [22:34:54.603] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:54 aztec-1 | [22:34:54.806] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:55 aztec-1 | [22:34:55.011] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:55 aztec-1 | [22:34:55.217] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:55 aztec-1 | [22:34:55.419] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:55 aztec-1 | [22:34:55.622] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:55 aztec-1 | [22:34:55.827] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:56 aztec-1 | [22:34:56.029] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:56 aztec-1 | [22:34:56.231] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:56 aztec-1 | [22:34:56.433] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:56 aztec-1 | [22:34:56.635] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:56 aztec-1 | [22:34:56.839] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:57 aztec-1 | [22:34:57.040] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:57 aztec-1 | [22:34:57.241] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:57 aztec-1 | [22:34:57.443] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:57 box-1 | \[WebServer] <i> [webpack-dev-server] Project is running at: 22:34:57 box-1 | [WebServer] <i> [webpack-dev-server] Loopback: http://localhost:5173/, http://[::1]:5173/ 22:34:57 box-1 | [WebServer] <i> [webpack-dev-server] On Your Network (IPv4): http://172.20.3.4:5173/ 22:34:57 box-1 | [WebServer] <i> [webpack-dev-server] Content not from webpack is served from '/root/aztec-packages/boxes/boxes/react/public' directory 22:34:57 box-1 | [WebServer] <i> [webpack-dev-server] 404s will fallback to '/index.html' 22:34:57 aztec-1 | [22:34:57.645] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:57 box-1 | 22:34:57 box-1 | Running 1 test using 1 worker 22:34:57 box-1 | 22:34:57 aztec-1 | [22:34:57.848] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:58 aztec-1 | [22:34:58.051] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:58 aztec-1 | [22:34:58.252] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:58 aztec-1 | [22:34:58.457] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:58 box-1 | 1 [webkit] › browser.spec.ts:3:1 › test 22:34:58 aztec-1 | [22:34:58.660] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:58 aztec-1 | [22:34:58.863] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:59 aztec-1 | [22:34:59.066] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:59 aztec-1 | [22:34:59.269] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:59 aztec-1 | [22:34:59.471] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:34:59 aztec-1 | [22:34:59.676] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:00 aztec-1 | [22:34:59.878] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:00 aztec-1 | [22:35:00.082] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:00 aztec-1 | [22:35:00.285] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:00 aztec-1 | [22:35:00.487] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:00 aztec-1 | [22:35:00.691] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:00 aztec-1 | [22:35:00.894] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:01 aztec-1 | [22:35:01.096] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:01 aztec-1 | [22:35:01.299] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:01 aztec-1 | [22:35:01.500] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:01 aztec-1 | [22:35:01.703] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:01 aztec-1 | [22:35:01.905] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:02 aztec-1 | [22:35:02.107] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:02 aztec-1 | [22:35:02.310] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:02 aztec-1 | [22:35:02.512] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:02 aztec-1 | [22:35:02.712] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:02 aztec-1 | [22:35:02.914] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:03 aztec-1 | [22:35:03.115] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:03 aztec-1 | [22:35:03.318] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:03 box-1 | [WebServer] <i> [webpack-dev-middleware] wait until bundle finished: / 22:35:03 aztec-1 | [22:35:03.520] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:03 aztec-1 | [22:35:03.723] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:03 aztec-1 | [22:35:03.924] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:04 aztec-1 | [22:35:04.126] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:04 aztec-1 | [22:35:04.328] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:04 aztec-1 | [22:35:04.528] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:04 aztec-1 | [22:35:04.729] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:05 aztec-1 | [22:35:04.935] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:05 aztec-1 | [22:35:05.136] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:05 aztec-1 | [22:35:05.339] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:05 aztec-1 | [22:35:05.540] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:05 aztec-1 | [22:35:05.742] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:06 aztec-1 | [22:35:05.945] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:06 aztec-1 | [22:35:06.146] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:06 aztec-1 | [22:35:06.348] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:06 aztec-1 | [22:35:06.549] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:06 aztec-1 | [22:35:06.751] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:07 aztec-1 | [22:35:06.954] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:07 aztec-1 | [22:35:07.156] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:07 aztec-1 | [22:35:07.359] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:07 aztec-1 | [22:35:07.561] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:07 aztec-1 | [22:35:07.763] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:07 aztec-1 | [22:35:07.965] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:08 aztec-1 | [22:35:08.167] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:08 aztec-1 | [22:35:08.369] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:08 aztec-1 | [22:35:08.570] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:08 aztec-1 | [22:35:08.773] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:09 aztec-1 | [22:35:08.977] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:09 aztec-1 | [22:35:09.179] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:09 aztec-1 | [22:35:09.383] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:09 aztec-1 | [22:35:09.587] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:09 aztec-1 | [22:35:09.792] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:10 aztec-1 | [22:35:09.994] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:10 aztec-1 | [22:35:10.196] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:10 aztec-1 | [22:35:10.397] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:10 aztec-1 | [22:35:10.603] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:10 aztec-1 | [22:35:10.806] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:11 aztec-1 | [22:35:11.012] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:11 aztec-1 | [22:35:11.214] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:11 aztec-1 | [22:35:11.416] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:11 aztec-1 | [22:35:11.617] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:11 aztec-1 | [22:35:11.819] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:12 aztec-1 | [22:35:12.022] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:12 aztec-1 | [22:35:12.225] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:12 aztec-1 | [22:35:12.429] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:12 aztec-1 | [22:35:12.631] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:12 aztec-1 | [22:35:12.833] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:13 aztec-1 | [22:35:13.036] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:13 aztec-1 | [22:35:13.239] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:13 aztec-1 | [22:35:13.440] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:13 aztec-1 | [22:35:13.559] INFO: pxe:service Added contract BoxReact at 0x0f96bf063ce2f3e49a0be0f0d03b3b26780d7056ee6b6a2e8ebdf3351fd0aaa7 with class 0x2cfc352e256c0cf875ccda6bdd1c5908d80a1000041910ea821bd5d2afd6ac29 22:35:13 aztec-1 | [22:35:13.653] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:13 aztec-1 | [22:35:13.949] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:14 aztec-1 | [22:35:14.164] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:14 aztec-1 | [22:35:14.385] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:14 aztec-1 | [22:35:14.617] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:14 aztec-1 | [22:35:14.821] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:15 aztec-1 | [22:35:15.053] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:15 aztec-1 | [22:35:15.577] INFO: pxe:service Proving completed in 1970.0234469999996ms {"timings":{"total":1970.0234469999996,"sync":18.08882900000026,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":345.1316280000028,"oracles":{"debugLog":{"times":[0.22171699999307748,0.11439399998926092,0.12982400000328198,0.25438800000119954,0.10597299999790266,0.10126299998955801,0.13448399999469984,0.16116499999770895]},"fetchTaggedLogs":{"times":[124.08499999999185]},"loadCapsule":{"times":[0.23106600000755861,0.1524539999954868,0.3377500000060536,0.2015559999999823,0.40093200000410434,2.272666000004392,1.5558960000053048]},"getSharedSecret":{"times":[4.03459800001292]},"aes128Decrypt":{"times":[0.18251600000075996,0.8402449999994133]},"getPublicKeysAndPartialAddress":{"times":[4.092430000004242]},"getKeyValidationRequest":{"times":[2.0743809999985388]},"storeCapsule":{"times":[4.340267000006861,2.630736999999499,4.291595999995479]},"deleteCapsule":{"times":[4.430990000008023]},"validateEnqueuedNotesAndEvents":{"times":[15.069980999993277]},"getNotes":{"times":[2.6034360000048764]},"getAuthWitness":{"times":[0.13027400001010392]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.06668200000422075]},"callPrivateFunction":{"times":[100.89710199998808,316.0452970000042]}}},{"functionName":"private_kernel_init","time":69.99284700000135},{"functionName":"ContractInstanceDeployer:deploy","time":51.23789899999974,"oracles":{"storeInExecutionCache":{"times":[0.0878519999969285]},"callPrivateFunction":{"times":[45.22551299999759]},"notifyCreatedNullifier":{"times":[0.21197699999902397]},"debugLog":{"times":[0.1299940000026254]}}},{"functionName":"private_kernel_inner","time":123.86282400001073},{"functionName":"ContractClassRegisterer:assert_class_id_is_registered","time":35.408605999997235,"oracles":{}},{"functionName":"private_kernel_inner","time":148.29286899999715},{"functionName":"BoxReact:constructor","time":297.84951400000136,"oracles":{"getContractInstance":{"times":[1.8824150000000373]},"debugLog":{"times":[0.1450440000044182,0.1053329999995185]},"fetchTaggedLogs":{"times":[74.01116500000353]},"loadCapsule":{"times":[0.301168999998481,1.172284000000218,0.9001359999965644]},"validateEnqueuedNotesAndEvents":{"times":[9.67494299999089]},"getRandomField":{"times":[0.18993499998759944,0.1337529999873368,0.16362399999343324,0.05921199999283999,0.03342999999586027,0.05681199999526143,0.03615200000058394,0.033670999997411855,0.041882000004989095,0.048502000005100854,0.041081000003032386,0.03212099999655038]},"notifyCreatedNullifier":{"times":[0.2264969999960158,0.18903599999612197]},"notifyCreatedNote":{"times":[0.20413500000722706]},"getIndexedTaggingSecretAsSender":{"times":[47.16943999999785]},"incrementAppTaggingSecretIndexAsSender":{"times":[24.538518000001204]}}},{"functionName":"private_kernel_inner","time":153.73261700000148},{"functionName":"private_kernel_reset","time":260.6572759999981},{"functionName":"private_kernel_tail","time":96.88052399999287}],"unaccounted":368.8880139999965}} 22:35:15 aztec-1 | [22:35:15.602] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:15 aztec-1 | [22:35:15.808] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:16 aztec-1 | [22:35:16.010] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:16 aztec-1 | [22:35:16.022] INFO: node Received tx 0x0007cd2dc8337148984a1ccca693a4726c9d14c3d602beea68da302fa6748a05 {"txHash":"0x0007cd2dc8337148984a1ccca693a4726c9d14c3d602beea68da302fa6748a05"} 22:35:16 aztec-1 | [22:35:16.023] INFO: pxe:service Sent transaction 0x0007cd2dc8337148984a1ccca693a4726c9d14c3d602beea68da302fa6748a05 22:35:16 aztec-1 | [22:35:16.096] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.020321893999993335s {"duration":0.020321893999993335,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":20992,"l2Gas":7834},"totalSizeInBytes":1568} 22:35:16 aztec-1 | [22:35:16.178] INFO: sequencer Built block 9 for slot 10 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x227694e951d2da1ea52c108089550b4358ad3c08a1ab3260998d565ea80da10e","globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":9,"slotNumber":10,"timestamp":1749077016,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":5050},"txHashes":["0x0007cd2dc8337148984a1ccca693a4726c9d14c3d602beea68da302fa6748a05"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":110.24858600000152,"publicProcessDuration":20.512149999995017,"rollupCircuitsDuration":105.24509899999248,"txCount":1,"blockNumber":9,"blockTimestamp":1749077016,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:35:16 aztec-1 | [22:35:16.251] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:16 aztec-1 | [22:35:16.453] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:35:16 aztec-1 | [22:35:16.455] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:16 aztec-1 | [22:35:16.460] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x0000000000000000000000000000000000000000000000000000000000000009"] on http://ethereum:8545 22:35:16 aztec-1 | [22:35:16.460] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 9 22:35:16 aztec-1 | [22:35:16.461] INFO: aztecjs:cheat_codes Proven tip moved: 8 -> 9. Pending tip: 9. 22:35:16 aztec-1 | [22:35:16.462] WARN: archiver Failed to reach L2 block 9 at 39 (latest is 8). Rolling back last synched L1 block number to 38. {"latestLocalL2BlockNumber":8,"latestLocalL2BlockArchive":"0x0f453ac7f10f534b80d4bd8f0579018e0c46c4ab9d3401f327d09c10f8fa5432","blocksSynchedTo":38,"currentL1BlockNumber":39,"provenBlockNumber":8,"provenArchive":"0x0f453ac7f10f534b80d4bd8f0579018e0c46c4ab9d3401f327d09c10f8fa5432","pendingBlockNumber":9,"pendingArchive":"0x1da3b8c0cc08dfdc1d0a84f0c9e562197a3337677b27777446efac2fc65927c9"} 22:35:16 aztec-1 | [22:35:16.470] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749077052] on http://ethereum:8545 22:35:16 aztec-1 | [22:35:16.471] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://ethereum:8545 22:35:16 aztec-1 | [22:35:16.472] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749077052 22:35:16 aztec-1 | [22:35:16.472] WARN: foundation:test-date-provider Time set to 2025-06-04T22:44:12.000Z {"offset":535528,"timeMs":1749077052000} 22:35:16 aztec-1 | [22:35:16.472] INFO: aztecjs:utils:watcher Slot 10 was filled, jumped to next slot 22:35:16 aztec-1 | [22:35:16.546] INFO: archiver Downloaded L2 block 9 {"blockHash":"0x227694e951d2da1ea52c108089550b4358ad3c08a1ab3260998d565ea80da10e","blockNumber":9,"txCount":1,"globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":9,"slotNumber":10,"timestamp":1749077016,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":5050},"archiveRoot":"0x1da3b8c0cc08dfdc1d0a84f0c9e562197a3337677b27777446efac2fc65927c9","archiveNextLeafIndex":10} 22:35:16 aztec-1 | [22:35:16.550] INFO: archiver Updated proven chain to block 9 {"provenBlockNumber":9} 22:35:16 aztec-1 | [22:35:16.608] INFO: world_state World state updated with L2 block 9 {"eventName":"l2-block-handled","duration":16.443020999999135,"unfinalisedBlockNumber":9,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":9,"blockTimestamp":1749077016,"privateLogCount":2,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:35:16 aztec-1 | [22:35:16.659] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:16 aztec-1 | [22:35:16.860] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:17 aztec-1 | [22:35:17.061] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:17 aztec-1 | [22:35:17.263] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:17 aztec-1 | [22:35:17.465] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:17 aztec-1 | [22:35:17.667] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:17 aztec-1 | [22:35:17.870] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:18 aztec-1 | [22:35:18.072] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:18 aztec-1 | [22:35:18.273] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:18 aztec-1 | [22:35:18.475] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:18 aztec-1 | [22:35:18.683] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:18 aztec-1 | [22:35:18.884] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:19 aztec-1 | [22:35:19.090] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:19 aztec-1 | [22:35:19.294] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:19 aztec-1 | [22:35:19.496] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:19 aztec-1 | [22:35:19.698] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:20 aztec-1 | [22:35:19.899] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:20 aztec-1 | [22:35:20.102] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:20 aztec-1 | [22:35:20.303] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:20 aztec-1 | [22:35:20.506] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:20 aztec-1 | [22:35:20.709] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:20 aztec-1 | [22:35:20.915] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:21 aztec-1 | [22:35:21.118] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:21 aztec-1 | [22:35:21.319] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:21 aztec-1 | [22:35:21.522] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:21 aztec-1 | [22:35:21.743] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:22 aztec-1 | [22:35:22.059] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:22 aztec-1 | [22:35:22.264] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:22 aztec-1 | [22:35:22.494] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:23 aztec-1 | [22:35:22.976] INFO: pxe:service Proving completed in 1327.031375999999ms {"timings":{"total":1327.031375999999,"sync":12.875476000001072,"perFunction":[{"functionName":"SchnorrAccount:entrypoint","time":297.53616500001226,"oracles":{"debugLog":{"times":[0.33653999998932704,0.11021300000720657,0.09864199999719858,0.17006499999843072,0.08966199999849778,0.053411999993841164,0.06957200000761077,0.1309740000142483]},"fetchTaggedLogs":{"times":[97.5335439999908]},"loadCapsule":{"times":[0.15370399999665096,0.08934200000658166,0.25488799999584444,0.3410299999959534,0.23574699999880977,0.19223600000259466,0.5122239999909652]},"getSharedSecret":{"times":[3.490252000003238]},"aes128Decrypt":{"times":[0.2382870000001276,0.9445280000072671]},"getPublicKeysAndPartialAddress":{"times":[1.3486490000068443]},"getKeyValidationRequest":{"times":[1.7816820000007283]},"storeCapsule":{"times":[2.2973479999927804,2.160313000000315,2.063980000006268]},"deleteCapsule":{"times":[2.1916239999991376]},"validateEnqueuedNotesAndEvents":{"times":[11.232227999993484]},"getNotes":{"times":[3.849761999998009]},"getAuthWitness":{"times":[0.21291599998949096]},"notifySetMinRevertibleSideEffectCounter":{"times":[0.14409400000295136]},"callPrivateFunction":{"times":[344.5822509999998]}}},{"functionName":"private_kernel_init","time":50.2733409999928},{"functionName":"BoxReact:setNumber","time":326.55766399999266,"oracles":{"debugLog":{"times":[0.1648049999930663,0.09334300000045914,0.1136629999964498,0.17673500000091735,0.07659199999761768,0.060021999990567565,0.07669200000236742]},"fetchTaggedLogs":{"times":[93.74555300000065]},"loadCapsule":{"times":[0.20237499999348074,0.16714499999943655,0.26225800000247546,0.21146700000099372,0.1735659999976633,0.5971270000009099,0.2111460000014631]},"getSharedSecret":{"times":[11.584459000005154]},"aes128Decrypt":{"times":[0.4106819999869913,0.5998380000091856]},"getPublicKeysAndPartialAddress":{"times":[1.62220700000762,2.1278129999991506]},"getKeyValidationRequest":{"times":[2.658638000008068,1.5924960000120336]},"storeCapsule":{"times":[3.066980000003241,2.3949999999895226,2.200345000004745]},"deleteCapsule":{"times":[2.4590319999988424]},"validateEnqueuedNotesAndEvents":{"times":[17.693938000011258]},"getRandomField":{"times":[0.19041600001219194,0.156474999996135,0.12893399999302346,0.070821999994223,0.060962000003200956,0.042201999996905215,0.045700999995460734,0.036210999998729676,0.030471000005491078,0.0361809999885736,0.02936000000045169,0.03512099999352358]},"getNotes":{"times":[2.322617999991053]},"notifyNullifiedNote":{"times":[0.1749159999890253]},"notifyCreatedNote":{"times":[0.18354499999259133]},"getIndexedTaggingSecretAsSender":{"times":[39.78094399999827]},"incrementAppTaggingSecretIndexAsSender":{"times":[20.71046600000409]}}},{"functionName":"private_kernel_inner","time":128.73229600000195},{"functionName":"private_kernel_reset","time":247.36583700000483},{"functionName":"private_kernel_tail","time":93.88763700000709}],"unaccounted":169.80295999998634}} 22:35:23 aztec-1 | [22:35:22.999] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:23 aztec-1 | [22:35:23.203] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:23 aztec-1 | [22:35:23.292] INFO: node Received tx 0x2506d5f261aafe86b70fea499382dc37b99dc24fa6b1f318a6fe5d9046a03d62 {"txHash":"0x2506d5f261aafe86b70fea499382dc37b99dc24fa6b1f318a6fe5d9046a03d62"} 22:35:23 aztec-1 | [22:35:23.292] INFO: pxe:service Sent transaction 0x2506d5f261aafe86b70fea499382dc37b99dc24fa6b1f318a6fe5d9046a03d62 22:35:23 aztec-1 | [22:35:23.340] INFO: simulator:public-processor Processed 1 successful txs and 0 failed txs in 0.02042045700000017s {"duration":0.02042045700000017,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":11776,"l2Gas":4814},"totalSizeInBytes":992} 22:35:23 aztec-1 | [22:35:23.436] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:23 aztec-1 | [22:35:23.452] INFO: sequencer Built block 10 for slot 11 with 1 txs and 0 messages. 0 mana/s {"blockHash":"0x2acd2b1d0a40875f98332e988fdd8c3720a4b583910e24fa50c662a8755fae02","globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":10,"slotNumber":11,"timestamp":1749077052,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":5050},"txHashes":["0x2506d5f261aafe86b70fea499382dc37b99dc24fa6b1f318a6fe5d9046a03d62"],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":141.8838909999904,"publicProcessDuration":20.578231999999844,"rollupCircuitsDuration":137.11920200000168,"txCount":1,"blockNumber":10,"blockTimestamp":1749077052,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:35:24 aztec-1 | [22:35:23.751] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:24 aztec-1 | [22:35:23.767] INFO: ethereum:cheat_codes Calling hardhat_setStorageAt with params: ["0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae","0x0958201b72d64259285941dffd868dac55267471fcc73e8a06e1fd9cf8706362","0x000000000000000000000000000000000000000000000000000000000000000a"] on http://ethereum:8545 22:35:24 aztec-1 | [22:35:23.771] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 22:35:24 aztec-1 | [22:35:23.772] WARN: ethereum:cheat_codes Set L1 storage for contract 0x9a9f2ccfde556a7e9ff0848998aa4a0cfd8863ae at 4226519774845294989066245638914502055781420935494253450203740607592046551906 to 10 22:35:24 aztec-1 | [22:35:23.775] INFO: aztecjs:cheat_codes Proven tip moved: 9 -> 10. Pending tip: 10. 22:35:24 aztec-1 | [22:35:23.775] INFO: ethereum:cheat_codes Calling evm_setNextBlockTimestamp with params: [1749077088] on http://ethereum:8545 22:35:24 aztec-1 | [22:35:23.776] INFO: ethereum:cheat_codes Calling hardhat_mine with params: [1] on http://ethereum:8545 22:35:24 aztec-1 | [22:35:23.777] WARN: ethereum:cheat_codes Warped L1 timestamp to 1749077088 22:35:24 aztec-1 | [22:35:23.777] WARN: foundation:test-date-provider Time set to 2025-06-04T22:44:48.000Z {"offset":564223,"timeMs":1749077088000} 22:35:24 aztec-1 | [22:35:23.777] INFO: aztecjs:utils:watcher Slot 11 was filled, jumped to next slot 22:35:24 aztec-1 | [22:35:23.781] WARN: archiver Failed to reach L2 block 10 at 41 (latest is 9). Rolling back last synched L1 block number to 40. {"latestLocalL2BlockNumber":9,"latestLocalL2BlockArchive":"0x1da3b8c0cc08dfdc1d0a84f0c9e562197a3337677b27777446efac2fc65927c9","blocksSynchedTo":40,"currentL1BlockNumber":41,"provenBlockNumber":9,"provenArchive":"0x1da3b8c0cc08dfdc1d0a84f0c9e562197a3337677b27777446efac2fc65927c9","pendingBlockNumber":10,"pendingArchive":"0x24a5dadaf8d0e9b90687e14605f8447126acef48b7deda11e3be0b318e0c961c"} 22:35:24 aztec-1 | [22:35:23.876] INFO: archiver Downloaded L2 block 10 {"blockHash":"0x2acd2b1d0a40875f98332e988fdd8c3720a4b583910e24fa50c662a8755fae02","blockNumber":10,"txCount":1,"globalVariables":{"chainId":31337,"version":3190523442,"blockNumber":10,"slotNumber":11,"timestamp":1749077052,"coinbase":"0x0000000000000000000000000000000000000000","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","feePerDaGas":0,"feePerL2Gas":5050},"archiveRoot":"0x24a5dadaf8d0e9b90687e14605f8447126acef48b7deda11e3be0b318e0c961c","archiveNextLeafIndex":11} 22:35:24 aztec-1 | [22:35:23.882] INFO: archiver Updated proven chain to block 10 {"provenBlockNumber":10} 22:35:24 aztec-1 | [22:35:23.938] INFO: world_state World state updated with L2 block 10 {"eventName":"l2-block-handled","duration":17.788960000005318,"unfinalisedBlockNumber":10,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":1,"blockNumber":10,"blockTimestamp":1749077052,"privateLogCount":1,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 22:35:24 aztec-1 | [22:35:23.958] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:24 aztec-1 | [22:35:24.161] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:24 aztec-1 | [22:35:24.363] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:24 aztec-1 | [22:35:24.568] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:24 aztec-1 | [22:35:24.770] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:25 aztec-1 | [22:35:24.974] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:25 aztec-1 | [22:35:25.177] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:25 aztec-1 | [22:35:25.383] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:25 aztec-1 | [22:35:25.596] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:25 aztec-1 | [22:35:25.801] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:26 aztec-1 | [22:35:26.006] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:26 ✘ 1 [webkit] › browser.spec.ts:3:1 › test (26.8s) 22:35:26 box-1 | 22:35:26 box-1 | 1) [webkit] › browser.spec.ts:3:1 › test ───────────────────────────────────────────────────────── 22:35:26 box-1 | 22:35:26 box-1 | Error: expect(locator).toBeVisible() 22:35:26 box-1 | 22:35:26 box-1 | Locator: getByText('Number is: 1') 22:35:26 box-1 | Expected: visible 22:35:26 box-1 | Received: <element(s) not found> 22:35:26 box-1 | Call log: 22:35:26 box-1 | - expect.toBeVisible with timeout 90000ms 22:35:26 box-1 | - waiting for getByText('Number is: 1') 22:35:26 box-1 | 22:35:26 box-1 | 22:35:26 box-1 | 22 | // Read number 22:35:26 box-1 | 23 | await page.getByRole('button', { name: 'Read' }).click(); 22:35:26 box-1 | > 24 | await expect(page.getByText('Number is: 1')).toBeVisible(); 22:35:26 box-1 | | ^ 22:35:26 box-1 | 25 | }); 22:35:26 box-1 | 26 | 22:35:26 box-1 | at /root/aztec-packages/boxes/boxes/react/tests/browser.spec.ts:24:48 22:35:26 box-1 | 22:35:26 box-1 | Slow test file: [webkit] › browser.spec.ts (26.8s) 22:35:26 box-1 | Consider splitting slow test files to speed up parallel execution 22:35:26 box-1 | 1 failed 22:35:26 box-1 | [webkit] › browser.spec.ts:3:1 › test ────────────────────────────────────────────────────────── 22:35:26 box-1 | \npm notice 22:35:26 box-1 | npm notice New major version of npm available! 10.9.2 -> 11.4.1 22:35:26 box-1 | npm notice Changelog: https://github.com/npm/cli/releases/tag/v11.4.1 22:35:26 box-1 | npm notice To update run: npm install -g npm@11.4.1 22:35:26 box-1 | npm notice 22:35:26 aztec-1 | [22:35:26.207] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:26 box-1 | \ 22:35:26 aztec-1 | [22:35:26.410] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:26 aztec-1 | [22:35:26.613] INFO: ethereum:cheat_codes Calling eth_getBlockByNumber with params: ["latest",true] on http://ethereum:8545 22:35:26 Aborting on container exit... 22:35:26 box-1 exited with code 1 22:35:26 Container react-webkit-box-1 Stopping 22:35:26 Container react-webkit-box-1 Stopped 22:35:26 Container react-webkit-aztec-1 Stopping 22:35:28 Container react-webkit-aztec-1 Stopped 22:35:28 Container react-webkit-ethereum-1 Stopping 22:35:28 Container react-webkit-ethereum-1 Stopped 22:35:28