Parent Log:
http://ci.aztec-labs.com/54c502658eb930c3
Command: 19ef62d9450eeb9e yarn-project/scripts/run_test.sh archiver/src/archiver/archiver.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/eb7990c89ac679ce7fdfc2e985670cbf85c04be2
Env: REF_NAME=gh-readonly-queue/next/pr-14918-b70544b6d50e3ecb6598361f1990bd51745c7b55 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Tue Jun 17 09:01:46 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14918_amd64_x4-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_fba8e3924e2a5da2_next
09:01:50 [09:01:50.816]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:01:53 [09:01:53.843]
INFO:
archiver:test Waiting for archiver to sync to block 3
09:01:53 [09:01:53.865]
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":"0x2d0b841121b8cd3c026edfba5033b647dedc3f69e381f0c327cde3f25ec4f3bd","rollingHash":"0x43bec5ac432b57ca48077b8e72e0a53c"},"messageCount":2}
09:01:53 [09:01:53.959]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x1cb15c315da73223fba2750d6a3189e04e61ee1358e07fe9d337d8007183d4e2","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750150910810,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
09:01:55 [09:01:55.014]
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":"0x0657dbed006b35029c6096f9b31c1cad7066efa45568e98d750ebf3066cab345","rollingHash":"0x82dd9057af6481f36044c73ba066f14b"},"messageCount":4}
09:01:55 [09:01:55.113]
INFO:
archiver Updated proven chain to block 1
{"provenBlockNumber":1}
09:01:55 [09:01:55.309]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2ad361f6e5674af315bbf3126f21f03360363908a65ff991fa00a405b27f379c","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750150910822,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
09:01:55 [09:01:55.311]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x03cd1a2e0874f661ad60717a8819e94bb9a6c33ebff0b7cd7ecd92564f84d951","blockNumber":3,"txCount":4,"globalVariables":{"blockNumber":3,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1750150910834,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000004","archiveNextLeafIndex":4}
09:01:55 [09:01:55.431]
INFO:
archiver Stopped.
09:01:55 [09:01:55.437]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:01:58 [09:01:58.350]
INFO:
archiver:test Waiting for archiver to sync to block 2
09:01:58 [09:01:58.360]
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":"0x28df90387807f90d6ac589842fdfbaeb383b20e8337ee8bc78e3298fdc0927dd","rollingHash":"0x9055756644a419e04e22ffcfe1a4ad24"},"messageCount":2}
09:01:58 [09:01:58.388]
WARN:
archiver Ignoring L2 block 3 due to archive root mismatch
{"actual":"0x19f6d440c94687bb031c791018e98313d122686aae6abb4b388cc368046cdfcf","expected":"0x0000000000000000000000000000000000000000000000000000000000000004"}
09:01:58 [09:01:58.509]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x1c374e250fa60fd414d7c4f959f804190326c7700956a53b4b015999c0911fad","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750150915446,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
09:01:58 [09:01:58.511]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x299b7383cf91b460cfe05f3aba4bbf4238f55c39777844ef1841cba4e0a3b2cf","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750150915458,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
09:01:58 [09:01:58.594]
INFO:
archiver Stopped.
09:01:58 [09:01:58.597]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:02:01 [09:02:01.593]
INFO:
archiver:test Waiting for archiver to sync to block 2
09:02:02 [09:02:02.620]
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":"0x2345da8d885cebbe001aedd5a5f775833b17d318b87430aa78a7a68afc1b7763","rollingHash":"0xc3fcada65f12ea248af08b7602c0c508"},"messageCount":2}
09:02:02 [09:02:02.756]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x2fc24f9d9b42f3259e66dbed5bbb927bf287291cc16cb1f10f48d1560602e0db","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750150918608,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
09:02:02 [09:02:02.757]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x2e655128bc78aeacbc21bf0d46951c8ac61d0dc2eb95f248f2864765c7d455c8","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750150918620,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
09:02:02 [09:02:02.844]
INFO:
archiver Stopped.
09:02:02 [09:02:02.847]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:02:05 [09:02:05.500]
INFO:
archiver:test Waiting for archiver to sync to block 2
09:02:05 [09:02:05.546]
ERROR:
archiver Error in running promise: BlockTagTooOldError: Block tag 50 is more than 128 blocks behind the latest block 200
09:02:05 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15)
09:02:05 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:331:9)
09:02:05 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20)
09:02:05 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28)
09:02:05 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34)
09:02:05 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33
09:02:05 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21)
09:02:06 [09:02:06.559]
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":"0x1beae7697472caa90e24ed1d9155b1fd1c6d43272bc36c9f13cec8a5718b8c88","rollingHash":"0xf90457204d9e142de813c593cd2c80a4"},"messageCount":2}
09:02:06 [09:02:06.714]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x0952ca8b61405ab3dab3fcffbcd30a41cf693198d0e1cf92e5a1ba62812e9715","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750150922858,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
09:02:06 [09:02:06.715]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x301ed8a67b18460b8117fde773c11127dd9f3b5ec79eb0a56274bce91d8b587f","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750150922870,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
09:02:06 [09:02:06.719]
ERROR:
archiver Error in running promise: BlockTagTooOldError: Block tag 250 is more than 128 blocks behind the latest block 400
09:02:06 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15)
09:02:06 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:331:9)
09:02:06 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20)
09:02:06 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28)
09:02:06 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34)
09:02:06 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33
09:02:06 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21)
09:02:07 [09:02:07.857]
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:02:07 [09:02:07.861]
ERROR:
archiver Error in running promise: BlockTagTooOldError: Block tag 450 is more than 128 blocks behind the latest block 600
09:02:07 at checkBlockTag (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/utils.js:9:15)
09:02:07 at RollupContract.canPruneAtTime (/home/aztec-dev/aztec-packages/yarn-project/ethereum/dest/contracts/rollup.js:331:9)
09:02:07 at Archiver.canPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:366:20)
09:02:07 at Archiver.handleEpochPrune (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:379:28)
09:02:07 at Archiver.sync (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:332:34)
09:02:07 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:33
09:02:07 at poll (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/promise/running-promise.js:48:21)
09:02:08 [09:02:08.804]
INFO:
archiver Stopped.
09:02:08 [09:02:08.807]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:02:09 [09:02:09.191]
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":"0x0527834efc783563446b8c17e498022a3ea756a5d19a173597b167d52ddd2fd0","rollingHash":"0x113d443e0782e9cb3c3622ef414dc6af"},"messageCount":6}
09:02:09 [09:02:09.192]
WARN:
archiver Last message retrieved rolling hash does not match remote state.
{"lastMessage":{"index":35,"l1BlockHash":"0x0000000000000000000000000000000000000000000000000000000000000065","l1BlockNumber":101,"l2BlockNumber":3,"leaf":"0x0527834efc783563446b8c17e498022a3ea756a5d19a173597b167d52ddd2fd0","rollingHash":"0x113d443e0782e9cb3c3622ef414dc6af"},"remoteMessagesState":{"messagesRollingHash":"0x1f90f97a1142e44755bf6a300fc7d85d","totalMessagesInserted":5,"treeInProgress":0}}
09:02:09 [09:02:09.285]
WARN:
archiver:test Reorging L1 to L2 messages
09:02:10 [09:02:10.213]
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":"0x0527834efc783563446b8c17e498022a3ea756a5d19a173597b167d52ddd2fd0","rollingHash":"0x113d443e0782e9cb3c3622ef414dc6af"}}
09:02:10 [09:02:10.223]
WARN:
archiver Deleting all local L1 to L2 messages after index 33
09:02:10 [09:02:10.239]
WARN:
archiver:message_store Deleted 2 L1 to L2 messages from index 34 from the store
09:02:10 [09:02:10.259]
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":"0x0d652527262d0de6ec84167ff9c69c10bf40d36573aff42c7e8f1b23da28df1b","rollingHash":"0x910014bedc3deac59346859462e5f4f7"},"messageCount":5}
09:02:10 [09:02:10.376]
INFO:
archiver Stopped.
09:02:10 [09:02:10.383]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:02:10 [09:02:10.941]
INFO:
archiver:test Syncing L2 block on slot 2 mined in L1 block 4
09:02:12 [09:02:12.010]
INFO:
archiver:test Waiting for archiver to sync to block 1
09:02:12 [09:02:12.113]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x25765e9d4d27f05c51e2a71f3f9e9bab06b47f034253dee2e7dc4dae68fb8bd1","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750150930389,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
09:02:12 [09:02:12.216]
INFO:
archiver Stopped.
09:02:12 [09:02:12.218]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:02:13 [09:02:13.073]
INFO:
archiver:test Syncing L2 block on slot 3 mined in L1 block 6
09:02:14 [09:02:14.091]
INFO:
archiver:test Waiting for archiver to sync to block 1
09:02:14 [09:02:14.189]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x249a0b40f533d366db883f41574cf14c5d0c6f3ebc92eab8cf4cd81bb05cb773","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1750150932229,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
09:02:14 [09:02:14.197]
INFO:
archiver Stopped.
09:02:14 [09:02:14.199]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:02:14 [09:02:14.561]
INFO:
archiver:test Syncing archiver to L1 block 6
09:02:14 [09:02:14.573]
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":"0xe3cae50a0ede88f7723578c8a22d1f535ff058f9e82709787de61c130994aa95","l1BlockNumber":0}}
09:02:14 [09:02:14.599]
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:02:14 [09:02:14.602]
INFO:
archiver Stopped.
09:02:14 [09:02:14.606]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:02:14 [09:02:14.964]
INFO:
archiver:test Syncing archiver to L1 block 7
09:02:14 [09:02:14.965]
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":"0x9eee3466b399d1a7d8e40759c791efe341143dece72193f056a055f25cd431eb","l1BlockNumber":0}}
09:02:14 [09:02:14.978]
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:02:14 [09:02:14.980]
INFO:
archiver Stopped.
09:02:14 [09:02:14.982]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:02:15 [09:02:15.415]
INFO:
archiver:test Syncing epoch 0 with L2 block on slot 1 mined in L1 block 2
09:02:16 [09:02:16.868]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x0d1d49122575b0eb051e232ab66ba9dcd4153587d967fb8a145663a6da285280","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750150934994,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
09:02:16 [09:02:16.879]
INFO:
archiver Stopped.
09:02:16 [09:02:16.883]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:02:17 [09:02:17.209]
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":"0xe9c39e0cc0b69129364a1b3d2e9adb50ced4a6a4d59deb2917cab274afeb1003","l1BlockNumber":0}}
09:02:17 [09:02:17.230]
INFO:
archiver Stopped.
09:02:17 [09:02:17.232]
INFO:
kv-store:lmdb-v2:archiver_test Starting data store with maxReaders 16
09:02:20 [09:02:20.802]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x1133f3476fbb1579d001177e4e56bfcb09c1cac644db6d03addc405d454095ff","blockNumber":1,"txCount":4,"globalVariables":{"blockNumber":1,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":1,"timestamp":1750150937244,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000002","archiveNextLeafIndex":2}
09:02:20 [09:02:20.804]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x211bb9404e5ce3d5b9235317e828d3a1fba56ac556f6fbba368572e2e2973d59","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750150937256,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
09:02:21 [09:02:21.933]
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:02:22 [09:02:22.993]
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:02:22 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:79:15
09:02:22 at AztecLMDBStoreV2.transactionAsync (/home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:106:20)
09:02:22 at BlockStore.addBlocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:69:12)
09:02:22 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:1416:7
09:02:22 at /home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:111:29
09:02:22 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33
09:02:22 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {
09:02:22 newBlockNumber: 3,
09:02:22 previousBlockNumber: 1
09:02:22 }
09:02:23 [09:02:23.020]
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":"0x1133f3476fbb1579d001177e4e56bfcb09c1cac644db6d03addc405d454095ff","newBlockNumber":3,"updatedL1SyncPoint":70}
09:02:23 [09:02:23.021]
ERROR:
archiver Error in running promise: InitialBlockNumberNotSequentialError: Cannot insert new block 3 given previous block number in store is 1
09:02:23 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:79:15
09:02:23 at AztecLMDBStoreV2.transactionAsync (/home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:106:20)
09:02:23 at BlockStore.addBlocks (/home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/kv_archiver_store/block_store.ts:69:12)
09:02:23 at /home/aztec-dev/aztec-packages/yarn-project/archiver/src/archiver/archiver.ts:1416:7
09:02:23 at /home/aztec-dev/aztec-packages/yarn-project/kv-store/dest/lmdb-v2/store.js:111:29
09:02:23 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:58:33
09:02:23 at FifoMemoryQueue.process (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {
09:02:23 newBlockNumber: 3,
09:02:23 previousBlockNumber: 1
09:02:23 }
09:02:24 [09:02:24.195]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x211bb9404e5ce3d5b9235317e828d3a1fba56ac556f6fbba368572e2e2973d59","blockNumber":2,"txCount":4,"globalVariables":{"blockNumber":2,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":2,"timestamp":1750150937256,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000003","archiveNextLeafIndex":3}
09:02:24 [09:02:24.196]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x1623936c2050b57e00f1d098e41d3182288ff18702a2dd31815869002030b5dc","blockNumber":3,"txCount":4,"globalVariables":{"blockNumber":3,"chainId":1,"coinbase":"0x0000000000000000000000000000000000000705","feePerDaGas":1799,"feePerL2Gas":1800,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000706","slotNumber":3,"timestamp":1750150937268,"version":1},"archiveRoot":"0x0000000000000000000000000000000000000000000000000000000000000004","archiveNextLeafIndex":4}
09:02:24 [09:02:24.283]
INFO:
archiver Stopped.
09:02:24
PASS src/archiver/archiver.test.ts (
36.642 s)
09:02:24 Archiver
09:02:24
✓ syncs l1 to l2 messages and blocks (4636 ms)
09:02:24
✓ ignores block 3 because it has been pruned (3161 ms)
09:02:24
✓ skip event search if no changes found (4250 ms)
09:02:24
✓ handles L2 reorg (5960 ms)
09:02:24
✓ handles updated messages due to L1 reorg (1571 ms)
09:02:24
✓ reports an epoch as pending if the current L2 block is not in the last slot of the epoch (1839 ms)
09:02:24
✓ reports an epoch as complete if the current L2 block is in the last slot of the epoch (1980 ms)
09:02:24
✓ reports an epoch as pending if the current L1 block is not the last one on the epoch and no L2 block landed (404 ms)
09:02:24
✓ reports an epoch as complete if the current L1 block is the last one on the epoch and no L2 block landed (378 ms)
09:02:24
✓ reports an epoch as complete due to timestamp only once all its blocks have been synced (1899 ms)
09:02:24
✓ starts new loop if latest L1 block has advanced beyond what a non-archive L1 node tracks (350 ms)
09:02:24
✓ handles a block gap due to a spurious L2 prune (7053 ms)
09:02:24
○ skipped handles an upcoming L2 prune
09:02:24
09:02:24
Test Suites: 1 passed, 1 total
09:02:24
Tests: 1 skipped,
12 passed, 13 total
09:02:24
Snapshots: 0 total
09:02:24
Time: 36.753 s
09:02:24
Ran all test suites matching archiver/src/archiver/archiver.test.ts
.
09:02:24
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?