Parent Log: http://ci.aztec-labs.com/30fc99b02d171efe Command: be792e9a8a7f847e yarn-project/scripts/run_test.sh archiver/src/archiver/archiver.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/a8c553f203c98e5ca274e763c8e51daaaaf760d6 Env: REF_NAME=gh-readonly-queue/next/pr-15017-30660269b33bab8cca354c41659533acf4d48e07 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 13 09:37:22 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15017_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_fba8e3924e2a5da2_next 09:37:26 [09:37:26.228] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:29 [09:37:29.152] INFO: archiver:test Waiting for archiver to sync to block 3 09:37:29 [09:37:29.170] INFO: archiver Retrieved 2 new L1 to L2 messages up to message with index 1 for L2 block 1 {"lastMessage":{"index":1,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000063","l1BlockNumber":99,"l2BlockNumber":1,"leaf":"0x129f685d67e2bceaddebf98b3709066a72b011386eec1b78086770c141309cac","rollingHash":"0xc37d52143042798643fdc91c9c798ad1"},"messageCount":2} 09:37:29 [09:37:29.281] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2b26d5c90c5089a7ec6d02c4e769a4d00a999ae3ddf8bfe4e8d07a04bad9840e","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749807446238,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:37:30 [09:37:30.306] INFO: archiver Retrieved 4 new L1 to L2 messages up to message with index 32 for L2 block 3 {"lastMessage":{"index":32,"l1BlockHash":"0x00000000000000000000000000000000000000000000000000000000000009ca","l1BlockNumber":2506,"l2BlockNumber":3,"leaf":"0x032cb04042f9c4e23190a19f17c1215b54f767ed2da27a4c2fd521deec959835","rollingHash":"0x3a8e4b6b131ce18d26992cf457ce28bd"},"messageCount":4} 09:37:30 [09:37:30.345] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 09:37:30 [09:37:30.517] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x17a2e985b5af5d8d0253a93c7b9d0bb166157e002d1aacaf01d2e9d96e831cdb","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749807446250,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:37:30 [09:37:30.518] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x145a6447f9acad929f54e047f80ecf85dc79d0d7e39911ffeb1b6c1719a5828d","blockNumber":3,"txCount":4,"globalVariables":{"blockNumber":3,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1749807446262,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000004","archiveNextLeafIndex":4} 09:37:30 [09:37:30.694] INFO: archiver Stopped. 09:37:30 [09:37:30.700] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:33 [09:37:33.098] INFO: archiver:test Waiting for archiver to sync to block 2 09:37:33 [09:37:33.110] INFO: archiver Retrieved 2 new L1 to L2 messages up to message with index 1 for L2 block 1 {"lastMessage":{"index":1,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000044","l1BlockNumber":68,"l2BlockNumber":1,"leaf":"0x17be4da08446206ad801779f8545a39c71d13f782ae6c1d65da80e3363875012","rollingHash":"0x7988c507201d441f56c9f02a65257297"},"messageCount":2} 09:37:33 [09:37:33.126] WARN: archiver Ignoring L2 block 3 due to archive root mismatch {"actual":"0x25981caaaa92eafac7bc1cfc8cd10d9d3d5edd01c671451add3d444eb06c03d1","expected":"0x0000000000000000000000000000000000000000000000000000000000000004"} 09:37:33 [09:37:33.206] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2637a45fc06d4e6df80576e64c4711ad06908d1f601b5acba411242a61ff0593","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749807450711,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:37:33 [09:37:33.206] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x222c776266f25946915d0e2a1c7e7d163f07c2ca19fed38779c611cd9af1af84","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749807450723,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:37:33 [09:37:33.304] INFO: archiver Stopped. 09:37:33 [09:37:33.305] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:35 [09:37:35.616] INFO: archiver:test Waiting for archiver to sync to block 2 09:37:36 [09:37:36.809] INFO: archiver Retrieved 2 new L1 to L2 messages up to message with index 1 for L2 block 1 {"lastMessage":{"index":1,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000044","l1BlockNumber":68,"l2BlockNumber":1,"leaf":"0x1c63679a8e101c821bf2f964487b5cdff0f27f0734e01416f053b10c1cfa20ad","rollingHash":"0xebe71273e00c3df713670e64aa255464"},"messageCount":2} 09:37:37 [09:37:37.070] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x0c79a527a889dc08cce0a2ecbc063d517e026ce62ec7a3a0276b65733c85946a","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749807453317,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:37:37 [09:37:37.071] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x16fc276e4a052ebc344af32e13ec74f0e7b55b247a1e855fb3292d76cfac8da1","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749807453329,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:37:37 [09:37:37.167] INFO: archiver Stopped. 09:37:37 [09:37:37.173] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:39 [09:37:39.853] INFO: archiver:test Waiting for archiver to sync to block 2 09:37:39 [09:37:39.899] ERROR: archiver Error in running promise: BlockTagTooOldError: Block tag 50 is more than 128 blocks behind the latest block 200 09:37:39 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15) 09:37:39 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:326:9) 09:37:39 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20) 09:37:39 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28) 09:37:39 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34) 09:37:39 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33 09:37:39 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21) 09:37:40 [09:37:40.908] INFO: archiver Retrieved 2 new L1 to L2 messages up to message with index 1 for L2 block 1 {"lastMessage":{"index":1,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000044","l1BlockNumber":68,"l2BlockNumber":1,"leaf":"0x11203433aecfe16c21f230689b8de628ccedb4f8ba070d968a42edf8fd0987c4","rollingHash":"0xc19e88f47940aadf8410899935a0bb83"},"messageCount":2} 09:37:41 [09:37:41.006] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1c15b4e79c2cee5f5d70efdea8a9ed0e9d4bcf5a0abfd3dbd82f5b711addcb43","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749807457181,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:37:41 [09:37:41.006] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x1591b8a91b88d28e1c082c9a43a754cbfab8ebac562523fd1cfe7b7f16e8e119","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749807457193,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:37:41 [09:37:41.009] ERROR: archiver Error in running promise: BlockTagTooOldError: Block tag 250 is more than 128 blocks behind the latest block 400 09:37:41 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15) 09:37:41 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:326:9) 09:37:41 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20) 09:37:41 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28) 09:37:41 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34) 09:37:41 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33 09:37:41 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21) 09:37:42 [09:37:42.091] WARN: archiver Unwound 1 block from L2 block 2 due to mismatched block hashes at L1 block 450. Updated L2 latest block is 1. 09:37:42 [09:37:42.093] ERROR: archiver Error in running promise: BlockTagTooOldError: Block tag 450 is more than 128 blocks behind the latest block 600 09:37:42 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15) 09:37:42 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:326:9) 09:37:42 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20) 09:37:42 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28) 09:37:42 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34) 09:37:42 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33 09:37:42 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21) 09:37:43 [09:37:43.116] ERROR: archiver Error in running promise: TypeError: (intermediate value) is not iterable 09:37:43 at Archiver.handleL2blocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:595:7) 09:37:43 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:326:28) 09:37:43 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33 09:37:43 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21) 09:37:43 at RunningPromise.stop (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:82:9) 09:37:43 at Archiver.stop (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:887:5) 09:37:43 at Object.<anonymous> (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.test.ts:248:5) 09:37:43 [09:37:43.116] INFO: archiver Stopped. 09:37:43 [09:37:43.118] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:43 [09:37:43.487] INFO: archiver Retrieved 6 new L1 to L2 messages up to message with index 35 for L2 block 3 {"lastMessage":{"index":35,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000065","l1BlockNumber":101,"l2BlockNumber":3,"leaf":"0x2c3b0a55e2d617ef74efd9864b215671eeda7118b07cf9d7a17e6327b4dd35aa","rollingHash":"0x2296bdb252aa6463e6d805ebff873658"},"messageCount":6} 09:37:43 [09:37:43.488] WARN: archiver Last message retrieved rolling hash does not match remote state. {"lastMessage":{"index":35,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000065","l1BlockNumber":101,"l2BlockNumber":3,"leaf":"0x2c3b0a55e2d617ef74efd9864b215671eeda7118b07cf9d7a17e6327b4dd35aa","rollingHash":"0x2296bdb252aa6463e6d805ebff873658"},"remoteMessagesState":{"messagesRollingHash":"0x298c90fe98172928308ba83f21f207c2","totalMessagesInserted":5,"treeInProgress":0}} 09:37:43 [09:37:43.587] WARN: archiver:test Reorging L1 to L2 messages 09:37:44 [09:37:44.499] WARN: archiver Rolling back L1 to L2 messages due to hash mismatch or msg not found. {"messagesSyncPoint":{"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000065","l1BlockNumber":101},"localLastMessage":{"index":35,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000065","l1BlockNumber":101,"l2BlockNumber":3,"leaf":"0x2c3b0a55e2d617ef74efd9864b215671eeda7118b07cf9d7a17e6327b4dd35aa","rollingHash":"0x2296bdb252aa6463e6d805ebff873658"}} 09:37:44 [09:37:44.502] WARN: archiver Deleting all local L1 to L2 messages after index 33 09:37:44 [09:37:44.503] WARN: archiver:message_store Deleted 2 L1 to L2 messages from index 34 from the store 09:37:44 [09:37:44.525] INFO: archiver Retrieved 5 new L1 to L2 messages up to message with index 65 for L2 block 5 {"lastMessage":{"index":65,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000066","l1BlockNumber":102,"l2BlockNumber":5,"leaf":"0x042940445a6fbc10a0cec64a7a1bd3e239a0e7695faf79be4d65b62ef1515463","rollingHash":"0x0221995245c59d7719aa4b5fc5e01d58"},"messageCount":5} 09:37:44 [09:37:44.599] INFO: archiver Stopped. 09:37:44 [09:37:44.600] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:44 [09:37:44.887] INFO: archiver:test Syncing L2 block on slot 2 mined in L1 block 4 09:37:45 [09:37:45.582] INFO: archiver:test Waiting for archiver to sync to block 1 09:37:45 [09:37:45.633] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x2049f6a284e87eb6cb87c3223f923506da556de009f3da0eba29e56353a73663","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749807464612,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:37:45 [09:37:45.685] INFO: archiver Stopped. 09:37:45 [09:37:45.687] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:45 [09:37:45.958] INFO: archiver:test Syncing L2 block on slot 3 mined in L1 block 6 09:37:46 [09:37:46.693] INFO: archiver:test Waiting for archiver to sync to block 1 09:37:46 [09:37:46.755] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x11baafc65611c02af477ba2818c85a0aa3555dcf04a47d728d8cf38cdfc4519c","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1749807465699,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:37:46 [09:37:46.795] INFO: archiver Stopped. 09:37:46 [09:37:46.798] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:47 [09:37:47.075] INFO: archiver:test Syncing archiver to L1 block 6 09:37:47 [09:37:47.076] INFO: archiver Starting archiver sync to rollup contract 0x0000000000000000000000000000000000000000 from L1 block 0 to current L1 block 6 with hash 0x0000000000000000000000000000000000000000000000000000000000000006 {"blocksSynchedTo":0,"messagesSynchedTo":{"l1BlockHash":"0x3e0b09fecfb48db4adcdc91b18f0fe2f8a09f2208d9de34f2e1ba9b85917cc60","l1BlockNumber":0}} 09:37:47 [09:37:47.092] INFO: archiver Initial archiver sync to L1 block 6 complete. {"l1BlockNumber":6,"syncPoint":{"blocksSynchedTo":6,"messagesSynchedTo":{"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000006","l1BlockNumber":6}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 09:37:47 [09:37:47.094] INFO: archiver Stopped. 09:37:47 [09:37:47.095] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:47 [09:37:47.445] INFO: archiver:test Syncing archiver to L1 block 7 09:37:47 [09:37:47.448] INFO: archiver Starting archiver sync to rollup contract 0x0000000000000000000000000000000000000000 from L1 block 0 to current L1 block 7 with hash 0x0000000000000000000000000000000000000000000000000000000000000007 {"blocksSynchedTo":0,"messagesSynchedTo":{"l1BlockHash":"0xcce01aa792eed210425932d0fcee96efe6285fd4479d9505db8fd9a0aa6cda55","l1BlockNumber":0}} 09:37:47 [09:37:47.469] INFO: archiver Initial archiver sync to L1 block 7 complete. {"l1BlockNumber":7,"syncPoint":{"blocksSynchedTo":7,"messagesSynchedTo":{"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000007","l1BlockNumber":7}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 09:37:47 [09:37:47.471] INFO: archiver Stopped. 09:37:47 [09:37:47.473] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:47 [09:37:47.781] INFO: archiver:test Syncing epoch 0 with L2 block on slot 1 mined in L1 block 2 09:37:48 [09:37:48.702] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x11a2fff7aa2fd21b6948639185e72f12829feb0d14b05a05bf0165a0848d91b1","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749807467484,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:37:48 [09:37:48.709] INFO: archiver Stopped. 09:37:48 [09:37:48.712] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:49 [09:37:49.154] INFO: archiver Starting archiver sync to rollup contract 0x0000000000000000000000000000000000000000 from L1 block 0 to current L1 block 2000 with hash 0x00000000000000000000000000000000000000000000000000000000000007d0 {"blocksSynchedTo":0,"messagesSynchedTo":{"l1BlockHash":"0xa8c9c33880edf90d8c1e1e964d9757b895ec56f4749c4b9a65fde2e0e969a82f","l1BlockNumber":0}} 09:37:49 [09:37:49.160] INFO: archiver Stopped. 09:37:49 [09:37:49.163] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:37:53 [09:37:53.582] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1778cad432914d6cf54a2058d525aa1b8b73e60db88ea1bae16bc82a94fbf991","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749807469174,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:37:53 [09:37:53.584] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x070e11b8bbeade65211311084c22c9b0adb6d1e20ad0b60c0a116c18a6ffcb1f","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749807469186,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:37:54 [09:37:54.916] WARN: archiver Unwound 1 block from L2 block 2 due to mismatched block hashes at L1 block 95. Updated L2 latest block is 1. 09:37:55 [09:37:55.994] ERROR: kv-store:lmdb-v2:archiver_test Failed to commit transaction: InitialBlockNumberNotSequentialError: Cannot insert new block 3 given previous block number in store is 1 09:37:55 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:79:15 09:37:55 at AztecLMDBStoreV2.transactionAsync (/home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:106:20) 09:37:55 at BlockStore.addBlocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:69:12) 09:37:55 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:1416:7 09:37:55 at /home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:111:29 09:37:55 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 09:37:55 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) { 09:37:55 newBlockNumber: 3, 09:37:55 previousBlockNumber: 1 09:37:55 } 09:37:56 [09:37:56.021] WARN: archiver Attempting to insert block 3 with previous block 1. Rolling back L1 sync point to 70 to try and fetch the missing blocks. {"previousBlockNumber":1,"previousBlockHash":"0x1778cad432914d6cf54a2058d525aa1b8b73e60db88ea1bae16bc82a94fbf991","newBlockNumber":3,"updatedL1SyncPoint":70} 09:37:56 [09:37:56.022] ERROR: archiver Error in running promise: InitialBlockNumberNotSequentialError: Cannot insert new block 3 given previous block number in store is 1 09:37:56 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:79:15 09:37:56 at AztecLMDBStoreV2.transactionAsync (/home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:106:20) 09:37:56 at BlockStore.addBlocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:69:12) 09:37:56 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:1416:7 09:37:56 at /home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:111:29 09:37:56 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 09:37:56 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) { 09:37:56 newBlockNumber: 3, 09:37:56 previousBlockNumber: 1 09:37:56 } 09:37:57 [09:37:57.182] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x070e11b8bbeade65211311084c22c9b0adb6d1e20ad0b60c0a116c18a6ffcb1f","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749807469186,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:37:57 [09:37:57.184] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x00645edb3a603423874cbaf7a1ede6bd250449d68401aa418dae886aa8a31a3f","blockNumber":3,"txCount":4,"globalVariables":{"blockNumber":3,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1749807469198,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000004","archiveNextLeafIndex":4} 09:37:57 [09:37:57.274] INFO: archiver Stopped. 09:37:57 PASS src/archiver/archiver.test.ts (33.971 s) 09:37:57 Archiver 09:37:57 syncs l1 to l2 messages and blocks (4472 ms) 09:37:57 ignores block 3 because it has been pruned (2606 ms) 09:37:57 skip event search if no changes found (3863 ms) 09:37:57 handles L2 reorg (5948 ms) 09:37:57 handles updated messages due to L1 reorg (1482 ms) 09:37:57 reports an epoch as pending if the current L2 block is not in the last slot of the epoch (1087 ms) 09:37:57 reports an epoch as complete if the current L2 block is in the last slot of the epoch (1110 ms) 09:37:57 reports an epoch as pending if the current L1 block is not the last one on the epoch and no L2 block landed (298 ms) 09:37:57 reports an epoch as complete if the current L1 block is the last one on the epoch and no L2 block landed (377 ms) 09:37:57 reports an epoch as complete due to timestamp only once all its blocks have been synced (1238 ms) 09:37:57 starts new loop if latest L1 block has advanced beyond what a non-archive L1 node tracks (451 ms) 09:37:57 handles a block gap due to a spurious L2 prune (8114 ms) 09:37:57 skipped handles an upcoming L2 prune 09:37:57 09:37:57 Test Suites: 1 passed, 1 total 09:37:57 Tests: 1 skipped, 12 passed, 13 total 09:37:57 Snapshots: 0 total 09:37:57 Time: 34.057 s 09:37:57 Ran all test suites matching /archiver\/src\/archiver\/archiver.test.ts/i. 09:37:57 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?