Parent Log:
http://ci.aztec-labs.com/516fa63e1f82d416
Command: 97e7ef9a556fd7e6 yarn-project/scripts/run_test.sh archiver/src/archiver/archiver.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/f3a077dd83e56ee0ae0a1175f0dc39fdfa50e6d7
Env: REF_NAME=gh-readonly-queue/master/pr-14734-a229cf871638d3fd774f9272645cc1ac29b8196a CURRENT_VERSION=0.87.9 CI_FULL=1
Date: Tue Jun 24 10:39:00 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14734_amd64_x1-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_fba8e3924e2a5da2_master
10:39:03 [10:39:03.761]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:07 [10:39:07.687]
INFO:
archiver:test Waiting for archiver to sync to block 3
10:39:07 [10:39:07.765]
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":"0x1d47afa830fc1cb256b9f2b37526cafe73df01f34fc5ae12a8c8f05d28f1aaec","rollingHash":"0xf3b15dcebc06c64a63d312e2dbd29cfd"},"messageCount":2}
10:39:07 [10:39:07.889]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x18fdeed0560ea852d91b4f76f8c6b5ffc5baf6a380fcabc827d170edacd832fa","blockNumber":1,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":1,"slotNumber":1,"timestamp":1750761543770,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
10:39:08 [10:39:08.922]
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":"0x0a1940adf5779c7167d7e7c963a4a5f02b658051a7af8e94f49e137d79bf4588","rollingHash":"0x3dd25b7cdadc1d6df13b8e0538087995"},"messageCount":4}
10:39:08 [10:39:08.993]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
10:39:09 [10:39:09.131]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x071187b3fe62815e818368fe291b1c6bad899af7876a1c14ad6698949bfcbc06","blockNumber":2,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":2,"slotNumber":2,"timestamp":1750761543782,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
10:39:09 [10:39:09.133]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x19aa8ee3d1f16923aa8ef944cb99ff276a90842c11d74085b97973da448dc66d","blockNumber":3,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":3,"slotNumber":3,"timestamp":1750761543794,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000004","archiveNextLeafIndex":4}
10:39:09 [10:39:09.296]
INFO:
archiver Stopped.
10:39:09 [10:39:09.300]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:13 [10:39:13.180]
INFO:
archiver:test Waiting for archiver to sync to block 2
10:39:13 [10:39:13.190]
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":"0x19fb8222ed30aed391fd6a171e927e3097cae7e556ebec6de56ce87844add1dc","rollingHash":"0xa62e5378bd8d047e77ad459b2945ebf0"},"messageCount":2}
10:39:13 [10:39:13.214]
WARN:
archiver Ignoring L2 block 3 due to archive root mismatch
{"actual":"0x29ad63e5b14d4780c0387e47821d2755881144115e71adba177bb098e3647c15","expected":"0x0000000000000000000000000000000000000000000000000000000000000004"}
10:39:13 [10:39:13.326]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x0c8fca0e5cbbf5b338c6e7da628d1647eebd3fcc52d2ee10af70935f89d4e6dd","blockNumber":1,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":1,"slotNumber":1,"timestamp":1750761549311,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
10:39:13 [10:39:13.328]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x0a625a8fde39a21096c5137f133dd362dbda65d0e1da22c7d61e5ab203ad8b71","blockNumber":2,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":2,"slotNumber":2,"timestamp":1750761549323,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
10:39:13 [10:39:13.412]
INFO:
archiver Stopped.
10:39:13 [10:39:13.414]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:17 [10:39:17.473]
INFO:
archiver:test Waiting for archiver to sync to block 2
10:39:18 [10:39:18.498]
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":"0x014734e9030ad8ab35ae22edda7c7ead7f92a22a97300fcf23deb3c08762de8d","rollingHash":"0x8ba3fcb6b9785befe9fb145a7465da02"},"messageCount":2}
10:39:18 [10:39:18.606]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x27cca09fe6db1155c10f73e9c1833a1b9b38438d4f883b39cbfbc5c163b81fc0","blockNumber":1,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":1,"slotNumber":1,"timestamp":1750761553425,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
10:39:18 [10:39:18.607]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x24276deaa47e6c75472ab54cc0cd75ff789b0384ede3d6a2518d8da7f9595d96","blockNumber":2,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":2,"slotNumber":2,"timestamp":1750761553437,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
10:39:18 [10:39:18.694]
INFO:
archiver Stopped.
10:39:18 [10:39:18.696]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:22 [10:39:22.273]
INFO:
archiver:test Waiting for archiver to sync to block 2
10:39:22 [10:39:22.315]
ERROR:
archiver Error in running promise: BlockTagTooOldError: Block tag 50 is more than 128 blocks behind the latest block 200
10:39:22 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15)
10:39:22 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:318:9)
10:39:22 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:365:20)
10:39:22 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:378:28)
10:39:22 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:331:34)
10:39:22 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33
10:39:22 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21)
10:39:23 [10:39:23.325]
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":"0x17904d00f5652948f1c1dda91abc60e5bac7df8e7a7ff9e74816ea2db422c93d","rollingHash":"0xf81c446c3b9672ff7821a5d6d006d55d"},"messageCount":2}
10:39:23 [10:39:23.428]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x2c01af52f8f90064574104fb9da2576d57073a915faf2b5f25a446d22169a2a5","blockNumber":1,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":1,"slotNumber":1,"timestamp":1750761558708,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
10:39:23 [10:39:23.429]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x048bbbfded5887b0da3510489c425b3fbc68f18b5f2c74f9ae07eff3421300f8","blockNumber":2,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":2,"slotNumber":2,"timestamp":1750761558720,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
10:39:23 [10:39:23.431]
ERROR:
archiver Error in running promise: BlockTagTooOldError: Block tag 250 is more than 128 blocks behind the latest block 400
10:39:23 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15)
10:39:23 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:318:9)
10:39:23 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:365:20)
10:39:23 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:378:28)
10:39:23 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:331:34)
10:39:23 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33
10:39:23 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21)
10:39:24 [10:39:24.516]
WARN:
archiver Unwound 1 block from L2 block 2 due to mismatched block hashes at L1 block 450. Updated L2 latest block is 1.
10:39:24 [10:39:24.518]
ERROR:
archiver Error in running promise: BlockTagTooOldError: Block tag 450 is more than 128 blocks behind the latest block 600
10:39:24 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15)
10:39:24 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:318:9)
10:39:24 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:365:20)
10:39:24 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:378:28)
10:39:24 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:331:34)
10:39:24 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33
10:39:24 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21)
10:39:25 [10:39:25.522]
ERROR:
archiver Error in running promise: TypeError: (intermediate value) is not iterable
10:39:25 at Archiver.handleL2blocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:588:7)
10:39:25 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:325:28)
10:39:25 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33
10:39:25 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21)
10:39:25 [10:39:25.524]
INFO:
archiver Stopped.
10:39:25 [10:39:25.526]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:25 [10:39:25.877]
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":"0x1f16877aa851bb6e1beb398a77413debf3fa979b379ac3f3a8c4a96266e4f3ff","rollingHash":"0x84dc2116c3c1e066ae334e72e72599c0"},"messageCount":6}
10:39:25 [10:39:25.878]
WARN:
archiver Last message retrieved rolling hash does not match remote state.
{"lastMessage":{"index":35,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000065","l1BlockNumber":101,"l2BlockNumber":3,"leaf":"0x1f16877aa851bb6e1beb398a77413debf3fa979b379ac3f3a8c4a96266e4f3ff","rollingHash":"0x84dc2116c3c1e066ae334e72e72599c0"},"remoteMessagesState":{"messagesRollingHash":"0x7ca4d5b01d881f4deea204d7ff738a4d","totalMessagesInserted":5,"treeInProgress":0}}
10:39:25 [10:39:25.972]
WARN:
archiver:test Reorging L1 to L2 messages
10:39:26 [10:39:26.887]
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":"0x1f16877aa851bb6e1beb398a77413debf3fa979b379ac3f3a8c4a96266e4f3ff","rollingHash":"0x84dc2116c3c1e066ae334e72e72599c0"}}
10:39:26 [10:39:26.889]
WARN:
archiver Deleting all local L1 to L2 messages after index 33
10:39:26 [10:39:26.890]
WARN:
archiver:message_store Deleted 2 L1 to L2 messages from index 34 from the store
10:39:26 [10:39:26.910]
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":"0x2469bde76a4c95c12b7c429e3644673202418a86f6fabde6b29335e3b3a360b8","rollingHash":"0x4fd9f392987757c4914b1f4265b143cf"},"messageCount":5}
10:39:26 [10:39:26.984]
INFO:
archiver Stopped.
10:39:26 [10:39:26.985]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:27 [10:39:27.269]
INFO:
archiver:test Syncing L2 block on slot 2 mined in L1 block 4
10:39:28 [10:39:28.345]
INFO:
archiver:test Waiting for archiver to sync to block 1
10:39:28 [10:39:28.415]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x0107e66ddde48acdc1767db3f37cc1722bd1ecf2c4ca837430af719c6ccacde4","blockNumber":1,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":1,"slotNumber":2,"timestamp":1750761566997,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
10:39:28 [10:39:28.450]
INFO:
archiver Stopped.
10:39:28 [10:39:28.452]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:28 [10:39:28.731]
INFO:
archiver:test Syncing L2 block on slot 3 mined in L1 block 6
10:39:29 [10:39:29.866]
INFO:
archiver:test Waiting for archiver to sync to block 1
10:39:29 [10:39:29.937]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x13f1ad08da83066aeedf785bb19717500da3bbbdf982e2ab7f4ecb1a9237ee94","blockNumber":1,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":1,"slotNumber":3,"timestamp":1750761568463,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
10:39:29 [10:39:29.969]
INFO:
archiver Stopped.
10:39:29 [10:39:29.973]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:30 [10:39:30.367]
INFO:
archiver:test Syncing archiver to L1 block 6
10:39:30 [10:39:30.370]
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":"0x72e0405f076234b6323b622419166071eca602dcc1e688473b8b0d54da150061","l1BlockNumber":0}}
10:39:30 [10:39:30.381]
INFO:
archiver Initial archiver sync to L1 block 6 complete.
{"l1BlockNumber":6,"syncPoint":{"blocksSynchedTo":6},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
10:39:30 [10:39:30.383]
INFO:
archiver Stopped.
10:39:30 [10:39:30.385]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:30 [10:39:30.707]
INFO:
archiver:test Syncing archiver to L1 block 7
10:39:30 [10:39:30.714]
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":"0x0b6d26eabb99cd8ef8396d7f57dad2e721f6aaadd2ba96a1abefd25d2068aae6","l1BlockNumber":0}}
10:39:30 [10:39:30.724]
INFO:
archiver Initial archiver sync to L1 block 7 complete.
{"l1BlockNumber":7,"syncPoint":{"blocksSynchedTo":7},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
10:39:30 [10:39:30.726]
INFO:
archiver Stopped.
10:39:30 [10:39:30.728]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:31 [10:39:31.046]
INFO:
archiver:test Syncing epoch 0 with L2 block on slot 1 mined in L1 block 2
10:39:32 [10:39:32.474]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x10dea845713560675e837e951a1759ca3af2151e11cd26b5f591e0d166c9e194","blockNumber":1,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":1,"slotNumber":1,"timestamp":1750761570739,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
10:39:32 [10:39:32.490]
INFO:
archiver Stopped.
10:39:32 [10:39:32.492]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:32 [10:39:32.851]
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":"0x4eb375b9bcc3a1c9eec777bf007fa7cc7f9cfc9760dc83f23e4f1f1530fef22c","l1BlockNumber":0}}
10:39:32 [10:39:32.869]
INFO:
archiver Stopped.
10:39:32 [10:39:32.872]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
10:39:37 [10:39:37.880]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x0df908d8e4e13e4d9fcdf8be77bc0af48fd1d8ced8efb6675e2f70f1edcf46e6","blockNumber":1,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":1,"slotNumber":1,"timestamp":1750761572883,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
10:39:37 [10:39:37.888]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x17c078e7c8ae53dee8f5da86409e5330f115959eff52759819a21ab3b8a21fb0","blockNumber":2,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":2,"slotNumber":2,"timestamp":1750761572895,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
10:39:39 [10:39:39.073]
WARN:
archiver Unwound 1 block from L2 block 2 due to mismatched block hashes at L1 block 95. Updated L2 latest block is 1.
10:39:40 [10:39:40.141]
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
10:39:40 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:78:15
10:39:40 at AztecLMDBStoreV2.transactionAsync (/home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:106:20)
10:39:40 at BlockStore.addBlocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:68:12)
10:39:40 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:1394:7
10:39:40 at /home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:111:29
10:39:40 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33
10:39:40 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {
10:39:40 newBlockNumber: 3,
10:39:40 previousBlockNumber: 1
10:39:40 }
10:39:40 [10:39:40.171]
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":"0x0df908d8e4e13e4d9fcdf8be77bc0af48fd1d8ced8efb6675e2f70f1edcf46e6","newBlockNumber":3,"updatedL1SyncPoint":70}
10:39:40 [10:39:40.172]
ERROR:
archiver Error in running promise: InitialBlockNumberNotSequentialError: Cannot insert new block 3 given previous block number in store is 1
10:39:40 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:78:15
10:39:40 at AztecLMDBStoreV2.transactionAsync (/home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:106:20)
10:39:40 at BlockStore.addBlocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:68:12)
10:39:40 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:1394:7
10:39:40 at /home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:111:29
10:39:40 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33
10:39:40 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {
10:39:40 newBlockNumber: 3,
10:39:40 previousBlockNumber: 1
10:39:40 }
10:39:41 [10:39:41.309]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x17c078e7c8ae53dee8f5da86409e5330f115959eff52759819a21ab3b8a21fb0","blockNumber":2,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":2,"slotNumber":2,"timestamp":1750761572895,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
10:39:41 [10:39:41.312]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x2b379302ddfee1d7a9d17ebc6e28aa48eb8159d578775029104aee4ccab7bca0","blockNumber":3,"txCount":4,"globalVariables":{"chainId":1,"version":1,"blockNumber":3,"slotNumber":3,"timestamp":1750761572907,"coinbase":"0x0000000000000000000000000000000000000705","feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","feePerDaGas":1799,"feePerL2Gas":1800},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000004","archiveNextLeafIndex":4}
10:39:41 [10:39:41.405]
INFO:
archiver Stopped.
10:39:41
PASS src/archiver/archiver.test.ts (
40.069 s)
10:39:41 Archiver
10:39:41
✓ syncs l1 to l2 messages and blocks (5541 ms)
10:39:41
✓ ignores block 3 because it has been pruned (4113 ms)
10:39:41
✓ skip event search if no changes found (5282 ms)
10:39:41
✓ handles L2 reorg (6829 ms)
10:39:41
✓ handles updated messages due to L1 reorg (1459 ms)
10:39:41
✓ reports an epoch as pending if the current L2 block is not in the last slot of the epoch (1467 ms)
10:39:41
✓ reports an epoch as complete if the current L2 block is in the last slot of the epoch (1519 ms)
10:39:41
✓ reports an epoch as pending if the current L1 block is not the last one on the epoch and no L2 block landed (413 ms)
10:39:41
✓ reports an epoch as complete if the current L1 block is the last one on the epoch and no L2 block landed (343 ms)
10:39:41
✓ reports an epoch as complete due to timestamp only once all its blocks have been synced (1763 ms)
10:39:41
✓ starts new loop if latest L1 block has advanced beyond what a non-archive L1 node tracks (379 ms)
10:39:41
✓ handles a block gap due to a spurious L2 prune (8539 ms)
10:39:41
○ skipped handles an upcoming L2 prune
10:39:41
10:39:41
Test Suites: 1 passed, 1 total
10:39:41
Tests: 1 skipped,
12 passed, 13 total
10:39:41
Snapshots: 0 total
10:39:41
Time: 40.135 s
10:39:41
Ran all test suites matching /archiver\/src\/archiver\/archiver.test.ts/i
.
10:39:41
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?