Parent Log:
http://ci.aztec-labs.com/99010f58f098e93c
Command: d4f09ddb861c41ed:ISOLATE=1:NAME=e2e_snapshot_sync yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_snapshot_sync.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/d64582316e960acb89baf16d63e5ac1e59a00898
Env: REF_NAME=gh-readonly-queue/staging/pr-15274-9ba478709ce5c48099f79f9531da8292811cb18a CURRENT_VERSION=1.0.0 CI_FULL=1
Date: Wed Jun 25 10:34:05 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15274_amd64_x4-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_eb8f79a88ef38365_staging
10:34:05 +++ id -u
10:34:05 +++ id -g
10:34:05 ++ docker run -d --name e2e_snapshot_sync --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_snapshot_sync.test.ts'\'''
10:34:06 + cid=d723f5bf6c6b1b3d4ebaff20fd668bd3eba9b3379f9d320fcdfeb79ce4167661
10:34:06 + set +x
10:34:07 {"level":25,"time":1750847647002,"pid":12,"hostname":"d723f5bf6c6b","module":"logger","msg":"Logger initialized with level verbose"}
10:34:13 [10:34:13.752]
INFO:
e2e:e2e_snapshot_sync Logging metrics to log/unknown.jsonl
10:34:13 [10:34:13.943]
INFO:
e2e:e2e_snapshot_sync Sent 0.1 ETH to deployer
{"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000}
10:34:21 [10:34:21.964]
INFO:
e2e:e2e_snapshot_sync Sent 0.1 ETH to deployer
{"deployer":"0x05f32b3cc3888453ff71b01135b34ff8e41263f2","value":100000000000000000}
10:34:29 [10:34:29.981]
INFO:
e2e:e2e_snapshot_sync Deployed Multicall3
10:34:29 [10:34:29.983]
INFO:
e2e:e2e_snapshot_sync Calling anvil_setBlockTimestampInterval with params: [8]
10:34:29 [10:34:29.985]
WARN:
e2e:e2e_snapshot_sync Set block interval to 8
10:34:29 [10:34:29.985]
VERBOSE:
e2e:e2e_snapshot_sync Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266
10:34:30 [10:34:30.018]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x8166bb789c828e492198babef9becf8ac44628f059d48e6f68114a9ae2ade6ec
{"gasLimit":867658,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"}
10:34:30 [10:34:30.019]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xB8999345dA8041f1Da51ac5179B1F055A560f397 in tx 0x8166bb789c828e492198babef9becf8ac44628f059d48e6f68114a9ae2ade6ec.
10:34:30 [10:34:30.022]
VERBOSE:
e2e:e2e_snapshot_sync Deployed Fee Asset at 0xb8999345da8041f1da51ac5179b1f055a560f397
10:34:30 [10:34:30.048]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x54e85b9df7ffc820e6a6ff58a31f23431086d2eb1e70bebbe93b11fae03b5b88
{"gasLimit":867644,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"}
10:34:30 [10:34:30.048]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xBb9e13665Cfb3d531F288a11E7312b6b91C59292 in tx 0x54e85b9df7ffc820e6a6ff58a31f23431086d2eb1e70bebbe93b11fae03b5b88.
10:34:30 [10:34:30.049]
VERBOSE:
e2e:e2e_snapshot_sync Deployed Staking Asset at 0xbb9e13665cfb3d531f288a11e7312b6b91c59292
10:34:30 [10:34:30.075]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0xe00b8a0d873aba93ed25ed166a9f08732af23cc55fe51a2d7b7f005821e1f4a1
{"gasLimit":3252094,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"}
10:34:30 [10:34:30.075]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x6f26a1916Df432654607f9c75b764e535e65cf3e in tx 0xe00b8a0d873aba93ed25ed166a9f08732af23cc55fe51a2d7b7f005821e1f4a1.
10:34:30 [10:34:30.076]
VERBOSE:
e2e:e2e_snapshot_sync Deployed GSE at 0x6f26a1916df432654607f9c75b764e535e65cf3e
10:34:30 [10:34:30.096]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0xa6857db8faf3a25b2828067b414c8168becfd095aaa2f887fda070b5fbf20c9f
{"gasLimit":1081864,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"}
10:34:30 [10:34:30.097]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x3C709AFec1acEaE522c13145005De788a3CC65c8 in tx 0xa6857db8faf3a25b2828067b414c8168becfd095aaa2f887fda070b5fbf20c9f.
10:34:30 [10:34:30.097]
VERBOSE:
e2e:e2e_snapshot_sync Deployed Registry at 0x3c709afec1aceae522c13145005de788a3cc65c8
10:34:30 [10:34:30.117]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x9d0b1f1a289d86d868863c2fd712978073b42c6b0ecbc0324bcc7cc91428551b
{"gasLimit":2232036,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"}
10:34:30 [10:34:30.118]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xEDE9b34af448F9261efea2DafB2364866b09E01A in tx 0x9d0b1f1a289d86d868863c2fd712978073b42c6b0ecbc0324bcc7cc91428551b.
10:34:30 [10:34:30.119]
VERBOSE:
e2e:e2e_snapshot_sync Deployed GovernanceProposer at 0xede9b34af448f9261efea2dafb2364866b09e01a
10:34:30 [10:34:30.140]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x5973d96c48886344c4e1a66f79fc8ae17359e23b78558801c01bddd7d86e2879
{"gasLimit":3092007,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"}
10:34:30 [10:34:30.141]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xa49A3d51a71916F87d60f0e919Fb66E4b933b4df in tx 0x5973d96c48886344c4e1a66f79fc8ae17359e23b78558801c01bddd7d86e2879.
10:34:30 [10:34:30.141]
VERBOSE:
e2e:e2e_snapshot_sync Deployed Governance at 0xa49a3d51a71916f87d60f0e919fb66e4b933b4df
10:34:30 [10:34:30.151]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0xd5764b0fb18b2ec8b225faae55261f2301788697df3109326d3237b9bbf8b83f
{"gasLimit":100000,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"}
10:34:30 [10:34:30.152]
VERBOSE:
e2e:e2e_snapshot_sync Set governance on GSE in 0xd5764b0fb18b2ec8b225faae55261f2301788697df3109326d3237b9bbf8b83f
10:34:30 [10:34:30.169]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x6b6383628448b5965932ed93a8fe94e838d8dba142d7a525bd0e7eead4b2e99e
{"gasLimit":397405,"maxFeePerGas":"120.351651125","maxPriorityFeePerGas":"118.94979"}
10:34:30 [10:34:30.169]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x705baA0D3bF675F9B7F169fd5FEA260c436Cd50c in tx 0x6b6383628448b5965932ed93a8fe94e838d8dba142d7a525bd0e7eead4b2e99e.
10:34:30 [10:34:30.170]
VERBOSE:
e2e:e2e_snapshot_sync Deployed CoinIssuer at 0x705baa0d3bf675f9b7f169fd5fea260c436cd50c
10:34:30 [10:34:30.170]
VERBOSE:
e2e:e2e_snapshot_sync Waiting for deployments to complete
10:34:30 [10:34:30.171]
INFO:
e2e:e2e_snapshot_sync Waiting for 7 transactions to be mined...
10:34:38 [10:34:38.192]
INFO:
e2e:e2e_snapshot_sync All transactions mined successfully
10:34:38 [10:34:38.204]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x5a9014997534cacc0ed8242279d80578ed45dcb586ca5feebd488ba3dc9638fa
{"gasLimit":100000,"maxFeePerGas":"143.976575211","maxPriorityFeePerGas":"142.739748"}
10:34:38 [10:34:38.204]
VERBOSE:
e2e:e2e_snapshot_sync Added coin issuer 0x705baa0d3bf675f9b7f169fd5fea260c436cd50c as minter on fee asset in 0x5a9014997534cacc0ed8242279d80578ed45dcb586ca5feebd488ba3dc9638fa
10:34:38 [10:34:38.219]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0xd49a5a68c155504b2752fe3bb569a02fc04bbc98956ceda33957c4f32b64b09b
{"gasLimit":56661,"maxFeePerGas":"143.976575211","maxPriorityFeePerGas":"142.739748"}
10:34:38 [10:34:38.237]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0xe400073ef2a3a5b99acb04ab044dccf51f90bacc46005437a46f68930a3713bf
{"gasLimit":344517,"maxFeePerGas":"143.976575211","maxPriorityFeePerGas":"142.739748"}
10:34:38 [10:34:38.237]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xB4fF23c4B1E2Bc7C86090d4FBDa21A457ee6727F in tx 0xe400073ef2a3a5b99acb04ab044dccf51f90bacc46005437a46f68930a3713bf.
10:34:38 [10:34:38.239]
VERBOSE:
e2e:e2e_snapshot_sync Deployed FeeAssetHandler at 0xb4ff23c4b1e2bc7c86090d4fbda21a457ee6727f
10:34:38 [10:34:38.266]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x2695c5133899373ccffb399194fd68b9e025a2dc30faffc9a979023b1032e319
{"gasLimit":56804,"maxFeePerGas":"143.976575211","maxPriorityFeePerGas":"142.739748"}
10:34:38 [10:34:38.267]
VERBOSE:
e2e:e2e_snapshot_sync Added fee asset handler 0xb4ff23c4b1e2bc7c86090d4fbda21a457ee6727f as minter on fee asset in 0x2695c5133899373ccffb399194fd68b9e025a2dc30faffc9a979023b1032e319
10:34:38 [10:34:38.304]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x36d181350256859290f82ca08c80faa6d8c6ebfd7fa6cbb4ca50af9d82d12caa
{"gasLimit":2514655,"maxFeePerGas":"143.976575211","maxPriorityFeePerGas":"142.739748"}
10:34:38 [10:34:38.305]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xF4de5cF63467155F12E722456ff7952Eb95c40b6 in tx 0x36d181350256859290f82ca08c80faa6d8c6ebfd7fa6cbb4ca50af9d82d12caa.
10:34:38 [10:34:38.306]
VERBOSE:
e2e:e2e_snapshot_sync Deployed StakingAssetHandler at 0xf4de5cf63467155f12e722456ff7952eb95c40b6
10:34:38 [10:34:38.325]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x892c42aa8c9a12a4eeb6632abb6274b6d316a5c227868fbc6ee0554619e11b8d
{"gasLimit":56804,"maxFeePerGas":"143.976575211","maxPriorityFeePerGas":"142.739748"}
10:34:38 [10:34:38.326]
VERBOSE:
e2e:e2e_snapshot_sync Added staking asset handler 0xf4de5cf63467155f12e722456ff7952eb95c40b6 as minter on staking asset in 0x892c42aa8c9a12a4eeb6632abb6274b6d316a5c227868fbc6ee0554619e11b8d
10:34:38 [10:34:38.326]
VERBOSE:
e2e:e2e_snapshot_sync Waiting for deployments to complete
10:34:38 [10:34:38.326]
INFO:
e2e:e2e_snapshot_sync Waiting for 9 transactions to be mined...
10:34:46 [10:34:46.352]
INFO:
e2e:e2e_snapshot_sync All transactions mined successfully
10:34:46 [10:34:46.409]
VERBOSE:
e2e:e2e_snapshot_sync Deployed shared contracts
10:34:46 [10:34:46.565]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x0aa0bc338bd0595b17184a7eddcb637ad794865490d99c784057deb94a39806c
{"gasLimit":84837,"maxFeePerGas":"172.470269872","maxPriorityFeePerGas":"171.2876976"}
10:34:46 [10:34:46.565]
VERBOSE:
e2e:e2e_snapshot_sync Funded reward distributor with 10000000000000000000000000 fee asset in 0x0aa0bc338bd0595b17184a7eddcb637ad794865490d99c784057deb94a39806c
10:34:46 [10:34:46.634]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0xe6b6ed6084dfc0ce6a590ebc48c4f5427acf8e4c7dbd88ff57a159be30fd8886
{"gasLimit":154658,"maxFeePerGas":"172.470269872","maxPriorityFeePerGas":"171.2876976"}
10:34:46 [10:34:46.635]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x277E22B0C9698d7f2A1cD7C6d857511617587309 in tx 0xe6b6ed6084dfc0ce6a590ebc48c4f5427acf8e4c7dbd88ff57a159be30fd8886.
10:34:46 [10:34:46.635]
VERBOSE:
e2e:e2e_snapshot_sync Rollup will use the mock verifier at 0x277e22b0c9698d7f2a1cd7c6d857511617587309
10:34:46 [10:34:46.636]
VERBOSE:
e2e:e2e_snapshot_sync Rollup config args
{"aztecSlotDuration":16,"aztecEpochDuration":64,"targetCommitteeSize":0,"aztecProofSubmissionEpochs":1,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"entryQueueFlushSizeMin":48,"entryQueueFlushSizeQuotient":2,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}}
10:34:46 [10:34:46.666]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0xc42fcbd057c40384e48b069456d1d65727fa35c5b60013709059bc68fd4c01c1
{"gasLimit":87007,"maxFeePerGas":"172.470269872","maxPriorityFeePerGas":"171.2876976"}
10:34:46 [10:34:46.667]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x755f7b0Abc16C7d115c66eCE21A4C10c13e13a5E in tx 0xc42fcbd057c40384e48b069456d1d65727fa35c5b60013709059bc68fd4c01c1.
10:34:46 [10:34:46.714]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x6dbe784103aee5f50d91a972cdf8fde168a06bc01794d5e605e9a34618044089
{"gasLimit":5120611,"maxFeePerGas":"172.470269872","maxPriorityFeePerGas":"171.2876976"}
10:34:46 [10:34:46.714]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x0B53Fb3A333b73bF09FeaA0a7Bf288F52466E450 in tx 0x6dbe784103aee5f50d91a972cdf8fde168a06bc01794d5e605e9a34618044089.
10:34:46 [10:34:46.744]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0xe54ff19803fe315b0fe022cdcdfee065dcbda7e81541c942ea34f45b19f4f728
{"gasLimit":2891348,"maxFeePerGas":"172.470269872","maxPriorityFeePerGas":"171.2876976"}
10:34:46 [10:34:46.745]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x8B9450ADB32f406dFF80fFFA24A9a85A72E733c2 in tx 0xe54ff19803fe315b0fe022cdcdfee065dcbda7e81541c942ea34f45b19f4f728.
10:34:46 [10:34:46.749]
VERBOSE:
e2e:e2e_snapshot_sync Awaiting for linked libraries to be deployed
10:34:54 [10:34:54.826]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x1d6a9a6abc78a3638198a844d69551d63ce71246113ecb1d3b7f660e51d600a3
{"gasLimit":11249762,"maxFeePerGas":"206.605011245","maxPriorityFeePerGas":"205.54523712"}
10:34:54 [10:34:54.827]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xe739E0CaD9c3877ed3018cd417b6755BdDE051a4 in tx 0x1d6a9a6abc78a3638198a844d69551d63ce71246113ecb1d3b7f660e51d600a3.
10:34:54 [10:34:54.827]
VERBOSE:
e2e:e2e_snapshot_sync Deployed Rollup at 0xe739e0cad9c3877ed3018cd417b6755bdde051a4
{"aztecSlotDuration":16,"aztecEpochDuration":64,"targetCommitteeSize":0,"aztecProofSubmissionEpochs":1,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"entryQueueFlushSizeMin":48,"entryQueueFlushSizeQuotient":2,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}}
10:34:54 [10:34:54.828]
INFO:
e2e:e2e_snapshot_sync Waiting for 11 transactions to be mined...
10:35:02 [10:35:02.842]
INFO:
e2e:e2e_snapshot_sync All transactions mined successfully
10:35:02 [10:35:02.843]
VERBOSE:
e2e:e2e_snapshot_sync All core contracts have been deployed
10:35:02 [10:35:02.865]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x97a0778f695702d8ebe009f701f6c98cf938649dec4fc96b7fc076231ec7a30c
{"gasLimit":1056482,"maxFeePerGas":"247.64210497","maxPriorityFeePerGas":"246.654284544"}
10:35:02 [10:35:02.865]
VERBOSE:
e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x83358324b50fC8467BB75C63619393FC65d1D2Bb in tx 0x97a0778f695702d8ebe009f701f6c98cf938649dec4fc96b7fc076231ec7a30c.
10:35:02 [10:35:02.865]
VERBOSE:
e2e:e2e_snapshot_sync Deployed SlashFactory at 0x83358324b50fc8467bb75c63619393fc65d1d2bb
10:35:02 [10:35:02.898]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0x5951b748666e346ef606e0650ef9dbccc07754aa11f4f1728dd712a980ccac70
{"gasLimit":117006,"maxFeePerGas":"247.64210497","maxPriorityFeePerGas":"246.654284544"}
10:35:02 [10:35:02.899]
VERBOSE:
e2e:e2e_snapshot_sync Adding rollup 0xe739e0cad9c3877ed3018cd417b6755bdde051a4 to registry 0x3c709afec1aceae522c13145005de788a3cc65c8 in tx 0x5951b748666e346ef606e0650ef9dbccc07754aa11f4f1728dd712a980ccac70
10:35:02 [10:35:02.913]
VERBOSE:
e2e:e2e_snapshot_sync Sent L1 transaction 0xcab0ef2d627c09f8436992d7c768e9cddf9112bbe0a5c4d3c586b9e90e3be176
{"gasLimit":109478,"maxFeePerGas":"247.64210497","maxPriorityFeePerGas":"246.654284544"}
10:35:02 [10:35:02.914]
VERBOSE:
e2e:e2e_snapshot_sync Adding rollup 0xe739e0cad9c3877ed3018cd417b6755bdde051a4 to GSE 0x6f26a1916df432654607f9c75b764e535e65cf3e in tx 0xcab0ef2d627c09f8436992d7c768e9cddf9112bbe0a5c4d3c586b9e90e3be176
10:35:10 [10:35:10.921]
INFO:
e2e:e2e_snapshot_sync Waiting for 12 transactions to be mined...
10:35:10 [10:35:10.952]
INFO:
e2e:e2e_snapshot_sync All transactions mined successfully
10:35:10 [10:35:10.958]
VERBOSE:
e2e:e2e_snapshot_sync Rollup deployed
10:35:10 [10:35:10.958]
VERBOSE:
e2e:e2e_snapshot_sync Waiting for rollup and slash factory to be deployed
10:35:10 [10:35:10.958]
INFO:
e2e:e2e_snapshot_sync Waiting for 12 transactions to be mined...
10:35:10 [10:35:10.996]
INFO:
e2e:e2e_snapshot_sync All transactions mined successfully
10:35:10 [10:35:10.996]
VERBOSE:
e2e:e2e_snapshot_sync All transactions for L1 deployment have been mined
10:35:11 [10:35:11.017]
INFO:
e2e:e2e_snapshot_sync Aztec L1 contracts initialized
{"registryAddress":"0x3c709afec1aceae522c13145005de788a3cc65c8","governanceAddress":"0xa49a3d51a71916f87d60f0e919fb66e4b933b4df","governanceProposerAddress":"0xede9b34af448f9261efea2dafb2364866b09e01a","rollupAddress":"0xe739e0cad9c3877ed3018cd417b6755bdde051a4","inboxAddress":"0x032a5d46f5ad3c6c14dad3bffb96f891023a8fc3","outboxAddress":"0x1c03db5a728811de2c21ddcfe06a527acdbfba1c","feeJuicePortalAddress":"0x9d40980775d989dd8bcbea734a726d76d6bc752f","feeJuiceAddress":"0xb8999345da8041f1da51ac5179b1f055a560f397","stakingAssetAddress":"0xbb9e13665cfb3d531f288a11e7312b6b91c59292","rewardDistributorAddress":"0x4a51916a6b10a43f6565042be5b6b69d8d613f64","gseAddress":"0x6f26a1916df432654607f9c75b764e535e65cf3e","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"}
10:35:11 [10:35:11.018]
INFO:
e2e:e2e_snapshot_sync Handing over to governance
10:35:11 [10:35:11.021]
INFO:
e2e:e2e_snapshot_sync Calling evm_setNextBlockTimestamp with params: [1750847717]
10:35:11 [10:35:11.023]
INFO:
e2e:e2e_snapshot_sync Calling hardhat_mine with params: [1]
10:35:11 [10:35:11.027]
INFO:
e2e:e2e_snapshot_sync Jumped to slot 1
10:35:11 [10:35:11.031]
WARN:
foundation:test-date-provider Time set to 2025-06-25T10:35:17.000Z
{"offset":5969,"timeMs":1750847717000}
10:35:11 [10:35:11.036]
INFO:
aztecjs:utils:watcher Watcher not started because not auto mining
10:35:11 [10:35:11.037]
INFO:
telemetry:client Using NoopTelemetryClient
10:35:11 [10:35:11.210]
INFO:
kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/a15989f71faf9412/blob-sink with map size 134217728 KB (LMDB v2)
10:35:11 [10:35:11.214]
INFO:
kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16
10:35:11 [10:35:11.223]
INFO:
blob-sink:server Server is running on
http://localhost:38287
10:35:11 [10:35:11.224]
VERBOSE:
e2e:e2e_snapshot_sync Creating and synching an aztec node...
10:35:11 [10:35:11.225]
VERBOSE:
e2e:e2e_snapshot_sync Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/967620ee/acvm
10:35:11 [10:35:11.226]
INFO:
node:blob-sink:client Creating HTTP blob sink client.
{"blobSinkUrl":"http://localhost:38287"}
10:35:11 [10:35:11.248]
VERBOSE:
node:MAIN-aztec-node Snapshot sync is disabled. No snapshots URL provided.
10:35:11 [10:35:11.249]
INFO:
archiver:lmdb Creating archiver data store at directory /tmp/a15989f71faf9412/archiver with map size 134217728 KB (LMDB v2)
10:35:11 [10:35:11.250]
INFO:
archiver:lmdb Starting data store with maxReaders 16
10:35:12 [10:35:12.035]
INFO:
node:blob-sink:client Testing configured blob sources
{"blobSinkUrl":"http://localhost:38287"}
10:35:12 [10:35:12.051]
INFO:
node:blob-sink:client Blob sink is reachable
{"blobSinkUrl":"http://localhost:38287"}
10:35:12 [10:35:12.052]
WARN:
node:blob-sink:client No L1 consensus host urls configured
10:35:12 [10:35:12.052]
WARN:
node:blob-sink:client No archive client configured
10:35:12 [10:35:12.055]
INFO:
archiver Starting archiver sync to rollup contract 0xe739e0cad9c3877ed3018cd417b6755bdde051a4 from L1 block 6 to current L1 block 8 with hash 0x412d124aa714aabbe924a75a6bd6a079f24bd6dd642873880111526168210826
{"blocksSynchedTo":6,"messagesSynchedTo":{"l1BlockHash":"0xec8f4c07351c08654f6e2e47918fb32223bdeddfa25c3b6fdd170605bcfde8c4","l1BlockNumber":6}}
10:35:12 [10:35:12.073]
INFO:
archiver Initial archiver sync to L1 block 8 complete.
{"l1BlockNumber":8,"syncPoint":{"blocksSynchedTo":8},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}}
10:35:12 [10:35:12.085]
INFO:
world-state:database Creating world state data store at directory /tmp/a15989f71faf9412/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads.
10:35:12 [10:35:12.113]
INFO:
world_state Created world state synchroniser with block history of 64
10:35:12 [10:35:12.114]
WARN:
node:MAIN-aztec-node Aztec node is accepting fake proofs
10:35:12 [10:35:12.114]
INFO:
bb-prover:queued_ivc_verifier Starting QueuedIVCVerifier with 8 concurrent verifiers
10:35:12 [10:35:12.128]
INFO:
p2p:lmdb-v2 Creating p2p data store at directory /tmp/a15989f71faf9412/p2p with map size 134217728 KB (LMDB v2)
10:35:12 [10:35:12.130]
INFO:
p2p:lmdb-v2 Starting data store with maxReaders 16
10:35:12 [10:35:12.131]
INFO:
p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/a15989f71faf9412/p2p-archive with map size 134217728 KB (LMDB v2)
10:35:12 [10:35:12.133]
INFO:
p2p-archive:lmdb-v2 Starting data store with maxReaders 16
10:35:12 [10:35:12.134]
INFO:
p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/a15989f71faf9412/p2p-peers with map size 134217728 KB (LMDB v2)
10:35:12 [10:35:12.135]
INFO:
p2p-peer:lmdb-v2 Starting data store with maxReaders 16
10:35:12 [10:35:12.136]
INFO:
p2p:tx_pool Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
10:35:12 [10:35:12.138]
VERBOSE:
p2p P2P is disabled. Using dummy P2P service.
10:35:12 [10:35:12.140]
VERBOSE:
world-state:block_stream Starting L2 block stream
{"proven":false,"pollIntervalMS":100}
10:35:12 [10:35:12.141]
INFO:
world_state Started world state synchronizer from block 1
10:35:12 [10:35:12.143]
VERBOSE:
world-state:block_stream Starting sync from block number 0
10:35:12 [10:35:12.145]
INFO:
p2p Starting p2p client from block 0 with empty mempools
10:35:12 [10:35:12.145]
VERBOSE:
p2p:l2-block-stream Starting L2 block stream
{"batchSize":20,"pollIntervalMS":100,"startingBlock":0}
10:35:12 [10:35:12.397]
INFO:
epoch-prune-watcher EpochPruneWatcher initialized
10:35:12 [10:35:12.436]
VERBOSE:
validator Initialized validator with addresses: 0x20b56ffce22d0a12d39f196097909d82777e55d7
10:35:12 [10:35:12.436]
VERBOSE:
node:MAIN-aztec-node All Aztec Node subsystems synced
10:35:12 [10:35:12.448]
INFO:
slasher Starting Slasher client...
10:35:12 [10:35:12.455]
VERBOSE:
p2p:l2-block-stream Starting sync from block number 0
10:35:12 [10:35:12.467]
INFO:
validator Started validator with addresses: 0x20b56ffce22d0a12d39f196097909d82777e55d7
10:35:12 [10:35:12.467]
VERBOSE:
validator Validators 0x20b56ffce22d0a12d39f196097909d82777e55d7 are not on the validator committee for epoch 0
10:35:12 [10:35:12.468]
INFO:
sequencer Sequencer config set
{"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":0,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/967620ee/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":8,"enforceTimeTable":false}
10:35:12 [10:35:12.468]
VERBOSE:
sequencer Sequencer timetable updated
{"enforceTimeTable":false}
10:35:12 [10:35:12.470]
INFO:
sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266
10:35:12 [10:35:12.471]
VERBOSE:
node:MAIN-aztec-node Sequencer started
10:35:12 [10:35:12.472]
INFO:
node:MAIN-aztec-node Aztec Node version: 1.0.0
10:35:12 [10:35:12.498]
INFO:
node:MAIN-aztec-node Aztec Node started on chain 0x7a69
{"registryAddress":"0x3c709afec1aceae522c13145005de788a3cc65c8","governanceAddress":"0xa49a3d51a71916f87d60f0e919fb66e4b933b4df","governanceProposerAddress":"0xede9b34af448f9261efea2dafb2364866b09e01a","rollupAddress":"0xe739e0cad9c3877ed3018cd417b6755bdde051a4","inboxAddress":"0x032a5d46f5ad3c6c14dad3bffb96f891023a8fc3","outboxAddress":"0x1c03db5a728811de2c21ddcfe06a527acdbfba1c","feeJuicePortalAddress":"0x9d40980775d989dd8bcbea734a726d76d6bc752f","feeJuiceAddress":"0xb8999345da8041f1da51ac5179b1f055a560f397","stakingAssetAddress":"0xbb9e13665cfb3d531f288a11e7312b6b91c59292","rewardDistributorAddress":"0x4a51916a6b10a43f6565042be5b6b69d8d613f64","gseAddress":"0x6f26a1916df432654607f9c75b764e535e65cf3e","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x83358324b50fc8467bb75c63619393fc65d1d2bb","feeAssetHandlerAddress":"0xb4ff23c4b1e2bc7c86090d4fbda21a457ee6727f","stakingAssetHandlerAddress":"0xf4de5cf63467155f12e722456ff7952eb95c40b6","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"}
10:35:12 [10:35:12.500]
VERBOSE:
e2e:e2e_snapshot_sync Creating a pxe...
10:35:12 [10:35:12.506]
INFO:
pxe:data:lmdb Creating pxe_data data store at directory /tmp/c9f6e1e21ffa46c0/pxe_data with map size 134217728 KB (LMDB v2)
10:35:12 [10:35:12.515]
INFO:
pxe:data:lmdb Starting data store with maxReaders 16
10:35:12 [10:35:12.534]
VERBOSE:
sequencer Preparing proposal for block 1 at slot 1
{"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750847717,"version":138408811},"chainTipArchive":"0x1f9c798be7975bb34c3e605a4c92c75796eae7b9a08644bc9a6a55354ed470be","blockNumber":1,"slot":1}
10:35:12 [10:35:12.943]
VERBOSE:
block-builder Building block 1 for slot 1
{"slot":1,"slotStart":"2025-06-25T10:35:17.000Z","now":"2025-06-25T10:35:18.911Z","blockNumber":1,"msgCount":0,"initialStateReference":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1fd848aa69e1633722fe249a5b7f53b094f1c9cef9f5c694b073fd1cc5850dfb","nullifierTree":"0x0c499b373a1f0fe1b510a63563546d2d39e206895056a5af0143c5f30d639073","publicDataTree":"0x23c08a6b1297210c5e24c76b9a936250a1ce2721576c26ea797c7ec35f9e46a9"},"initialArchiveRoot":"0x1f9c798be7975bb34c3e605a4c92c75796eae7b9a08644bc9a6a55354ed470be","opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}}
10:35:12 [10:35:12.987]
INFO:
simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.0020097919999971054s
{"duration":0.0020097919999971054,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0}
10:35:12 [10:35:12.989]
VERBOSE:
pxe:service Registered protocol contracts in pxe
{"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"}
10:35:12 [10:35:12.989]
INFO:
pxe:service Started PXE connected to chain 31337 version 138408811
10:35:12 [10:35:12.993]
INFO:
e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync waits until a few L2 blocks have been mined and purges blobs
10:35:12 [10:35:12.993]
WARN:
e2e:e2e_snapshot_sync Waiting for L2 blocks to be mined
10:35:13 [10:35:13.013]
INFO:
sequencer Built block 1 for slot 1 with 0 txs and 0 messages. 0 mana/s
{"blockHash":"0x2f2996db64834ee6dbe5d77f6eda3ff07fc8f2327ce6815c484508050c9c4bf3","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750847717,"version":138408811},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":143.46104700000433,"publicProcessDuration":3.112444999991567,"rollupCircuitsDuration":110.42364599999564,"txCount":0,"blockNumber":1,"blockTimestamp":1750847717,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:13 [10:35:13.015]
VERBOSE:
sequencer Attesting committee is empty
10:35:13 [10:35:13.214]
INFO:
e2e:e2e_snapshot_sync L1 block 8 mined at 10:35:17 with new L2 block 0 for epoch 0 with proof up to L2 block 0 for epoch 0
{"l1Timestamp":1750847717,"l1BlockNumber":8,"l2SlotNumber":1,"l2BlockNumber":0,"l2ProvenBlockNumber":0,"totalL2Messages":0}
10:35:15 [10:35:15.358]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x850d111c5c1efcb8ef034f609abd85b11fe14db0860454bd3cc88f1aca8bec35
10:35:15 [10:35:15.359]
VERBOSE:
node:MAIN-aztec-node Sent L1 transaction 0x850d111c5c1efcb8ef034f609abd85b11fe14db0860454bd3cc88f1aca8bec35
{"gasLimit":470455,"maxFeePerGas":"2.031144796","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
10:35:17 [10:35:17.813]
INFO:
e2e:e2e_snapshot_sync L1 block 9 mined at 10:35:25 with new L2 block 1 for epoch 0
{"l1Timestamp":1750847725,"l1BlockNumber":9,"l2SlotNumber":1,"l2BlockNumber":1,"l2ProvenBlockNumber":0,"totalL2Messages":0}
10:35:17 [10:35:17.953]
WARN:
node:blob-sink:client Unable to get blob sidecar for 0x07940851ad5ac5e1d117d7b390d7f35e1986d51aca5d9645ea0e2b3c97ffd680: Not Found (404)
{"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"}
10:35:17 [10:35:17.954]
WARN:
node:blob-sink:client Failed to fetch blobs for 0x07940851ad5ac5e1d117d7b390d7f35e1986d51aca5d9645ea0e2b3c97ffd680 from all blob sources
{"blobSinkUrl":"http://localhost:38287"}
10:35:18 [10:35:18.389]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
10:35:18 [10:35:18.390]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x850d111c5c1efcb8ef034f609abd85b11fe14db0860454bd3cc88f1aca8bec35","calldataSize":1220,"calldataGas":8828,"txCount":0,"blockNumber":1,"blockTimestamp":1750847717,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:18 [10:35:18.391]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
10:35:18 [10:35:18.412]
INFO:
blob-sink:server Received blob sidecar for block 0x07940851ad5ac5e1d117d7b390d7f35e1986d51aca5d9645ea0e2b3c97ffd680
10:35:18 [10:35:18.419]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x07940851ad5ac5e1d117d7b390d7f35e1986d51aca5d9645ea0e2b3c97ffd680
10:35:18 [10:35:18.511]
INFO:
archiver Downloaded L2 block 1
{"blockHash":"0x2f2996db64834ee6dbe5d77f6eda3ff07fc8f2327ce6815c484508050c9c4bf3","blockNumber":1,"txCount":0,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750847717,"version":138408811},"archiveRoot":"0x2f35da49d6f237f10ee24cdb836062a7292a71f421f0641c81450b5de4f8d867","archiveNextLeafIndex":2}
10:35:18 [10:35:18.527]
VERBOSE:
p2p Synched to latest block 1
10:35:18 [10:35:18.618]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":5.310723999995389,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":1,"blockTimestamp":1750847717,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:19 [10:35:19.439]
VERBOSE:
sequencer Preparing proposal for block 2 at slot 2
{"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750847733,"version":138408811},"chainTipArchive":"0x2f35da49d6f237f10ee24cdb836062a7292a71f421f0641c81450b5de4f8d867","blockNumber":2,"slot":2}
10:35:19 [10:35:19.453]
VERBOSE:
block-builder Building block 2 for slot 2
{"slot":2,"slotStart":"2025-06-25T10:35:33.000Z","now":"2025-06-25T10:35:25.422Z","blockNumber":2,"msgCount":0,"initialStateReference":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1fd848aa69e1633722fe249a5b7f53b094f1c9cef9f5c694b073fd1cc5850dfb","nullifierTree":"0x0c499b373a1f0fe1b510a63563546d2d39e206895056a5af0143c5f30d639073","publicDataTree":"0x23c08a6b1297210c5e24c76b9a936250a1ce2721576c26ea797c7ec35f9e46a9"},"initialArchiveRoot":"0x2f35da49d6f237f10ee24cdb836062a7292a71f421f0641c81450b5de4f8d867","opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}}
10:35:19 [10:35:19.456]
INFO:
simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.0009777909999975237s
{"duration":0.0009777909999975237,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0}
10:35:19 [10:35:19.472]
INFO:
sequencer Built block 2 for slot 2 with 0 txs and 0 messages. 0 mana/s
{"blockHash":"0x1645a9f06cd11451d1445caab8aa7104d589c905591dc9267e38b7d6d872fb1d","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750847733,"version":138408811},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":25.755524000007426,"publicProcessDuration":1.4626219999918249,"rollupCircuitsDuration":20.170364000005065,"txCount":0,"blockNumber":2,"blockTimestamp":1750847733,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:19 [10:35:19.475]
VERBOSE:
sequencer Attesting committee is empty
10:35:19 [10:35:19.536]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0xb703671f5c4a2f7a750984e7ddeb554109aea90dff6d60755bd3d6e14c5fac0f
10:35:19 [10:35:19.536]
VERBOSE:
node:MAIN-aztec-node Sent L1 transaction 0xb703671f5c4a2f7a750984e7ddeb554109aea90dff6d60755bd3d6e14c5fac0f
{"gasLimit":391098,"maxFeePerGas":"2.167251699","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"}
10:35:25 [10:35:25.863]
INFO:
e2e:e2e_snapshot_sync L1 block 10 mined at 10:35:33 with new L2 block 2 for epoch 0
{"l1Timestamp":1750847733,"l1BlockNumber":10,"l2SlotNumber":2,"l2BlockNumber":2,"l2ProvenBlockNumber":0,"totalL2Messages":0}
10:35:26 [10:35:26.197]
WARN:
node:blob-sink:client Unable to get blob sidecar for 0x8da17452a3627524068304c5dd29621a75b66cd0eca21e0b810e2bcff6c31e47: Not Found (404)
{"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"}
10:35:26 [10:35:26.197]
WARN:
node:blob-sink:client Failed to fetch blobs for 0x8da17452a3627524068304c5dd29621a75b66cd0eca21e0b810e2bcff6c31e47 from all blob sources
{"blobSinkUrl":"http://localhost:38287"}
10:35:26 [10:35:26.616]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
10:35:26 [10:35:26.617]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xb703671f5c4a2f7a750984e7ddeb554109aea90dff6d60755bd3d6e14c5fac0f","calldataSize":1220,"calldataGas":8828,"txCount":0,"blockNumber":2,"blockTimestamp":1750847733,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:26 [10:35:26.617]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
10:35:26 [10:35:26.621]
INFO:
blob-sink:server Received blob sidecar for block 0x8da17452a3627524068304c5dd29621a75b66cd0eca21e0b810e2bcff6c31e47
10:35:26 [10:35:26.628]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x8da17452a3627524068304c5dd29621a75b66cd0eca21e0b810e2bcff6c31e47
10:35:26 [10:35:26.762]
INFO:
archiver Downloaded L2 block 2
{"blockHash":"0x1645a9f06cd11451d1445caab8aa7104d589c905591dc9267e38b7d6d872fb1d","blockNumber":2,"txCount":0,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750847733,"version":138408811},"archiveRoot":"0x017581fafe1133137628183ecf4563b207ea2229347838b062b01a27eb0d0a5a","archiveNextLeafIndex":3}
10:35:26 [10:35:26.825]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":5.626361000002362,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":2,"blockTimestamp":1750847733,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:26 [10:35:26.870]
VERBOSE:
p2p Synched to latest block 2
10:35:33 [10:35:33.892]
INFO:
e2e:e2e_snapshot_sync L1 block 11 mined at 10:35:41
{"l1Timestamp":1750847741,"l1BlockNumber":11,"l2SlotNumber":2,"l2BlockNumber":2,"l2ProvenBlockNumber":0,"totalL2Messages":0}
10:35:35 [10:35:35.302]
VERBOSE:
sequencer Preparing proposal for block 3 at slot 3
{"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750847749,"version":138408811},"chainTipArchive":"0x017581fafe1133137628183ecf4563b207ea2229347838b062b01a27eb0d0a5a","blockNumber":3,"slot":3}
10:35:35 [10:35:35.318]
VERBOSE:
block-builder Building block 3 for slot 3
{"slot":3,"slotStart":"2025-06-25T10:35:49.000Z","now":"2025-06-25T10:35:41.287Z","blockNumber":3,"msgCount":0,"initialStateReference":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1fd848aa69e1633722fe249a5b7f53b094f1c9cef9f5c694b073fd1cc5850dfb","nullifierTree":"0x0c499b373a1f0fe1b510a63563546d2d39e206895056a5af0143c5f30d639073","publicDataTree":"0x23c08a6b1297210c5e24c76b9a936250a1ce2721576c26ea797c7ec35f9e46a9"},"initialArchiveRoot":"0x017581fafe1133137628183ecf4563b207ea2229347838b062b01a27eb0d0a5a","opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}}
10:35:35 [10:35:35.321]
INFO:
simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.00035414700000546874s
{"duration":0.00035414700000546874,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0}
10:35:35 [10:35:35.353]
INFO:
sequencer Built block 3 for slot 3 with 0 txs and 0 messages. 0 mana/s
{"blockHash":"0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750847749,"version":138408811},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":40.62992099999974,"publicProcessDuration":0.8046470000117552,"rollupCircuitsDuration":35.052814000009676,"txCount":0,"blockNumber":3,"blockTimestamp":1750847749,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:35 [10:35:35.358]
VERBOSE:
sequencer Attesting committee is empty
10:35:35 [10:35:35.441]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x36366cc24015331748de0eb256e237c57170e7f33b5a233c87c72a9c9419b2eb
10:35:35 [10:35:35.441]
VERBOSE:
node:MAIN-aztec-node Sent L1 transaction 0x36366cc24015331748de0eb256e237c57170e7f33b5a233c87c72a9c9419b2eb
{"gasLimit":393483,"maxFeePerGas":"1.759967839","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
10:35:41 [10:35:41.936]
INFO:
e2e:e2e_snapshot_sync L1 block 12 mined at 10:35:49 with new L2 block 3 for epoch 0
{"l1Timestamp":1750847749,"l1BlockNumber":12,"l2SlotNumber":3,"l2BlockNumber":3,"l2ProvenBlockNumber":0,"totalL2Messages":0}
10:35:41 [10:35:41.974]
WARN:
node:blob-sink:client Unable to get blob sidecar for 0x8498381ecf0fc2b905747728f935ccd3e5675c5d77bc3e3956a1ae85934207d7: Not Found (404)
{"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"}
10:35:41 [10:35:41.974]
WARN:
node:blob-sink:client Failed to fetch blobs for 0x8498381ecf0fc2b905747728f935ccd3e5675c5d77bc3e3956a1ae85934207d7 from all blob sources
{"blobSinkUrl":"http://localhost:38287"}
10:35:42 [10:35:42.514]
WARN:
node:blob-sink:client Unable to get blob sidecar for 0x8498381ecf0fc2b905747728f935ccd3e5675c5d77bc3e3956a1ae85934207d7: Not Found (404)
{"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"}
10:35:42 [10:35:42.514]
WARN:
node:blob-sink:client Failed to fetch blobs for 0x8498381ecf0fc2b905747728f935ccd3e5675c5d77bc3e3956a1ae85934207d7 from all blob sources
{"blobSinkUrl":"http://localhost:38287"}
10:35:42 [10:35:42.522]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
10:35:42 [10:35:42.522]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x36366cc24015331748de0eb256e237c57170e7f33b5a233c87c72a9c9419b2eb","calldataSize":1220,"calldataGas":8816,"txCount":0,"blockNumber":3,"blockTimestamp":1750847749,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:42 [10:35:42.523]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
10:35:42 [10:35:42.526]
INFO:
blob-sink:server Received blob sidecar for block 0x8498381ecf0fc2b905747728f935ccd3e5675c5d77bc3e3956a1ae85934207d7
10:35:42 [10:35:42.532]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x8498381ecf0fc2b905747728f935ccd3e5675c5d77bc3e3956a1ae85934207d7
10:35:43 [10:35:43.113]
INFO:
archiver Downloaded L2 block 3
{"blockHash":"0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478","blockNumber":3,"txCount":0,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750847749,"version":138408811},"archiveRoot":"0x12ede0c90061f09dfda4ab6cdd31b9ca6bf9feebc627352e5b52450540cbf9c9","archiveNextLeafIndex":4}
10:35:43 [10:35:43.145]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":6.630728999996791,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":3,"blockTimestamp":1750847749,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:43 [10:35:43.224]
VERBOSE:
p2p Synched to latest block 3
10:35:49 [10:35:49.934]
INFO:
e2e:e2e_snapshot_sync L1 block 13 mined at 10:35:57
{"l1Timestamp":1750847757,"l1BlockNumber":13,"l2SlotNumber":3,"l2BlockNumber":3,"l2ProvenBlockNumber":0,"totalL2Messages":0}
10:35:51 [10:35:51.159]
VERBOSE:
sequencer Preparing proposal for block 4 at slot 4
{"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750847765,"version":138408811},"chainTipArchive":"0x12ede0c90061f09dfda4ab6cdd31b9ca6bf9feebc627352e5b52450540cbf9c9","blockNumber":4,"slot":4}
10:35:51 [10:35:51.176]
VERBOSE:
block-builder Building block 4 for slot 4
{"slot":4,"slotStart":"2025-06-25T10:36:05.000Z","now":"2025-06-25T10:35:57.145Z","blockNumber":4,"msgCount":0,"initialStateReference":{"l1ToL2MessageTree":"0x2e33ee2008411c04b99c24b313513d097a0d21a5040b6193d1f978b8226892d6","noteHashTree":"0x1fd848aa69e1633722fe249a5b7f53b094f1c9cef9f5c694b073fd1cc5850dfb","nullifierTree":"0x0c499b373a1f0fe1b510a63563546d2d39e206895056a5af0143c5f30d639073","publicDataTree":"0x23c08a6b1297210c5e24c76b9a936250a1ce2721576c26ea797c7ec35f9e46a9"},"initialArchiveRoot":"0x12ede0c90061f09dfda4ab6cdd31b9ca6bf9feebc627352e5b52450540cbf9c9","opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}}
10:35:51 [10:35:51.179]
INFO:
simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.00035133700000005775s
{"duration":0.00035133700000005775,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0}
10:35:51 [10:35:51.197]
INFO:
sequencer Built block 4 for slot 4 with 0 txs and 0 messages. 0 mana/s
{"blockHash":"0x22fd69131e77969b27f3a8b6554cee2e67e67cf455f0450a20b5b0b2b0a0572a","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750847765,"version":138408811},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":28.354237000006833,"publicProcessDuration":0.8115169999946374,"rollupCircuitsDuration":22.02689599999576,"txCount":0,"blockNumber":4,"blockTimestamp":1750847765,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:51 [10:35:51.199]
VERBOSE:
sequencer Attesting committee is empty
10:35:51 [10:35:51.282]
VERBOSE:
ethereum:tx_delayer Sent tx immediately 0x3bed2fd22f776fc2ff3ee064f08bfe10995b07a318f11ec148ddd2e0cd76f5c5
10:35:51 [10:35:51.282]
VERBOSE:
node:MAIN-aztec-node Sent L1 transaction 0x3bed2fd22f776fc2ff3ee064f08bfe10995b07a318f11ec148ddd2e0cd76f5c5
{"gasLimit":393483,"maxFeePerGas":"1.629815562","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"}
10:35:57 [10:35:57.952]
INFO:
e2e:e2e_snapshot_sync L1 block 14 mined at 10:36:05 with new L2 block 4 for epoch 0
{"l1Timestamp":1750847765,"l1BlockNumber":14,"l2SlotNumber":4,"l2BlockNumber":4,"l2ProvenBlockNumber":0,"totalL2Messages":0}
10:35:58 [10:35:58.011]
WARN:
node:blob-sink:client Unable to get blob sidecar for 0x40db582240118e750ae15742b0aea53ac1658ede93ed344c8aed67fa7d91d615: Not Found (404)
{"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"}
10:35:58 [10:35:58.012]
WARN:
node:blob-sink:client Failed to fetch blobs for 0x40db582240118e750ae15742b0aea53ac1658ede93ed344c8aed67fa7d91d615 from all blob sources
{"blobSinkUrl":"http://localhost:38287"}
10:35:58 [10:35:58.017]
WARN:
e2e:e2e_snapshot_sync L2 block height is now 4. Purging all blobs from sink so snapshot is required.
10:35:58 [10:35:58.021]
INFO:
e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync creates a snapshot
10:35:58 [10:35:58.022]
WARN:
e2e:e2e_snapshot_sync Creating snapshot
10:35:58 [10:35:58.024]
INFO:
stdlib:file-store Creating local file file store at /tmp/snapshots-WBQuBR
10:35:58 [10:35:58.025]
INFO:
node:MAIN-aztec-node Pausing archiver and world state sync to start snapshot upload
10:35:58 [10:35:58.026]
INFO:
archiver Stopped.
10:35:58 [10:35:58.026]
INFO:
world_state Stopped sync
10:35:58 [10:35:58.026]
INFO:
node:MAIN-aztec-node Creating backups of lmdb environments to /tmp/a15989f71faf9412/snapshot-RTfZOe
10:35:58 [10:35:58.035]
INFO:
node:MAIN-aztec-node Data stores backed up to /tmp/a15989f71faf9412/snapshot-RTfZOe
{"paths":{"l1-to-l2-message-tree":"/tmp/a15989f71faf9412/snapshot-RTfZOe/world-state/L1ToL2MessageTree/data.mdb","archive-tree":"/tmp/a15989f71faf9412/snapshot-RTfZOe/world-state/ArchiveTree/data.mdb","public-data-tree":"/tmp/a15989f71faf9412/snapshot-RTfZOe/world-state/PublicDataTree/data.mdb","note-hash-tree":"/tmp/a15989f71faf9412/snapshot-RTfZOe/world-state/NoteHashTree/data.mdb","nullifier-tree":"/tmp/a15989f71faf9412/snapshot-RTfZOe/world-state/NullifierTree/data.mdb","archiver":"/tmp/a15989f71faf9412/snapshot-RTfZOe/archiver/data.mdb"}}
10:35:58 [10:35:58.035]
INFO:
node:MAIN-aztec-node Resuming archiver and world state sync
10:35:58 [10:35:58.035]
VERBOSE:
world-state:block_stream Starting L2 block stream
{"proven":false,"pollIntervalMS":100}
10:35:58 [10:35:58.036]
INFO:
world_state Resumed sync
10:35:58 [10:35:58.036]
INFO:
archiver Restarting archiver
10:35:58 [10:35:58.043]
INFO:
node:MAIN-aztec-node Uploading snapshot to file:///tmp/snapshots-WBQuBR
{"snapshot":{"l1ChainId":31337,"rollupVersion":138408811,"rollupAddress":"0xe739e0cad9c3877ed3018cd417b6755bdde051a4","l2BlockNumber":3,"l2BlockHash":"0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478","l1BlockNumber":13}}
10:35:58 [10:35:58.069]
INFO:
node:MAIN-aztec-node Snapshot uploaded successfully
{"snapshot":{"l1BlockNumber":13,"l2BlockHash":"0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478","l2BlockNumber":3,"schemaVersions":{"archiver":3,"worldState":2},"timestamp":1750847758044,"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/l1-to-l2-message-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","archive-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/archive-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","public-data-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/public-data-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","note-hash-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/note-hash-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","nullifier-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/nullifier-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","archiver":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/archiver-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db"}}}
10:35:58 [10:35:58.069]
INFO:
node:MAIN-aztec-node Cleaning up backup dir /tmp/a15989f71faf9412/snapshot-RTfZOe
10:35:58 [10:35:58.091]
WARN:
node:blob-sink:client Unable to get blob sidecar for 0x40db582240118e750ae15742b0aea53ac1658ede93ed344c8aed67fa7d91d615: Not Found (404)
{"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"}
10:35:58 [10:35:58.092]
WARN:
node:blob-sink:client Failed to fetch blobs for 0x40db582240118e750ae15742b0aea53ac1658ede93ed344c8aed67fa7d91d615 from all blob sources
{"blobSinkUrl":"http://localhost:38287"}
10:35:58 [10:35:58.346]
INFO:
sequencer:publisher Bundled [propose] transaction [succeeded]
10:35:58 [10:35:58.347]
VERBOSE:
sequencer:publisher Published L2 block to L1 rollup contract
{"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x3bed2fd22f776fc2ff3ee064f08bfe10995b07a318f11ec148ddd2e0cd76f5c5","calldataSize":1220,"calldataGas":8816,"txCount":0,"blockNumber":4,"blockTimestamp":1750847765,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:58 [10:35:58.347]
VERBOSE:
node:blob-sink:client Sending 1 blobs to blob sink
10:35:58 [10:35:58.351]
INFO:
blob-sink:server Received blob sidecar for block 0x40db582240118e750ae15742b0aea53ac1658ede93ed344c8aed67fa7d91d615
10:35:58 [10:35:58.357]
INFO:
blob-sink:server Blob sidecar stored successfully for block 0x40db582240118e750ae15742b0aea53ac1658ede93ed344c8aed67fa7d91d615
10:35:58 [10:35:58.654]
INFO:
archiver Downloaded L2 block 4
{"blockHash":"0x22fd69131e77969b27f3a8b6554cee2e67e67cf455f0450a20b5b0b2b0a0572a","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750847765,"version":138408811},"archiveRoot":"0x1b4b066bbbb04e47091e31e19897408ed57d0e5b3403a088b08940c4c0fc48cd","archiveNextLeafIndex":5}
10:35:58 [10:35:58.670]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":4.050684000001638,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1750847765,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:58 [10:35:58.689]
VERBOSE:
p2p Synched to latest block 4
10:35:59 [10:35:59.028]
WARN:
e2e:e2e_snapshot_sync Snapshot created
10:35:59 [10:35:59.030]
INFO:
e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync downloads snapshot when syncing new node
10:35:59 [10:35:59.031]
WARN:
e2e:e2e_snapshot_sync Syncing brand new node with snapshot sync
10:35:59 [10:35:59.031]
WARN:
e2e:e2e_snapshot_sync Creating and syncing a node without a validator...
10:35:59 [10:35:59.032]
INFO:
node:blob-sink:client:1 Creating HTTP blob sink client.
{"blobSinkUrl":"http://localhost:38287"}
10:35:59 [10:35:59.061]
INFO:
node:1 Creating local file file store at /tmp/snapshots-WBQuBR
10:35:59 [10:35:59.062]
VERBOSE:
node:1 Creating temporary archiver data store
10:35:59 [10:35:59.062]
INFO:
archiver:lmdb:1 Creating archiver data store at directory /tmp/a15989f71faf9412/ed89e324d213e6c7/archiver with map size 134217728 KB (LMDB v2)
10:35:59 [10:35:59.065]
INFO:
archiver:lmdb:1 Starting data store with maxReaders 16
10:35:59 [10:35:59.067]
VERBOSE:
node:1 Closing temporary archiver data store
{"archiverL2BlockNumber":0}
10:35:59 [10:35:59.071]
INFO:
node:1 Syncing from snapshot at L1 block 13 L2 block 3
{"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478","l1BlockNumber":13,"timestamp":1750847758044,"schemaVersions":{"archiver":3,"worldState":2},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/l1-to-l2-message-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","archive-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/archive-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","public-data-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/public-data-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","note-hash-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/note-hash-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","nullifier-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/nullifier-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","archiver":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/archiver-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db"}},"snapshotsUrl":"file:///tmp/snapshots-WBQuBR"}
10:35:59 [10:35:59.072]
INFO:
node:1 Creating local file file store at /tmp/snapshots-WBQuBR
10:35:59 [10:35:59.072]
INFO:
node:1 Downloading snapshot to /tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ
{"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478","l1BlockNumber":13,"timestamp":1750847758044,"schemaVersions":{"archiver":3,"worldState":2},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/l1-to-l2-message-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","archive-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/archive-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","public-data-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/public-data-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","note-hash-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/note-hash-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","nullifier-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/nullifier-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","archiver":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/archiver-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db"}},"downloadPaths":{"archiver":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/archiver.db","nullifier-tree":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/nullifier-tree.db","public-data-tree":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/public-data-tree.db","note-hash-tree":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/note-hash-tree.db","archive-tree":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/archive-tree.db","l1-to-l2-message-tree":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/l1-to-l2-message-tree.db"}}
10:35:59 [10:35:59.074]
INFO:
node:1 Snapshot downloaded at /tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ
{"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478","l1BlockNumber":13,"timestamp":1750847758044,"schemaVersions":{"archiver":3,"worldState":2},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/l1-to-l2-message-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","archive-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/archive-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","public-data-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/public-data-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","note-hash-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/note-hash-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","nullifier-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/nullifier-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","archiver":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/archiver-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db"}},"downloadPaths":{"archiver":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/archiver.db","nullifier-tree":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/nullifier-tree.db","public-data-tree":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/public-data-tree.db","note-hash-tree":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/note-hash-tree.db","archive-tree":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/archive-tree.db","l1-to-l2-message-tree":"/tmp/a15989f71faf9412/ed89e324d213e6c7/download-3MFrAJ/l1-to-l2-message-tree.db"}}
10:35:59 [10:35:59.078]
INFO:
node:1 Archiver database set up from snapshot
{"path":"/tmp/a15989f71faf9412/ed89e324d213e6c7/archiver","dbVersion":3,"rollupAddress":"0xe739e0cad9c3877ed3018cd417b6755bdde051a4"}
10:35:59 [10:35:59.082]
INFO:
node:1 World state database l1-to-l2-message-tree set up from snapshot
{"path":"/tmp/a15989f71faf9412/ed89e324d213e6c7/world_state/L1ToL2MessageTree","dbVersion":2,"rollupAddress":"0xe739e0cad9c3877ed3018cd417b6755bdde051a4"}
10:35:59 [10:35:59.082]
INFO:
node:1 World state database archive-tree set up from snapshot
{"path":"/tmp/a15989f71faf9412/ed89e324d213e6c7/world_state/ArchiveTree","dbVersion":2,"rollupAddress":"0xe739e0cad9c3877ed3018cd417b6755bdde051a4"}
10:35:59 [10:35:59.083]
INFO:
node:1 World state database public-data-tree set up from snapshot
{"path":"/tmp/a15989f71faf9412/ed89e324d213e6c7/world_state/PublicDataTree","dbVersion":2,"rollupAddress":"0xe739e0cad9c3877ed3018cd417b6755bdde051a4"}
10:35:59 [10:35:59.083]
INFO:
node:1 World state database note-hash-tree set up from snapshot
{"path":"/tmp/a15989f71faf9412/ed89e324d213e6c7/world_state/NoteHashTree","dbVersion":2,"rollupAddress":"0xe739e0cad9c3877ed3018cd417b6755bdde051a4"}
10:35:59 [10:35:59.084]
INFO:
node:1 World state database nullifier-tree set up from snapshot
{"path":"/tmp/a15989f71faf9412/ed89e324d213e6c7/world_state/NullifierTree","dbVersion":2,"rollupAddress":"0xe739e0cad9c3877ed3018cd417b6755bdde051a4"}
10:35:59 [10:35:59.085]
INFO:
node:1 P2P database cleared
{"path":"/tmp/a15989f71faf9412/ed89e324d213e6c7/p2p"}
10:35:59 [10:35:59.085]
INFO:
node:1 Snapshot synced to L1 block 13 L2 block 3
{"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478","l1BlockNumber":13,"timestamp":1750847758044,"schemaVersions":{"archiver":3,"worldState":2},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/l1-to-l2-message-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","archive-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/archive-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","public-data-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/public-data-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","note-hash-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/note-hash-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","nullifier-tree":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/nullifier-tree-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db","archiver":"file:///tmp/snapshots-WBQuBR/aztec-31337-138408811-0xe739e0cad9c3877ed3018cd417b6755bdde051a4/archiver-20250625103558-0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478.db"}}}
10:35:59 [10:35:59.086]
INFO:
archiver:lmdb:1 Creating archiver data store at directory /tmp/a15989f71faf9412/ed89e324d213e6c7/archiver with map size 134217728 KB (LMDB v2)
10:35:59 [10:35:59.088]
INFO:
archiver:lmdb:1 Starting data store with maxReaders 16
10:35:59 [10:35:59.406]
INFO:
node:blob-sink:client:1 Testing configured blob sources
{"blobSinkUrl":"http://localhost:38287"}
10:35:59 [10:35:59.407]
INFO:
node:blob-sink:client:1 Blob sink is reachable
{"blobSinkUrl":"http://localhost:38287"}
10:35:59 [10:35:59.408]
WARN:
node:blob-sink:client:1 No L1 consensus host urls configured
10:35:59 [10:35:59.408]
WARN:
node:blob-sink:client:1 No archive client configured
10:35:59 [10:35:59.410]
INFO:
archiver:1 Starting archiver sync to rollup contract 0xe739e0cad9c3877ed3018cd417b6755bdde051a4 from L1 block 12 to current L1 block 14 with hash 0x40db582240118e750ae15742b0aea53ac1658ede93ed344c8aed67fa7d91d615
{"blocksSynchedTo":12,"messagesSynchedTo":{"l1BlockHash":"0xec8f4c07351c08654f6e2e47918fb32223bdeddfa25c3b6fdd170605bcfde8c4","l1BlockNumber":6}}
10:35:59 [10:35:59.458]
INFO:
archiver:1 Downloaded L2 block 4
{"blockHash":"0x22fd69131e77969b27f3a8b6554cee2e67e67cf455f0450a20b5b0b2b0a0572a","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750847765,"version":138408811},"archiveRoot":"0x1b4b066bbbb04e47091e31e19897408ed57d0e5b3403a088b08940c4c0fc48cd","archiveNextLeafIndex":5}
10:35:59 [10:35:59.463]
INFO:
archiver:1 Initial archiver sync to L1 block 14 complete.
{"l1BlockNumber":14,"syncPoint":{"blocksSynchedTo":14},"latest":{"number":4,"hash":"0x22fd69131e77969b27f3a8b6554cee2e67e67cf455f0450a20b5b0b2b0a0572a"},"proven":{"number":0},"finalized":{"number":0}}
10:35:59 [10:35:59.470]
INFO:
world-state:database:1 Creating world state data store at directory /tmp/a15989f71faf9412/ed89e324d213e6c7/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads.
10:35:59 [10:35:59.479]
INFO:
world_state:1 Created world state synchroniser with block history of 64
10:35:59 [10:35:59.480]
WARN:
node:1 Aztec node is accepting fake proofs
10:35:59 [10:35:59.480]
INFO:
bb-prover:queued_ivc_verifier:1 Starting QueuedIVCVerifier with 8 concurrent verifiers
10:35:59 [10:35:59.486]
INFO:
p2p:lmdb-v2:1 Creating p2p data store at directory /tmp/a15989f71faf9412/ed89e324d213e6c7/p2p with map size 134217728 KB (LMDB v2)
10:35:59 [10:35:59.498]
INFO:
p2p:lmdb-v2:1 Starting data store with maxReaders 16
10:35:59 [10:35:59.500]
INFO:
p2p-archive:lmdb-v2:1 Creating p2p-archive data store at directory /tmp/a15989f71faf9412/ed89e324d213e6c7/p2p-archive with map size 134217728 KB (LMDB v2)
10:35:59 [10:35:59.507]
INFO:
p2p-archive:lmdb-v2:1 Starting data store with maxReaders 16
10:35:59 [10:35:59.509]
INFO:
p2p-peer:lmdb-v2:1 Creating p2p-peers data store at directory /tmp/a15989f71faf9412/ed89e324d213e6c7/p2p-peers with map size 134217728 KB (LMDB v2)
10:35:59 [10:35:59.510]
INFO:
p2p-peer:lmdb-v2:1 Starting data store with maxReaders 16
10:35:59 [10:35:59.511]
INFO:
p2p:tx_pool:1 Setting maximum tx mempool size
{"maxTxPoolSize":100000000}
10:35:59 [10:35:59.512]
VERBOSE:
p2p:1 P2P is disabled. Using dummy P2P service.
10:35:59 [10:35:59.513]
VERBOSE:
world_state:1 Starting sync from 4 to latest block 4
10:35:59 [10:35:59.513]
VERBOSE:
world-state:block_stream:1 Starting L2 block stream
{"proven":false,"pollIntervalMS":100}
10:35:59 [10:35:59.513]
INFO:
world_state:1 Started world state synchronizer from block 4
10:35:59 [10:35:59.515]
VERBOSE:
world-state:block_stream:1 Starting sync from block number 3
10:35:59 [10:35:59.520]
INFO:
world_state:1 World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":3.6453460000047926,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1750847765,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:35:59 [10:35:59.522]
INFO:
p2p:1 Starting p2p client from block 4 with empty mempools
10:35:59 [10:35:59.523]
VERBOSE:
p2p:1:l2-block-stream:1 Starting L2 block stream
{"batchSize":20,"pollIntervalMS":100,"startingBlock":4}
10:35:59 [10:35:59.523]
INFO:
epoch-prune-watcher:1 EpochPruneWatcher initialized
10:35:59 [10:35:59.523]
VERBOSE:
node:1 All Aztec Node subsystems synced
10:35:59 [10:35:59.529]
INFO:
slasher:1 Starting Slasher client...
10:35:59 [10:35:59.530]
INFO:
node:1 Aztec Node version: 1.0.0
10:35:59 [10:35:59.530]
INFO:
node:1 Aztec Node started on chain 0x7a69
{"registryAddress":"0x3c709afec1aceae522c13145005de788a3cc65c8","governanceAddress":"0xa49a3d51a71916f87d60f0e919fb66e4b933b4df","governanceProposerAddress":"0xede9b34af448f9261efea2dafb2364866b09e01a","rollupAddress":"0xe739e0cad9c3877ed3018cd417b6755bdde051a4","inboxAddress":"0x032a5d46f5ad3c6c14dad3bffb96f891023a8fc3","outboxAddress":"0x1c03db5a728811de2c21ddcfe06a527acdbfba1c","feeJuicePortalAddress":"0x9d40980775d989dd8bcbea734a726d76d6bc752f","feeJuiceAddress":"0xb8999345da8041f1da51ac5179b1f055a560f397","stakingAssetAddress":"0xbb9e13665cfb3d531f288a11e7312b6b91c59292","rewardDistributorAddress":"0x4a51916a6b10a43f6565042be5b6b69d8d613f64","gseAddress":"0x6f26a1916df432654607f9c75b764e535e65cf3e","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x83358324b50fc8467bb75c63619393fc65d1d2bb","feeAssetHandlerAddress":"0xb4ff23c4b1e2bc7c86090d4fbda21a457ee6727f","stakingAssetHandlerAddress":"0xf4de5cf63467155f12e722456ff7952eb95c40b6","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"}
10:35:59 [10:35:59.532]
WARN:
e2e:e2e_snapshot_sync New node synced
10:35:59 [10:35:59.535]
VERBOSE:
p2p:1:l2-block-stream:1 Starting sync from block number 3
10:35:59 [10:35:59.541]
WARN:
e2e:e2e_snapshot_sync Checking for L2 block 3 with hash 0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478 on both nodes
10:35:59 [10:35:59.543]
VERBOSE:
p2p:1 Synched to latest block 4
10:35:59 [10:35:59.546]
WARN:
e2e:e2e_snapshot_sync Stopping new node
10:35:59 [10:35:59.547]
INFO:
node:1 Stopping Aztec Node
10:36:01 [10:36:01.548]
INFO:
slasher:1 Slasher client stopped.
10:36:01 [10:36:01.549]
INFO:
p2p:1 P2P client stopped
10:36:01 [10:36:01.552]
INFO:
world_state:1 Stopped world state synchronizer
10:36:01 [10:36:01.552]
INFO:
archiver:1 Stopped.
10:36:01 [10:36:01.552]
INFO:
node:1 Stopped Aztec Node
10:36:01 [10:36:01.553]
INFO:
e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync downloads snapshot when syncing new prover node
10:36:01 [10:36:01.553]
WARN:
e2e:e2e_snapshot_sync Syncing brand new prover node with snapshot sync
10:36:01 [10:36:01.553]
WARN:
e2e:e2e_snapshot_sync Creating and syncing a prover node...
10:36:01 [10:36:01.604]
INFO:
blob-sink:client:prover-node Creating HTTP blob sink client.
{"blobSinkUrl":"http://localhost:38287"}
10:36:01 [10:36:01.607]
INFO:
archiver:lmdb:prover-node Creating archiver data store at directory /tmp/a15989f71faf9412/5fece80b545ddac8/archiver with map size 134217728 KB (LMDB v2)
10:36:01 [10:36:01.609]
INFO:
archiver:lmdb:prover-node Starting data store with maxReaders 16
10:36:01 [10:36:01.926]
INFO:
blob-sink:client:prover-node Testing configured blob sources
{"blobSinkUrl":"http://localhost:38287"}
10:36:01 [10:36:01.927]
INFO:
blob-sink:client:prover-node Blob sink is reachable
{"blobSinkUrl":"http://localhost:38287"}
10:36:01 [10:36:01.928]
WARN:
blob-sink:client:prover-node No L1 consensus host urls configured
10:36:01 [10:36:01.928]
WARN:
blob-sink:client:prover-node No archive client configured
10:36:01 [10:36:01.942]
INFO:
archiver:prover-node Starting archiver sync to rollup contract 0xe739e0cad9c3877ed3018cd417b6755bdde051a4 from L1 block 6 to current L1 block 14 with hash 0x40db582240118e750ae15742b0aea53ac1658ede93ed344c8aed67fa7d91d615
{"blocksSynchedTo":6,"messagesSynchedTo":{"l1BlockHash":"0xec8f4c07351c08654f6e2e47918fb32223bdeddfa25c3b6fdd170605bcfde8c4","l1BlockNumber":6}}
10:36:02 [10:36:02.085]
INFO:
archiver:prover-node Downloaded L2 block 1
{"blockHash":"0x2f2996db64834ee6dbe5d77f6eda3ff07fc8f2327ce6815c484508050c9c4bf3","blockNumber":1,"txCount":0,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":1,"timestamp":1750847717,"version":138408811},"archiveRoot":"0x2f35da49d6f237f10ee24cdb836062a7292a71f421f0641c81450b5de4f8d867","archiveNextLeafIndex":2}
10:36:02 [10:36:02.086]
INFO:
archiver:prover-node Downloaded L2 block 2
{"blockHash":"0x1645a9f06cd11451d1445caab8aa7104d589c905591dc9267e38b7d6d872fb1d","blockNumber":2,"txCount":0,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1750847733,"version":138408811},"archiveRoot":"0x017581fafe1133137628183ecf4563b207ea2229347838b062b01a27eb0d0a5a","archiveNextLeafIndex":3}
10:36:02 [10:36:02.086]
INFO:
archiver:prover-node Downloaded L2 block 3
{"blockHash":"0x2197becbb31d93d2dc47496b61a4a63dd0f9400bc3488a3a89aeca260bb2d478","blockNumber":3,"txCount":0,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1750847749,"version":138408811},"archiveRoot":"0x12ede0c90061f09dfda4ab6cdd31b9ca6bf9feebc627352e5b52450540cbf9c9","archiveNextLeafIndex":4}
10:36:02 [10:36:02.086]
INFO:
archiver:prover-node Downloaded L2 block 4
{"blockHash":"0x22fd69131e77969b27f3a8b6554cee2e67e67cf455f0450a20b5b0b2b0a0572a","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1750847765,"version":138408811},"archiveRoot":"0x1b4b066bbbb04e47091e31e19897408ed57d0e5b3403a088b08940c4c0fc48cd","archiveNextLeafIndex":5}
10:36:02 [10:36:02.089]
INFO:
archiver:prover-node Initial archiver sync to L1 block 14 complete.
{"l1BlockNumber":14,"syncPoint":{"blocksSynchedTo":14},"latest":{"number":4,"hash":"0x22fd69131e77969b27f3a8b6554cee2e67e67cf455f0450a20b5b0b2b0a0572a"},"proven":{"number":0},"finalized":{"number":0}}
10:36:02 [10:36:02.092]
INFO:
prover-node:blob-sink:client:prover-node Creating HTTP blob sink client.
{"blobSinkUrl":"http://localhost:38287"}
10:36:02 [10:36:02.092]
INFO:
prover-node:prover-node Creating local file file store at /tmp/snapshots-WBQuBR
10:36:02 [10:36:02.092]
VERBOSE:
prover-node:prover-node Creating temporary archiver data store
10:36:02 [10:36:02.093]
INFO:
archiver:lmdb:prover-node Creating archiver data store at directory /tmp/a15989f71faf9412/5fece80b545ddac8/archiver with map size 134217728 KB (LMDB v2)
10:36:02 [10:36:02.097]
INFO:
archiver:lmdb:prover-node Starting data store with maxReaders 16
10:36:02 [10:36:02.099]
VERBOSE:
prover-node:prover-node Closing temporary archiver data store
{"archiverL1BlockNumber":14,"archiverL2BlockNumber":4}
10:36:02 [10:36:02.100]
VERBOSE:
prover-node:prover-node Skipping non-forced snapshot sync as archiver is already synced to L2 block 4.
10:36:02 [10:36:02.100]
VERBOSE:
prover-node:prover-node Created archiver and synced to block 4
10:36:02 [10:36:02.104]
INFO:
world-state:database:prover-node Creating world state data store at directory /tmp/a15989f71faf9412/5fece80b545ddac8/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads.
10:36:02 [10:36:02.124]
INFO:
world_state:prover-node Created world state synchroniser with block history of 64
10:36:02 [10:36:02.125]
VERBOSE:
world_state:prover-node Starting sync from 1 to latest block 4
10:36:02 [10:36:02.125]
VERBOSE:
world-state:block_stream:prover-node Starting L2 block stream
{"proven":false,"pollIntervalMS":100}
10:36:02 [10:36:02.126]
INFO:
world_state:prover-node Started world state synchronizer from block 1
10:36:02 [10:36:02.127]
VERBOSE:
world-state:block_stream:prover-node Starting sync from block number 0
10:36:02 [10:36:02.143]
INFO:
world_state:prover-node World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":8.080376999991131,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":1,"blockTimestamp":1750847717,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:36:02 [10:36:02.148]
INFO:
world_state:prover-node World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":3.7028969999955734,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":2,"blockTimestamp":1750847733,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:36:02 [10:36:02.153]
INFO:
world_state:prover-node World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":4.823819999990519,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":3,"blockTimestamp":1750847749,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:36:02 [10:36:02.158]
INFO:
world_state:prover-node World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":3.651926000005915,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1750847765,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0}
10:36:02 [10:36:02.158]
WARN:
prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/a15989f71faf9412/5fece80b545ddac8/archiver when loading epoch databases, ignoring
10:36:02 [10:36:02.159]
WARN:
prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/a15989f71faf9412/5fece80b545ddac8/world_state when loading epoch databases, ignoring
10:36:02 [10:36:02.160]
INFO:
prover-client:proving-broker:prover-node Proving Broker started
10:36:02 [10:36:02.171]
INFO:
prover-node:prover-coordination:prover-node Using prover coordination via aztec node
10:36:02 [10:36:02.172]
INFO:
e2e:e2e_snapshot_sync:prover-node Created and synced prover node
{"publisherAddress":"0x9965507D1a55bcC2695C58ba16FB37d819B0A4dc"}
10:36:02 [10:36:02.173]
INFO:
prover-node:epoch-monitor:prover-node Started EpochMonitor
{"pollingIntervalMs":200}
10:36:02 [10:36:02.175]
INFO:
prover-node:prover-node Started Prover Node with prover id 0x0000000000000000000000009965507d1a55bcc2695c58ba16fb37d819b0a4dc
{"proverNodePollingIntervalMs":200,"proverNodeMaxPendingJobs":10,"proverNodeMaxParallelBlocksPerEpoch":32,"txGatheringIntervalMs":1000,"txGatheringBatchSize":10,"txGatheringMaxParallelRequestsPerNode":100,"dataDirectory":"/tmp/a15989f71faf9412/5fece80b545ddac8","l1ChainId":31337,"rollupVersion":138408811}
10:36:02 [10:36:02.175]
WARN:
e2e:e2e_snapshot_sync New node prover synced
10:36:02 [10:36:02.177]
VERBOSE:
prover-node:prover-node Fetching 0 tx hashes for block number 4 from coordination
10:36:02 [10:36:02.177]
INFO:
prover-node:combined-prover-coordination:prover-node Check for 0 txs found all in the pool
10:36:02 [10:36:02.180]
WARN:
e2e:e2e_snapshot_sync Stopping new prover node
10:36:02 [10:36:02.180]
INFO:
prover-node:prover-node Stopping ProverNode
10:36:02 [10:36:02.180]
INFO:
prover-node:epoch-monitor:prover-node Stopped EpochMonitor
10:36:02 [10:36:02.181]
INFO:
archiver:prover-node Stopped.
10:36:02 [10:36:02.183]
INFO:
world_state:prover-node Stopped world state synchronizer
10:36:02 [10:36:02.183]
INFO:
prover-node:prover-node Stopped ProverNode
10:36:02 [10:36:02.185]
INFO:
node:MAIN-aztec-node Stopping Aztec Node
10:36:04 [10:36:04.187]
INFO:
slasher Slasher client stopped.
10:36:04 [10:36:04.188]
INFO:
sequencer Stopped sequencer
10:36:04 [10:36:04.188]
INFO:
p2p P2P client stopped
10:36:04 [10:36:04.189]
INFO:
world_state Stopped world state synchronizer
10:36:04 [10:36:04.190]
INFO:
archiver Stopped.
10:36:04 [10:36:04.190]
INFO:
node:MAIN-aztec-node Stopped Aztec Node
10:36:04 [10:36:04.200]
INFO:
blob-sink:server Stopping blob sink
10:36:04 [10:36:04.200]
INFO:
blob-sink:server Blob sink stopped
10:36:04
PASS src/e2e_snapshot_sync.test.ts
10:36:04 e2e_snapshot_sync
10:36:04
✓ waits until a few L2 blocks have been mined and purges blobs (45028 ms)
10:36:04
✓ creates a snapshot (1008 ms)
10:36:04
✓ downloads snapshot when syncing new node (2523 ms)
10:36:04
✓ downloads snapshot when syncing new prover node (631 ms)
10:36:04
10:36:04
Test Suites: 1 passed, 1 total
10:36:04
Tests: 4 passed, 4 total
10:36:04
Snapshots: 0 total
10:36:04
Time: 117.545 s
10:36:04
Ran all test suites matching src/e2e_snapshot_sync.test.ts
.
10:36:04
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?