Parent Log:
http://ci.aztec-labs.com/e4f90c57de530d78
Command: f409422f407df62d yarn-project/scripts/run_test.sh archiver/src/archiver/archiver.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/f5bf74cc7cfdd8f2c3b0a69b410ed0dd2e068cda
Env: REF_NAME=gh-readonly-queue/next/pr-14610-d5c48d855d83e19712c6b72281801c6fce176ec1 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Wed Jun 18 13:59:53 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14610_amd64_x3-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_fba8e3924e2a5da2_next
13:59:57 [13:59:57.254]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:00 [14:00:00.264]
INFO:
archiver:test Waiting for archiver to sync to block 3
14:00:00 [14:00:00.290]
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":"0x0534c44ae457f795f7cddbd9e05b25458396bf4fe6ca89df88f8baf7ef9c9da1","rollingHash":"0x4ac73405b7e2b41fec334b5a51231cea"},"messageCount":2}
14:00:00 [14:00:00.391]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x163e37247b72dc57e28b01840e3c9d7e696b7143a902a849d41f237d54d2f577","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750255197249,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
14:00:01 [14:00:01.410]
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":"0x09700fea5c428fa3607c664c0d3608ee0f5bc46680fe4b9bd5938210aa1c7317","rollingHash":"0x5672c4b64169f5f7f7d9b158440d7021"},"messageCount":4}
14:00:01 [14:00:01.456]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
14:00:01 [14:00:01.630]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2a9cdd9ac7040a5279c4f91c5b5c5725c2fe013c49e6bf5cce428dd39b56a44c","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750255197261,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
14:00:01 [14:00:01.631]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x1d2092fcadfa940dfb0dadc97a272d5bdaff3807b648d624450f659aa92c2a5b","blockNumber":3,"txCount":4,"globalVariables":{"blockNumber":3,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1750255197273,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000004","archiveNextLeafIndex":4}
14:00:01 [14:00:01.791]
INFO:
archiver Stopped.
14:00:01 [14:00:01.795]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:04 [14:00:04.555]
INFO:
archiver:test Waiting for archiver to sync to block 2
14:00:04 [14:00:04.570]
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":"0x211a08a34ef23dca994bc1f29b17e132fb593e4fef0d0a3806c108f43af5a1d8","rollingHash":"0xb9e3f70d26a17816d1f62fec9100b96a"},"messageCount":2}
14:00:04 [14:00:04.592]
WARN:
archiver Ignoring L2 block 3 due to archive root mismatch
{"actual":"0x1addaa9446e93788512705464b71be9d71d76eb31ef4d9943c92465139faae7a","expected":"0x0000000000000000000000000000000000000000000000000000000000000004"}
14:00:04 [14:00:04.717]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x20708d5ee07dd2216fd0826446111ca195c6a125afb2028affae65daf520809f","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750255201806,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
14:00:04 [14:00:04.719]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x1b62f92ee13cd2decee250e8f885404f098bb8b66ed56801055008ad8c143049","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750255201818,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
14:00:04 [14:00:04.801]
INFO:
archiver Stopped.
14:00:04 [14:00:04.803]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:07 [14:00:07.709]
INFO:
archiver:test Waiting for archiver to sync to block 2
14:00:08 [14:00:08.745]
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":"0x0e76a6b9856934b43782a8bca765655949ad734ae59ef9c269a07ad17db9bc4d","rollingHash":"0x628b4ea937ec795f459404ddf8ea7975"},"messageCount":2}
14:00:08 [14:00:08.919]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x107cda829715c10bf260defd15580bdea55f848166e052d7a65693f776bcd0e7","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750255204815,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
14:00:08 [14:00:08.920]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x04540892c7f77c7cf1571e33ce60dad3b54c3dc4c9e1e71cfd841ed939c0d883","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750255204827,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
14:00:09 [14:00:09.002]
INFO:
archiver Stopped.
14:00:09 [14:00:09.008]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:12 [14:00:12.007]
INFO:
archiver:test Waiting for archiver to sync to block 2
14:00:12 [14:00:12.076]
ERROR:
archiver Error in running promise: BlockTagTooOldError: Block tag 50 is more than 128 blocks behind the latest block 200
14:00:12 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15)
14:00:12 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:331:9)
14:00:12 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20)
14:00:12 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28)
14:00:12 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34)
14:00:12 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33
14:00:12 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21)
14:00:13 [14:00:13.087]
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":"0x21683f74aca525e5868732e52a9192c6e7a177ba09f99b76e6e1d9bf0ddfa353","rollingHash":"0x67660c0ef9579864a0fcc3902efc2bf0"},"messageCount":2}
14:00:13 [14:00:13.251]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x26c9e2bdd173dd6bbd21724dedef2b5c8291e888a60d23d1a6517ddd2b7d73dd","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750255209015,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
14:00:13 [14:00:13.252]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x15c8f823290615bbf8c1327ed3d9a181903cc5cb8ea221db1ae004963cf2f8f1","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750255209027,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
14:00:13 [14:00:13.256]
ERROR:
archiver Error in running promise: BlockTagTooOldError: Block tag 250 is more than 128 blocks behind the latest block 400
14:00:13 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15)
14:00:13 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:331:9)
14:00:13 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20)
14:00:13 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28)
14:00:13 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34)
14:00:13 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33
14:00:13 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21)
14:00:14 [14:00:14.492]
WARN:
archiver Unwound 1 block from L2 block 2 due to mismatched block hashes at L1 block 450. Updated L2 latest block is 1.
14:00:14 [14:00:14.495]
ERROR:
archiver Error in running promise: BlockTagTooOldError: Block tag 450 is more than 128 blocks behind the latest block 600
14:00:14 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15)
14:00:14 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:331:9)
14:00:14 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20)
14:00:14 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28)
14:00:14 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34)
14:00:14 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33
14:00:14 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21)
14:00:15 [14:00:15.305]
INFO:
archiver Stopped.
14:00:15 [14:00:15.309]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:15 [14:00:15.716]
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":"0x1a070749d0037d308cef04be58906a964a27d1d815eaffbfe1ea495cb4e9a39e","rollingHash":"0x5fc1ae8ad6c41ef7e8a6372c19338b92"},"messageCount":6}
14:00:15 [14:00:15.717]
WARN:
archiver Last message retrieved rolling hash does not match remote state.
{"lastMessage":{"index":35,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000065","l1BlockNumber":101,"l2BlockNumber":3,"leaf":"0x1a070749d0037d308cef04be58906a964a27d1d815eaffbfe1ea495cb4e9a39e","rollingHash":"0x5fc1ae8ad6c41ef7e8a6372c19338b92"},"remoteMessagesState":{"messagesRollingHash":"0x9d40ecf70cb855e6e423dc25718c1a64","totalMessagesInserted":5,"treeInProgress":0}}
14:00:15 [14:00:15.811]
WARN:
archiver:test Reorging L1 to L2 messages
14:00:16 [14:00:16.755]
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":"0x1a070749d0037d308cef04be58906a964a27d1d815eaffbfe1ea495cb4e9a39e","rollingHash":"0x5fc1ae8ad6c41ef7e8a6372c19338b92"}}
14:00:16 [14:00:16.761]
WARN:
archiver Deleting all local L1 to L2 messages after index 33
14:00:16 [14:00:16.766]
WARN:
archiver:message_store Deleted 2 L1 to L2 messages from index 34 from the store
14:00:16 [14:00:16.792]
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":"0x28c72409ab16c9e8838eb80619764b574801cf08dfe438970bf9ae29c843f8cb","rollingHash":"0x67f8dee7c9354c28410fdea464194713"},"messageCount":5}
14:00:16 [14:00:16.911]
INFO:
archiver Stopped.
14:00:16 [14:00:16.926]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:17 [14:00:17.592]
INFO:
archiver:test Syncing L2 block on slot 2 mined in L1 block 4
14:00:18 [14:00:18.544]
INFO:
archiver:test Waiting for archiver to sync to block 1
14:00:18 [14:00:18.643]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x11a560baf7cf5a15e9d2406648317e9089f8f5c4ad7c04b8da3078da2ac7c225","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750255216934,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
14:00:18 [14:00:18.654]
INFO:
archiver Stopped.
14:00:18 [14:00:18.656]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:19 [14:00:19.115]
INFO:
archiver:test Syncing L2 block on slot 3 mined in L1 block 6
14:00:20 [14:00:20.056]
INFO:
archiver:test Waiting for archiver to sync to block 1
14:00:20 [14:00:20.125]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x25311bc300259251c55b8e6f9dae7904b6712e5649ded8fdb110903948013268","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1750255218668,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
14:00:20 [14:00:20.160]
INFO:
archiver Stopped.
14:00:20 [14:00:20.162]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:20 [14:00:20.597]
INFO:
archiver:test Syncing archiver to L1 block 6
14:00:20 [14:00:20.631]
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":"0xb56c1a46ad189e8be71eac058ad1c17102314ed97749e90823bd013b5cd8b69a","l1BlockNumber":0}}
14:00:20 [14:00:20.648]
INFO:
archiver Initial archiver sync to L1 block 6 complete.
{"l1BlockNumber":6,"syncPoint":{"blocksSynchedTo":6},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
14:00:20 [14:00:20.652]
INFO:
archiver Stopped.
14:00:20 [14:00:20.654]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:21 [14:00:21.067]
INFO:
archiver:test Syncing archiver to L1 block 7
14:00:21 [14:00:21.068]
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":"0x1b51e10e624a4e6568181c89cdf013517dfa2a7d4765a22546ac06dc20d8de95","l1BlockNumber":0}}
14:00:21 [14:00:21.088]
INFO:
archiver Initial archiver sync to L1 block 7 complete.
{"l1BlockNumber":7,"syncPoint":{"blocksSynchedTo":7},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
14:00:21 [14:00:21.096]
INFO:
archiver Stopped.
14:00:21 [14:00:21.104]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:22 [14:00:22.146]
INFO:
archiver:test Syncing epoch 0 with L2 block on slot 1 mined in L1 block 2
14:00:23 [14:00:23.444]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x172990050823ef2d808120dba7728c6514769447ca6fdb0532d3c8a9b6d32f65","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750255221112,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
14:00:23 [14:00:23.450]
INFO:
archiver Stopped.
14:00:23 [14:00:23.453]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:23 [14:00:23.860]
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":"0x1c0ecf3ab1562fddc5f9b3aeb92c67adce79600f1e567df5b6b3a3cbd6fbf73d","l1BlockNumber":0}}
14:00:23 [14:00:23.875]
INFO:
archiver Stopped.
14:00:23 [14:00:23.876]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
14:00:27 [14:00:27.402]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x005a1400477ac77dd2584b0e6ed7515eb3fd0f090075782635474dbf21a0dde1","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750255223888,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
14:00:27 [14:00:27.404]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2a704f42e7ff1237e2ded1e92f88ba71a9008911af59fd925487f8ed4b73a1a2","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750255223900,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
14:00:28 [14:00:28.568]
WARN:
archiver Unwound 1 block from L2 block 2 due to mismatched block hashes at L1 block 95. Updated L2 latest block is 1.
14:00:29 [14:00:29.628]
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
14:00:29 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:79:15
14:00:29 at AztecLMDBStoreV2.transactionAsync (/home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:106:20)
14:00:29 at BlockStore.addBlocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:69:12)
14:00:29 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:1412:7
14:00:29 at /home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:111:29
14:00:29 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33
14:00:29 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {
14:00:29 newBlockNumber: 3,
14:00:29 previousBlockNumber: 1
14:00:29 }
14:00:29 [14:00:29.653]
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":"0x005a1400477ac77dd2584b0e6ed7515eb3fd0f090075782635474dbf21a0dde1","newBlockNumber":3,"updatedL1SyncPoint":70}
14:00:29 [14:00:29.655]
ERROR:
archiver Error in running promise: InitialBlockNumberNotSequentialError: Cannot insert new block 3 given previous block number in store is 1
14:00:29 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:79:15
14:00:29 at AztecLMDBStoreV2.transactionAsync (/home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:106:20)
14:00:29 at BlockStore.addBlocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:69:12)
14:00:29 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:1412:7
14:00:29 at /home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:111:29
14:00:29 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33
14:00:29 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {
14:00:29 newBlockNumber: 3,
14:00:29 previousBlockNumber: 1
14:00:29 }
14:00:30 [14:00:30.864]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2a704f42e7ff1237e2ded1e92f88ba71a9008911af59fd925487f8ed4b73a1a2","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750255223900,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
14:00:30 [14:00:30.864]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x2126039629235a6ea9b098b08be67e92eee643e7aa63aa2f6461dcdaebdd52fd","blockNumber":3,"txCount":4,"globalVariables":{"blockNumber":3,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1750255223912,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000004","archiveNextLeafIndex":4}
14:00:30 [14:00:30.946]
INFO:
archiver Stopped.
14:00:30
PASS src/archiver/archiver.test.ts (
36.447 s)
14:00:30 Archiver
14:00:30
✓ syncs l1 to l2 messages and blocks (4558 ms)
14:00:30
✓ ignores block 3 because it has been pruned (3008 ms)
14:00:30
✓ skip event search if no changes found (4200 ms)
14:00:30
✓ handles L2 reorg (6303 ms)
14:00:30
✓ handles updated messages due to L1 reorg (1614 ms)
14:00:30
✓ reports an epoch as pending if the current L2 block is not in the last slot of the epoch (1732 ms)
14:00:30
✓ reports an epoch as complete if the current L2 block is in the last slot of the epoch (1505 ms)
14:00:30
✓ reports an epoch as pending if the current L1 block is not the last one on the epoch and no L2 block landed (491 ms)
14:00:30
✓ reports an epoch as complete if the current L1 block is the last one on the epoch and no L2 block landed (445 ms)
14:00:30
✓ reports an epoch as complete due to timestamp only once all its blocks have been synced (2352 ms)
14:00:30
✓ starts new loop if latest L1 block has advanced beyond what a non-archive L1 node tracks (423 ms)
14:00:30
✓ handles a block gap due to a spurious L2 prune (7070 ms)
14:00:30
○ skipped handles an upcoming L2 prune
14:00:30
14:00:30
Test Suites: 1 passed, 1 total
14:00:30
Tests: 1 skipped,
12 passed, 13 total
14:00:30
Snapshots: 0 total
14:00:30
Time: 36.526 s
14:00:30
Ran all test suites matching archiver/src/archiver/archiver.test.ts
.
14:00:30
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?