ACI ·

Parent Log: http://ci.aztec-labs.com/83b16f57969d44fb Command: 71ec8227227d28e6: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/a45107e7f95b675cb2768b6bcb06483b511141f4 Env: REF_NAME=gh-readonly-queue/next/pr-15018-2731d9a8aebf63d05db1a786296abdf897c49490 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Thu Jun 12 17:42:52 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15018_amd64_x2-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_eb8f79a88ef38365_next 17:42:52 +++ id -u 17:42:52 +++ id -g 17:42:52 ++ 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'\''' 17:42:53 + cid=0bcc837f74ad4e52b4c8f134b2a34b58c7359c6b016d36c30df65818fd2a0b37 17:42:53 + set +x 17:42:53 {"level":25,"time":1749750173734,"pid":12,"hostname":"0bcc837f74ad","module":"logger","msg":"Logger initialized with level verbose"} 17:43:00 [17:43:00.815] INFO: e2e:e2e_snapshot_sync Logging metrics to log/unknown.jsonl 17:43:00 [17:43:00.982] INFO: e2e:e2e_snapshot_sync Calling anvil_setBlockTimestampInterval with params: [8] 17:43:01 [17:43:01.019] WARN: e2e:e2e_snapshot_sync Set block interval to 8 17:43:01 [17:43:01.020] VERBOSE: e2e:e2e_snapshot_sync Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 17:43:01 [17:43:01.098] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xff8f3047f70ec9e63079d7903c02a47802dc292d5660d2da825ac209bbd9cd89 {"gasLimit":867658,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:43:01 [17:43:01.100] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xd8B56421e9b573AE62f2997B7b58858a4413A967 in tx 0xff8f3047f70ec9e63079d7903c02a47802dc292d5660d2da825ac209bbd9cd89. 17:43:01 [17:43:01.102] VERBOSE: e2e:e2e_snapshot_sync Deployed Fee Asset at 0xd8b56421e9b573ae62f2997b7b58858a4413a967 17:43:01 [17:43:01.141] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xb8a727e5dcee31d2ee7a6a94b8b01df7952fdc685dfb1b5bb36a0dbda9d08d89 {"gasLimit":867644,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:43:01 [17:43:01.154] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x026208feE3F4461826C8838C3569272E8C08E131 in tx 0xb8a727e5dcee31d2ee7a6a94b8b01df7952fdc685dfb1b5bb36a0dbda9d08d89. 17:43:01 [17:43:01.156] VERBOSE: e2e:e2e_snapshot_sync Deployed Staking Asset at 0x026208fee3f4461826c8838c3569272e8c08e131 17:43:01 [17:43:01.202] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x84345970a64bc89d244665c6d19bcf62f7a1fb0c5497fd61c66569ea96442f1f {"gasLimit":3118894,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:43:01 [17:43:01.204] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xad2120681B02De3e9b8aFd325977CDeDDf15f01C in tx 0x84345970a64bc89d244665c6d19bcf62f7a1fb0c5497fd61c66569ea96442f1f. 17:43:01 [17:43:01.205] VERBOSE: e2e:e2e_snapshot_sync Deployed GSE at 0xad2120681b02de3e9b8afd325977cdeddf15f01c 17:43:01 [17:43:01.248] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x96c1e759b945754976d026659a519c1c5d05a738916e69d742cdec67a5482765 {"gasLimit":1030513,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:43:01 [17:43:01.248] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x992D1f24CC5f368188d936cf0b2A111cEE586d4e in tx 0x96c1e759b945754976d026659a519c1c5d05a738916e69d742cdec67a5482765. 17:43:01 [17:43:01.250] VERBOSE: e2e:e2e_snapshot_sync Deployed Registry at 0x992d1f24cc5f368188d936cf0b2a111cee586d4e 17:43:01 [17:43:01.281] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x35838f7740ede8daad92b7b8589b59625f0100193e252bc6ce3862a65d23892c {"gasLimit":1998672,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:43:01 [17:43:01.282] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xfDB60896B1920A10Fd3AA268A292E51ebD5568A8 in tx 0x35838f7740ede8daad92b7b8589b59625f0100193e252bc6ce3862a65d23892c. 17:43:01 [17:43:01.283] VERBOSE: e2e:e2e_snapshot_sync Deployed GovernanceProposer at 0xfdb60896b1920a10fd3aa268a292e51ebd5568a8 17:43:01 [17:43:01.318] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x4dbcecd47a2081d10a38e4cf385714d92e542e5a44eb5a37a3810c6c6738dc4e {"gasLimit":3092007,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:43:01 [17:43:01.319] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x506150CaB49DBC09C8B79D20ac5c79CA28220AEA in tx 0x4dbcecd47a2081d10a38e4cf385714d92e542e5a44eb5a37a3810c6c6738dc4e. 17:43:01 [17:43:01.320] VERBOSE: e2e:e2e_snapshot_sync Deployed Governance at 0x506150cab49dbc09c8b79d20ac5c79ca28220aea 17:43:01 [17:43:01.344] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xf2ecc0d2040ae9928a4b186c21f02e611c2904f24b196eed69d646e9333cc00d {"gasLimit":100000,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:43:01 [17:43:01.344] VERBOSE: e2e:e2e_snapshot_sync Set governance on GSE in 0xf2ecc0d2040ae9928a4b186c21f02e611c2904f24b196eed69d646e9333cc00d 17:43:01 [17:43:01.370] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x77f9fa97fbbcb04392e88d456c198520b3425518c3d2d4146393099192372448 {"gasLimit":397390,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 17:43:01 [17:43:01.371] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x1649EeAD62C64Db7F63182989C8c41Ab25025C21 in tx 0x77f9fa97fbbcb04392e88d456c198520b3425518c3d2d4146393099192372448. 17:43:01 [17:43:01.372] VERBOSE: e2e:e2e_snapshot_sync Deployed CoinIssuer at 0x1649eead62c64db7f63182989c8c41ab25025c21 17:43:01 [17:43:01.372] VERBOSE: e2e:e2e_snapshot_sync Waiting for deployments to complete 17:43:01 [17:43:01.373] INFO: e2e:e2e_snapshot_sync Waiting for 7 transactions to be mined... 17:43:09 [17:43:09.400] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 17:43:09 [17:43:09.418] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xc033579f2357cfd2f6fa38d1ef9986415f4ed794add3fff64984bc3f1257e970 {"gasLimit":100000,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:43:09 [17:43:09.419] VERBOSE: e2e:e2e_snapshot_sync Added coin issuer 0x1649eead62c64db7f63182989c8c41ab25025c21 as minter on fee asset in 0xc033579f2357cfd2f6fa38d1ef9986415f4ed794add3fff64984bc3f1257e970 17:43:09 [17:43:09.443] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xd6a54e4eed6f07d2b8dcaafbd3883b3558583e43612f444af113d489245a2bb1 {"gasLimit":56661,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:43:09 [17:43:09.467] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xa67ff7f4001dc5703375e116caba00222d15ec13472e10af8018f62318b463cb {"gasLimit":344517,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:43:09 [17:43:09.467] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x3607dbAfDe17871E0D6A8f929151C30b83510D39 in tx 0xa67ff7f4001dc5703375e116caba00222d15ec13472e10af8018f62318b463cb. 17:43:09 [17:43:09.468] VERBOSE: e2e:e2e_snapshot_sync Deployed FeeAssetHandler at 0x3607dbafde17871e0d6a8f929151c30b83510d39 17:43:09 [17:43:09.489] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xa32bc1b02f5f02b41626611ec0e0056cad989330fbf908181b5d4f7678377aae {"gasLimit":56804,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:43:09 [17:43:09.489] VERBOSE: e2e:e2e_snapshot_sync Added fee asset handler 0x3607dbafde17871e0d6a8f929151c30b83510d39 as minter on fee asset in 0xa32bc1b02f5f02b41626611ec0e0056cad989330fbf908181b5d4f7678377aae 17:43:09 [17:43:09.532] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xadb884185b00b3cf3fb2aac4753fbbc2bbb58dfbab2a937d61ea0e950d96b91b {"gasLimit":2514669,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:43:09 [17:43:09.535] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x499C89D6b68cBdcA67C96Bff13Eb5B5a8fDb25a2 in tx 0xadb884185b00b3cf3fb2aac4753fbbc2bbb58dfbab2a937d61ea0e950d96b91b. 17:43:09 [17:43:09.538] VERBOSE: e2e:e2e_snapshot_sync Deployed StakingAssetHandler at 0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2 17:43:09 [17:43:09.573] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x2b32bbf996c6d3500330bc3ce74137b03f19074efe8ad0d3e14e6dea009f12e4 {"gasLimit":56804,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 17:43:09 [17:43:09.574] VERBOSE: e2e:e2e_snapshot_sync Added staking asset handler 0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2 as minter on staking asset in 0x2b32bbf996c6d3500330bc3ce74137b03f19074efe8ad0d3e14e6dea009f12e4 17:43:09 [17:43:09.575] VERBOSE: e2e:e2e_snapshot_sync Waiting for deployments to complete 17:43:09 [17:43:09.575] INFO: e2e:e2e_snapshot_sync Waiting for 9 transactions to be mined... 17:43:17 [17:43:17.598] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 17:43:17 [17:43:17.630] VERBOSE: e2e:e2e_snapshot_sync Deployed shared contracts 17:43:17 [17:43:17.667] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x1f3bf003fea3920e27f0ab1b5a7c080b356836c498ba06ccbbb2f38e05cac9a5 {"gasLimit":84823,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 17:43:17 [17:43:17.668] VERBOSE: e2e:e2e_snapshot_sync Funded reward distributor with 10000000000000000000000000 fee asset in 0x1f3bf003fea3920e27f0ab1b5a7c080b356836c498ba06ccbbb2f38e05cac9a5 17:43:17 [17:43:17.687] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x8ddfc36dd291a7e69dbb1d1c4b25283f53b9e73f733772b984e1b7cef75ca71d {"gasLimit":154658,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 17:43:17 [17:43:17.688] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x277E22B0C9698d7f2A1cD7C6d857511617587309 in tx 0x8ddfc36dd291a7e69dbb1d1c4b25283f53b9e73f733772b984e1b7cef75ca71d. 17:43:17 [17:43:17.688] VERBOSE: e2e:e2e_snapshot_sync Rollup will use the mock verifier at 0x277e22b0c9698d7f2a1cd7c6d857511617587309 17:43:17 [17:43:17.689] 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}} 17:43:17 [17:43:17.707] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x1244dd983dfa48995970c0afd0fb79b5391ff919edd2ee7939902fc973eec3e1 {"gasLimit":86992,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 17:43:17 [17:43:17.708] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xbba8820C80d584aEc2Cb092C3a0bE628aAB41fe3 in tx 0x1244dd983dfa48995970c0afd0fb79b5391ff919edd2ee7939902fc973eec3e1. 17:43:17 [17:43:17.750] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x0785920f3b1808bbb32fbbb9fc7abf594c7e8c615f21bf1b26859927d6d53edc {"gasLimit":6301243,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 17:43:17 [17:43:17.751] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x0130CEd3370Af8E822F3D9076177E04F1cA75D3e in tx 0x0785920f3b1808bbb32fbbb9fc7abf594c7e8c615f21bf1b26859927d6d53edc. 17:43:17 [17:43:17.752] VERBOSE: e2e:e2e_snapshot_sync Awaiting for linked libraries to be deployed 17:43:25 [17:43:25.853] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x6e7ed508f1b65dba3fc8a5f51f5beb413b5896aae6eac657e36893159f07869a {"gasLimit":11245410,"maxFeePerGas":"3.44200128","maxPriorityFeePerGas":"2.0736"} 17:43:25 [17:43:25.854] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x6C4896C00FB7428F6031272a840d0635150312ae in tx 0x6e7ed508f1b65dba3fc8a5f51f5beb413b5896aae6eac657e36893159f07869a. 17:43:25 [17:43:25.855] VERBOSE: e2e:e2e_snapshot_sync Deployed Rollup at 0x6c4896c00fb7428f6031272a840d0635150312ae {"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}} 17:43:25 [17:43:25.856] INFO: e2e:e2e_snapshot_sync Waiting for 11 transactions to be mined... 17:43:33 [17:43:33.891] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 17:43:33 [17:43:33.895] VERBOSE: e2e:e2e_snapshot_sync All core contracts have been deployed 17:43:33 [17:43:33.961] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xc1c232c760a6e8ae1fe2f202656091f89d031ebb33ad2765f57b460c7a9ed8fe {"gasLimit":1056496,"maxFeePerGas":"3.747782171","maxPriorityFeePerGas":"2.48832"} 17:43:33 [17:43:33.961] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x5511c8F078cC8714dD2996f52E6DF240447aE71D in tx 0xc1c232c760a6e8ae1fe2f202656091f89d031ebb33ad2765f57b460c7a9ed8fe. 17:43:33 [17:43:33.962] VERBOSE: e2e:e2e_snapshot_sync Deployed SlashFactory at 0x5511c8f078cc8714dd2996f52e6df240447ae71d 17:43:34 [17:43:34.017] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xc3db96b59813e14956bb5e8c621c3da7e0483a1b1f5d7da335862acac3a85eaf {"gasLimit":116846,"maxFeePerGas":"3.747782171","maxPriorityFeePerGas":"2.48832"} 17:43:34 [17:43:34.017] VERBOSE: e2e:e2e_snapshot_sync Adding rollup 0x6c4896c00fb7428f6031272a840d0635150312ae to registry 0x992d1f24cc5f368188d936cf0b2a111cee586d4e in tx 0xc3db96b59813e14956bb5e8c621c3da7e0483a1b1f5d7da335862acac3a85eaf 17:43:34 [17:43:34.040] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xeb5d02151ac4ea41589d22f117efb31ba075b7540beea899bbde9df61ae1be71 {"gasLimit":109478,"maxFeePerGas":"3.747782171","maxPriorityFeePerGas":"2.48832"} 17:43:34 [17:43:34.041] VERBOSE: e2e:e2e_snapshot_sync Adding rollup 0x6c4896c00fb7428f6031272a840d0635150312ae to GSE 0xad2120681b02de3e9b8afd325977cdeddf15f01c in tx 0xeb5d02151ac4ea41589d22f117efb31ba075b7540beea899bbde9df61ae1be71 17:43:42 [17:43:42.068] INFO: e2e:e2e_snapshot_sync Waiting for 12 transactions to be mined... 17:43:42 [17:43:42.124] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 17:43:42 [17:43:42.132] VERBOSE: e2e:e2e_snapshot_sync Rollup deployed 17:43:42 [17:43:42.133] VERBOSE: e2e:e2e_snapshot_sync Waiting for rollup and slash factory to be deployed 17:43:42 [17:43:42.133] INFO: e2e:e2e_snapshot_sync Waiting for 12 transactions to be mined... 17:43:42 [17:43:42.180] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 17:43:42 [17:43:42.181] VERBOSE: e2e:e2e_snapshot_sync All transactions for L1 deployment have been mined 17:43:42 [17:43:42.237] INFO: e2e:e2e_snapshot_sync Aztec L1 contracts initialized {"registryAddress":"0x992d1f24cc5f368188d936cf0b2a111cee586d4e","governanceAddress":"0x506150cab49dbc09c8b79d20ac5c79ca28220aea","governanceProposerAddress":"0xfdb60896b1920a10fd3aa268a292e51ebd5568a8","rollupAddress":"0x6c4896c00fb7428f6031272a840d0635150312ae","inboxAddress":"0xe4d60b12b0b7ed88c4c6ddb302fd34ac3c76bb93","outboxAddress":"0xa558ec040e993f34f8372128706ed88345906a05","feeJuicePortalAddress":"0xaac66a0f031e867fe79793b9bba0e976f8c92075","feeJuiceAddress":"0xd8b56421e9b573ae62f2997b7b58858a4413a967","stakingAssetAddress":"0x026208fee3f4461826c8838c3569272e8c08e131","rewardDistributorAddress":"0xd462e23c2c8a9b4f83de76004a170d4cebb5d3e1","gseAddress":"0xad2120681b02de3e9b8afd325977cdeddf15f01c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 17:43:42 [17:43:42.237] INFO: e2e:e2e_snapshot_sync Handing over to governance 17:43:42 [17:43:42.245] INFO: e2e:e2e_snapshot_sync Calling evm_setNextBlockTimestamp with params: [1749750228] 17:43:42 [17:43:42.247] INFO: e2e:e2e_snapshot_sync Calling hardhat_mine with params: [1] 17:43:42 [17:43:42.256] INFO: e2e:e2e_snapshot_sync Jumped to slot 1 17:43:42 [17:43:42.268] INFO: aztecjs:utils:watcher Watcher not started because not auto mining 17:43:42 [17:43:42.269] INFO: telemetry:client Using NoopTelemetryClient 17:43:42 [17:43:42.273] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/3fa8b2f0ba989fa9/blob-sink with map size 134217728 KB (LMDB v2) 17:43:42 [17:43:42.284] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 17:43:42 [17:43:42.299] INFO: blob-sink:server Server is running on http://localhost:33047 17:43:42 [17:43:42.300] VERBOSE: e2e:e2e_snapshot_sync Creating and synching an aztec node... 17:43:42 [17:43:42.301] VERBOSE: e2e:e2e_snapshot_sync Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/d9303712/acvm 17:43:42 [17:43:42.303] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:33047"} 17:43:42 [17:43:42.332] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 17:43:42 [17:43:42.333] INFO: archiver:lmdb Creating archiver data store at directory /tmp/3fa8b2f0ba989fa9/archiver with map size 134217728 KB (LMDB v2) 17:43:42 [17:43:42.335] INFO: archiver:lmdb Starting data store with maxReaders 16 17:43:43 [17:43:43.417] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:33047"} 17:43:43 [17:43:43.445] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:33047"} 17:43:43 [17:43:43.445] WARN: node:blob-sink:client No L1 consensus host urls configured 17:43:43 [17:43:43.445] WARN: node:blob-sink:client No archive client configured 17:43:43 [17:43:43.448] INFO: archiver Starting archiver sync to rollup contract 0x6c4896c00fb7428f6031272a840d0635150312ae from L1 block 4 to current L1 block 6 with hash 0x8030142a90d0c90d34f6da95e6d58051d4b1c52b7e1e09c9660eb196bb257610 {"blocksSynchedTo":4,"messagesSynchedTo":{"l1BlockHash":"0x268e00e4f54a29be6ea664149978e9937b4fbedafc00ad4c9292310121008c79","l1BlockNumber":4}} 17:43:43 [17:43:43.479] INFO: archiver Initial archiver sync to L1 block 6 complete. {"l1BlockNumber":6,"syncPoint":{"blocksSynchedTo":6,"messagesSynchedTo":{"l1BlockHash":"0x8030142a90d0c90d34f6da95e6d58051d4b1c52b7e1e09c9660eb196bb257610","l1BlockNumber":6}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 17:43:43 [17:43:43.490] INFO: world-state:database Creating world state data store at directory /tmp/3fa8b2f0ba989fa9/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:43:43 [17:43:43.519] INFO: world_state Created world state synchroniser with block history of 64 17:43:43 [17:43:43.519] WARN: node Aztec node is accepting fake proofs 17:43:43 [17:43:43.535] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/3fa8b2f0ba989fa9/p2p with map size 134217728 KB (LMDB v2) 17:43:43 [17:43:43.537] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 17:43:43 [17:43:43.539] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/3fa8b2f0ba989fa9/p2p-archive with map size 134217728 KB (LMDB v2) 17:43:43 [17:43:43.541] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 17:43:43 [17:43:43.542] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/3fa8b2f0ba989fa9/p2p-peers with map size 134217728 KB (LMDB v2) 17:43:43 [17:43:43.543] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 17:43:43 [17:43:43.545] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:43:43 [17:43:43.546] VERBOSE: p2p P2P is disabled. Using dummy P2P service 17:43:43 [17:43:43.549] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:43:43 [17:43:43.550] INFO: world_state Started world state synchronizer from block 1 17:43:43 [17:43:43.552] VERBOSE: world-state:block_stream Starting sync from block number 0 17:43:43 [17:43:43.554] INFO: p2p Starting p2p client from block 0 with empty mempools 17:43:43 [17:43:43.554] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 17:43:43 [17:43:43.849] INFO: epoch-prune-watcher EpochPruneWatcher initialized 17:43:43 [17:43:43.891] VERBOSE: validator Initialized validator with addresses: 0x8b6502e5bc3e50d56b6cbecce189f2dff8b3b78f 17:43:43 [17:43:43.892] VERBOSE: node All Aztec Node subsystems synced 17:43:43 [17:43:43.908] INFO: slasher Starting Slasher client... 17:43:43 [17:43:43.920] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 17:43:43 [17:43:43.925] INFO: sequencer-client Deploying forwarder contract 17:43:43 [17:43:43.948] VERBOSE: sequencer-client Sent L1 transaction 0x6a41f282ba3b374825eaa9a049582630fb5fd49601d97115d1e20b9e9a4c40b2 {"gasLimit":323704,"maxFeePerGas":"2.259667855","maxPriorityFeePerGas":"1.2"} 17:43:43 [17:43:43.949] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0x6a41f282ba3b374825eaa9a049582630fb5fd49601d97115d1e20b9e9a4c40b2. 17:43:51 [17:43:51.959] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 17:43:51 [17:43:51.970] INFO: validator Started validator with addresses: 0x8b6502e5bc3e50d56b6cbecce189f2dff8b3b78f 17:43:51 [17:43:51.970] VERBOSE: validator Validators 0x8b6502e5bc3e50d56b6cbecce189f2dff8b3b78f are not on the validator committee for epoch 0 17:43:51 [17:43:51.971] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":0,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/d9303712/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":8,"enforceTimeTable":false} 17:43:51 [17:43:51.971] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 17:43:51 [17:43:51.973] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 17:43:51 [17:43:51.975] INFO: node Aztec Node version: 0.87.6 17:43:51 [17:43:51.975] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x992d1f24cc5f368188d936cf0b2a111cee586d4e","governanceAddress":"0x506150cab49dbc09c8b79d20ac5c79ca28220aea","governanceProposerAddress":"0xfdb60896b1920a10fd3aa268a292e51ebd5568a8","rollupAddress":"0x6c4896c00fb7428f6031272a840d0635150312ae","inboxAddress":"0xe4d60b12b0b7ed88c4c6ddb302fd34ac3c76bb93","outboxAddress":"0xa558ec040e993f34f8372128706ed88345906a05","feeJuicePortalAddress":"0xaac66a0f031e867fe79793b9bba0e976f8c92075","feeJuiceAddress":"0xd8b56421e9b573ae62f2997b7b58858a4413a967","stakingAssetAddress":"0x026208fee3f4461826c8838c3569272e8c08e131","rewardDistributorAddress":"0xd462e23c2c8a9b4f83de76004a170d4cebb5d3e1","gseAddress":"0xad2120681b02de3e9b8afd325977cdeddf15f01c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x5511c8f078cc8714dd2996f52e6df240447ae71d","feeAssetHandlerAddress":"0x3607dbafde17871e0d6a8f929151c30b83510d39","stakingAssetHandlerAddress":"0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 17:43:51 [17:43:51.977] VERBOSE: e2e:e2e_snapshot_sync Creating a pxe... 17:43:51 [17:43:51.984] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/cdd0e56d63d12a07/pxe_data with map size 134217728 KB (LMDB v2) 17:43:51 [17:43:51.989] 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} 17:43:51 [17:43:51.991] INFO: pxe:data:lmdb Starting data store with maxReaders 16 17:43:52 [17:43:52.349] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 17:43:52 [17:43:52.350] INFO: pxe:service Started PXE connected to chain 31337 version 2872520363 17:43:52 [17:43:52.354] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync waits until a few L2 blocks have been mined and purges blobs 17:43:52 [17:43:52.355] WARN: e2e:e2e_snapshot_sync Waiting for L2 blocks to be mined 17:43:52 [17:43:52.498] 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} 17:43:52 [17:43:52.582] INFO: e2e:e2e_snapshot_sync L1 block 7 mined at 17:43:56 with new L2 block 0 for epoch 0 with proof up to L2 block 0 for epoch 0 {"l1Timestamp":1749750236,"l1BlockNumber":7,"l2SlotNumber":1,"l2BlockNumber":0,"l2ProvenBlockNumber":0,"totalL2Messages":0} 17:43:53 [17:43:53.007] 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} 17:43:53 [17:43:53.515] 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} 17:43:54 [17:43:54.023] 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} 17:43:54 [17:43:54.533] 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} 17:43:55 [17:43:55.045] 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} 17:43:55 [17:43:55.553] 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} 17:43:56 [17:43:56.070] 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":1749750244,"version":2872520363},"chainTipArchive":"0x1f9c798be7975bb34c3e605a4c92c75796eae7b9a08644bc9a6a55354ed470be","blockNumber":1,"slot":2} 17:43:56 [17:43:56.095] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-12T17:44:04.000Z","now":"2025-06-12T17:43:56.095Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 17:43:56 [17:43:56.101] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.000995456999997259s {"duration":0.000995456999997259,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 17:43:56 [17:43:56.120] INFO: sequencer Built block 1 for slot 2 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x020537c1a634c077aa3b7b8184898addd2ff49e356a724e3c9ac3c00ce2d5504","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749750244,"version":2872520363},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":35.05013599999802,"publicProcessDuration":2.4930549999990035,"rollupCircuitsDuration":25.42754500000592,"txCount":0,"blockNumber":1,"blockTimestamp":1749750244,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:43:56 [17:43:56.122] VERBOSE: sequencer Attesting committee is empty 17:43:56 [17:43:56.978] INFO: e2e:e2e_snapshot_sync L1 block 8 mined at 17:44:04 {"l1Timestamp":1749750244,"l1BlockNumber":8,"l2SlotNumber":2,"l2BlockNumber":0,"l2ProvenBlockNumber":0,"totalL2Messages":0} 17:43:58 [17:43:58.781] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xb0ffc47ae5caba34889b64c97bd6bfb7c01478375f803ee04d7afcf6d7a8381a 17:43:58 [17:43:58.782] VERBOSE: node Sent L1 transaction 0xb0ffc47ae5caba34889b64c97bd6bfb7c01478375f803ee04d7afcf6d7a8381a {"gasLimit":485800,"maxFeePerGas":"2.367209374","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 17:44:04 [17:44:04.868] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:44:04 [17:44:04.870] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xb0ffc47ae5caba34889b64c97bd6bfb7c01478375f803ee04d7afcf6d7a8381a","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":1,"blockTimestamp":1749750244,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:04 [17:44:04.871] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:44:04 [17:44:04.905] INFO: blob-sink:server Received blob sidecar for block 0xaf102d0cec74456ccd2a74c6a9601111b0d9ec6ad3b5cc7c43397ef7de46d521 17:44:04 [17:44:04.923] INFO: blob-sink:server Blob sidecar stored successfully for block 0xaf102d0cec74456ccd2a74c6a9601111b0d9ec6ad3b5cc7c43397ef7de46d521 17:44:04 [17:44:04.994] INFO: e2e:e2e_snapshot_sync L1 block 9 mined at 17:44:12 with new L2 block 1 for epoch 0 {"l1Timestamp":1749750252,"l1BlockNumber":9,"l2SlotNumber":2,"l2BlockNumber":1,"l2ProvenBlockNumber":0,"totalL2Messages":0} 17:44:05 [17:44:05.318] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x020537c1a634c077aa3b7b8184898addd2ff49e356a724e3c9ac3c00ce2d5504","blockNumber":1,"txCount":0,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749750244,"version":2872520363},"archiveRoot":"0x2a74b2e738b2d6d3d67172e2f2c25d3413e775780aa54d0e08266bd30abe4232","archiveNextLeafIndex":2} 17:44:05 [17:44:05.348] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":5.635261000003084,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":1,"blockTimestamp":1749750244,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:05 [17:44:05.350] VERBOSE: p2p Synched to latest block 1 17:44:05 [17:44:05.431] 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} 17:44:05 [17:44:05.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} 17:44:06 [17:44:06.452] 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} 17:44:06 [17:44:06.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} 17:44:07 [17:44:07.471] 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} 17:44:07 [17:44:07.978] 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} 17:44:08 [17:44:08.488] 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} 17:44:09 [17:44:09.000] 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} 17:44:09 [17:44:09.516] 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} 17:44:10 [17:44:10.053] 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} 17:44:10 [17:44:10.566] 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} 17:44:11 [17:44:11.078] 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} 17:44:11 [17:44:11.603] 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} 17:44:12 [17:44:12.119] 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":1749750260,"version":2872520363},"chainTipArchive":"0x2a74b2e738b2d6d3d67172e2f2c25d3413e775780aa54d0e08266bd30abe4232","blockNumber":2,"slot":3} 17:44:12 [17:44:12.141] VERBOSE: block-builder Building block 2 for slot 3 {"slot":3,"slotStart":"2025-06-12T17:44:20.000Z","now":"2025-06-12T17:44:12.141Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 17:44:12 [17:44:12.147] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.0007056579999916721s {"duration":0.0007056579999916721,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 17:44:12 [17:44:12.167] INFO: sequencer Built block 2 for slot 3 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x037cb03adf2332516dd5d9871cd0ec9113b71923a2d0f74c640e81961d140e26","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749750260,"version":2872520363},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":35.96757000000798,"publicProcessDuration":1.6517709999898216,"rollupCircuitsDuration":27.616941000000224,"txCount":0,"blockNumber":2,"blockTimestamp":1749750260,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:12 [17:44:12.170] VERBOSE: sequencer Attesting committee is empty 17:44:12 [17:44:12.274] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x2d7203e42b5f6d4241fab78a73c3037565638fe589a32d75269fd9cda700473b 17:44:12 [17:44:12.275] VERBOSE: node Sent L1 transaction 0x2d7203e42b5f6d4241fab78a73c3037565638fe589a32d75269fd9cda700473b {"gasLimit":414577,"maxFeePerGas":"2.439697614","maxPriorityFeePerGas":"1.728","maxFeePerBlobGas":"0.000000001"} 17:44:12 [17:44:12.968] WARN: node:blob-sink:client Unable to get blob sidecar for 0x9d545619c750a48d734c3179c43c12a1c04604e7f7ec96362243a3e5959fc5f7: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 17:44:12 [17:44:12.969] WARN: node:blob-sink:client Failed to fetch blobs for 0x9d545619c750a48d734c3179c43c12a1c04604e7f7ec96362243a3e5959fc5f7 from all blob sources {"blobSinkUrl":"http://localhost:33047"} 17:44:13 [17:44:13.019] INFO: e2e:e2e_snapshot_sync L1 block 10 mined at 17:44:20 with new L2 block 2 for epoch 0 {"l1Timestamp":1749750260,"l1BlockNumber":10,"l2SlotNumber":3,"l2BlockNumber":2,"l2ProvenBlockNumber":0,"totalL2Messages":0} 17:44:13 [17:44:13.304] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:44:13 [17:44:13.308] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x2d7203e42b5f6d4241fab78a73c3037565638fe589a32d75269fd9cda700473b","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":2,"blockTimestamp":1749750260,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:13 [17:44:13.308] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:44:13 [17:44:13.313] INFO: blob-sink:server Received blob sidecar for block 0x9d545619c750a48d734c3179c43c12a1c04604e7f7ec96362243a3e5959fc5f7 17:44:13 [17:44:13.319] INFO: blob-sink:server Blob sidecar stored successfully for block 0x9d545619c750a48d734c3179c43c12a1c04604e7f7ec96362243a3e5959fc5f7 17:44:13 [17:44:13.554] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x037cb03adf2332516dd5d9871cd0ec9113b71923a2d0f74c640e81961d140e26","blockNumber":2,"txCount":0,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749750260,"version":2872520363},"archiveRoot":"0x02c3bee6b201170f3f2ff9f6f298b1e21d7e776c8ddc550803996381c9c58331","archiveNextLeafIndex":3} 17:44:13 [17:44:13.573] VERBOSE: p2p Synched to latest block 2 17:44:13 [17:44:13.666] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":6.018530999994255,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":2,"blockTimestamp":1749750260,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:13 [17:44:13.834] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:13 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:13 [17:44:13.835] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:14 [17:44:14.354] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:14 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:14 [17:44:14.354] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:14 [17:44:14.871] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:14 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:14 [17:44:14.871] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:15 [17:44:15.388] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:15 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:15 [17:44:15.388] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:15 [17:44:15.903] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:15 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:15 [17:44:15.904] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:16 [17:44:16.418] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:16 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:16 [17:44:16.418] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:16 [17:44:16.936] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:16 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:16 [17:44:16.936] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:17 [17:44:17.451] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:17 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:17 [17:44:17.452] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:17 [17:44:17.985] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:17 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:17 [17:44:17.988] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:18 [17:44:18.525] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:18 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:18 [17:44:18.526] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:19 [17:44:19.040] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:19 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:19 [17:44:19.040] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:19 [17:44:19.554] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:19 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:19 [17:44:19.554] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:20 [17:44:20.094] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:20 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:20 [17:44:20.097] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:20 [17:44:20.640] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:20 error: "Rollup__SlotAlreadyInChain(3, 3)" 17:44:20 [17:44:20.652] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 17:44:21 [17:44:21.049] INFO: e2e:e2e_snapshot_sync L1 block 11 mined at 17:44:28 {"l1Timestamp":1749750268,"l1BlockNumber":11,"l2SlotNumber":3,"l2BlockNumber":2,"l2ProvenBlockNumber":0,"totalL2Messages":0} 17:44:21 [17:44:21.186] 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} 17:44:21 [17:44:21.701] 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} 17:44:22 [17:44:22.213] 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} 17:44:22 [17:44:22.722] 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} 17:44:23 [17:44:23.240] 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} 17:44:23 [17:44:23.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 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 17:44:24 [17:44:24.291] 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} 17:44:24 [17:44:24.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 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 17:44:25 [17:44:25.334] 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} 17:44:25 [17:44:25.844] 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} 17:44:26 [17:44:26.352] 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} 17:44:26 [17:44:26.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 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 17:44:27 [17:44:27.373] 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} 17:44:27 [17:44:27.884] 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} 17:44:28 [17:44:28.406] 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":1749750276,"version":2872520363},"chainTipArchive":"0x02c3bee6b201170f3f2ff9f6f298b1e21d7e776c8ddc550803996381c9c58331","blockNumber":3,"slot":4} 17:44:28 [17:44:28.419] VERBOSE: block-builder Building block 3 for slot 4 {"slot":4,"slotStart":"2025-06-12T17:44:36.000Z","now":"2025-06-12T17:44:28.419Z","blockNumber":3,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 17:44:28 [17:44:28.422] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.0004805919999926118s {"duration":0.0004805919999926118,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 17:44:28 [17:44:28.436] INFO: sequencer Built block 3 for slot 4 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749750276,"version":2872520363},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":21.069307999990997,"publicProcessDuration":0.858092000009492,"rollupCircuitsDuration":16.542052000004333,"txCount":0,"blockNumber":3,"blockTimestamp":1749750276,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:28 [17:44:28.439] VERBOSE: sequencer Attesting committee is empty 17:44:28 [17:44:28.543] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x62bc54c9d2d8e6e3b3ba8a4e7b81402587173581dcb151f8b98343fdaea9afa9 17:44:28 [17:44:28.543] VERBOSE: node Sent L1 transaction 0x62bc54c9d2d8e6e3b3ba8a4e7b81402587173581dcb151f8b98343fdaea9afa9 {"gasLimit":416977,"maxFeePerGas":"1.748133915","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:44:29 [17:44:29.032] INFO: e2e:e2e_snapshot_sync L1 block 12 mined at 17:44:36 with new L2 block 3 for epoch 0 {"l1Timestamp":1749750276,"l1BlockNumber":12,"l2SlotNumber":4,"l2BlockNumber":3,"l2ProvenBlockNumber":0,"totalL2Messages":0} 17:44:29 [17:44:29.080] WARN: node:blob-sink:client Unable to get blob sidecar for 0xa808d49707c5817c6a42130bbeb5490b66a9bdc69494bc5b3f076238d114d76a: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 17:44:29 [17:44:29.080] WARN: node:blob-sink:client Failed to fetch blobs for 0xa808d49707c5817c6a42130bbeb5490b66a9bdc69494bc5b3f076238d114d76a from all blob sources {"blobSinkUrl":"http://localhost:33047"} 17:44:29 [17:44:29.577] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:44:29 [17:44:29.577] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x62bc54c9d2d8e6e3b3ba8a4e7b81402587173581dcb151f8b98343fdaea9afa9","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":3,"blockTimestamp":1749750276,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:29 [17:44:29.578] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:44:29 [17:44:29.580] INFO: blob-sink:server Received blob sidecar for block 0xa808d49707c5817c6a42130bbeb5490b66a9bdc69494bc5b3f076238d114d76a 17:44:29 [17:44:29.584] INFO: blob-sink:server Blob sidecar stored successfully for block 0xa808d49707c5817c6a42130bbeb5490b66a9bdc69494bc5b3f076238d114d76a 17:44:29 [17:44:29.632] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e","blockNumber":3,"txCount":0,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749750276,"version":2872520363},"archiveRoot":"0x069d441b7b1d2e9bbc11a16b601cc2559886b833ac9b61c41ce31bde863341f9","archiveNextLeafIndex":4} 17:44:29 [17:44:29.646] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":3.750476000001072,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":3,"blockTimestamp":1749750276,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:29 [17:44:29.672] VERBOSE: p2p Synched to latest block 3 17:44:30 [17:44:30.097] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:30 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:30 [17:44:30.097] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:30 [17:44:30.612] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:30 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:30 [17:44:30.613] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:31 [17:44:31.131] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:31 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:31 [17:44:31.131] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:31 [17:44:31.651] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:31 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:31 [17:44:31.652] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:32 [17:44:32.168] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:32 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:32 [17:44:32.168] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:32 [17:44:32.688] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:32 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:32 [17:44:32.688] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:33 [17:44:33.204] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:33 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:33 [17:44:33.204] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:33 [17:44:33.718] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:33 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:33 [17:44:33.718] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:34 [17:44:34.235] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:34 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:34 [17:44:34.235] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:34 [17:44:34.755] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:34 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:34 [17:44:34.755] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:35 [17:44:35.276] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:35 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:35 [17:44:35.277] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:35 [17:44:35.794] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:35 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:35 [17:44:35.795] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:36 [17:44:36.307] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:36 error: "Rollup__SlotAlreadyInChain(4, 4)" 17:44:36 [17:44:36.308] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 17:44:36 [17:44:36.819] 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} 17:44:36 [17:44:36.832] INFO: e2e:e2e_snapshot_sync L1 block 13 mined at 17:44:44 {"l1Timestamp":1749750284,"l1BlockNumber":13,"l2SlotNumber":4,"l2BlockNumber":3,"l2ProvenBlockNumber":0,"totalL2Messages":0} 17:44:37 [17:44:37.326] 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} 17:44:37 [17:44:37.834] 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} 17:44:38 [17:44:38.343] 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} 17:44:38 [17:44:38.861] 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} 17:44:39 [17:44:39.376] 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} 17:44:39 [17:44:39.890] 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} 17:44:40 [17:44:40.403] 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} 17:44:40 [17:44:40.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 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 17:44:41 [17:44:41.435] 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} 17:44:41 [17:44:41.947] 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} 17:44:42 [17:44:42.461] 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} 17:44:42 [17:44:42.974] 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} 17:44:43 [17:44:43.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 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 17:44:44 [17:44:44.001] 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} 17:44:44 [17:44:44.512] 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":1749750292,"version":2872520363},"chainTipArchive":"0x069d441b7b1d2e9bbc11a16b601cc2559886b833ac9b61c41ce31bde863341f9","blockNumber":4,"slot":5} 17:44:44 [17:44:44.522] VERBOSE: block-builder Building block 4 for slot 5 {"slot":5,"slotStart":"2025-06-12T17:44:52.000Z","now":"2025-06-12T17:44:44.522Z","blockNumber":4,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 17:44:44 [17:44:44.525] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.00031293800000275953s {"duration":0.00031293800000275953,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 17:44:44 [17:44:44.537] INFO: sequencer Built block 4 for slot 5 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x0151b76fe673e259c36e8251f175b5efa847db7f2495e3bc9b255558515ac046","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749750292,"version":2872520363},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":19.853768999993918,"publicProcessDuration":0.7099979999911739,"rollupCircuitsDuration":15.01849800000491,"txCount":0,"blockNumber":4,"blockTimestamp":1749750292,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:44 [17:44:44.540] VERBOSE: sequencer Attesting committee is empty 17:44:44 [17:44:44.610] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xc2e39d269202ec1fab9e71451a6316c03d21040cc3b4b98545e8eb2c1cb362fb 17:44:44 [17:44:44.610] VERBOSE: node Sent L1 transaction 0xc2e39d269202ec1fab9e71451a6316c03d21040cc3b4b98545e8eb2c1cb362fb {"gasLimit":416989,"maxFeePerGas":"1.62080043","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 17:44:44 [17:44:44.849] INFO: e2e:e2e_snapshot_sync L1 block 14 mined at 17:44:52 with new L2 block 4 for epoch 0 {"l1Timestamp":1749750292,"l1BlockNumber":14,"l2SlotNumber":5,"l2BlockNumber":4,"l2ProvenBlockNumber":0,"totalL2Messages":0} 17:44:44 [17:44:44.939] WARN: node:blob-sink:client Unable to get blob sidecar for 0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 17:44:44 [17:44:44.940] WARN: node:blob-sink:client Failed to fetch blobs for 0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28 from all blob sources {"blobSinkUrl":"http://localhost:33047"} 17:44:45 [17:44:45.384] WARN: e2e:e2e_snapshot_sync L2 block height is now 4. Purging all blobs from sink so snapshot is required. 17:44:45 [17:44:45.387] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync creates a snapshot 17:44:45 [17:44:45.388] WARN: e2e:e2e_snapshot_sync Creating snapshot 17:44:45 [17:44:45.390] INFO: stdlib:file-store Creating local file file store at /tmp/snapshots-lLQK8O 17:44:45 [17:44:45.391] INFO: node Pausing archiver and world state sync to start snapshot upload 17:44:45 [17:44:45.392] INFO: archiver Stopped. 17:44:45 [17:44:45.392] INFO: world_state Stopped sync 17:44:45 [17:44:45.392] INFO: node Creating backups of lmdb environments to /tmp/3fa8b2f0ba989fa9/snapshot-WjF88d 17:44:45 [17:44:45.397] INFO: node Data stores backed up to /tmp/3fa8b2f0ba989fa9/snapshot-WjF88d {"paths":{"l1-to-l2-message-tree":"/tmp/3fa8b2f0ba989fa9/snapshot-WjF88d/world-state/L1ToL2MessageTree/data.mdb","archive-tree":"/tmp/3fa8b2f0ba989fa9/snapshot-WjF88d/world-state/ArchiveTree/data.mdb","public-data-tree":"/tmp/3fa8b2f0ba989fa9/snapshot-WjF88d/world-state/PublicDataTree/data.mdb","note-hash-tree":"/tmp/3fa8b2f0ba989fa9/snapshot-WjF88d/world-state/NoteHashTree/data.mdb","nullifier-tree":"/tmp/3fa8b2f0ba989fa9/snapshot-WjF88d/world-state/NullifierTree/data.mdb","archiver":"/tmp/3fa8b2f0ba989fa9/snapshot-WjF88d/archiver/data.mdb"}} 17:44:45 [17:44:45.397] INFO: node Resuming archiver and world state sync 17:44:45 [17:44:45.397] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:44:45 [17:44:45.398] INFO: world_state Resumed sync 17:44:45 [17:44:45.398] INFO: archiver Restarting archiver 17:44:45 [17:44:45.402] INFO: node Uploading snapshot to file:///tmp/snapshots-lLQK8O {"snapshot":{"l1ChainId":31337,"rollupVersion":2872520363,"rollupAddress":"0x6c4896c00fb7428f6031272a840d0635150312ae","l2BlockNumber":3,"l2BlockHash":"0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e","l1BlockNumber":13}} 17:44:45 [17:44:45.418] INFO: node Snapshot uploaded successfully {"snapshot":{"l1BlockNumber":13,"l2BlockHash":"0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e","l2BlockNumber":3,"schemaVersions":{"archiver":2,"worldState":1},"timestamp":1749750285403,"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/l1-to-l2-message-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","archive-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/archive-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","public-data-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/public-data-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","note-hash-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/note-hash-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","nullifier-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/nullifier-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","archiver":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/archiver-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db"}}} 17:44:45 [17:44:45.418] INFO: node Cleaning up backup dir /tmp/3fa8b2f0ba989fa9/snapshot-WjF88d 17:44:45 [17:44:45.436] WARN: node:blob-sink:client Unable to get blob sidecar for 0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 17:44:45 [17:44:45.436] WARN: node:blob-sink:client Failed to fetch blobs for 0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28 from all blob sources {"blobSinkUrl":"http://localhost:33047"} 17:44:45 [17:44:45.625] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 17:44:45 [17:44:45.625] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xc2e39d269202ec1fab9e71451a6316c03d21040cc3b4b98545e8eb2c1cb362fb","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":4,"blockTimestamp":1749750292,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:45 [17:44:45.625] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 17:44:45 [17:44:45.628] INFO: blob-sink:server Received blob sidecar for block 0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28 17:44:45 [17:44:45.632] INFO: blob-sink:server Blob sidecar stored successfully for block 0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28 17:44:46 [17:44:46.010] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x0151b76fe673e259c36e8251f175b5efa847db7f2495e3bc9b255558515ac046","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749750292,"version":2872520363},"archiveRoot":"0x1dcbff3c982941a04b31d81369f4df4dacb5f9d54011a79ef63a6fab61ebbec6","archiveNextLeafIndex":5} 17:44:46 [17:44:46.026] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":3.8292169999913312,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1749750292,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:46 [17:44:46.029] VERBOSE: p2p Synched to latest block 4 17:44:46 [17:44:46.155] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:46 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:46 [17:44:46.156] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:46 [17:44:46.394] WARN: e2e:e2e_snapshot_sync Snapshot created 17:44:46 [17:44:46.396] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync downloads snapshot when syncing new node 17:44:46 [17:44:46.398] WARN: e2e:e2e_snapshot_sync Syncing brand new node with snapshot sync 17:44:46 [17:44:46.399] WARN: e2e:e2e_snapshot_sync Creating and syncing a node without a validator... 17:44:46 [17:44:46.400] INFO: node:blob-sink:client:1 Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:33047"} 17:44:46 [17:44:46.443] INFO: node:1 Creating local file file store at /tmp/snapshots-lLQK8O 17:44:46 [17:44:46.443] VERBOSE: node:1 Creating temporary archiver data store 17:44:46 [17:44:46.447] INFO: archiver:lmdb:1 Creating archiver data store at directory /tmp/3fa8b2f0ba989fa9/313b998ad679da8e/archiver with map size 134217728 KB (LMDB v2) 17:44:46 [17:44:46.454] INFO: archiver:lmdb:1 Starting data store with maxReaders 16 17:44:46 [17:44:46.458] VERBOSE: node:1 Closing temporary archiver data store {"archiverL2BlockNumber":0} 17:44:46 [17:44:46.464] INFO: node:1 Syncing from snapshot at L1 block 13 L2 block 3 {"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e","l1BlockNumber":13,"timestamp":1749750285403,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/l1-to-l2-message-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","archive-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/archive-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","public-data-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/public-data-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","note-hash-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/note-hash-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","nullifier-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/nullifier-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","archiver":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/archiver-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db"}},"snapshotsUrl":"file:///tmp/snapshots-lLQK8O"} 17:44:46 [17:44:46.465] INFO: node:1 Creating local file file store at /tmp/snapshots-lLQK8O 17:44:46 [17:44:46.466] INFO: node:1 Downloading snapshot to /tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1 {"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e","l1BlockNumber":13,"timestamp":1749750285403,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/l1-to-l2-message-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","archive-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/archive-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","public-data-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/public-data-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","note-hash-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/note-hash-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","nullifier-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/nullifier-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","archiver":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/archiver-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db"}},"downloadPaths":{"archiver":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/archiver.db","nullifier-tree":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/nullifier-tree.db","public-data-tree":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/public-data-tree.db","note-hash-tree":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/note-hash-tree.db","archive-tree":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/archive-tree.db","l1-to-l2-message-tree":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/l1-to-l2-message-tree.db"}} 17:44:46 [17:44:46.470] INFO: node:1 Snapshot downloaded at /tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1 {"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e","l1BlockNumber":13,"timestamp":1749750285403,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/l1-to-l2-message-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","archive-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/archive-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","public-data-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/public-data-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","note-hash-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/note-hash-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","nullifier-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/nullifier-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","archiver":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/archiver-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db"}},"downloadPaths":{"archiver":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/archiver.db","nullifier-tree":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/nullifier-tree.db","public-data-tree":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/public-data-tree.db","note-hash-tree":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/note-hash-tree.db","archive-tree":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/archive-tree.db","l1-to-l2-message-tree":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/download-RWTpj1/l1-to-l2-message-tree.db"}} 17:44:46 [17:44:46.478] INFO: node:1 Archiver database set up from snapshot {"path":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/archiver","dbVersion":2,"rollupAddress":"0x6c4896c00fb7428f6031272a840d0635150312ae"} 17:44:46 [17:44:46.482] INFO: node:1 World state database l1-to-l2-message-tree set up from snapshot {"path":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/world_state/L1ToL2MessageTree","dbVersion":1,"rollupAddress":"0x6c4896c00fb7428f6031272a840d0635150312ae"} 17:44:46 [17:44:46.483] INFO: node:1 World state database archive-tree set up from snapshot {"path":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/world_state/ArchiveTree","dbVersion":1,"rollupAddress":"0x6c4896c00fb7428f6031272a840d0635150312ae"} 17:44:46 [17:44:46.484] INFO: node:1 World state database public-data-tree set up from snapshot {"path":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/world_state/PublicDataTree","dbVersion":1,"rollupAddress":"0x6c4896c00fb7428f6031272a840d0635150312ae"} 17:44:46 [17:44:46.484] INFO: node:1 World state database note-hash-tree set up from snapshot {"path":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/world_state/NoteHashTree","dbVersion":1,"rollupAddress":"0x6c4896c00fb7428f6031272a840d0635150312ae"} 17:44:46 [17:44:46.485] INFO: node:1 World state database nullifier-tree set up from snapshot {"path":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/world_state/NullifierTree","dbVersion":1,"rollupAddress":"0x6c4896c00fb7428f6031272a840d0635150312ae"} 17:44:46 [17:44:46.486] INFO: node:1 P2P database cleared {"path":"/tmp/3fa8b2f0ba989fa9/313b998ad679da8e/p2p"} 17:44:46 [17:44:46.491] INFO: node:1 Snapshot synced to L1 block 13 L2 block 3 {"snapshot":{"l2BlockNumber":3,"l2BlockHash":"0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e","l1BlockNumber":13,"timestamp":1749750285403,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/l1-to-l2-message-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","archive-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/archive-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","public-data-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/public-data-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","note-hash-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/note-hash-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","nullifier-tree":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/nullifier-tree-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db","archiver":"file:///tmp/snapshots-lLQK8O/aztec-31337-2872520363-0x6c4896c00fb7428f6031272a840d0635150312ae/archiver-20250612174445-0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e.db"}}} 17:44:46 [17:44:46.492] INFO: archiver:lmdb:1 Creating archiver data store at directory /tmp/3fa8b2f0ba989fa9/313b998ad679da8e/archiver with map size 134217728 KB (LMDB v2) 17:44:46 [17:44:46.495] INFO: archiver:lmdb:1 Starting data store with maxReaders 16 17:44:46 [17:44:46.821] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:46 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:46 [17:44:46.821] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:46 [17:44:46.934] INFO: node:blob-sink:client:1 Testing configured blob sources {"blobSinkUrl":"http://localhost:33047"} 17:44:46 [17:44:46.937] INFO: node:blob-sink:client:1 Blob sink is reachable {"blobSinkUrl":"http://localhost:33047"} 17:44:46 [17:44:46.937] WARN: node:blob-sink:client:1 No L1 consensus host urls configured 17:44:46 [17:44:46.938] WARN: node:blob-sink:client:1 No archive client configured 17:44:46 [17:44:46.942] INFO: archiver:1 Starting archiver sync to rollup contract 0x6c4896c00fb7428f6031272a840d0635150312ae from L1 block 12 to current L1 block 14 with hash 0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28 {"blocksSynchedTo":12,"messagesSynchedTo":{"l1BlockHash":"0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28","l1BlockNumber":14}} 17:44:47 [17:44:47.018] INFO: archiver:1 Downloaded L2 block 4 {"blockHash":"0x0151b76fe673e259c36e8251f175b5efa847db7f2495e3bc9b255558515ac046","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749750292,"version":2872520363},"archiveRoot":"0x1dcbff3c982941a04b31d81369f4df4dacb5f9d54011a79ef63a6fab61ebbec6","archiveNextLeafIndex":5} 17:44:47 [17:44:47.036] INFO: archiver:1 Initial archiver sync to L1 block 14 complete. {"l1BlockNumber":14,"syncPoint":{"blocksSynchedTo":14,"messagesSynchedTo":{"l1BlockHash":"0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28","l1BlockNumber":14}},"latest":{"number":4,"hash":"0x0151b76fe673e259c36e8251f175b5efa847db7f2495e3bc9b255558515ac046"},"proven":{"number":0},"finalized":{"number":0}} 17:44:47 [17:44:47.068] INFO: world-state:database:1 Creating world state data store at directory /tmp/3fa8b2f0ba989fa9/313b998ad679da8e/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:44:47 [17:44:47.089] INFO: world_state:1 Created world state synchroniser with block history of 64 17:44:47 [17:44:47.089] WARN: node:1 Aztec node is accepting fake proofs 17:44:47 [17:44:47.112] INFO: p2p:lmdb-v2:1 Creating p2p data store at directory /tmp/3fa8b2f0ba989fa9/313b998ad679da8e/p2p with map size 134217728 KB (LMDB v2) 17:44:47 [17:44:47.120] INFO: p2p:lmdb-v2:1 Starting data store with maxReaders 16 17:44:47 [17:44:47.125] INFO: p2p-archive:lmdb-v2:1 Creating p2p-archive data store at directory /tmp/3fa8b2f0ba989fa9/313b998ad679da8e/p2p-archive with map size 134217728 KB (LMDB v2) 17:44:47 [17:44:47.132] INFO: p2p-archive:lmdb-v2:1 Starting data store with maxReaders 16 17:44:47 [17:44:47.137] INFO: p2p-peer:lmdb-v2:1 Creating p2p-peers data store at directory /tmp/3fa8b2f0ba989fa9/313b998ad679da8e/p2p-peers with map size 134217728 KB (LMDB v2) 17:44:47 [17:44:47.139] INFO: p2p-peer:lmdb-v2:1 Starting data store with maxReaders 16 17:44:47 [17:44:47.141] INFO: p2p:tx_pool:1 Setting maximum tx mempool size {"maxTxPoolSize":100000000} 17:44:47 [17:44:47.141] VERBOSE: p2p:1 P2P is disabled. Using dummy P2P service 17:44:47 [17:44:47.143] VERBOSE: world_state:1 Starting sync from 4 to latest block 4 17:44:47 [17:44:47.144] VERBOSE: world-state:block_stream:1 Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:44:47 [17:44:47.144] INFO: world_state:1 Started world state synchronizer from block 4 17:44:47 [17:44:47.149] VERBOSE: world-state:block_stream:1 Starting sync from block number 3 17:44:47 [17:44:47.169] INFO: world_state:1 World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":14.132095000008121,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1749750292,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:47 [17:44:47.175] INFO: p2p:1 Starting p2p client from block 4 with empty mempools 17:44:47 [17:44:47.176] VERBOSE: p2p:l2-block-stream:1 Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":4} 17:44:47 [17:44:47.177] INFO: epoch-prune-watcher:1 EpochPruneWatcher initialized 17:44:47 [17:44:47.177] VERBOSE: node:1 All Aztec Node subsystems synced 17:44:47 [17:44:47.188] INFO: slasher:1 Starting Slasher client... 17:44:47 [17:44:47.191] INFO: node:1 Aztec Node version: 0.87.6 17:44:47 [17:44:47.191] INFO: node:1 Aztec Node started on chain 0x7a69 {"registryAddress":"0x992d1f24cc5f368188d936cf0b2a111cee586d4e","governanceAddress":"0x506150cab49dbc09c8b79d20ac5c79ca28220aea","governanceProposerAddress":"0xfdb60896b1920a10fd3aa268a292e51ebd5568a8","rollupAddress":"0x6c4896c00fb7428f6031272a840d0635150312ae","inboxAddress":"0xe4d60b12b0b7ed88c4c6ddb302fd34ac3c76bb93","outboxAddress":"0xa558ec040e993f34f8372128706ed88345906a05","feeJuicePortalAddress":"0xaac66a0f031e867fe79793b9bba0e976f8c92075","feeJuiceAddress":"0xd8b56421e9b573ae62f2997b7b58858a4413a967","stakingAssetAddress":"0x026208fee3f4461826c8838c3569272e8c08e131","rewardDistributorAddress":"0xd462e23c2c8a9b4f83de76004a170d4cebb5d3e1","gseAddress":"0xad2120681b02de3e9b8afd325977cdeddf15f01c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x5511c8f078cc8714dd2996f52e6df240447ae71d","feeAssetHandlerAddress":"0x3607dbafde17871e0d6a8f929151c30b83510d39","stakingAssetHandlerAddress":"0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 17:44:47 [17:44:47.193] WARN: e2e:e2e_snapshot_sync New node synced 17:44:47 [17:44:47.197] VERBOSE: p2p:l2-block-stream:1 Starting sync from block number 3 17:44:47 [17:44:47.205] WARN: e2e:e2e_snapshot_sync Checking for L2 block 3 with hash 0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e on both nodes 17:44:47 [17:44:47.207] VERBOSE: p2p:1 Synched to latest block 4 17:44:47 [17:44:47.219] WARN: e2e:e2e_snapshot_sync Stopping new node 17:44:47 [17:44:47.220] INFO: node:1 Stopping Aztec Node 17:44:47 [17:44:47.343] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:47 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:47 [17:44:47.345] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:47 [17:44:47.861] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:47 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:47 [17:44:47.862] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:48 [17:44:48.377] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:48 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:48 [17:44:48.377] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:48 [17:44:48.893] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:48 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:48 [17:44:48.894] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:49 [17:44:49.223] INFO: slasher:1 Slasher client stopped. 17:44:49 [17:44:49.225] INFO: p2p:1 P2P client stopped 17:44:49 [17:44:49.227] INFO: world_state:1 Stopped world state synchronizer 17:44:49 [17:44:49.227] INFO: archiver:1 Stopped. 17:44:49 [17:44:49.228] INFO: node:1 Stopped Aztec Node 17:44:49 [17:44:49.230] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync downloads snapshot when syncing new prover node 17:44:49 [17:44:49.230] WARN: e2e:e2e_snapshot_sync Syncing brand new prover node with snapshot sync 17:44:49 [17:44:49.230] WARN: e2e:e2e_snapshot_sync Creating and syncing a prover node... 17:44:49 [17:44:49.286] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:33047"} 17:44:49 [17:44:49.290] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/3fa8b2f0ba989fa9/b671963b5403d32a/archiver with map size 134217728 KB (LMDB v2) 17:44:49 [17:44:49.292] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 17:44:49 [17:44:49.523] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:49 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:49 [17:44:49.523] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:49 [17:44:49.665] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:33047"} 17:44:49 [17:44:49.668] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:33047"} 17:44:49 [17:44:49.669] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 17:44:49 [17:44:49.669] WARN: blob-sink:client:prover-node No archive client configured 17:44:49 [17:44:49.673] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x6c4896c00fb7428f6031272a840d0635150312ae from L1 block 4 to current L1 block 14 with hash 0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28 {"blocksSynchedTo":4,"messagesSynchedTo":{"l1BlockHash":"0x268e00e4f54a29be6ea664149978e9937b4fbedafc00ad4c9292310121008c79","l1BlockNumber":4}} 17:44:49 [17:44:49.862] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x020537c1a634c077aa3b7b8184898addd2ff49e356a724e3c9ac3c00ce2d5504","blockNumber":1,"txCount":0,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749750244,"version":2872520363},"archiveRoot":"0x2a74b2e738b2d6d3d67172e2f2c25d3413e775780aa54d0e08266bd30abe4232","archiveNextLeafIndex":2} 17:44:49 [17:44:49.867] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x037cb03adf2332516dd5d9871cd0ec9113b71923a2d0f74c640e81961d140e26","blockNumber":2,"txCount":0,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749750260,"version":2872520363},"archiveRoot":"0x02c3bee6b201170f3f2ff9f6f298b1e21d7e776c8ddc550803996381c9c58331","archiveNextLeafIndex":3} 17:44:49 [17:44:49.871] INFO: archiver:prover-node Downloaded L2 block 3 {"blockHash":"0x1ba02a94afb75b7b4986bafc6f9faa9c3fc13f5f1b85a1c2bf0250f26698328e","blockNumber":3,"txCount":0,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749750276,"version":2872520363},"archiveRoot":"0x069d441b7b1d2e9bbc11a16b601cc2559886b833ac9b61c41ce31bde863341f9","archiveNextLeafIndex":4} 17:44:49 [17:44:49.872] INFO: archiver:prover-node Downloaded L2 block 4 {"blockHash":"0x0151b76fe673e259c36e8251f175b5efa847db7f2495e3bc9b255558515ac046","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749750292,"version":2872520363},"archiveRoot":"0x1dcbff3c982941a04b31d81369f4df4dacb5f9d54011a79ef63a6fab61ebbec6","archiveNextLeafIndex":5} 17:44:49 [17:44:49.885] INFO: archiver:prover-node Initial archiver sync to L1 block 14 complete. {"l1BlockNumber":14,"syncPoint":{"blocksSynchedTo":14,"messagesSynchedTo":{"l1BlockHash":"0x4877cb183de9f5eaf7a96f19330cf26b13de084b73150586e566c66009ab9d28","l1BlockNumber":14}},"latest":{"number":4,"hash":"0x0151b76fe673e259c36e8251f175b5efa847db7f2495e3bc9b255558515ac046"},"proven":{"number":0},"finalized":{"number":0}} 17:44:49 [17:44:49.889] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:33047"} 17:44:49 [17:44:49.890] INFO: prover-node:prover-node Creating local file file store at /tmp/snapshots-lLQK8O 17:44:49 [17:44:49.890] VERBOSE: prover-node:prover-node Creating temporary archiver data store 17:44:49 [17:44:49.892] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/3fa8b2f0ba989fa9/b671963b5403d32a/archiver with map size 134217728 KB (LMDB v2) 17:44:49 [17:44:49.896] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 17:44:49 [17:44:49.900] VERBOSE: prover-node:prover-node Closing temporary archiver data store {"archiverL1BlockNumber":14,"archiverL2BlockNumber":4} 17:44:49 [17:44:49.901] VERBOSE: prover-node:prover-node Skipping non-forced snapshot sync as archiver is already synced to L2 block 4. 17:44:49 [17:44:49.902] VERBOSE: prover-node:prover-node Created archiver and synced to block 4 17:44:49 [17:44:49.910] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/3fa8b2f0ba989fa9/b671963b5403d32a/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 17:44:49 [17:44:49.940] INFO: world_state:prover-node Created world state synchroniser with block history of 64 17:44:49 [17:44:49.941] VERBOSE: world_state:prover-node Starting sync from 1 to latest block 4 17:44:49 [17:44:49.942] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":100} 17:44:49 [17:44:49.942] INFO: world_state:prover-node Started world state synchronizer from block 1 17:44:49 [17:44:49.945] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 17:44:49 [17:44:49.981] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":3.5155590000067605,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":1,"blockTimestamp":1749750244,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:49 [17:44:49.986] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":4.738088999991305,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":2,"blockTimestamp":1749750260,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:49 [17:44:49.991] INFO: world_state:prover-node World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":4.48811299999943,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":3,"blockTimestamp":1749750276,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:50 [17:44:50.000] INFO: world_state:prover-node World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":7.812355999994907,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1749750292,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 17:44:50 [17:44:50.001] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/3fa8b2f0ba989fa9/b671963b5403d32a/archiver when loading epoch databases, ignoring 17:44:50 [17:44:50.001] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/3fa8b2f0ba989fa9/b671963b5403d32a/world_state when loading epoch databases, ignoring 17:44:50 [17:44:50.003] INFO: prover-client:proving-broker:prover-node Proving Broker started 17:44:50 [17:44:50.016] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 17:44:50 [17:44:50.017] INFO: e2e:e2e_snapshot_sync:prover-node Created and synced prover node {"publisherAddress":"0x9965507D1a55bcC2695C58ba16FB37d819B0A4dc"} 17:44:50 [17:44:50.018] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 17:44:50 [17:44:50.021] VERBOSE: prover-node:prover-node Fetching 0 tx hashes for block number 4 from coordination 17:44:50 [17:44:50.022] INFO: prover-node:combined-prover-coordination:prover-node Check for 0 txs found all in the pool 17:44:50 [17:44:50.024] 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/3fa8b2f0ba989fa9/b671963b5403d32a","l1ChainId":31337,"rollupVersion":2872520363} 17:44:50 [17:44:50.024] WARN: e2e:e2e_snapshot_sync New node prover synced 17:44:50 [17:44:50.031] WARN: e2e:e2e_snapshot_sync Stopping new prover node 17:44:50 [17:44:50.031] INFO: prover-node:prover-node Stopping ProverNode 17:44:50 [17:44:50.032] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 17:44:50 [17:44:50.032] INFO: archiver:prover-node Stopped. 17:44:50 [17:44:50.035] INFO: world_state:prover-node Stopped world state synchronizer 17:44:50 [17:44:50.035] INFO: prover-node:prover-node Stopped ProverNode 17:44:50 [17:44:50.046] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:50 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:50 [17:44:50.047] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:50 [17:44:50.066] INFO: node Stopping Aztec Node 17:44:50 [17:44:50.587] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:50 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:50 [17:44:50.588] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:51 [17:44:51.103] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:51 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:51 [17:44:51.104] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:51 [17:44:51.618] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 17:44:51 error: "Rollup__SlotAlreadyInChain(5, 5)" 17:44:51 [17:44:51.618] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 17:44:52 [17:44:52.068] INFO: slasher Slasher client stopped. 17:44:52 [17:44:52.069] INFO: sequencer Stopped sequencer 17:44:52 [17:44:52.070] INFO: p2p P2P client stopped 17:44:52 [17:44:52.074] INFO: world_state Stopped world state synchronizer 17:44:52 [17:44:52.074] INFO: archiver Stopped. 17:44:52 [17:44:52.074] INFO: node Stopped Aztec Node 17:44:52 [17:44:52.089] INFO: blob-sink:server Stopping blob sink 17:44:52 [17:44:52.090] INFO: blob-sink:server Blob sink stopped 17:44:52 PASS src/e2e_snapshot_sync.test.ts 17:44:52 e2e_snapshot_sync 17:44:52 ✓ waits until a few L2 blocks have been mined and purges blobs (53033 ms) 17:44:52 ✓ creates a snapshot (1008 ms) 17:44:52 ✓ downloads snapshot when syncing new node (2833 ms) 17:44:52 ✓ downloads snapshot when syncing new prover node (807 ms) 17:44:52 17:44:52 Test Suites: 1 passed, 1 total 17:44:52 Tests: 4 passed, 4 total 17:44:52 Snapshots: 0 total 17:44:52 Time: 118.602 s 17:44:52 Ran all test suites matching /src\/e2e_snapshot_sync.test.ts/i. 17:44:52 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?