Parent Log: http://ci.aztec-labs.com/f8dbd6e9d5360f06 Command: 751df696adf04d3f: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/106f897363bb5aee27ddd091b5be9641b011c5bb Env: REF_NAME=gh-readonly-queue/next/pr-15004-2b9c409698cf0f475a7a9f5884117c8ad2a4f79a CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Thu Jun 12 15:48:46 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15004_amd64_x4-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_eb8f79a88ef38365_next 15:48:46 +++ id -u 15:48:46 +++ id -g 15:48:46 ++ 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'\''' 15:48:46 + cid=c7f7a1236acbf9e1aa66f4abc62ed314d0c7b8a31fab85a9028bb577d1e57ecc 15:48:46 + set +x 15:48:47 {"level":25,"time":1749743327667,"pid":12,"hostname":"c7f7a1236acb","module":"logger","msg":"Logger initialized with level verbose"} 15:48:54 [15:48:54.038] INFO: e2e:e2e_snapshot_sync Logging metrics to log/unknown.jsonl 15:48:54 [15:48:54.228] INFO: e2e:e2e_snapshot_sync Calling anvil_setBlockTimestampInterval with params: [8] 15:48:54 [15:48:54.259] WARN: e2e:e2e_snapshot_sync Set block interval to 8 15:48:54 [15:48:54.260] VERBOSE: e2e:e2e_snapshot_sync Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 15:48:54 [15:48:54.320] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xff8f3047f70ec9e63079d7903c02a47802dc292d5660d2da825ac209bbd9cd89 {"gasLimit":867658,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:48:54 [15:48:54.321] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xd8B56421e9b573AE62f2997B7b58858a4413A967 in tx 0xff8f3047f70ec9e63079d7903c02a47802dc292d5660d2da825ac209bbd9cd89. 15:48:54 [15:48:54.323] VERBOSE: e2e:e2e_snapshot_sync Deployed Fee Asset at 0xd8b56421e9b573ae62f2997b7b58858a4413a967 15:48:54 [15:48:54.354] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xb8a727e5dcee31d2ee7a6a94b8b01df7952fdc685dfb1b5bb36a0dbda9d08d89 {"gasLimit":867644,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:48:54 [15:48:54.355] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x026208feE3F4461826C8838C3569272E8C08E131 in tx 0xb8a727e5dcee31d2ee7a6a94b8b01df7952fdc685dfb1b5bb36a0dbda9d08d89. 15:48:54 [15:48:54.356] VERBOSE: e2e:e2e_snapshot_sync Deployed Staking Asset at 0x026208fee3f4461826c8838c3569272e8c08e131 15:48:54 [15:48:54.393] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x84345970a64bc89d244665c6d19bcf62f7a1fb0c5497fd61c66569ea96442f1f {"gasLimit":3118894,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:48:54 [15:48:54.394] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xad2120681B02De3e9b8aFd325977CDeDDf15f01C in tx 0x84345970a64bc89d244665c6d19bcf62f7a1fb0c5497fd61c66569ea96442f1f. 15:48:54 [15:48:54.395] VERBOSE: e2e:e2e_snapshot_sync Deployed GSE at 0xad2120681b02de3e9b8afd325977cdeddf15f01c 15:48:54 [15:48:54.419] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x96c1e759b945754976d026659a519c1c5d05a738916e69d742cdec67a5482765 {"gasLimit":1030513,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:48:54 [15:48:54.419] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x992D1f24CC5f368188d936cf0b2A111cEE586d4e in tx 0x96c1e759b945754976d026659a519c1c5d05a738916e69d742cdec67a5482765. 15:48:54 [15:48:54.421] VERBOSE: e2e:e2e_snapshot_sync Deployed Registry at 0x992d1f24cc5f368188d936cf0b2a111cee586d4e 15:48:54 [15:48:54.450] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x35838f7740ede8daad92b7b8589b59625f0100193e252bc6ce3862a65d23892c {"gasLimit":1998672,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:48:54 [15:48:54.450] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xfDB60896B1920A10Fd3AA268A292E51ebD5568A8 in tx 0x35838f7740ede8daad92b7b8589b59625f0100193e252bc6ce3862a65d23892c. 15:48:54 [15:48:54.451] VERBOSE: e2e:e2e_snapshot_sync Deployed GovernanceProposer at 0xfdb60896b1920a10fd3aa268a292e51ebd5568a8 15:48:54 [15:48:54.500] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x4dbcecd47a2081d10a38e4cf385714d92e542e5a44eb5a37a3810c6c6738dc4e {"gasLimit":3092007,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:48:54 [15:48:54.501] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x506150CaB49DBC09C8B79D20ac5c79CA28220AEA in tx 0x4dbcecd47a2081d10a38e4cf385714d92e542e5a44eb5a37a3810c6c6738dc4e. 15:48:54 [15:48:54.502] VERBOSE: e2e:e2e_snapshot_sync Deployed Governance at 0x506150cab49dbc09c8b79d20ac5c79ca28220aea 15:48:54 [15:48:54.517] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xf2ecc0d2040ae9928a4b186c21f02e611c2904f24b196eed69d646e9333cc00d {"gasLimit":100000,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:48:54 [15:48:54.517] VERBOSE: e2e:e2e_snapshot_sync Set governance on GSE in 0xf2ecc0d2040ae9928a4b186c21f02e611c2904f24b196eed69d646e9333cc00d 15:48:54 [15:48:54.542] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x77f9fa97fbbcb04392e88d456c198520b3425518c3d2d4146393099192372448 {"gasLimit":397390,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 15:48:54 [15:48:54.543] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x1649EeAD62C64Db7F63182989C8c41Ab25025C21 in tx 0x77f9fa97fbbcb04392e88d456c198520b3425518c3d2d4146393099192372448. 15:48:54 [15:48:54.543] VERBOSE: e2e:e2e_snapshot_sync Deployed CoinIssuer at 0x1649eead62c64db7f63182989c8c41ab25025c21 15:48:54 [15:48:54.544] VERBOSE: e2e:e2e_snapshot_sync Waiting for deployments to complete 15:48:54 [15:48:54.544] INFO: e2e:e2e_snapshot_sync Waiting for 7 transactions to be mined... 15:49:02 [15:49:02.574] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 15:49:02 [15:49:02.589] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xc033579f2357cfd2f6fa38d1ef9986415f4ed794add3fff64984bc3f1257e970 {"gasLimit":100000,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:49:02 [15:49:02.590] VERBOSE: e2e:e2e_snapshot_sync Added coin issuer 0x1649eead62c64db7f63182989c8c41ab25025c21 as minter on fee asset in 0xc033579f2357cfd2f6fa38d1ef9986415f4ed794add3fff64984bc3f1257e970 15:49:02 [15:49:02.621] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xd6a54e4eed6f07d2b8dcaafbd3883b3558583e43612f444af113d489245a2bb1 {"gasLimit":56661,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:49:02 [15:49:02.665] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xa67ff7f4001dc5703375e116caba00222d15ec13472e10af8018f62318b463cb {"gasLimit":344517,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:49:02 [15:49:02.666] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x3607dbAfDe17871E0D6A8f929151C30b83510D39 in tx 0xa67ff7f4001dc5703375e116caba00222d15ec13472e10af8018f62318b463cb. 15:49:02 [15:49:02.666] VERBOSE: e2e:e2e_snapshot_sync Deployed FeeAssetHandler at 0x3607dbafde17871e0d6a8f929151c30b83510d39 15:49:02 [15:49:02.686] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xa32bc1b02f5f02b41626611ec0e0056cad989330fbf908181b5d4f7678377aae {"gasLimit":56804,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:49:02 [15:49:02.686] VERBOSE: e2e:e2e_snapshot_sync Added fee asset handler 0x3607dbafde17871e0d6a8f929151c30b83510d39 as minter on fee asset in 0xa32bc1b02f5f02b41626611ec0e0056cad989330fbf908181b5d4f7678377aae 15:49:02 [15:49:02.722] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xadb884185b00b3cf3fb2aac4753fbbc2bbb58dfbab2a937d61ea0e950d96b91b {"gasLimit":2514669,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:49:02 [15:49:02.726] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x499C89D6b68cBdcA67C96Bff13Eb5B5a8fDb25a2 in tx 0xadb884185b00b3cf3fb2aac4753fbbc2bbb58dfbab2a937d61ea0e950d96b91b. 15:49:02 [15:49:02.728] VERBOSE: e2e:e2e_snapshot_sync Deployed StakingAssetHandler at 0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2 15:49:02 [15:49:02.750] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x2b32bbf996c6d3500330bc3ce74137b03f19074efe8ad0d3e14e6dea009f12e4 {"gasLimit":56804,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 15:49:02 [15:49:02.750] VERBOSE: e2e:e2e_snapshot_sync Added staking asset handler 0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2 as minter on staking asset in 0x2b32bbf996c6d3500330bc3ce74137b03f19074efe8ad0d3e14e6dea009f12e4 15:49:02 [15:49:02.750] VERBOSE: e2e:e2e_snapshot_sync Waiting for deployments to complete 15:49:02 [15:49:02.750] INFO: e2e:e2e_snapshot_sync Waiting for 9 transactions to be mined... 15:49:10 [15:49:10.769] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 15:49:10 [15:49:10.787] VERBOSE: e2e:e2e_snapshot_sync Deployed shared contracts 15:49:10 [15:49:10.817] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x1f3bf003fea3920e27f0ab1b5a7c080b356836c498ba06ccbbb2f38e05cac9a5 {"gasLimit":84823,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 15:49:10 [15:49:10.817] VERBOSE: e2e:e2e_snapshot_sync Funded reward distributor with 10000000000000000000000000 fee asset in 0x1f3bf003fea3920e27f0ab1b5a7c080b356836c498ba06ccbbb2f38e05cac9a5 15:49:10 [15:49:10.836] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x8ddfc36dd291a7e69dbb1d1c4b25283f53b9e73f733772b984e1b7cef75ca71d {"gasLimit":154658,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 15:49:10 [15:49:10.837] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x277E22B0C9698d7f2A1cD7C6d857511617587309 in tx 0x8ddfc36dd291a7e69dbb1d1c4b25283f53b9e73f733772b984e1b7cef75ca71d. 15:49:10 [15:49:10.837] VERBOSE: e2e:e2e_snapshot_sync Rollup will use the mock verifier at 0x277e22b0c9698d7f2a1cd7c6d857511617587309 15:49:10 [15:49:10.837] VERBOSE: e2e:e2e_snapshot_sync Rollup config args {"aztecSlotDuration":16,"aztecEpochDuration":64,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 15:49:10 [15:49:10.853] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x1244dd983dfa48995970c0afd0fb79b5391ff919edd2ee7939902fc973eec3e1 {"gasLimit":86992,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 15:49:10 [15:49:10.853] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xbba8820C80d584aEc2Cb092C3a0bE628aAB41fe3 in tx 0x1244dd983dfa48995970c0afd0fb79b5391ff919edd2ee7939902fc973eec3e1. 15:49:10 [15:49:10.892] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x0785920f3b1808bbb32fbbb9fc7abf594c7e8c615f21bf1b26859927d6d53edc {"gasLimit":6301243,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 15:49:10 [15:49:10.892] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x0130CEd3370Af8E822F3D9076177E04F1cA75D3e in tx 0x0785920f3b1808bbb32fbbb9fc7abf594c7e8c615f21bf1b26859927d6d53edc. 15:49:10 [15:49:10.893] VERBOSE: e2e:e2e_snapshot_sync Awaiting for linked libraries to be deployed 15:49:18 [15:49:18.964] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x9fab5e6c50f35cd07081c2daeda39149173d779c0a11b5d0ff94cbe4e3c8ec3e {"gasLimit":11236180,"maxFeePerGas":"3.44200128","maxPriorityFeePerGas":"2.0736"} 15:49:18 [15:49:18.964] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x95a09E7Be6254EbFc5A54b60118c1A92C5e2EA9A in tx 0x9fab5e6c50f35cd07081c2daeda39149173d779c0a11b5d0ff94cbe4e3c8ec3e. 15:49:18 [15:49:18.965] VERBOSE: e2e:e2e_snapshot_sync Deployed Rollup at 0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a {"aztecSlotDuration":16,"aztecEpochDuration":64,"targetCommitteeSize":48,"aztecProofSubmissionWindow":64,"slashingQuorum":6,"slashingRoundSize":10,"manaTarget":10000000000,"provingCostPerMana":100,"rewardConfig":{"sequencerBps":5000,"increment":200000,"maxScore":5000000,"a":5000,"k":1000000,"minimum":100000}} 15:49:18 [15:49:18.965] INFO: e2e:e2e_snapshot_sync Waiting for 11 transactions to be mined... 15:49:26 [15:49:26.978] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 15:49:26 [15:49:26.979] VERBOSE: e2e:e2e_snapshot_sync All core contracts have been deployed 15:49:26 [15:49:26.997] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x5448ec3a811591d1ca1d7fbf4a585dfa123458c85092357c4a6d019b7d652097 {"gasLimit":1056496,"maxFeePerGas":"3.747782171","maxPriorityFeePerGas":"2.48832"} 15:49:26 [15:49:26.997] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x5DC1d6631848a79dBf3d23f32eD2865EA58f4568 in tx 0x5448ec3a811591d1ca1d7fbf4a585dfa123458c85092357c4a6d019b7d652097. 15:49:26 [15:49:26.997] VERBOSE: e2e:e2e_snapshot_sync Deployed SlashFactory at 0x5dc1d6631848a79dbf3d23f32ed2865ea58f4568 15:49:27 [15:49:27.023] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x354bdda96e2bb91663c0f88ffd862e168b6a5c33e643381624cfe8945ea6614d {"gasLimit":116846,"maxFeePerGas":"3.747782171","maxPriorityFeePerGas":"2.48832"} 15:49:27 [15:49:27.023] VERBOSE: e2e:e2e_snapshot_sync Adding rollup 0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a to registry 0x992d1f24cc5f368188d936cf0b2a111cee586d4e in tx 0x354bdda96e2bb91663c0f88ffd862e168b6a5c33e643381624cfe8945ea6614d 15:49:27 [15:49:27.039] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x3ba8ff811238e8c53c6b7c88d6d649e3c83c571e0fe001c22e7bbe9d995d8f20 {"gasLimit":109478,"maxFeePerGas":"3.747782171","maxPriorityFeePerGas":"2.48832"} 15:49:27 [15:49:27.039] VERBOSE: e2e:e2e_snapshot_sync Adding rollup 0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a to GSE 0xad2120681b02de3e9b8afd325977cdeddf15f01c in tx 0x3ba8ff811238e8c53c6b7c88d6d649e3c83c571e0fe001c22e7bbe9d995d8f20 15:49:35 [15:49:35.048] INFO: e2e:e2e_snapshot_sync Waiting for 12 transactions to be mined... 15:49:35 [15:49:35.096] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 15:49:35 [15:49:35.105] VERBOSE: e2e:e2e_snapshot_sync Rollup deployed 15:49:35 [15:49:35.105] VERBOSE: e2e:e2e_snapshot_sync Waiting for rollup and slash factory to be deployed 15:49:35 [15:49:35.106] INFO: e2e:e2e_snapshot_sync Waiting for 12 transactions to be mined... 15:49:35 [15:49:35.150] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 15:49:35 [15:49:35.150] VERBOSE: e2e:e2e_snapshot_sync All transactions for L1 deployment have been mined 15:49:35 [15:49:35.173] INFO: e2e:e2e_snapshot_sync Aztec L1 contracts initialized {"registryAddress":"0x992d1f24cc5f368188d936cf0b2a111cee586d4e","governanceAddress":"0x506150cab49dbc09c8b79d20ac5c79ca28220aea","governanceProposerAddress":"0xfdb60896b1920a10fd3aa268a292e51ebd5568a8","rollupAddress":"0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a","inboxAddress":"0xb07029f24e033a765cd9ed26be66e4b427c76191","outboxAddress":"0xce822e10d21283a1bdff93bc0ca28868be347d6d","feeJuicePortalAddress":"0x12416d2875c3a1bb68bdd5f2f4d0fbc30afa5600","feeJuiceAddress":"0xd8b56421e9b573ae62f2997b7b58858a4413a967","stakingAssetAddress":"0x026208fee3f4461826c8838c3569272e8c08e131","rewardDistributorAddress":"0xd462e23c2c8a9b4f83de76004a170d4cebb5d3e1","gseAddress":"0xad2120681b02de3e9b8afd325977cdeddf15f01c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 15:49:35 [15:49:35.174] INFO: e2e:e2e_snapshot_sync Handing over to governance 15:49:35 [15:49:35.178] INFO: e2e:e2e_snapshot_sync Calling evm_setNextBlockTimestamp with params: [1749743382] 15:49:35 [15:49:35.179] INFO: e2e:e2e_snapshot_sync Calling hardhat_mine with params: [1] 15:49:35 [15:49:35.182] INFO: e2e:e2e_snapshot_sync Jumped to slot 1 15:49:35 [15:49:35.189] INFO: aztecjs:utils:watcher Watcher not started because not auto mining 15:49:35 [15:49:35.190] INFO: telemetry:client Using NoopTelemetryClient 15:49:35 [15:49:35.193] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/3be6ee64dce6bf25/blob-sink with map size 134217728 KB (LMDB v2) 15:49:35 [15:49:35.197] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 15:49:35 [15:49:35.212] INFO: blob-sink:server Server is running on http://localhost:35071 15:49:35 [15:49:35.250] VERBOSE: e2e:e2e_snapshot_sync Creating and synching an aztec node... 15:49:35 [15:49:35.255] VERBOSE: e2e:e2e_snapshot_sync Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/dbe42089/acvm 15:49:35 [15:49:35.261] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:35071"} 15:49:35 [15:49:35.380] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 15:49:35 [15:49:35.385] INFO: archiver:lmdb Creating archiver data store at directory /tmp/3be6ee64dce6bf25/archiver with map size 134217728 KB (LMDB v2) 15:49:35 [15:49:35.388] INFO: archiver:lmdb Starting data store with maxReaders 16 15:49:36 [15:49:36.337] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:35071"} 15:49:36 [15:49:36.363] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:35071"} 15:49:36 [15:49:36.364] WARN: node:blob-sink:client No L1 consensus host urls configured 15:49:36 [15:49:36.364] WARN: node:blob-sink:client No archive client configured 15:49:36 [15:49:36.373] INFO: archiver Starting archiver sync to rollup contract 0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a from L1 block 4 to current L1 block 6 with hash 0x5396974ddb7c5744571a22f0d74564c7122757c38f18fe1e4477bb4531d04a5d {"blocksSynchedTo":4,"messagesSynchedTo":{"l1BlockHash":"0x236d9b1f4945c0acf9dfbce8b4d1b305a53c288c6fd9e06e34840b0882dd330a","l1BlockNumber":4}} 15:49:36 [15:49:36.397] INFO: archiver Initial archiver sync to L1 block 6 complete. {"l1BlockNumber":6,"syncPoint":{"blocksSynchedTo":6,"messagesSynchedTo":{"l1BlockHash":"0x5396974ddb7c5744571a22f0d74564c7122757c38f18fe1e4477bb4531d04a5d","l1BlockNumber":6}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 15:49:36 [15:49:36.406] INFO: world-state:database Creating world state data store at directory /tmp/3be6ee64dce6bf25/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:49:36 [15:49:36.440] INFO: world_state Created world state synchroniser with block history of 64 15:49:36 [15:49:36.441] WARN: node Aztec node is accepting fake proofs 15:49:36 [15:49:36.460] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/3be6ee64dce6bf25/p2p with map size 134217728 KB (LMDB v2) 15:49:36 [15:49:36.465] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 15:49:36 [15:49:36.469] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/3be6ee64dce6bf25/p2p-archive with map size 134217728 KB (LMDB v2) 15:49:36 [15:49:36.472] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 15:49:36 [15:49:36.475] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/3be6ee64dce6bf25/p2p-peers with map size 134217728 KB (LMDB v2) 15:49:36 [15:49:36.478] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 15:49:36 [15:49:36.482] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:49:36 [15:49:36.483] VERBOSE: p2p P2P is disabled. Using dummy P2P service 15:49:36 [15:49:36.487] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:49:36 [15:49:36.488] INFO: world_state Started world state synchronizer from block 1 15:49:36 [15:49:36.493] VERBOSE: world-state:block_stream Starting sync from block number 0 15:49:36 [15:49:36.496] INFO: p2p Starting p2p client from block 0 with empty mempools 15:49:36 [15:49:36.496] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 15:49:36 [15:49:36.871] INFO: epoch-prune-watcher EpochPruneWatcher initialized 15:49:36 [15:49:36.910] VERBOSE: validator Initialized validator with addresses: 0xa26c9210ea7ecebd77dfacb00a5d6cec0577880e 15:49:36 [15:49:36.911] VERBOSE: node All Aztec Node subsystems synced 15:49:36 [15:49:36.921] INFO: slasher Starting Slasher client... 15:49:36 [15:49:36.932] INFO: sequencer-client Deploying forwarder contract 15:49:36 [15:49:36.934] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 15:49:36 [15:49:36.964] VERBOSE: sequencer-client Sent L1 transaction 0xda888973b4ad2d3d163799c42065a89b2c05bcb621343d65d24f9b27b4d854fa {"gasLimit":323704,"maxFeePerGas":"2.259597543","maxPriorityFeePerGas":"1.2"} 15:49:36 [15:49:36.965] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0xda888973b4ad2d3d163799c42065a89b2c05bcb621343d65d24f9b27b4d854fa. 15:49:44 [15:49:44.990] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 15:49:45 [15:49:45.011] INFO: validator Started validator with addresses: 0xa26c9210ea7ecebd77dfacb00a5d6cec0577880e 15:49:45 [15:49:45.012] VERBOSE: validator Validators 0xa26c9210ea7ecebd77dfacb00a5d6cec0577880e are not on the validator committee for epoch 0 15:49:45 [15:49:45.012] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":0,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/dbe42089/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":8,"enforceTimeTable":false} 15:49:45 [15:49:45.012] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 15:49:45 [15:49:45.014] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 15:49:45 [15:49:45.014] INFO: node Aztec Node version: 0.87.6 15:49:45 [15:49:45.015] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x992d1f24cc5f368188d936cf0b2a111cee586d4e","governanceAddress":"0x506150cab49dbc09c8b79d20ac5c79ca28220aea","governanceProposerAddress":"0xfdb60896b1920a10fd3aa268a292e51ebd5568a8","rollupAddress":"0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a","inboxAddress":"0xb07029f24e033a765cd9ed26be66e4b427c76191","outboxAddress":"0xce822e10d21283a1bdff93bc0ca28868be347d6d","feeJuicePortalAddress":"0x12416d2875c3a1bb68bdd5f2f4d0fbc30afa5600","feeJuiceAddress":"0xd8b56421e9b573ae62f2997b7b58858a4413a967","stakingAssetAddress":"0x026208fee3f4461826c8838c3569272e8c08e131","rewardDistributorAddress":"0xd462e23c2c8a9b4f83de76004a170d4cebb5d3e1","gseAddress":"0xad2120681b02de3e9b8afd325977cdeddf15f01c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x5dc1d6631848a79dbf3d23f32ed2865ea58f4568","feeAssetHandlerAddress":"0x3607dbafde17871e0d6a8f929151c30b83510d39","stakingAssetHandlerAddress":"0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 15:49:45 [15:49:45.015] VERBOSE: e2e:e2e_snapshot_sync Creating a pxe... 15:49:45 [15:49:45.021] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/5b3c0d0e3792b9e3/pxe_data with map size 134217728 KB (LMDB v2) 15:49:45 [15:49:45.024] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 15:49:45 [15:49:45.027] INFO: pxe:data:lmdb Starting data store with maxReaders 16 15:49:45 [15:49:45.476] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 15:49:45 [15:49:45.477] INFO: pxe:service Started PXE connected to chain 31337 version 1923106030 15:49:45 [15:49:45.481] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync waits until a few L2 blocks have been mined and purges blobs 15:49:45 [15:49:45.481] WARN: e2e:e2e_snapshot_sync Waiting for L2 blocks to be mined 15:49:45 [15:49:45.534] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 15:49:45 [15:49:45.703] INFO: e2e:e2e_snapshot_sync L1 block 7 mined at 15:49:50 with new L2 block 0 for epoch 0 with proof up to L2 block 0 for epoch 0 {"l1Timestamp":1749743390,"l1BlockNumber":7,"l2SlotNumber":1,"l2BlockNumber":0,"l2ProvenBlockNumber":0,"totalL2Messages":0} 15:49:46 [15:49:46.044] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 15:49:46 [15:49:46.552] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 15:49:47 [15:49:47.061] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 15:49:47 [15:49:47.568] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 15:49:48 [15:49:48.075] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 15:49:48 [15:49:48.582] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 15:49:49 [15:49:49.091] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 15:49:49 [15:49:49.598] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 15:49:50 [15:49:50.095] INFO: e2e:e2e_snapshot_sync L1 block 8 mined at 15:49:58 {"l1Timestamp":1749743398,"l1BlockNumber":8,"l2SlotNumber":2,"l2BlockNumber":0,"l2ProvenBlockNumber":0,"totalL2Messages":0} 15:49:50 [15:49:50.111] VERBOSE: sequencer Preparing proposal for block 1 at slot 2 {"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749743398,"version":1923106030},"chainTipArchive":"0x1f9c798be7975bb34c3e605a4c92c75796eae7b9a08644bc9a6a55354ed470be","blockNumber":1,"slot":2} 15:49:50 [15:49:50.127] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-12T15:49:58.000Z","now":"2025-06-12T15:49:50.127Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 15:49:50 [15:49:50.132] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.0014614740000033636s {"duration":0.0014614740000033636,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 15:49:50 [15:49:50.153] INFO: sequencer Built block 1 for slot 2 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x0323910d906adbc04be482a40e1ac9892a965b761b273d70061521e36ff4ceea","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749743398,"version":1923106030},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":34.60420399999566,"publicProcessDuration":2.3921810000028927,"rollupCircuitsDuration":26.804936000000453,"txCount":0,"blockNumber":1,"blockTimestamp":1749743398,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:49:50 [15:49:50.156] VERBOSE: sequencer Attesting committee is empty 15:49:52 [15:49:52.805] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x88bba01cc022f081be8e0b31100713d9af2565a5473857454a46c3ad752304bd 15:49:52 [15:49:52.805] VERBOSE: node Sent L1 transaction 0x88bba01cc022f081be8e0b31100713d9af2565a5473857454a46c3ad752304bd {"gasLimit":485800,"maxFeePerGas":"2.013314732","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:49:58 [15:49:58.106] INFO: e2e:e2e_snapshot_sync L1 block 9 mined at 15:50:06 with new L2 block 1 for epoch 0 {"l1Timestamp":1749743406,"l1BlockNumber":9,"l2SlotNumber":2,"l2BlockNumber":1,"l2ProvenBlockNumber":0,"totalL2Messages":0} 15:49:58 [15:49:58.229] WARN: node:blob-sink:client Unable to get blob sidecar for 0x6047404955a255e154b575fe7c1b4b2cd29bc328308ce695eb348d94ea7236b9: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 15:49:58 [15:49:58.229] WARN: node:blob-sink:client Failed to fetch blobs for 0x6047404955a255e154b575fe7c1b4b2cd29bc328308ce695eb348d94ea7236b9 from all blob sources {"blobSinkUrl":"http://localhost:35071"} 15:49:58 [15:49:58.767] WARN: node:blob-sink:client Unable to get blob sidecar for 0x6047404955a255e154b575fe7c1b4b2cd29bc328308ce695eb348d94ea7236b9: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 15:49:58 [15:49:58.767] WARN: node:blob-sink:client Failed to fetch blobs for 0x6047404955a255e154b575fe7c1b4b2cd29bc328308ce695eb348d94ea7236b9 from all blob sources {"blobSinkUrl":"http://localhost:35071"} 15:49:58 [15:49:58.864] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:49:58 [15:49:58.866] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x88bba01cc022f081be8e0b31100713d9af2565a5473857454a46c3ad752304bd","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":1,"blockTimestamp":1749743398,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:49:58 [15:49:58.867] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:49:58 [15:49:58.883] INFO: blob-sink:server Received blob sidecar for block 0x6047404955a255e154b575fe7c1b4b2cd29bc328308ce695eb348d94ea7236b9 15:49:58 [15:49:58.904] INFO: blob-sink:server Blob sidecar stored successfully for block 0x6047404955a255e154b575fe7c1b4b2cd29bc328308ce695eb348d94ea7236b9 15:49:59 [15:49:59.346] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x0323910d906adbc04be482a40e1ac9892a965b761b273d70061521e36ff4ceea","blockNumber":1,"txCount":0,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749743398,"version":1923106030},"archiveRoot":"0x1f261cbfb0e371080756773843906ea58d98d5c6b60438057d4ccaf23e9ebd19","archiveNextLeafIndex":2} 15:49:59 [15:49:59.454] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.5405700000119396,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":1,"blockTimestamp":1749743398,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:49:59 [15:49:59.461] VERBOSE: p2p Synched to latest block 1 15:49:59 [15:49:59.906] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:00 [15:50:00.415] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:00 [15:50:00.924] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:01 [15:50:01.432] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:01 [15:50:01.943] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:02 [15:50:02.453] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:02 [15:50:02.962] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:03 [15:50:03.470] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:03 [15:50:03.980] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:04 [15:50:04.489] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:04 [15:50:04.997] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:05 [15:50:05.505] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 15:50:06 [15:50:06.017] VERBOSE: sequencer Preparing proposal for block 2 at slot 3 {"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749743414,"version":1923106030},"chainTipArchive":"0x1f261cbfb0e371080756773843906ea58d98d5c6b60438057d4ccaf23e9ebd19","blockNumber":2,"slot":3} 15:50:06 [15:50:06.026] VERBOSE: block-builder Building block 2 for slot 3 {"slot":3,"slotStart":"2025-06-12T15:50:14.000Z","now":"2025-06-12T15:50:06.026Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 15:50:06 [15:50:06.027] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.00017737200000556187s {"duration":0.00017737200000556187,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 15:50:06 [15:50:06.038] INFO: sequencer Built block 2 for slot 3 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x1aa93a9ab588b1bb8a3f676846ae2d6560db3e67691d5fc7908e8f97648881ae","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749743414,"version":1923106030},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":17.007147000011173,"publicProcessDuration":0.4074689999979455,"rollupCircuitsDuration":12.565744000006816,"txCount":0,"blockNumber":2,"blockTimestamp":1749743414,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:06 [15:50:06.040] VERBOSE: sequencer Attesting committee is empty 15:50:06 [15:50:06.109] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x89142b971157913d9919b36f2d301dc39292e4b0d328fb5882f924ffa85d9ebd 15:50:06 [15:50:06.109] VERBOSE: node Sent L1 transaction 0x89142b971157913d9919b36f2d301dc39292e4b0d328fb5882f924ffa85d9ebd {"gasLimit":414577,"maxFeePerGas":"1.824718914","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:50:06 [15:50:06.125] INFO: e2e:e2e_snapshot_sync L1 block 10 mined at 15:50:14 {"l1Timestamp":1749743414,"l1BlockNumber":10,"l2SlotNumber":3,"l2BlockNumber":1,"l2ProvenBlockNumber":0,"totalL2Messages":0} 15:50:14 [15:50:14.190] INFO: e2e:e2e_snapshot_sync L1 block 11 mined at 15:50:22 with new L2 block 2 for epoch 0 {"l1Timestamp":1749743422,"l1BlockNumber":11,"l2SlotNumber":3,"l2BlockNumber":2,"l2ProvenBlockNumber":0,"totalL2Messages":0} 15:50:14 [15:50:14.203] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:50:14 [15:50:14.203] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x89142b971157913d9919b36f2d301dc39292e4b0d328fb5882f924ffa85d9ebd","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":2,"blockTimestamp":1749743414,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:14 [15:50:14.204] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:50:14 [15:50:14.241] INFO: blob-sink:server Received blob sidecar for block 0x19526686042bc1dc148ad735b46d53cdb83bbbc55f2d60f7dba564bd4b86b517 15:50:14 [15:50:14.251] WARN: node:blob-sink:client Unable to get blob sidecar for 0x19526686042bc1dc148ad735b46d53cdb83bbbc55f2d60f7dba564bd4b86b517: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 15:50:14 [15:50:14.252] WARN: node:blob-sink:client Failed to fetch blobs for 0x19526686042bc1dc148ad735b46d53cdb83bbbc55f2d60f7dba564bd4b86b517 from all blob sources {"blobSinkUrl":"http://localhost:35071"} 15:50:14 [15:50:14.253] INFO: blob-sink:server Blob sidecar stored successfully for block 0x19526686042bc1dc148ad735b46d53cdb83bbbc55f2d60f7dba564bd4b86b517 15:50:14 [15:50:14.750] WARN: sequencer:publisher Failed canProposeAtTime check with InvalidArchive 15:50:14 error: "Rollup__InvalidArchive(0x09439b23787b58351fce9909f1400961fb656e475933ee839562b865fd9bfcfa, 0x1f261cbfb0e371080756773843906ea58d98d5c6b60438057d4ccaf23e9ebd19)" 15:50:14 [15:50:14.751] WARN: sequencer Cannot propose block 2 at slot 3 due to failed rollup contract check 15:50:14 [15:50:14.795] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x1aa93a9ab588b1bb8a3f676846ae2d6560db3e67691d5fc7908e8f97648881ae","blockNumber":2,"txCount":0,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749743414,"version":1923106030},"archiveRoot":"0x09439b23787b58351fce9909f1400961fb656e475933ee839562b865fd9bfcfa","archiveNextLeafIndex":3} 15:50:14 [15:50:14.884] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":12.960909000001266,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":2,"blockTimestamp":1749743414,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:14 [15:50:14.885] VERBOSE: p2p Synched to latest block 2 15:50:15 [15:50:15.269] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:15 [15:50:15.784] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:16 [15:50:16.293] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:16 [15:50:16.803] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:17 [15:50:17.313] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:17 [15:50:17.825] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:18 [15:50:18.365] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:18 [15:50:18.883] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:19 [15:50:19.400] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:19 [15:50:19.915] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:20 [15:50:20.425] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:20 [15:50:20.934] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:21 [15:50:21.443] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:21 [15:50:21.960] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 15:50:22 [15:50:22.156] INFO: e2e:e2e_snapshot_sync L1 block 12 mined at 15:50:30 {"l1Timestamp":1749743430,"l1BlockNumber":12,"l2SlotNumber":4,"l2BlockNumber":2,"l2ProvenBlockNumber":0,"totalL2Messages":0} 15:50:22 [15:50:22.476] VERBOSE: sequencer Preparing proposal for block 3 at slot 4 {"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749743430,"version":1923106030},"chainTipArchive":"0x09439b23787b58351fce9909f1400961fb656e475933ee839562b865fd9bfcfa","blockNumber":3,"slot":4} 15:50:22 [15:50:22.490] VERBOSE: block-builder Building block 3 for slot 4 {"slot":4,"slotStart":"2025-06-12T15:50:30.000Z","now":"2025-06-12T15:50:22.490Z","blockNumber":3,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 15:50:22 [15:50:22.495] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.0007382919999945443s {"duration":0.0007382919999945443,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 15:50:22 [15:50:22.510] INFO: sequencer Built block 3 for slot 4 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749743430,"version":1923106030},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":27.288063999993028,"publicProcessDuration":1.499295000001439,"rollupCircuitsDuration":20.892084999999497,"txCount":0,"blockNumber":3,"blockTimestamp":1749743430,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:22 [15:50:22.513] VERBOSE: sequencer Attesting committee is empty 15:50:22 [15:50:22.596] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xbc3e700f43c352c7b0aeab0847b868e3e71ad2b3fde0d67eb15e3791b89009ba 15:50:22 [15:50:22.596] VERBOSE: node Sent L1 transaction 0xbc3e700f43c352c7b0aeab0847b868e3e71ad2b3fde0d67eb15e3791b89009ba {"gasLimit":416977,"maxFeePerGas":"1.679585347","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:50:30 [15:50:30.212] INFO: e2e:e2e_snapshot_sync L1 block 13 mined at 15:50:38 with new L2 block 3 for epoch 0 {"l1Timestamp":1749743438,"l1BlockNumber":13,"l2SlotNumber":4,"l2BlockNumber":3,"l2ProvenBlockNumber":0,"totalL2Messages":0} 15:50:30 [15:50:30.266] WARN: node:blob-sink:client Unable to get blob sidecar for 0x09119aa99dc5e70bd521df9674e392cfbb3f10f03e0a6c9a65da0789186aedb8: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 15:50:30 [15:50:30.266] WARN: node:blob-sink:client Failed to fetch blobs for 0x09119aa99dc5e70bd521df9674e392cfbb3f10f03e0a6c9a65da0789186aedb8 from all blob sources {"blobSinkUrl":"http://localhost:35071"} 15:50:30 [15:50:30.669] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:50:30 [15:50:30.669] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xbc3e700f43c352c7b0aeab0847b868e3e71ad2b3fde0d67eb15e3791b89009ba","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":3,"blockTimestamp":1749743430,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:30 [15:50:30.670] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:50:30 [15:50:30.673] INFO: blob-sink:server Received blob sidecar for block 0x09119aa99dc5e70bd521df9674e392cfbb3f10f03e0a6c9a65da0789186aedb8 15:50:30 [15:50:30.685] INFO: blob-sink:server Blob sidecar stored successfully for block 0x09119aa99dc5e70bd521df9674e392cfbb3f10f03e0a6c9a65da0789186aedb8 15:50:30 [15:50:30.827] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1","blockNumber":3,"txCount":0,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749743430,"version":1923106030},"archiveRoot":"0x2098c55547fa819bea132d8da49ca74a999bc5ec5646b8382f43be34e93d1825","archiveNextLeafIndex":4} 15:50:30 [15:50:30.848] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":4.696238999997149,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":3,"blockTimestamp":1749743430,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:30 [15:50:30.906] VERBOSE: p2p Synched to latest block 3 15:50:31 [15:50:31.204] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:31 [15:50:31.716] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:32 [15:50:32.226] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:32 [15:50:32.736] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:33 [15:50:33.245] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:33 [15:50:33.757] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:34 [15:50:34.266] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:34 [15:50:34.779] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:35 [15:50:35.295] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:35 [15:50:35.815] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:36 [15:50:36.332] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:36 [15:50:36.842] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:37 [15:50:37.353] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:37 [15:50:37.863] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 15:50:38 [15:50:38.227] INFO: e2e:e2e_snapshot_sync L1 block 14 mined at 15:50:46 {"l1Timestamp":1749743446,"l1BlockNumber":14,"l2SlotNumber":5,"l2BlockNumber":3,"l2ProvenBlockNumber":0,"totalL2Messages":0} 15:50:38 [15:50:38.384] VERBOSE: sequencer Preparing proposal for block 4 at slot 5 {"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749743446,"version":1923106030},"chainTipArchive":"0x2098c55547fa819bea132d8da49ca74a999bc5ec5646b8382f43be34e93d1825","blockNumber":4,"slot":5} 15:50:38 [15:50:38.405] VERBOSE: block-builder Building block 4 for slot 5 {"slot":5,"slotStart":"2025-06-12T15:50:46.000Z","now":"2025-06-12T15:50:38.405Z","blockNumber":4,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 15:50:38 [15:50:38.409] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.0015535290000116219s {"duration":0.0015535290000116219,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 15:50:38 [15:50:38.431] INFO: sequencer Built block 4 for slot 5 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x05ec32ad1e5581f85e2787373cf037b225f9c51c056c3fcc99c205395516aa61","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749743446,"version":1923106030},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":39.79792300000554,"publicProcessDuration":2.0804360000038287,"rollupCircuitsDuration":30.974763000005623,"txCount":0,"blockNumber":4,"blockTimestamp":1749743446,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:38 [15:50:38.435] VERBOSE: sequencer Attesting committee is empty 15:50:38 [15:50:38.525] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xcd6f1706d2d4fc3fd2a01de0dc971e1c5b0b4a064a9d627e2fc5bca59294e672 15:50:38 [15:50:38.526] VERBOSE: node Sent L1 transaction 0xcd6f1706d2d4fc3fd2a01de0dc971e1c5b0b4a064a9d627e2fc5bca59294e672 {"gasLimit":416989,"maxFeePerGas":"1.568175943","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 15:50:46 [15:50:46.153] WARN: node:blob-sink:client Unable to get blob sidecar for 0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 15:50:46 [15:50:46.154] WARN: node:blob-sink:client Failed to fetch blobs for 0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066 from all blob sources {"blobSinkUrl":"http://localhost:35071"} 15:50:46 [15:50:46.234] INFO: e2e:e2e_snapshot_sync L1 block 15 mined at 15:50:54 with new L2 block 4 for epoch 0 {"l1Timestamp":1749743454,"l1BlockNumber":15,"l2SlotNumber":5,"l2BlockNumber":4,"l2ProvenBlockNumber":0,"totalL2Messages":0} 15:50:46 [15:50:46.523] WARN: e2e:e2e_snapshot_sync L2 block height is now 4. Purging all blobs from sink so snapshot is required. 15:50:46 [15:50:46.527] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync creates a snapshot 15:50:46 [15:50:46.527] WARN: e2e:e2e_snapshot_sync Creating snapshot 15:50:46 [15:50:46.530] INFO: stdlib:file-store Creating local file file store at /tmp/snapshots-WfFdTk 15:50:46 [15:50:46.531] INFO: node Pausing archiver and world state sync to start snapshot upload 15:50:46 [15:50:46.532] INFO: archiver Stopped. 15:50:46 [15:50:46.532] INFO: world_state Stopped sync 15:50:46 [15:50:46.532] INFO: node Creating backups of lmdb environments to /tmp/3be6ee64dce6bf25/snapshot-1mnr3W 15:50:46 [15:50:46.535] INFO: node Data stores backed up to /tmp/3be6ee64dce6bf25/snapshot-1mnr3W {"paths":{"l1-to-l2-message-tree":"/tmp/3be6ee64dce6bf25/snapshot-1mnr3W/world-state/L1ToL2MessageTree/data.mdb","archive-tree":"/tmp/3be6ee64dce6bf25/snapshot-1mnr3W/world-state/ArchiveTree/data.mdb","public-data-tree":"/tmp/3be6ee64dce6bf25/snapshot-1mnr3W/world-state/PublicDataTree/data.mdb","note-hash-tree":"/tmp/3be6ee64dce6bf25/snapshot-1mnr3W/world-state/NoteHashTree/data.mdb","nullifier-tree":"/tmp/3be6ee64dce6bf25/snapshot-1mnr3W/world-state/NullifierTree/data.mdb","archiver":"/tmp/3be6ee64dce6bf25/snapshot-1mnr3W/archiver/data.mdb"}} 15:50:46 [15:50:46.536] INFO: node Resuming archiver and world state sync 15:50:46 [15:50:46.536] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:50:46 [15:50:46.537] INFO: world_state Resumed sync 15:50:46 [15:50:46.537] INFO: archiver Restarting archiver 15:50:46 [15:50:46.550] INFO: node Uploading snapshot to file:///tmp/snapshots-WfFdTk {"snapshot":{"l1ChainId":31337,"rollupVersion":1923106030,"rollupAddress":"0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a","l2BlockNumber":3,"l2BlockHash":"0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1","l1BlockNumber":14}} 15:50:46 [15:50:46.576] INFO: node Snapshot uploaded successfully {"snapshot":{"l1BlockNumber":14,"l2BlockHash":"0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1","l2BlockNumber":3,"schemaVersions":{"archiver":2,"worldState":1},"timestamp":1749743446552,"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/l1-to-l2-message-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","archive-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/archive-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","public-data-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/public-data-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","note-hash-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/note-hash-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","nullifier-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/nullifier-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","archiver":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/archiver-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db"}}} 15:50:46 [15:50:46.576] INFO: node Cleaning up backup dir /tmp/3be6ee64dce6bf25/snapshot-1mnr3W 15:50:46 [15:50:46.591] WARN: node:blob-sink:client Unable to get blob sidecar for 0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 15:50:46 [15:50:46.591] WARN: node:blob-sink:client Failed to fetch blobs for 0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066 from all blob sources {"blobSinkUrl":"http://localhost:35071"} 15:50:46 [15:50:46.597] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 15:50:46 [15:50:46.597] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xcd6f1706d2d4fc3fd2a01de0dc971e1c5b0b4a064a9d627e2fc5bca59294e672","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":4,"blockTimestamp":1749743446,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:46 [15:50:46.597] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 15:50:46 [15:50:46.600] INFO: blob-sink:server Received blob sidecar for block 0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066 15:50:46 [15:50:46.604] INFO: blob-sink:server Blob sidecar stored successfully for block 0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066 15:50:47 [15:50:47.131] WARN: sequencer:publisher Failed canProposeAtTime check with InvalidArchive 15:50:47 error: "Rollup__InvalidArchive(0x20047a823f7a25b15b4b2bd0c5a0775125c2b8856a51c01ee8a87c386aad45d1, 0x2098c55547fa819bea132d8da49ca74a999bc5ec5646b8382f43be34e93d1825)" 15:50:47 [15:50:47.132] WARN: sequencer Cannot propose block 4 at slot 5 due to failed rollup contract check 15:50:47 [15:50:47.160] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x05ec32ad1e5581f85e2787373cf037b225f9c51c056c3fcc99c205395516aa61","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749743446,"version":1923106030},"archiveRoot":"0x20047a823f7a25b15b4b2bd0c5a0775125c2b8856a51c01ee8a87c386aad45d1","archiveNextLeafIndex":5} 15:50:47 [15:50:47.272] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":3.6684479999967152,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1749743446,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:47 [15:50:47.273] VERBOSE: p2p Synched to latest block 4 15:50:47 [15:50:47.533] WARN: e2e:e2e_snapshot_sync Snapshot created 15:50:47 [15:50:47.535] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync downloads snapshot when syncing new node 15:50:47 [15:50:47.536] WARN: e2e:e2e_snapshot_sync Syncing brand new node with snapshot sync 15:50:47 [15:50:47.536] WARN: e2e:e2e_snapshot_sync Creating and syncing a node without a validator... 15:50:47 [15:50:47.537] INFO: node:blob-sink:client:1 Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:35071"} 15:50:47 [15:50:47.569] INFO: node:1 Creating local file file store at /tmp/snapshots-WfFdTk 15:50:47 [15:50:47.569] VERBOSE: node:1 Creating temporary archiver data store 15:50:47 [15:50:47.571] INFO: archiver:lmdb:1 Creating archiver data store at directory /tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/archiver with map size 134217728 KB (LMDB v2) 15:50:47 [15:50:47.573] INFO: archiver:lmdb:1 Starting data store with maxReaders 16 15:50:47 [15:50:47.585] VERBOSE: node:1 Closing temporary archiver data store {"archiverL2BlockNumber":0} 15:50:47 [15:50:47.596] INFO: node:1 Syncing from snapshot at L1 block 14 L2 block 3 {"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1","l1BlockNumber":14,"timestamp":1749743446552,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/l1-to-l2-message-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","archive-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/archive-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","public-data-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/public-data-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","note-hash-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/note-hash-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","nullifier-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/nullifier-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","archiver":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/archiver-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db"}},"snapshotsUrl":"file:///tmp/snapshots-WfFdTk"} 15:50:47 [15:50:47.596] INFO: node:1 Creating local file file store at /tmp/snapshots-WfFdTk 15:50:47 [15:50:47.597] INFO: node:1 Downloading snapshot to /tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo {"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1","l1BlockNumber":14,"timestamp":1749743446552,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/l1-to-l2-message-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","archive-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/archive-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","public-data-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/public-data-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","note-hash-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/note-hash-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","nullifier-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/nullifier-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","archiver":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/archiver-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db"}},"downloadPaths":{"archiver":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/archiver.db","nullifier-tree":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/nullifier-tree.db","public-data-tree":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/public-data-tree.db","note-hash-tree":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/note-hash-tree.db","archive-tree":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/archive-tree.db","l1-to-l2-message-tree":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/l1-to-l2-message-tree.db"}} 15:50:47 [15:50:47.603] INFO: node:1 Snapshot downloaded at /tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo {"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1","l1BlockNumber":14,"timestamp":1749743446552,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/l1-to-l2-message-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","archive-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/archive-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","public-data-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/public-data-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","note-hash-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/note-hash-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","nullifier-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/nullifier-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","archiver":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/archiver-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db"}},"downloadPaths":{"archiver":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/archiver.db","nullifier-tree":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/nullifier-tree.db","public-data-tree":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/public-data-tree.db","note-hash-tree":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/note-hash-tree.db","archive-tree":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/archive-tree.db","l1-to-l2-message-tree":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/download-FeKtXo/l1-to-l2-message-tree.db"}} 15:50:47 [15:50:47.607] INFO: node:1 Archiver database set up from snapshot {"path":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/archiver","dbVersion":2,"rollupAddress":"0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a"} 15:50:47 [15:50:47.608] INFO: node:1 World state database l1-to-l2-message-tree set up from snapshot {"path":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/world_state/L1ToL2MessageTree","dbVersion":1,"rollupAddress":"0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a"} 15:50:47 [15:50:47.609] INFO: node:1 World state database archive-tree set up from snapshot {"path":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/world_state/ArchiveTree","dbVersion":1,"rollupAddress":"0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a"} 15:50:47 [15:50:47.609] INFO: node:1 World state database public-data-tree set up from snapshot {"path":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/world_state/PublicDataTree","dbVersion":1,"rollupAddress":"0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a"} 15:50:47 [15:50:47.609] INFO: node:1 World state database note-hash-tree set up from snapshot {"path":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/world_state/NoteHashTree","dbVersion":1,"rollupAddress":"0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a"} 15:50:47 [15:50:47.610] INFO: node:1 World state database nullifier-tree set up from snapshot {"path":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/world_state/NullifierTree","dbVersion":1,"rollupAddress":"0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a"} 15:50:47 [15:50:47.610] INFO: node:1 P2P database cleared {"path":"/tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/p2p"} 15:50:47 [15:50:47.611] INFO: node:1 Snapshot synced to L1 block 14 L2 block 3 {"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1","l1BlockNumber":14,"timestamp":1749743446552,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/l1-to-l2-message-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","archive-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/archive-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","public-data-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/public-data-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","note-hash-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/note-hash-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","nullifier-tree":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/nullifier-tree-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db","archiver":"file:///tmp/snapshots-WfFdTk/aztec-31337-1923106030-0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a/archiver-20250612155046-0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1.db"}}} 15:50:47 [15:50:47.611] INFO: archiver:lmdb:1 Creating archiver data store at directory /tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/archiver with map size 134217728 KB (LMDB v2) 15:50:47 [15:50:47.613] INFO: archiver:lmdb:1 Starting data store with maxReaders 16 15:50:47 [15:50:47.721] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 5 but got 6. {"rollup":[6,5],"newBlockNumber":5,"expectedSlot":5} 15:50:47 [15:50:47.900] INFO: node:blob-sink:client:1 Testing configured blob sources {"blobSinkUrl":"http://localhost:35071"} 15:50:47 [15:50:47.902] INFO: node:blob-sink:client:1 Blob sink is reachable {"blobSinkUrl":"http://localhost:35071"} 15:50:47 [15:50:47.902] WARN: node:blob-sink:client:1 No L1 consensus host urls configured 15:50:47 [15:50:47.902] WARN: node:blob-sink:client:1 No archive client configured 15:50:47 [15:50:47.904] INFO: archiver:1 Starting archiver sync to rollup contract 0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a from L1 block 13 to current L1 block 15 with hash 0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066 {"blocksSynchedTo":13,"messagesSynchedTo":{"l1BlockHash":"0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066","l1BlockNumber":15}} 15:50:47 [15:50:47.945] INFO: archiver:1 Downloaded L2 block 4 {"blockHash":"0x05ec32ad1e5581f85e2787373cf037b225f9c51c056c3fcc99c205395516aa61","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749743446,"version":1923106030},"archiveRoot":"0x20047a823f7a25b15b4b2bd0c5a0775125c2b8856a51c01ee8a87c386aad45d1","archiveNextLeafIndex":5} 15:50:47 [15:50:47.951] INFO: archiver:1 Initial archiver sync to L1 block 15 complete. {"l1BlockNumber":15,"syncPoint":{"blocksSynchedTo":15,"messagesSynchedTo":{"l1BlockHash":"0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066","l1BlockNumber":15}},"latest":{"number":4,"hash":"0x05ec32ad1e5581f85e2787373cf037b225f9c51c056c3fcc99c205395516aa61"},"proven":{"number":0},"finalized":{"number":0}} 15:50:47 [15:50:47.959] INFO: world-state:database:1 Creating world state data store at directory /tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:50:47 [15:50:47.969] INFO: world_state:1 Created world state synchroniser with block history of 64 15:50:47 [15:50:47.969] WARN: node:1 Aztec node is accepting fake proofs 15:50:47 [15:50:47.980] INFO: p2p:lmdb-v2:1 Creating p2p data store at directory /tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/p2p with map size 134217728 KB (LMDB v2) 15:50:47 [15:50:47.994] INFO: p2p:lmdb-v2:1 Starting data store with maxReaders 16 15:50:47 [15:50:47.996] INFO: p2p-archive:lmdb-v2:1 Creating p2p-archive data store at directory /tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/p2p-archive with map size 134217728 KB (LMDB v2) 15:50:48 [15:50:48.000] INFO: p2p-archive:lmdb-v2:1 Starting data store with maxReaders 16 15:50:48 [15:50:48.002] INFO: p2p-peer:lmdb-v2:1 Creating p2p-peers data store at directory /tmp/3be6ee64dce6bf25/2640a3e816ea3ddb/p2p-peers with map size 134217728 KB (LMDB v2) 15:50:48 [15:50:48.003] INFO: p2p-peer:lmdb-v2:1 Starting data store with maxReaders 16 15:50:48 [15:50:48.005] INFO: p2p:tx_pool:1 Setting maximum tx mempool size {"maxTxPoolSize":100000000} 15:50:48 [15:50:48.005] VERBOSE: p2p:1 P2P is disabled. Using dummy P2P service 15:50:48 [15:50:48.007] VERBOSE: world_state:1 Starting sync from 4 to latest block 4 15:50:48 [15:50:48.007] VERBOSE: world-state:block_stream:1 Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:50:48 [15:50:48.007] INFO: world_state:1 Started world state synchronizer from block 4 15:50:48 [15:50:48.010] VERBOSE: world-state:block_stream:1 Starting sync from block number 3 15:50:48 [15:50:48.018] INFO: world_state:1 World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":5.318885000000591,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1749743446,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:48 [15:50:48.022] INFO: p2p:1 Starting p2p client from block 4 with empty mempools 15:50:48 [15:50:48.022] VERBOSE: p2p:l2-block-stream:1 Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":4} 15:50:48 [15:50:48.023] INFO: epoch-prune-watcher:1 EpochPruneWatcher initialized 15:50:48 [15:50:48.023] VERBOSE: node:1 All Aztec Node subsystems synced 15:50:48 [15:50:48.029] INFO: slasher:1 Starting Slasher client... 15:50:48 [15:50:48.031] INFO: node:1 Aztec Node version: 0.87.6 15:50:48 [15:50:48.031] INFO: node:1 Aztec Node started on chain 0x7a69 {"registryAddress":"0x992d1f24cc5f368188d936cf0b2a111cee586d4e","governanceAddress":"0x506150cab49dbc09c8b79d20ac5c79ca28220aea","governanceProposerAddress":"0xfdb60896b1920a10fd3aa268a292e51ebd5568a8","rollupAddress":"0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a","inboxAddress":"0xb07029f24e033a765cd9ed26be66e4b427c76191","outboxAddress":"0xce822e10d21283a1bdff93bc0ca28868be347d6d","feeJuicePortalAddress":"0x12416d2875c3a1bb68bdd5f2f4d0fbc30afa5600","feeJuiceAddress":"0xd8b56421e9b573ae62f2997b7b58858a4413a967","stakingAssetAddress":"0x026208fee3f4461826c8838c3569272e8c08e131","rewardDistributorAddress":"0xd462e23c2c8a9b4f83de76004a170d4cebb5d3e1","gseAddress":"0xad2120681b02de3e9b8afd325977cdeddf15f01c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x5dc1d6631848a79dbf3d23f32ed2865ea58f4568","feeAssetHandlerAddress":"0x3607dbafde17871e0d6a8f929151c30b83510d39","stakingAssetHandlerAddress":"0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 15:50:48 [15:50:48.032] WARN: e2e:e2e_snapshot_sync New node synced 15:50:48 [15:50:48.035] VERBOSE: p2p:l2-block-stream:1 Starting sync from block number 3 15:50:48 [15:50:48.041] WARN: e2e:e2e_snapshot_sync Checking for L2 block 3 with hash 0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1 on both nodes 15:50:48 [15:50:48.042] VERBOSE: p2p:1 Synched to latest block 4 15:50:48 [15:50:48.047] WARN: e2e:e2e_snapshot_sync Stopping new node 15:50:48 [15:50:48.048] INFO: node:1 Stopping Aztec Node 15:50:48 [15:50:48.230] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 5 but got 6. {"rollup":[6,5],"newBlockNumber":5,"expectedSlot":5} 15:50:48 [15:50:48.742] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 5 but got 6. {"rollup":[6,5],"newBlockNumber":5,"expectedSlot":5} 15:50:49 [15:50:49.251] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 5 but got 6. {"rollup":[6,5],"newBlockNumber":5,"expectedSlot":5} 15:50:49 [15:50:49.761] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 5 but got 6. {"rollup":[6,5],"newBlockNumber":5,"expectedSlot":5} 15:50:50 [15:50:50.050] INFO: slasher:1 Slasher client stopped. 15:50:50 [15:50:50.050] INFO: p2p:1 P2P client stopped 15:50:50 [15:50:50.052] INFO: world_state:1 Stopped world state synchronizer 15:50:50 [15:50:50.052] INFO: archiver:1 Stopped. 15:50:50 [15:50:50.052] INFO: node:1 Stopped Aztec Node 15:50:50 [15:50:50.053] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync downloads snapshot when syncing new prover node 15:50:50 [15:50:50.054] WARN: e2e:e2e_snapshot_sync Syncing brand new prover node with snapshot sync 15:50:50 [15:50:50.054] WARN: e2e:e2e_snapshot_sync Creating and syncing a prover node... 15:50:50 [15:50:50.109] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:35071"} 15:50:50 [15:50:50.115] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/3be6ee64dce6bf25/d1e227b47c0df4e7/archiver with map size 134217728 KB (LMDB v2) 15:50:50 [15:50:50.118] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 15:50:50 [15:50:50.322] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 5 but got 6. {"rollup":[6,5],"newBlockNumber":5,"expectedSlot":5} 15:50:50 [15:50:50.394] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:35071"} 15:50:50 [15:50:50.396] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:35071"} 15:50:50 [15:50:50.396] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 15:50:50 [15:50:50.396] WARN: blob-sink:client:prover-node No archive client configured 15:50:50 [15:50:50.398] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x95a09e7be6254ebfc5a54b60118c1a92c5e2ea9a from L1 block 4 to current L1 block 15 with hash 0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066 {"blocksSynchedTo":4,"messagesSynchedTo":{"l1BlockHash":"0x236d9b1f4945c0acf9dfbce8b4d1b305a53c288c6fd9e06e34840b0882dd330a","l1BlockNumber":4}} 15:50:50 [15:50:50.535] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x0323910d906adbc04be482a40e1ac9892a965b761b273d70061521e36ff4ceea","blockNumber":1,"txCount":0,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749743398,"version":1923106030},"archiveRoot":"0x1f261cbfb0e371080756773843906ea58d98d5c6b60438057d4ccaf23e9ebd19","archiveNextLeafIndex":2} 15:50:50 [15:50:50.535] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x1aa93a9ab588b1bb8a3f676846ae2d6560db3e67691d5fc7908e8f97648881ae","blockNumber":2,"txCount":0,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749743414,"version":1923106030},"archiveRoot":"0x09439b23787b58351fce9909f1400961fb656e475933ee839562b865fd9bfcfa","archiveNextLeafIndex":3} 15:50:50 [15:50:50.536] INFO: archiver:prover-node Downloaded L2 block 3 {"blockHash":"0x03e07b434df5f40b3ae627d344c53ea9dacbe101707060c4eeb3f68ef63f86e1","blockNumber":3,"txCount":0,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749743430,"version":1923106030},"archiveRoot":"0x2098c55547fa819bea132d8da49ca74a999bc5ec5646b8382f43be34e93d1825","archiveNextLeafIndex":4} 15:50:50 [15:50:50.536] INFO: archiver:prover-node Downloaded L2 block 4 {"blockHash":"0x05ec32ad1e5581f85e2787373cf037b225f9c51c056c3fcc99c205395516aa61","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749743446,"version":1923106030},"archiveRoot":"0x20047a823f7a25b15b4b2bd0c5a0775125c2b8856a51c01ee8a87c386aad45d1","archiveNextLeafIndex":5} 15:50:50 [15:50:50.541] INFO: archiver:prover-node Initial archiver sync to L1 block 15 complete. {"l1BlockNumber":15,"syncPoint":{"blocksSynchedTo":15,"messagesSynchedTo":{"l1BlockHash":"0x7b6ec5df11af3e1bb8c320f5576a0561130c5c3a664a9eff991bfe168d118066","l1BlockNumber":15}},"latest":{"number":4,"hash":"0x05ec32ad1e5581f85e2787373cf037b225f9c51c056c3fcc99c205395516aa61"},"proven":{"number":0},"finalized":{"number":0}} 15:50:50 [15:50:50.544] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:35071"} 15:50:50 [15:50:50.544] INFO: prover-node:prover-node Creating local file file store at /tmp/snapshots-WfFdTk 15:50:50 [15:50:50.545] VERBOSE: prover-node:prover-node Creating temporary archiver data store 15:50:50 [15:50:50.546] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/3be6ee64dce6bf25/d1e227b47c0df4e7/archiver with map size 134217728 KB (LMDB v2) 15:50:50 [15:50:50.549] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 15:50:50 [15:50:50.552] VERBOSE: prover-node:prover-node Closing temporary archiver data store {"archiverL1BlockNumber":15,"archiverL2BlockNumber":4} 15:50:50 [15:50:50.553] VERBOSE: prover-node:prover-node Skipping non-forced snapshot sync as archiver is already synced to L2 block 4. 15:50:50 [15:50:50.554] VERBOSE: prover-node:prover-node Created archiver and synced to block 4 15:50:50 [15:50:50.559] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/3be6ee64dce6bf25/d1e227b47c0df4e7/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 15:50:50 [15:50:50.584] INFO: world_state:prover-node Created world state synchroniser with block history of 64 15:50:50 [15:50:50.585] VERBOSE: world_state:prover-node Starting sync from 1 to latest block 4 15:50:50 [15:50:50.586] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":100} 15:50:50 [15:50:50.586] INFO: world_state:prover-node Started world state synchronizer from block 1 15:50:50 [15:50:50.588] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 15:50:50 [15:50:50.592] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":2.432491999992635,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":1,"blockTimestamp":1749743398,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:50 [15:50:50.596] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.6472760000033304,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":2,"blockTimestamp":1749743414,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:50 [15:50:50.598] INFO: world_state:prover-node World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.626235000003362,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":3,"blockTimestamp":1749743430,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:50 [15:50:50.604] INFO: world_state:prover-node World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":5.275141000005533,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1749743446,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 15:50:50 [15:50:50.606] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/3be6ee64dce6bf25/d1e227b47c0df4e7/archiver when loading epoch databases, ignoring 15:50:50 [15:50:50.606] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/3be6ee64dce6bf25/d1e227b47c0df4e7/world_state when loading epoch databases, ignoring 15:50:50 [15:50:50.607] INFO: prover-client:proving-broker:prover-node Proving Broker started 15:50:50 [15:50:50.619] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 15:50:50 [15:50:50.620] INFO: e2e:e2e_snapshot_sync:prover-node Created and synced prover node {"publisherAddress":"0x9965507D1a55bcC2695C58ba16FB37d819B0A4dc"} 15:50:50 [15:50:50.621] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 15:50:50 [15:50:50.626] 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/3be6ee64dce6bf25/d1e227b47c0df4e7","l1ChainId":31337,"rollupVersion":1923106030} 15:50:50 [15:50:50.627] WARN: e2e:e2e_snapshot_sync New node prover synced 15:50:50 [15:50:50.627] VERBOSE: prover-node:prover-node Fetching 0 tx hashes for block number 4 from coordination 15:50:50 [15:50:50.628] INFO: prover-node:combined-prover-coordination:prover-node Check for 0 txs found all in the pool 15:50:50 [15:50:50.630] WARN: e2e:e2e_snapshot_sync Stopping new prover node 15:50:50 [15:50:50.631] INFO: prover-node:prover-node Stopping ProverNode 15:50:50 [15:50:50.631] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 15:50:50 [15:50:50.631] INFO: archiver:prover-node Stopped. 15:50:50 [15:50:50.633] INFO: world_state:prover-node Stopped world state synchronizer 15:50:50 [15:50:50.633] INFO: prover-node:prover-node Stopped ProverNode 15:50:50 [15:50:50.636] INFO: node Stopping Aztec Node 15:50:50 [15:50:50.832] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 5 but got 6. {"rollup":[6,5],"newBlockNumber":5,"expectedSlot":5} 15:50:51 [15:50:51.339] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 5 but got 6. {"rollup":[6,5],"newBlockNumber":5,"expectedSlot":5} 15:50:51 [15:50:51.851] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 5 but got 6. {"rollup":[6,5],"newBlockNumber":5,"expectedSlot":5} 15:50:52 [15:50:52.361] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 5 but got 6. {"rollup":[6,5],"newBlockNumber":5,"expectedSlot":5} 15:50:52 [15:50:52.637] INFO: slasher Slasher client stopped. 15:50:52 [15:50:52.638] INFO: sequencer Stopped sequencer 15:50:52 [15:50:52.639] INFO: p2p P2P client stopped 15:50:52 [15:50:52.640] INFO: world_state Stopped world state synchronizer 15:50:52 [15:50:52.640] INFO: archiver Stopped. 15:50:52 [15:50:52.640] INFO: node Stopped Aztec Node 15:50:52 [15:50:52.651] INFO: blob-sink:server Stopping blob sink 15:50:52 [15:50:52.651] INFO: blob-sink:server Blob sink stopped 15:50:52 PASS src/e2e_snapshot_sync.test.ts 15:50:52 e2e_snapshot_sync 15:50:52 ✓ waits until a few L2 blocks have been mined and purges blobs (61045 ms) 15:50:52 ✓ creates a snapshot (1008 ms) 15:50:52 ✓ downloads snapshot when syncing new node (2518 ms) 15:50:52 ✓ downloads snapshot when syncing new prover node (580 ms) 15:50:52 15:50:52 Test Suites: 1 passed, 1 total 15:50:52 Tests: 4 passed, 4 total 15:50:52 Snapshots: 0 total 15:50:52 Time: 125.172 s 15:50:52 Ran all test suites matching /src\/e2e_snapshot_sync.test.ts/i. 15:50:52 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?