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?