Parent Log: http://ci.aztec-labs.com/2df2f23eb2ea1efb Command: f5e85dbc8a1d83c5 yarn-project/scripts/run_test.sh archiver/src/archiver/archiver.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/26c5a39fe03723d11540f721293d7aebd1f478d9 Env: REF_NAME=gh-readonly-queue/next/pr-14995-75d792847d8434a0c504e7adf5c102a913065272 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Fri Jun 13 09:00:09 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14995_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:00:12 [09:00:12.834] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:15 [09:00:15.560] INFO: archiver:test Waiting for archiver to sync to block 3 09:00:15 [09:00:15.573] 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":"0x1914768811b8bb93a195fa908a6abadda4f8ac08475955295fa740d497e69039","rollingHash":"0x2c94a012ca22096ab5f9799ff98d4335"},"messageCount":2} 09:00:15 [09:00:15.643] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x183ee04edac80b037b146d12e6c6eeda8812ca694e0fbef00c8d457ef5ff6a90","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749805212841,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:00:16 [09:00:16.663] 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":"0x222e42abd9f9c66d84ed096bd162f9ec6380dc2eef578faf9f45c6671781a87e","rollingHash":"0x3abf43cd33e28b84a67702c8479627a1"},"messageCount":4} 09:00:16 [09:00:16.698] INFO: archiver Updated proven chain to block 1 {"provenBlockNumber":1} 09:00:16 [09:00:16.949] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x05a51591693ee4e8e51db52d1bdc778e74239d925455e439d118755bb3185285","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749805212853,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:00:16 [09:00:16.950] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x2ef378ee722e994a0cbab6a0181b5532aae42623d9d65905b1f949ac9add5f7c","blockNumber":3,"txCount":4,"globalVariables":{"blockNumber":3,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1749805212865,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000004","archiveNextLeafIndex":4} 09:00:17 [09:00:17.126] INFO: archiver Stopped. 09:00:17 [09:00:17.130] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:19 [09:00:19.697] INFO: archiver:test Waiting for archiver to sync to block 2 09:00:19 [09:00:19.708] 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":"0x1f8ea4b441b2a5a8bad7695a7cf72e7416ba59c65a065470d854d84a006fca84","rollingHash":"0xa634c17cc55ca5643376fe7fdcb8371a"},"messageCount":2} 09:00:19 [09:00:19.733] WARN: archiver Ignoring L2 block 3 due to archive root mismatch {"actual":"0x1d6d686bcdd0f4e1a588bc302e649024ed63b5d1ee3be11bb4c9c98f280f61b4","expected":"0x0000000000000000000000000000000000000000000000000000000000000004"} 09:00:19 [09:00:19.818] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x043e4c9bac7d713b8bed3e82ce43f69fcbc004b52c00a84a9a78fa128ff388b4","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749805217141,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:00:19 [09:00:19.819] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x06ef5ae2a1e20dc3e18aea26d13120598ac1986c6b50300ff33113a91c88835b","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749805217153,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:00:19 [09:00:19.911] INFO: archiver Stopped. 09:00:19 [09:00:19.913] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:22 [09:00:22.727] INFO: archiver:test Waiting for archiver to sync to block 2 09:00:23 [09:00:23.764] 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":"0x303a849e36867aa0a166f98a672a66db10894941517d8569d8403be9e9b6bf6b","rollingHash":"0xc8b46131f0285433fb1721ed5d73dbdc"},"messageCount":2} 09:00:23 [09:00:23.891] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x1a66ef01a07a9ce99546111772ef9013bf83701adbc886326fdc1c1f04a7ca66","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749805219925,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:00:23 [09:00:23.892] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x0fbee51a3e5be35cb7861c9713d371e427dac21266a727cc5bac7b5bf5d0af2e","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749805219937,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:00:23 [09:00:23.980] INFO: archiver Stopped. 09:00:23 [09:00:23.982] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:26 [09:00:26.814] INFO: archiver:test Waiting for archiver to sync to block 2 09:00:26 [09:00:26.860] ERROR: archiver Error in running promise: BlockTagTooOldError: Block tag 50 is more than 128 blocks behind the latest block 200 09:00:26 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15) 09:00:26 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:326:9) 09:00:26 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20) 09:00:26 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28) 09:00:26 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34) 09:00:26 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33 09:00:26 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21) 09:00:27 [09:00:27.870] 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":"0x259ef7b6707bc3127f1ac04640199314d5be44311c883bcf565cf44bf1c759c0","rollingHash":"0xfc16e07c26152255832d44bb66e8604c"},"messageCount":2} 09:00:27 [09:00:27.989] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x05dcbdae3d8170951f6e77ba44247730a5961bcba64f99ec164122e40b5b8b50","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749805223993,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:00:27 [09:00:27.990] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x22f94650298730b5b0ad226e1740a42c2932ac2deef9bffb9fba7f39f5fcbd86","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749805224005,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:00:27 [09:00:27.992] ERROR: archiver Error in running promise: BlockTagTooOldError: Block tag 250 is more than 128 blocks behind the latest block 400 09:00:27 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15) 09:00:27 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:326:9) 09:00:27 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20) 09:00:27 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28) 09:00:27 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34) 09:00:27 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33 09:00:27 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21) 09:00:29 [09:00:29.072] 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:00:29 [09:00:29.074] ERROR: archiver Error in running promise: BlockTagTooOldError: Block tag 450 is more than 128 blocks behind the latest block 600 09:00:29 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15) 09:00:29 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:326:9) 09:00:29 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20) 09:00:29 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28) 09:00:29 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34) 09:00:29 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33 09:00:29 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21) 09:00:30 [09:00:30.097] ERROR: archiver Error in running promise: TypeError: (intermediate value) is not iterable 09:00:30 at Archiver.handleL2blocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:595:7) 09:00:30 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:326:28) 09:00:30 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33 09:00:30 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21) 09:00:30 at RunningPromise.stop (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:82:9) 09:00:30 at Archiver.stop (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:887:5) 09:00:30 at Object.<anonymous> (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.test.ts:248:5) 09:00:30 [09:00:30.098] INFO: archiver Stopped. 09:00:30 [09:00:30.099] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:30 [09:00:30.438] 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":"0x1f4082428a4a35e763a8fea94057563014f19eda2a169efbf3cf683d148233f2","rollingHash":"0x2d7f677a2e4eeea522a6183fe404f76b"},"messageCount":6} 09:00:30 [09:00:30.438] WARN: archiver Last message retrieved rolling hash does not match remote state. {"lastMessage":{"index":35,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000065","l1BlockNumber":101,"l2BlockNumber":3,"leaf":"0x1f4082428a4a35e763a8fea94057563014f19eda2a169efbf3cf683d148233f2","rollingHash":"0x2d7f677a2e4eeea522a6183fe404f76b"},"remoteMessagesState":{"messagesRollingHash":"0x600899715b3c4e7c620b8a60d56561a5","totalMessagesInserted":5,"treeInProgress":0}} 09:00:30 [09:00:30.535] WARN: archiver:test Reorging L1 to L2 messages 09:00:31 [09:00:31.449] 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":"0x1f4082428a4a35e763a8fea94057563014f19eda2a169efbf3cf683d148233f2","rollingHash":"0x2d7f677a2e4eeea522a6183fe404f76b"}} 09:00:31 [09:00:31.453] WARN: archiver Deleting all local L1 to L2 messages after index 33 09:00:31 [09:00:31.455] WARN: archiver:message_store Deleted 2 L1 to L2 messages from index 34 from the store 09:00:31 [09:00:31.470] 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":"0x088793af13f53aee86370d20f044454fa6a9e63576cc931c7f84b46128c78b6d","rollingHash":"0x023bb373a5247cc7efd678a42fa27cff"},"messageCount":5} 09:00:31 [09:00:31.562] INFO: archiver Stopped. 09:00:31 [09:00:31.565] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:31 [09:00:31.882] INFO: archiver:test Syncing L2 block on slot 2 mined in L1 block 4 09:00:32 [09:00:32.740] INFO: archiver:test Waiting for archiver to sync to block 1 09:00:32 [09:00:32.851] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x194eab3ecd198c4cdb83bdef36b598876fa15e94c5f53cd1077840a26657070d","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749805231576,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:00:32 [09:00:32.946] INFO: archiver Stopped. 09:00:32 [09:00:32.948] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:33 [09:00:33.296] INFO: archiver:test Syncing L2 block on slot 3 mined in L1 block 6 09:00:34 [09:00:34.267] INFO: archiver:test Waiting for archiver to sync to block 1 09:00:34 [09:00:34.355] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x0338bb9c5ca306d5e42a56c065b3920888f1fd85f96f306ff7e071b2ba64fe60","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1749805232959,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:00:34 [09:00:34.397] INFO: archiver Stopped. 09:00:34 [09:00:34.400] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:34 [09:00:34.859] INFO: archiver:test Syncing archiver to L1 block 6 09:00:34 [09:00:34.861] 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":"0x09a2e46c9131ed50efaa0b378b72de28d49c0a48de4a25cae34f57be63a0a321","l1BlockNumber":0}} 09:00:34 [09:00:34.885] 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:00:34 [09:00:34.888] INFO: archiver Stopped. 09:00:34 [09:00:34.892] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:35 [09:00:35.329] INFO: archiver:test Syncing archiver to L1 block 7 09:00:35 [09:00:35.332] 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":"0x9c178b03411f848367eb55f43d8c389cbc67960100ab418011486f87f063f436","l1BlockNumber":0}} 09:00:35 [09:00:35.359] 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:00:35 [09:00:35.362] INFO: archiver Stopped. 09:00:35 [09:00:35.365] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:36 [09:00:36.278] INFO: archiver:test Syncing epoch 0 with L2 block on slot 1 mined in L1 block 2 09:00:38 [09:00:38.365] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x02dd636cac3314647436267e091e1a8827c2c3690e13a130e958a0c68cce77ab","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749805235376,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:00:38 [09:00:38.372] INFO: archiver Stopped. 09:00:38 [09:00:38.377] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:38 [09:00:38.728] 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":"0x1bf0e31c8bc493430b0330143e59030046d7831612da09f6e4bc39383964cd76","l1BlockNumber":0}} 09:00:38 [09:00:38.730] INFO: archiver Stopped. 09:00:38 [09:00:38.732] INFO: kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16 09:00:42 [09:00:42.950] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x081e7f6654e7c8737b1f1652cff4d3fcd08293fee917a916e292f02c0ab96da2","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1749805238743,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2} 09:00:42 [09:00:42.951] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x14e80d565314eea88f43430cc44296211b142c1dde345bf45a1445cecebff245","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749805238755,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:00:44 [09:00:44.064] 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:00:45 [09:00:45.153] 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:00:45 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:79:15 09:00:45 at AztecLMDBStoreV2.transactionAsync (/home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:106:20) 09:00:45 at BlockStore.addBlocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:69:12) 09:00:45 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:1416:7 09:00:45 at /home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:111:29 09:00:45 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 09:00:45 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) { 09:00:45 newBlockNumber: 3, 09:00:45 previousBlockNumber: 1 09:00:45 } 09:00:45 [09:00:45.203] 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":"0x081e7f6654e7c8737b1f1652cff4d3fcd08293fee917a916e292f02c0ab96da2","newBlockNumber":3,"updatedL1SyncPoint":70} 09:00:45 [09:00:45.228] ERROR: archiver Error in running promise: InitialBlockNumberNotSequentialError: Cannot insert new block 3 given previous block number in store is 1 09:00:45 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:79:15 09:00:45 at AztecLMDBStoreV2.transactionAsync (/home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:106:20) 09:00:45 at BlockStore.addBlocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:69:12) 09:00:45 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:1416:7 09:00:45 at /home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:111:29 09:00:45 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33 09:00:45 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) { 09:00:45 newBlockNumber: 3, 09:00:45 previousBlockNumber: 1 09:00:45 } 09:00:46 [09:00:46.423] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x14e80d565314eea88f43430cc44296211b142c1dde345bf45a1445cecebff245","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1749805238755,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3} 09:00:46 [09:00:46.425] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x168edc195c6e2ea690946427b4aa7a5650c0a880891809403a1632759e64e9db","blockNumber":3,"txCount":4,"globalVariables":{"blockNumber":3,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1749805238767,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000004","archiveNextLeafIndex":4} 09:00:46 [09:00:46.509] INFO: archiver Stopped. 09:00:46 PASS src/archiver/archiver.test.ts (36.531 s) 09:00:46 Archiver 09:00:46 syncs l1 to l2 messages and blocks (4300 ms) 09:00:46 ignores block 3 because it has been pruned (2782 ms) 09:00:46 skip event search if no changes found (4068 ms) 09:00:46 handles L2 reorg (6117 ms) 09:00:46 handles updated messages due to L1 reorg (1465 ms) 09:00:46 reports an epoch as pending if the current L2 block is not in the last slot of the epoch (1383 ms) 09:00:46 reports an epoch as complete if the current L2 block is in the last slot of the epoch (1451 ms) 09:00:46 reports an epoch as pending if the current L1 block is not the last one on the epoch and no L2 block landed (490 ms) 09:00:46 reports an epoch as complete if the current L1 block is the last one on the epoch and no L2 block landed (473 ms) 09:00:46 reports an epoch as complete due to timestamp only once all its blocks have been synced (3008 ms) 09:00:46 starts new loop if latest L1 block has advanced beyond what a non-archive L1 node tracks (358 ms) 09:00:46 handles a block gap due to a spurious L2 prune (7779 ms) 09:00:46 skipped handles an upcoming L2 prune 09:00:46 09:00:46 Test Suites: 1 passed, 1 total 09:00:46 Tests: 1 skipped, 12 passed, 13 total 09:00:46 Snapshots: 0 total 09:00:46 Time: 36.648 s 09:00:46 Ran all test suites matching /archiver\/src\/archiver\/archiver.test.ts/i. 09:00:46 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?