Parent Log: http://ci.aztec-labs.com/14921c3326ff4988 Command: f90a5f977f0e6ffb: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/98fbe17330964452777de26d56f0a3ed5633aca1 Env: REF_NAME=gh-readonly-queue/next/pr-14921-fa23733be8278348dff0959c8094bcfd89eb44d5 CURRENT_VERSION=0.87.6 CI_FULL=0 Date: Thu Jun 12 10:19:28 UTC 2025 System: ARCH=arm64 CPUS=64 MEM=247Gi HOSTNAME=pr-14921_arm64_a1-fast Resources: CPU_LIST=0-63 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_eb8f79a88ef38365_next 10:19:28 +++ id -u 10:19:28 +++ id -g 10:19:28 ++ docker run -d --name e2e_snapshot_sync --net=none --cpuset-cpus=0-63 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/end-to-end/scripts/run_test.sh simple src/e2e_snapshot_sync.test.ts'\''' 10:19:28 + cid=dd48fd284ee0690969bbac4810f7e4be3b618eb1e743b25948dee82c3a095aa7 10:19:28 + set +x 10:19:29 {"level":25,"time":1749723569339,"pid":12,"hostname":"dd48fd284ee0","module":"logger","msg":"Logger initialized with level verbose"} 10:19:33 [10:19:33.611] INFO: e2e:e2e_snapshot_sync Logging metrics to log/unknown.jsonl 10:19:33 [10:19:33.732] INFO: e2e:e2e_snapshot_sync Calling anvil_setBlockTimestampInterval with params: [8] 10:19:33 [10:19:33.754] WARN: e2e:e2e_snapshot_sync Set block interval to 8 10:19:33 [10:19:33.755] VERBOSE: e2e:e2e_snapshot_sync Deploying contracts from 0xf39Fd6e51aad88F6F4ce6aB8827279cffFb92266 10:19:33 [10:19:33.803] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xff8f3047f70ec9e63079d7903c02a47802dc292d5660d2da825ac209bbd9cd89 {"gasLimit":867658,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 10:19:33 [10:19:33.804] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xd8B56421e9b573AE62f2997B7b58858a4413A967 in tx 0xff8f3047f70ec9e63079d7903c02a47802dc292d5660d2da825ac209bbd9cd89. 10:19:33 [10:19:33.806] VERBOSE: e2e:e2e_snapshot_sync Deployed Fee Asset at 0xd8b56421e9b573ae62f2997b7b58858a4413a967 10:19:33 [10:19:33.825] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xb8a727e5dcee31d2ee7a6a94b8b01df7952fdc685dfb1b5bb36a0dbda9d08d89 {"gasLimit":867644,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 10:19:33 [10:19:33.826] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x026208feE3F4461826C8838C3569272E8C08E131 in tx 0xb8a727e5dcee31d2ee7a6a94b8b01df7952fdc685dfb1b5bb36a0dbda9d08d89. 10:19:33 [10:19:33.827] VERBOSE: e2e:e2e_snapshot_sync Deployed Staking Asset at 0x026208fee3f4461826c8838c3569272e8c08e131 10:19:33 [10:19:33.847] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x84345970a64bc89d244665c6d19bcf62f7a1fb0c5497fd61c66569ea96442f1f {"gasLimit":3118894,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 10:19:33 [10:19:33.848] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xad2120681B02De3e9b8aFd325977CDeDDf15f01C in tx 0x84345970a64bc89d244665c6d19bcf62f7a1fb0c5497fd61c66569ea96442f1f. 10:19:33 [10:19:33.849] VERBOSE: e2e:e2e_snapshot_sync Deployed GSE at 0xad2120681b02de3e9b8afd325977cdeddf15f01c 10:19:33 [10:19:33.866] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x96c1e759b945754976d026659a519c1c5d05a738916e69d742cdec67a5482765 {"gasLimit":1030513,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 10:19:33 [10:19:33.867] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x992D1f24CC5f368188d936cf0b2A111cEE586d4e in tx 0x96c1e759b945754976d026659a519c1c5d05a738916e69d742cdec67a5482765. 10:19:33 [10:19:33.867] VERBOSE: e2e:e2e_snapshot_sync Deployed Registry at 0x992d1f24cc5f368188d936cf0b2a111cee586d4e 10:19:33 [10:19:33.889] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x35838f7740ede8daad92b7b8589b59625f0100193e252bc6ce3862a65d23892c {"gasLimit":1998672,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 10:19:33 [10:19:33.890] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xfDB60896B1920A10Fd3AA268A292E51ebD5568A8 in tx 0x35838f7740ede8daad92b7b8589b59625f0100193e252bc6ce3862a65d23892c. 10:19:33 [10:19:33.890] VERBOSE: e2e:e2e_snapshot_sync Deployed GovernanceProposer at 0xfdb60896b1920a10fd3aa268a292e51ebd5568a8 10:19:33 [10:19:33.909] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x4dbcecd47a2081d10a38e4cf385714d92e542e5a44eb5a37a3810c6c6738dc4e {"gasLimit":3092007,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 10:19:33 [10:19:33.909] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x506150CaB49DBC09C8B79D20ac5c79CA28220AEA in tx 0x4dbcecd47a2081d10a38e4cf385714d92e542e5a44eb5a37a3810c6c6738dc4e. 10:19:33 [10:19:33.910] VERBOSE: e2e:e2e_snapshot_sync Deployed Governance at 0x506150cab49dbc09c8b79d20ac5c79ca28220aea 10:19:33 [10:19:33.921] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xf2ecc0d2040ae9928a4b186c21f02e611c2904f24b196eed69d646e9333cc00d {"gasLimit":100000,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 10:19:33 [10:19:33.921] VERBOSE: e2e:e2e_snapshot_sync Set governance on GSE in 0xf2ecc0d2040ae9928a4b186c21f02e611c2904f24b196eed69d646e9333cc00d 10:19:33 [10:19:33.936] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x77f9fa97fbbcb04392e88d456c198520b3425518c3d2d4146393099192372448 {"gasLimit":397390,"maxFeePerGas":"2.80180664","maxPriorityFeePerGas":"1.2"} 10:19:33 [10:19:33.936] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x1649EeAD62C64Db7F63182989C8c41Ab25025C21 in tx 0x77f9fa97fbbcb04392e88d456c198520b3425518c3d2d4146393099192372448. 10:19:33 [10:19:33.937] VERBOSE: e2e:e2e_snapshot_sync Deployed CoinIssuer at 0x1649eead62c64db7f63182989c8c41ab25025c21 10:19:33 [10:19:33.937] VERBOSE: e2e:e2e_snapshot_sync Waiting for deployments to complete 10:19:33 [10:19:33.937] INFO: e2e:e2e_snapshot_sync Waiting for 7 transactions to be mined... 10:19:41 [10:19:41.955] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 10:19:41 [10:19:41.964] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xc033579f2357cfd2f6fa38d1ef9986415f4ed794add3fff64984bc3f1257e970 {"gasLimit":100000,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 10:19:41 [10:19:41.965] VERBOSE: e2e:e2e_snapshot_sync Added coin issuer 0x1649eead62c64db7f63182989c8c41ab25025c21 as minter on fee asset in 0xc033579f2357cfd2f6fa38d1ef9986415f4ed794add3fff64984bc3f1257e970 10:19:41 [10:19:41.976] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xd6a54e4eed6f07d2b8dcaafbd3883b3558583e43612f444af113d489245a2bb1 {"gasLimit":56661,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 10:19:41 [10:19:41.990] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xa67ff7f4001dc5703375e116caba00222d15ec13472e10af8018f62318b463cb {"gasLimit":344517,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 10:19:41 [10:19:41.990] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x3607dbAfDe17871E0D6A8f929151C30b83510D39 in tx 0xa67ff7f4001dc5703375e116caba00222d15ec13472e10af8018f62318b463cb. 10:19:41 [10:19:41.990] VERBOSE: e2e:e2e_snapshot_sync Deployed FeeAssetHandler at 0x3607dbafde17871e0d6a8f929151c30b83510d39 10:19:42 [10:19:42.009] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xa32bc1b02f5f02b41626611ec0e0056cad989330fbf908181b5d4f7678377aae {"gasLimit":56804,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 10:19:42 [10:19:42.009] VERBOSE: e2e:e2e_snapshot_sync Added fee asset handler 0x3607dbafde17871e0d6a8f929151c30b83510d39 as minter on fee asset in 0xa32bc1b02f5f02b41626611ec0e0056cad989330fbf908181b5d4f7678377aae 10:19:42 [10:19:42.030] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xadb884185b00b3cf3fb2aac4753fbbc2bbb58dfbab2a937d61ea0e950d96b91b {"gasLimit":2514669,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 10:19:42 [10:19:42.030] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x499C89D6b68cBdcA67C96Bff13Eb5B5a8fDb25a2 in tx 0xadb884185b00b3cf3fb2aac4753fbbc2bbb58dfbab2a937d61ea0e950d96b91b. 10:19:42 [10:19:42.031] VERBOSE: e2e:e2e_snapshot_sync Deployed StakingAssetHandler at 0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2 10:19:42 [10:19:42.094] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x2b32bbf996c6d3500330bc3ce74137b03f19074efe8ad0d3e14e6dea009f12e4 {"gasLimit":56804,"maxFeePerGas":"3.04180664","maxPriorityFeePerGas":"1.44"} 10:19:42 [10:19:42.094] VERBOSE: e2e:e2e_snapshot_sync Added staking asset handler 0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2 as minter on staking asset in 0x2b32bbf996c6d3500330bc3ce74137b03f19074efe8ad0d3e14e6dea009f12e4 10:19:42 [10:19:42.094] VERBOSE: e2e:e2e_snapshot_sync Waiting for deployments to complete 10:19:42 [10:19:42.094] INFO: e2e:e2e_snapshot_sync Waiting for 9 transactions to be mined... 10:19:50 [10:19:50.104] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 10:19:50 [10:19:50.117] VERBOSE: e2e:e2e_snapshot_sync Deployed shared contracts 10:19:50 [10:19:50.131] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x1f3bf003fea3920e27f0ab1b5a7c080b356836c498ba06ccbbb2f38e05cac9a5 {"gasLimit":84823,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 10:19:50 [10:19:50.132] VERBOSE: e2e:e2e_snapshot_sync Funded reward distributor with 10000000000000000000000000 fee asset in 0x1f3bf003fea3920e27f0ab1b5a7c080b356836c498ba06ccbbb2f38e05cac9a5 10:19:50 [10:19:50.145] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x8ddfc36dd291a7e69dbb1d1c4b25283f53b9e73f733772b984e1b7cef75ca71d {"gasLimit":154658,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 10:19:50 [10:19:50.146] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x277E22B0C9698d7f2A1cD7C6d857511617587309 in tx 0x8ddfc36dd291a7e69dbb1d1c4b25283f53b9e73f733772b984e1b7cef75ca71d. 10:19:50 [10:19:50.146] VERBOSE: e2e:e2e_snapshot_sync Rollup will use the mock verifier at 0x277e22b0c9698d7f2a1cd7c6d857511617587309 10:19:50 [10:19:50.146] 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}} 10:19:50 [10:19:50.158] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x1244dd983dfa48995970c0afd0fb79b5391ff919edd2ee7939902fc973eec3e1 {"gasLimit":86992,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 10:19:50 [10:19:50.158] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0xbba8820C80d584aEc2Cb092C3a0bE628aAB41fe3 in tx 0x1244dd983dfa48995970c0afd0fb79b5391ff919edd2ee7939902fc973eec3e1. 10:19:50 [10:19:50.186] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x0785920f3b1808bbb32fbbb9fc7abf594c7e8c615f21bf1b26859927d6d53edc {"gasLimit":6301243,"maxFeePerGas":"3.2549605","maxPriorityFeePerGas":"1.728"} 10:19:50 [10:19:50.186] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x0130CEd3370Af8E822F3D9076177E04F1cA75D3e in tx 0x0785920f3b1808bbb32fbbb9fc7abf594c7e8c615f21bf1b26859927d6d53edc. 10:19:50 [10:19:50.187] VERBOSE: e2e:e2e_snapshot_sync Awaiting for linked libraries to be deployed 10:19:58 [10:19:58.250] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x96af7b7060ad2b8a1895bb0f78150f621cd8e1d27e6cc8186d971a7a8bb04cbf {"gasLimit":11236180,"maxFeePerGas":"3.44200128","maxPriorityFeePerGas":"2.0736"} 10:19:58 [10:19:58.250] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x22C526E219d22F337bfAaDCC36F833e71667B88e in tx 0x96af7b7060ad2b8a1895bb0f78150f621cd8e1d27e6cc8186d971a7a8bb04cbf. 10:19:58 [10:19:58.251] VERBOSE: e2e:e2e_snapshot_sync Deployed Rollup at 0x22c526e219d22f337bfaadcc36f833e71667b88e {"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}} 10:19:58 [10:19:58.251] INFO: e2e:e2e_snapshot_sync Waiting for 11 transactions to be mined... 10:20:06 [10:20:06.263] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 10:20:06 [10:20:06.263] VERBOSE: e2e:e2e_snapshot_sync All core contracts have been deployed 10:20:06 [10:20:06.281] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0xa22b7ce3155331a8cadb49227a6ec64541a0e4642f4730691b7708186b6bd413 {"gasLimit":1056496,"maxFeePerGas":"3.747782171","maxPriorityFeePerGas":"2.48832"} 10:20:06 [10:20:06.281] VERBOSE: e2e:e2e_snapshot_sync Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000001 to address 0x94D7eB9f5a68684efD66f848E9efBa1b079CC9e0 in tx 0xa22b7ce3155331a8cadb49227a6ec64541a0e4642f4730691b7708186b6bd413. 10:20:06 [10:20:06.281] VERBOSE: e2e:e2e_snapshot_sync Deployed SlashFactory at 0x94d7eb9f5a68684efd66f848e9efba1b079cc9e0 10:20:06 [10:20:06.305] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x2ade36a1a60bc31f56288ec83d806195f304f483a4df171a11502fd9bcfb7489 {"gasLimit":116846,"maxFeePerGas":"3.747782171","maxPriorityFeePerGas":"2.48832"} 10:20:06 [10:20:06.305] VERBOSE: e2e:e2e_snapshot_sync Adding rollup 0x22c526e219d22f337bfaadcc36f833e71667b88e to registry 0x992d1f24cc5f368188d936cf0b2a111cee586d4e in tx 0x2ade36a1a60bc31f56288ec83d806195f304f483a4df171a11502fd9bcfb7489 10:20:06 [10:20:06.320] VERBOSE: e2e:e2e_snapshot_sync Sent L1 transaction 0x2958f6dfb1ba542973ffdc5051220cf4c90ed581a113e51ff256df4c8825c9fc {"gasLimit":109478,"maxFeePerGas":"3.747782171","maxPriorityFeePerGas":"2.48832"} 10:20:06 [10:20:06.321] VERBOSE: e2e:e2e_snapshot_sync Adding rollup 0x22c526e219d22f337bfaadcc36f833e71667b88e to GSE 0xad2120681b02de3e9b8afd325977cdeddf15f01c in tx 0x2958f6dfb1ba542973ffdc5051220cf4c90ed581a113e51ff256df4c8825c9fc 10:20:14 [10:20:14.327] INFO: e2e:e2e_snapshot_sync Waiting for 12 transactions to be mined... 10:20:14 [10:20:14.358] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 10:20:14 [10:20:14.363] VERBOSE: e2e:e2e_snapshot_sync Rollup deployed 10:20:14 [10:20:14.363] VERBOSE: e2e:e2e_snapshot_sync Waiting for rollup and slash factory to be deployed 10:20:14 [10:20:14.364] INFO: e2e:e2e_snapshot_sync Waiting for 12 transactions to be mined... 10:20:14 [10:20:14.391] INFO: e2e:e2e_snapshot_sync All transactions mined successfully 10:20:14 [10:20:14.391] VERBOSE: e2e:e2e_snapshot_sync All transactions for L1 deployment have been mined 10:20:14 [10:20:14.408] INFO: e2e:e2e_snapshot_sync Aztec L1 contracts initialized {"registryAddress":"0x992d1f24cc5f368188d936cf0b2a111cee586d4e","governanceAddress":"0x506150cab49dbc09c8b79d20ac5c79ca28220aea","governanceProposerAddress":"0xfdb60896b1920a10fd3aa268a292e51ebd5568a8","rollupAddress":"0x22c526e219d22f337bfaadcc36f833e71667b88e","inboxAddress":"0xd011bc17cf103a874287b684028feedd08533dda","outboxAddress":"0x7b7dace4d3ecf3263b7137bfa340c9b9395affc6","feeJuicePortalAddress":"0x65c65becd51d5c16aa739688dda2929d780481a1","feeJuiceAddress":"0xd8b56421e9b573ae62f2997b7b58858a4413a967","stakingAssetAddress":"0x026208fee3f4461826c8838c3569272e8c08e131","rewardDistributorAddress":"0xd462e23c2c8a9b4f83de76004a170d4cebb5d3e1","gseAddress":"0xad2120681b02de3e9b8afd325977cdeddf15f01c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266"} 10:20:14 [10:20:14.408] INFO: e2e:e2e_snapshot_sync Handing over to governance 10:20:14 [10:20:14.411] INFO: e2e:e2e_snapshot_sync Calling evm_setNextBlockTimestamp with params: [1749723621] 10:20:14 [10:20:14.412] INFO: e2e:e2e_snapshot_sync Calling hardhat_mine with params: [1] 10:20:14 [10:20:14.414] INFO: e2e:e2e_snapshot_sync Jumped to slot 1 10:20:14 [10:20:14.420] INFO: aztecjs:utils:watcher Watcher not started because not auto mining 10:20:14 [10:20:14.420] INFO: telemetry:client Using NoopTelemetryClient 10:20:14 [10:20:14.422] INFO: kv-store:lmdb-v2:blob-sink Creating blob-sink data store at directory /tmp/f57da7bf000e4c3c/blob-sink with map size 134217728 KB (LMDB v2) 10:20:14 [10:20:14.425] INFO: kv-store:lmdb-v2:blob-sink Starting data store with maxReaders 16 10:20:14 [10:20:14.432] INFO: blob-sink:server Server is running on http://localhost:42919 10:20:14 [10:20:14.432] VERBOSE: e2e:e2e_snapshot_sync Creating and synching an aztec node... 10:20:14 [10:20:14.433] VERBOSE: e2e:e2e_snapshot_sync Using native ACVM binary at ../../noir/noir-repo/target/release/acvm with working directory /tmp/a83c8177/acvm 10:20:14 [10:20:14.434] INFO: node:blob-sink:client Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42919"} 10:20:14 [10:20:14.453] VERBOSE: node Snapshot sync is disabled. No snapshots URL provided. 10:20:14 [10:20:14.454] INFO: archiver:lmdb Creating archiver data store at directory /tmp/f57da7bf000e4c3c/archiver with map size 134217728 KB (LMDB v2) 10:20:14 [10:20:14.455] INFO: archiver:lmdb Starting data store with maxReaders 16 10:20:15 [10:20:15.033] INFO: node:blob-sink:client Testing configured blob sources {"blobSinkUrl":"http://localhost:42919"} 10:20:15 [10:20:15.047] INFO: node:blob-sink:client Blob sink is reachable {"blobSinkUrl":"http://localhost:42919"} 10:20:15 [10:20:15.047] WARN: node:blob-sink:client No L1 consensus host urls configured 10:20:15 [10:20:15.047] WARN: node:blob-sink:client No archive client configured 10:20:15 [10:20:15.050] INFO: archiver Starting archiver sync to rollup contract 0x22c526e219d22f337bfaadcc36f833e71667b88e from L1 block 4 to current L1 block 6 with hash 0xe280c78f73dea3f9f85c7f9ad6411d7e90dbb4a882a9c44702471bcada6310ae {"blocksSynchedTo":4,"messagesSynchedTo":{"l1BlockHash":"0x49bed39f610663ebc87ef29fef6989d015c4a5f5d5eb8219bc391923131dafa6","l1BlockNumber":4}} 10:20:15 [10:20:15.062] INFO: archiver Initial archiver sync to L1 block 6 complete. {"l1BlockNumber":6,"syncPoint":{"blocksSynchedTo":6,"messagesSynchedTo":{"l1BlockHash":"0xe280c78f73dea3f9f85c7f9ad6411d7e90dbb4a882a9c44702471bcada6310ae","l1BlockNumber":6}},"latest":{"number":0},"proven":{"number":0},"finalized":{"number":0}} 10:20:15 [10:20:15.067] INFO: world-state:database Creating world state data store at directory /tmp/f57da7bf000e4c3c/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 10:20:15 [10:20:15.090] INFO: world_state Created world state synchroniser with block history of 64 10:20:15 [10:20:15.090] WARN: node Aztec node is accepting fake proofs 10:20:15 [10:20:15.099] INFO: p2p:lmdb-v2 Creating p2p data store at directory /tmp/f57da7bf000e4c3c/p2p with map size 134217728 KB (LMDB v2) 10:20:15 [10:20:15.100] INFO: p2p:lmdb-v2 Starting data store with maxReaders 16 10:20:15 [10:20:15.101] INFO: p2p-archive:lmdb-v2 Creating p2p-archive data store at directory /tmp/f57da7bf000e4c3c/p2p-archive with map size 134217728 KB (LMDB v2) 10:20:15 [10:20:15.102] INFO: p2p-archive:lmdb-v2 Starting data store with maxReaders 16 10:20:15 [10:20:15.103] INFO: p2p-peer:lmdb-v2 Creating p2p-peers data store at directory /tmp/f57da7bf000e4c3c/p2p-peers with map size 134217728 KB (LMDB v2) 10:20:15 [10:20:15.104] INFO: p2p-peer:lmdb-v2 Starting data store with maxReaders 16 10:20:15 [10:20:15.105] INFO: p2p:tx_pool Setting maximum tx mempool size {"maxTxPoolSize":100000000} 10:20:15 [10:20:15.105] VERBOSE: p2p P2P is disabled. Using dummy P2P service 10:20:15 [10:20:15.108] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 10:20:15 [10:20:15.108] INFO: world_state Started world state synchronizer from block 1 10:20:15 [10:20:15.110] VERBOSE: world-state:block_stream Starting sync from block number 0 10:20:15 [10:20:15.112] INFO: p2p Starting p2p client from block 0 with empty mempools 10:20:15 [10:20:15.112] VERBOSE: p2p:l2-block-stream Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":0} 10:20:15 [10:20:15.345] INFO: epoch-prune-watcher EpochPruneWatcher initialized 10:20:15 [10:20:15.377] VERBOSE: validator Initialized validator with addresses: 0x98c580ce64f6adffd61fd94b330b8725463a9eb9 10:20:15 [10:20:15.378] VERBOSE: node All Aztec Node subsystems synced 10:20:15 [10:20:15.385] INFO: slasher Starting Slasher client... 10:20:15 [10:20:15.394] INFO: sequencer-client Deploying forwarder contract 10:20:15 [10:20:15.395] VERBOSE: p2p:l2-block-stream Starting sync from block number 0 10:20:15 [10:20:15.409] VERBOSE: sequencer-client Sent L1 transaction 0xda888973b4ad2d3d163799c42065a89b2c05bcb621343d65d24f9b27b4d854fa {"gasLimit":323704,"maxFeePerGas":"2.259597543","maxPriorityFeePerGas":"1.2"} 10:20:15 [10:20:15.409] VERBOSE: sequencer-client Deployed contract with salt 0x0000000000000000000000000000000000000000000000000000000000000042 to address 0x0fe4d493871B0C51332De8A330B02BA8172Da4aC in tx 0xda888973b4ad2d3d163799c42065a89b2c05bcb621343d65d24f9b27b4d854fa. 10:20:23 [10:20:23.415] INFO: sequencer-client Forwarder contract deployed at 0x0fe4d493871b0c51332de8a330b02ba8172da4ac 10:20:23 [10:20:23.421] INFO: validator Started validator with addresses: 0x98c580ce64f6adffd61fd94b330b8725463a9eb9 10:20:23 [10:20:23.422] VERBOSE: validator Validators 0x98c580ce64f6adffd61fd94b330b8725463a9eb9 are not on the validator committee for epoch 0 10:20:23 [10:20:23.422] INFO: sequencer Sequencer config set {"transactionPollingIntervalMS":500,"maxTxsPerBlock":32,"minTxsPerBlock":0,"maxL2BlockGas":10000000000,"publishTxsWithProposals":false,"maxDABlockGas":10000000000,"acvmWorkingDirectory":"/tmp/a83c8177/acvm","acvmBinaryPath":"../../noir/noir-repo/target/release/acvm","maxBlockSizeInBytes":1048576,"governanceProposerPayload":"0x0000000000000000000000000000000000000000","maxL1TxInclusionTimeIntoSlot":8,"enforceTimeTable":false} 10:20:23 [10:20:23.423] VERBOSE: sequencer Sequencer timetable updated {"enforceTimeTable":false} 10:20:23 [10:20:23.424] INFO: sequencer Sequencer started with address 0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266 10:20:23 [10:20:23.424] INFO: node Aztec Node version: 0.87.6 10:20:23 [10:20:23.425] INFO: node Aztec Node started on chain 0x7a69 {"registryAddress":"0x992d1f24cc5f368188d936cf0b2a111cee586d4e","governanceAddress":"0x506150cab49dbc09c8b79d20ac5c79ca28220aea","governanceProposerAddress":"0xfdb60896b1920a10fd3aa268a292e51ebd5568a8","rollupAddress":"0x22c526e219d22f337bfaadcc36f833e71667b88e","inboxAddress":"0xd011bc17cf103a874287b684028feedd08533dda","outboxAddress":"0x7b7dace4d3ecf3263b7137bfa340c9b9395affc6","feeJuicePortalAddress":"0x65c65becd51d5c16aa739688dda2929d780481a1","feeJuiceAddress":"0xd8b56421e9b573ae62f2997b7b58858a4413a967","stakingAssetAddress":"0x026208fee3f4461826c8838c3569272e8c08e131","rewardDistributorAddress":"0xd462e23c2c8a9b4f83de76004a170d4cebb5d3e1","gseAddress":"0xad2120681b02de3e9b8afd325977cdeddf15f01c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x94d7eb9f5a68684efd66f848e9efba1b079cc9e0","feeAssetHandlerAddress":"0x3607dbafde17871e0d6a8f929151c30b83510d39","stakingAssetHandlerAddress":"0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 10:20:23 [10:20:23.425] VERBOSE: e2e:e2e_snapshot_sync Creating a pxe... 10:20:23 [10:20:23.429] INFO: pxe:data:lmdb Creating pxe_data data store at directory /tmp/5629bf040705978d/pxe_data with map size 134217728 KB (LMDB v2) 10:20:23 [10:20:23.432] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 10:20:23 [10:20:23.433] INFO: pxe:data:lmdb Starting data store with maxReaders 16 10:20:23 [10:20:23.676] VERBOSE: pxe:service Registered protocol contracts in pxe {"AuthRegistry":"0x0000000000000000000000000000000000000000000000000000000000000001","ContractInstanceDeployer":"0x0000000000000000000000000000000000000000000000000000000000000002","ContractClassRegisterer":"0x0000000000000000000000000000000000000000000000000000000000000003","MultiCallEntrypoint":"0x0000000000000000000000000000000000000000000000000000000000000004","FeeJuice":"0x0000000000000000000000000000000000000000000000000000000000000005","Router":"0x0000000000000000000000000000000000000000000000000000000000000006"} 10:20:23 [10:20:23.677] INFO: pxe:service Started PXE connected to chain 31337 version 1548034364 10:20:23 [10:20:23.679] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync waits until a few L2 blocks have been mined and purges blobs 10:20:23 [10:20:23.679] WARN: e2e:e2e_snapshot_sync Waiting for L2 blocks to be mined 10:20:23 [10:20:23.900] INFO: e2e:e2e_snapshot_sync L1 block 7 mined at 10:20:29 with new L2 block 0 for epoch 0 with proof up to L2 block 0 for epoch 0 {"l1Timestamp":1749723629,"l1BlockNumber":7,"l2SlotNumber":1,"l2BlockNumber":0,"l2ProvenBlockNumber":0,"totalL2Messages":0} 10:20:23 [10:20:23.937] 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} 10:20:24 [10:20:24.442] 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} 10:20:24 [10:20:24.948] 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} 10:20:25 [10:20:25.453] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 1 but got 2. {"rollup":[2,1],"newBlockNumber":1,"expectedSlot":1} 10:20:25 [10:20:25.959] 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} 10:20:26 [10:20:26.465] 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} 10:20:26 [10:20:26.971] 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} 10:20:27 [10:20:27.476] 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} 10:20:27 [10:20:27.982] 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} 10:20:28 [10:20:28.487] 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} 10:20:28 [10:20:28.991] 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} 10:20:29 [10:20:29.505] 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":1749723637,"version":1548034364},"chainTipArchive":"0x1f9c798be7975bb34c3e605a4c92c75796eae7b9a08644bc9a6a55354ed470be","blockNumber":1,"slot":2} 10:20:29 [10:20:29.517] VERBOSE: block-builder Building block 1 for slot 2 {"slot":2,"slotStart":"2025-06-12T10:20:37.000Z","now":"2025-06-12T10:20:29.517Z","blockNumber":1,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 10:20:29 [10:20:29.520] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.00040791300000273624s {"duration":0.00040791300000273624,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 10:20:29 [10:20:29.532] INFO: sequencer Built block 1 for slot 2 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x0c35e8e66dc553a6538a50685057a8804ea0894e538d19ea60218607f0715708","globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749723637,"version":1548034364},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":21.721451999997953,"publicProcessDuration":1.132963000003656,"rollupCircuitsDuration":15.213638000001083,"txCount":0,"blockNumber":1,"blockTimestamp":1749723637,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:20:29 [10:20:29.534] VERBOSE: sequencer Attesting committee is empty 10:20:29 [10:20:29.689] INFO: e2e:e2e_snapshot_sync L1 block 8 mined at 10:20:37 {"l1Timestamp":1749723637,"l1BlockNumber":8,"l2SlotNumber":2,"l2BlockNumber":0,"l2ProvenBlockNumber":0,"totalL2Messages":0} 10:20:32 [10:20:32.123] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x64aade32840501582163bd4c526a443b58a6b426fd8714b89ab9125438362c76 10:20:32 [10:20:32.124] VERBOSE: node Sent L1 transaction 0x64aade32840501582163bd4c526a443b58a6b426fd8714b89ab9125438362c76 {"gasLimit":485800,"maxFeePerGas":"2.367147852","maxPriorityFeePerGas":"1.44","maxFeePerBlobGas":"0.000000001"} 10:20:37 [10:20:37.696] INFO: e2e:e2e_snapshot_sync L1 block 9 mined at 10:20:45 with new L2 block 1 for epoch 0 {"l1Timestamp":1749723645,"l1BlockNumber":9,"l2SlotNumber":2,"l2BlockNumber":1,"l2ProvenBlockNumber":0,"totalL2Messages":0} 10:20:37 [10:20:37.734] WARN: node:blob-sink:client Unable to get blob sidecar for 0x69345359cd773e20a91ede8b18a526c327f78fb6847ff05b733e7b6329c26ffd: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 10:20:37 [10:20:37.734] WARN: node:blob-sink:client Failed to fetch blobs for 0x69345359cd773e20a91ede8b18a526c327f78fb6847ff05b733e7b6329c26ffd from all blob sources {"blobSinkUrl":"http://localhost:42919"} 10:20:38 [10:20:38.164] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:20:38 [10:20:38.164] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x64aade32840501582163bd4c526a443b58a6b426fd8714b89ab9125438362c76","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":1,"blockTimestamp":1749723637,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:20:38 [10:20:38.165] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 10:20:38 [10:20:38.177] INFO: blob-sink:server Received blob sidecar for block 0x69345359cd773e20a91ede8b18a526c327f78fb6847ff05b733e7b6329c26ffd 10:20:38 [10:20:38.182] INFO: blob-sink:server Blob sidecar stored successfully for block 0x69345359cd773e20a91ede8b18a526c327f78fb6847ff05b733e7b6329c26ffd 10:20:38 [10:20:38.274] INFO: archiver Downloaded L2 block 1 {"blockHash":"0x0c35e8e66dc553a6538a50685057a8804ea0894e538d19ea60218607f0715708","blockNumber":1,"txCount":0,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749723637,"version":1548034364},"archiveRoot":"0x1a22b30ae45d6b4e0872b9d4a580170b3916dfe45d18c84c2114de74b04658e3","archiveNextLeafIndex":2} 10:20:38 [10:20:38.303] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":3.1105349999997998,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":1,"blockTimestamp":1749723637,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:20:38 [10:20:38.328] VERBOSE: p2p Synched to latest block 1 10:20:38 [10:20:38.691] 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} 10:20:39 [10:20:39.198] 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} 10:20:39 [10:20:39.705] 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} 10:20:40 [10:20:40.212] 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} 10:20:40 [10:20:40.718] 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} 10:20:41 [10:20:41.226] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 10:20:41 [10:20:41.733] 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} 10:20:42 [10:20:42.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 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 10:20:42 [10:20:42.748] 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} 10:20:43 [10:20:43.254] 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} 10:20:43 [10:20:43.761] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 2 but got 3. {"rollup":[3,2],"newBlockNumber":2,"expectedSlot":2} 10:20:44 [10:20:44.267] 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} 10:20:44 [10:20:44.775] 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} 10:20:45 [10:20:45.285] 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":1749723653,"version":1548034364},"chainTipArchive":"0x1a22b30ae45d6b4e0872b9d4a580170b3916dfe45d18c84c2114de74b04658e3","blockNumber":2,"slot":3} 10:20:45 [10:20:45.295] VERBOSE: block-builder Building block 2 for slot 3 {"slot":3,"slotStart":"2025-06-12T10:20:53.000Z","now":"2025-06-12T10:20:45.295Z","blockNumber":2,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 10:20:45 [10:20:45.297] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.00020494699999107978s {"duration":0.00020494699999107978,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 10:20:45 [10:20:45.307] INFO: sequencer Built block 2 for slot 3 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x2d6df922757b0394a0358ccbeefc4348bdbd6cc1c4550d214cbe06758f4191c8","globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749723653,"version":1548034364},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":16.936581999994814,"publicProcessDuration":0.5381829999969341,"rollupCircuitsDuration":12.232163000007858,"txCount":0,"blockNumber":2,"blockTimestamp":1749723653,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:20:45 [10:20:45.310] VERBOSE: sequencer Attesting committee is empty 10:20:45 [10:20:45.370] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xefcca1b452ff6e9d15f810abf25d880f501d8491c9726e64cb951a9a270d844b 10:20:45 [10:20:45.371] VERBOSE: node Sent L1 transaction 0xefcca1b452ff6e9d15f810abf25d880f501d8491c9726e64cb951a9a270d844b {"gasLimit":414577,"maxFeePerGas":"2.439650389","maxPriorityFeePerGas":"1.728","maxFeePerBlobGas":"0.000000001"} 10:20:45 [10:20:45.696] INFO: e2e:e2e_snapshot_sync L1 block 10 mined at 10:20:53 with new L2 block 2 for epoch 0 {"l1Timestamp":1749723653,"l1BlockNumber":10,"l2SlotNumber":3,"l2BlockNumber":2,"l2ProvenBlockNumber":0,"totalL2Messages":0} 10:20:45 [10:20:45.844] WARN: node:blob-sink:client Unable to get blob sidecar for 0x221f833d709584dd2fedf4c37512dc9fbdac225fbe758fe71f9115b8c86ba54e: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 10:20:45 [10:20:45.844] WARN: node:blob-sink:client Failed to fetch blobs for 0x221f833d709584dd2fedf4c37512dc9fbdac225fbe758fe71f9115b8c86ba54e from all blob sources {"blobSinkUrl":"http://localhost:42919"} 10:20:46 [10:20:46.368] WARN: node:blob-sink:client Unable to get blob sidecar for 0x221f833d709584dd2fedf4c37512dc9fbdac225fbe758fe71f9115b8c86ba54e: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 10:20:46 [10:20:46.368] WARN: node:blob-sink:client Failed to fetch blobs for 0x221f833d709584dd2fedf4c37512dc9fbdac225fbe758fe71f9115b8c86ba54e from all blob sources {"blobSinkUrl":"http://localhost:42919"} 10:20:46 [10:20:46.384] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:20:46 [10:20:46.384] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xefcca1b452ff6e9d15f810abf25d880f501d8491c9726e64cb951a9a270d844b","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":2,"blockTimestamp":1749723653,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:20:46 [10:20:46.385] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 10:20:46 [10:20:46.388] INFO: blob-sink:server Received blob sidecar for block 0x221f833d709584dd2fedf4c37512dc9fbdac225fbe758fe71f9115b8c86ba54e 10:20:46 [10:20:46.393] INFO: blob-sink:server Blob sidecar stored successfully for block 0x221f833d709584dd2fedf4c37512dc9fbdac225fbe758fe71f9115b8c86ba54e 10:20:46 [10:20:46.909] INFO: archiver Downloaded L2 block 2 {"blockHash":"0x2d6df922757b0394a0358ccbeefc4348bdbd6cc1c4550d214cbe06758f4191c8","blockNumber":2,"txCount":0,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749723653,"version":1548034364},"archiveRoot":"0x17e4b21e58c4a1674de74d7978d66891b274fd9c8a21d702593a70dfb8e4fe90","archiveNextLeafIndex":3} 10:20:46 [10:20:46.918] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:46 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:46 [10:20:46.919] WARN: sequencer Cannot propose block 2 at slot 3 due to failed rollup contract check 10:20:46 [10:20:46.947] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.2996209999982966,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":2,"blockTimestamp":1749723653,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:20:47 [10:20:47.025] VERBOSE: p2p Synched to latest block 2 10:20:47 [10:20:47.430] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:47 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:47 [10:20:47.431] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:47 [10:20:47.941] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:47 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:47 [10:20:47.941] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:48 [10:20:48.451] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:48 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:48 [10:20:48.451] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:48 [10:20:48.962] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:48 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:48 [10:20:48.962] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:49 [10:20:49.473] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:49 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:49 [10:20:49.474] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:49 [10:20:49.983] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:49 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:49 [10:20:49.983] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:50 [10:20:50.493] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:50 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:50 [10:20:50.494] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:51 [10:20:51.006] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:51 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:51 [10:20:51.006] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:51 [10:20:51.515] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:51 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:51 [10:20:51.515] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:52 [10:20:52.026] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:52 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:52 [10:20:52.026] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:52 [10:20:52.535] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:52 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:52 [10:20:52.535] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:53 [10:20:53.045] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:53 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:53 [10:20:53.045] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:53 [10:20:53.555] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:20:53 error: "Rollup__SlotAlreadyInChain(3, 3)" 10:20:53 [10:20:53.555] WARN: sequencer Cannot propose block 3 at slot 3 due to failed rollup contract check 10:20:53 [10:20:53.702] INFO: e2e:e2e_snapshot_sync L1 block 11 mined at 10:21:01 {"l1Timestamp":1749723661,"l1BlockNumber":11,"l2SlotNumber":3,"l2BlockNumber":2,"l2ProvenBlockNumber":0,"totalL2Messages":0} 10:20:54 [10:20:54.062] 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} 10:20:54 [10:20:54.568] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 10:20:55 [10:20:55.076] 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} 10:20:55 [10:20:55.582] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 10:20:56 [10:20:56.089] 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} 10:20:56 [10:20:56.598] WARN: sequencer Cannot propose block due to slot mismatch with rollup contract (this can be caused by a clock out of sync). Expected slot 3 but got 4. {"rollup":[4,3],"newBlockNumber":3,"expectedSlot":3} 10:20:57 [10:20:57.106] 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} 10:20:57 [10:20:57.613] 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} 10:20:58 [10:20:58.120] 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} 10:20:58 [10:20:58.627] 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} 10:20:59 [10:20:59.134] 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} 10:20:59 [10:20:59.640] 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} 10:21:00 [10:21:00.146] 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} 10:21:00 [10:21:00.653] 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} 10:21:01 [10:21:01.163] 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":1749723669,"version":1548034364},"chainTipArchive":"0x17e4b21e58c4a1674de74d7978d66891b274fd9c8a21d702593a70dfb8e4fe90","blockNumber":3,"slot":4} 10:21:01 [10:21:01.171] VERBOSE: block-builder Building block 3 for slot 4 {"slot":4,"slotStart":"2025-06-12T10:21:09.000Z","now":"2025-06-12T10:21:01.171Z","blockNumber":3,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 10:21:01 [10:21:01.173] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.00015595300000859424s {"duration":0.00015595300000859424,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 10:21:01 [10:21:01.182] INFO: sequencer Built block 3 for slot 4 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x14a6778b3ff93b8e137fafe76b837fd631d18bc849bfecd903510245f82d69fa","globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749723669,"version":1548034364},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":16.315860999995493,"publicProcessDuration":0.49066799999854993,"rollupCircuitsDuration":11.715827000007266,"txCount":0,"blockNumber":3,"blockTimestamp":1749723669,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:21:01 [10:21:01.184] VERBOSE: sequencer Attesting committee is empty 10:21:01 [10:21:01.276] VERBOSE: ethereum:tx_delayer Sent tx immediately 0x7f6e031a05be171e833aec5831082371998e43b1a315581deeb8cddde990f68e 10:21:01 [10:21:01.277] VERBOSE: node Sent L1 transaction 0x7f6e031a05be171e833aec5831082371998e43b1a315581deeb8cddde990f68e {"gasLimit":416977,"maxFeePerGas":"1.74809754","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 10:21:01 [10:21:01.707] INFO: e2e:e2e_snapshot_sync L1 block 12 mined at 10:21:09 with new L2 block 3 for epoch 0 {"l1Timestamp":1749723669,"l1BlockNumber":12,"l2SlotNumber":4,"l2BlockNumber":3,"l2ProvenBlockNumber":0,"totalL2Messages":0} 10:21:02 [10:21:02.098] WARN: node:blob-sink:client Unable to get blob sidecar for 0xbe6d881da8167ac0f89129a2921270f642e2dce5c09d11ed87fd7d40787cc729: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 10:21:02 [10:21:02.098] WARN: node:blob-sink:client Failed to fetch blobs for 0xbe6d881da8167ac0f89129a2921270f642e2dce5c09d11ed87fd7d40787cc729 from all blob sources {"blobSinkUrl":"http://localhost:42919"} 10:21:02 [10:21:02.292] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:21:02 [10:21:02.293] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0x7f6e031a05be171e833aec5831082371998e43b1a315581deeb8cddde990f68e","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":3,"blockTimestamp":1749723669,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:21:02 [10:21:02.293] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 10:21:02 [10:21:02.295] INFO: blob-sink:server Received blob sidecar for block 0xbe6d881da8167ac0f89129a2921270f642e2dce5c09d11ed87fd7d40787cc729 10:21:02 [10:21:02.300] INFO: blob-sink:server Blob sidecar stored successfully for block 0xbe6d881da8167ac0f89129a2921270f642e2dce5c09d11ed87fd7d40787cc729 10:21:02 [10:21:02.638] INFO: archiver Downloaded L2 block 3 {"blockHash":"0x14a6778b3ff93b8e137fafe76b837fd631d18bc849bfecd903510245f82d69fa","blockNumber":3,"txCount":0,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749723669,"version":1548034364},"archiveRoot":"0x1a020bd8b627ed4656343d471ee1f3471a375b97b854aedf8da3719b3444f8d4","archiveNextLeafIndex":4} 10:21:02 [10:21:02.698] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.3898360000021057,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":3,"blockTimestamp":1749723669,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:21:02 [10:21:02.745] VERBOSE: p2p Synched to latest block 3 10:21:02 [10:21:02.808] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:02 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:02 [10:21:02.808] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:03 [10:21:03.318] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:03 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:03 [10:21:03.318] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:03 [10:21:03.827] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:03 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:03 [10:21:03.827] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:04 [10:21:04.338] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:04 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:04 [10:21:04.339] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:04 [10:21:04.848] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:04 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:04 [10:21:04.848] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:05 [10:21:05.358] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:05 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:05 [10:21:05.358] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:05 [10:21:05.866] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:05 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:05 [10:21:05.867] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:06 [10:21:06.378] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:06 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:06 [10:21:06.378] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:06 [10:21:06.886] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:06 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:06 [10:21:06.887] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:07 [10:21:07.396] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:07 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:07 [10:21:07.396] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:07 [10:21:07.904] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:07 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:07 [10:21:07.905] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:08 [10:21:08.414] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:08 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:08 [10:21:08.414] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:08 [10:21:08.923] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:08 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:08 [10:21:08.923] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:09 [10:21:09.432] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:09 error: "Rollup__SlotAlreadyInChain(4, 4)" 10:21:09 [10:21:09.432] WARN: sequencer Cannot propose block 4 at slot 4 due to failed rollup contract check 10:21:09 [10:21:09.715] INFO: e2e:e2e_snapshot_sync L1 block 13 mined at 10:21:17 {"l1Timestamp":1749723677,"l1BlockNumber":13,"l2SlotNumber":4,"l2BlockNumber":3,"l2ProvenBlockNumber":0,"totalL2Messages":0} 10:21:09 [10:21:09.938] 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} 10:21:10 [10:21:10.445] 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} 10:21:10 [10:21:10.951] 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} 10:21:11 [10:21:11.458] 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} 10:21:11 [10:21:11.966] 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} 10:21:12 [10:21:12.472] 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} 10:21:12 [10:21:12.979] 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} 10:21:13 [10:21:13.486] 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} 10:21:13 [10:21:13.994] 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} 10:21:14 [10:21:14.501] 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} 10:21:15 [10:21:15.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 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 10:21:15 [10:21:15.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 4 but got 5. {"rollup":[5,4],"newBlockNumber":4,"expectedSlot":4} 10:21:16 [10:21:16.022] 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} 10:21:16 [10:21:16.528] 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} 10:21:17 [10:21:17.037] 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":1749723685,"version":1548034364},"chainTipArchive":"0x1a020bd8b627ed4656343d471ee1f3471a375b97b854aedf8da3719b3444f8d4","blockNumber":4,"slot":5} 10:21:17 [10:21:17.046] VERBOSE: block-builder Building block 4 for slot 5 {"slot":5,"slotStart":"2025-06-12T10:21:25.000Z","now":"2025-06-12T10:21:17.046Z","blockNumber":4,"msgCount":0,"opts":{"maxTransactions":32,"maxBlockSize":1048576,"maxBlockGas":{"daGas":10000000000,"l2Gas":10000000000}}} 10:21:17 [10:21:17.048] INFO: simulator:public-processor Processed 0 successful txs and 0 failed txs in 0.00018724799998744856s {"duration":0.00018724799998744856,"rate":0,"totalPublicGas":{"daGas":0,"l2Gas":0},"totalBlockGas":{"daGas":0,"l2Gas":0},"totalSizeInBytes":0} 10:21:17 [10:21:17.058] INFO: sequencer Built block 4 for slot 5 with 0 txs and 0 messages. 0 mana/s {"blockHash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680","globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749723685,"version":1548034364},"txHashes":[],"eventName":"l2-block-built","creator":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","duration":16.76387500000419,"publicProcessDuration":0.5721829999965848,"rollupCircuitsDuration":11.957743000006303,"txCount":0,"blockNumber":4,"blockTimestamp":1749723685,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:21:17 [10:21:17.059] VERBOSE: sequencer Attesting committee is empty 10:21:17 [10:21:17.113] VERBOSE: ethereum:tx_delayer Sent tx immediately 0xeb1798e64143109186416b93f029a71176537102bcb903b80d8dfa4ff749c44e 10:21:17 [10:21:17.113] VERBOSE: node Sent L1 transaction 0xeb1798e64143109186416b93f029a71176537102bcb903b80d8dfa4ff749c44e {"gasLimit":416989,"maxFeePerGas":"1.620772506","maxPriorityFeePerGas":"1.2","maxFeePerBlobGas":"0.000000001"} 10:21:17 [10:21:17.720] INFO: e2e:e2e_snapshot_sync L1 block 14 mined at 10:21:25 with new L2 block 4 for epoch 0 {"l1Timestamp":1749723685,"l1BlockNumber":14,"l2SlotNumber":5,"l2BlockNumber":4,"l2ProvenBlockNumber":0,"totalL2Messages":0} 10:21:17 [10:21:17.806] WARN: node:blob-sink:client Unable to get blob sidecar for 0x8a5fb65150a5857a8e788a1e04cb783cc3366bd86bc945c13f2ffcb2630b3c25: Not Found (404) {"status":404,"statusText":"Not Found","body":"{\"error\":\"Blob not found\"}"} 10:21:17 [10:21:17.806] WARN: node:blob-sink:client Failed to fetch blobs for 0x8a5fb65150a5857a8e788a1e04cb783cc3366bd86bc945c13f2ffcb2630b3c25 from all blob sources {"blobSinkUrl":"http://localhost:42919"} 10:21:18 [10:21:18.125] INFO: sequencer:publisher Bundled [propose] transaction [succeeded] 10:21:18 [10:21:18.126] VERBOSE: sequencer:publisher Published L2 block to L1 rollup contract {"sender":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","transactionHash":"0xeb1798e64143109186416b93f029a71176537102bcb903b80d8dfa4ff749c44e","calldataSize":1220,"calldataGas":8840,"txCount":0,"blockNumber":4,"blockTimestamp":1749723685,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:21:18 [10:21:18.126] VERBOSE: node:blob-sink:client Sending 1 blobs to blob sink 10:21:18 [10:21:18.128] INFO: blob-sink:server Received blob sidecar for block 0x8a5fb65150a5857a8e788a1e04cb783cc3366bd86bc945c13f2ffcb2630b3c25 10:21:18 [10:21:18.133] INFO: blob-sink:server Blob sidecar stored successfully for block 0x8a5fb65150a5857a8e788a1e04cb783cc3366bd86bc945c13f2ffcb2630b3c25 10:21:18 [10:21:18.344] INFO: archiver Downloaded L2 block 4 {"blockHash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749723685,"version":1548034364},"archiveRoot":"0x273bef51fbf97761dddfe7acd9388dc04741685db1338e79f73c8763f8447dfa","archiveNextLeafIndex":5} 10:21:18 [10:21:18.350] VERBOSE: p2p Synched to latest block 4 10:21:18 [10:21:18.449] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.3542769999912707,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1749723685,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:21:18 [10:21:18.638] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:18 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:18 [10:21:18.638] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:18 [10:21:18.689] WARN: e2e:e2e_snapshot_sync L2 block height is now 4. Purging all blobs from sink so snapshot is required. 10:21:18 [10:21:18.691] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync creates a snapshot 10:21:18 [10:21:18.691] WARN: e2e:e2e_snapshot_sync Creating snapshot 10:21:18 [10:21:18.693] INFO: stdlib:file-store Creating local file file store at /tmp/snapshots-QxpcEh 10:21:18 [10:21:18.693] INFO: node Pausing archiver and world state sync to start snapshot upload 10:21:18 [10:21:18.693] INFO: archiver Stopped. 10:21:18 [10:21:18.694] INFO: world_state Stopped sync 10:21:18 [10:21:18.694] INFO: node Creating backups of lmdb environments to /tmp/f57da7bf000e4c3c/snapshot-gucFtI 10:21:18 [10:21:18.696] INFO: node Data stores backed up to /tmp/f57da7bf000e4c3c/snapshot-gucFtI {"paths":{"l1-to-l2-message-tree":"/tmp/f57da7bf000e4c3c/snapshot-gucFtI/world-state/L1ToL2MessageTree/data.mdb","archive-tree":"/tmp/f57da7bf000e4c3c/snapshot-gucFtI/world-state/ArchiveTree/data.mdb","public-data-tree":"/tmp/f57da7bf000e4c3c/snapshot-gucFtI/world-state/PublicDataTree/data.mdb","note-hash-tree":"/tmp/f57da7bf000e4c3c/snapshot-gucFtI/world-state/NoteHashTree/data.mdb","nullifier-tree":"/tmp/f57da7bf000e4c3c/snapshot-gucFtI/world-state/NullifierTree/data.mdb","archiver":"/tmp/f57da7bf000e4c3c/snapshot-gucFtI/archiver/data.mdb"}} 10:21:18 [10:21:18.696] INFO: node Resuming archiver and world state sync 10:21:18 [10:21:18.696] VERBOSE: world-state:block_stream Starting L2 block stream {"proven":false,"pollIntervalMS":100} 10:21:18 [10:21:18.696] INFO: world_state Resumed sync 10:21:18 [10:21:18.696] INFO: archiver Restarting archiver 10:21:18 [10:21:18.699] INFO: node Uploading snapshot to file:///tmp/snapshots-QxpcEh {"snapshot":{"l1ChainId":31337,"rollupVersion":1548034364,"rollupAddress":"0x22c526e219d22f337bfaadcc36f833e71667b88e","l2BlockNumber":4,"l2BlockHash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680","l1BlockNumber":14}} 10:21:18 [10:21:18.706] INFO: node Snapshot uploaded successfully {"snapshot":{"l1BlockNumber":14,"l2BlockHash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680","l2BlockNumber":4,"schemaVersions":{"archiver":2,"worldState":1},"timestamp":1749723678700,"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/l1-to-l2-message-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","archive-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/archive-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","public-data-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/public-data-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","note-hash-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/note-hash-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","nullifier-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/nullifier-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","archiver":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/archiver-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db"}}} 10:21:18 [10:21:18.707] INFO: node Cleaning up backup dir /tmp/f57da7bf000e4c3c/snapshot-gucFtI 10:21:19 [10:21:19.147] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:19 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:19 [10:21:19.147] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:19 [10:21:19.656] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:19 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:19 [10:21:19.656] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:19 [10:21:19.695] WARN: e2e:e2e_snapshot_sync Snapshot created 10:21:19 [10:21:19.696] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync downloads snapshot when syncing new node 10:21:19 [10:21:19.696] WARN: e2e:e2e_snapshot_sync Syncing brand new node with snapshot sync 10:21:19 [10:21:19.696] WARN: e2e:e2e_snapshot_sync Creating and syncing a node without a validator... 10:21:19 [10:21:19.697] INFO: node:blob-sink:client:1 Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42919"} 10:21:19 [10:21:19.717] INFO: node:1 Creating local file file store at /tmp/snapshots-QxpcEh 10:21:19 [10:21:19.718] VERBOSE: node:1 Creating temporary archiver data store 10:21:19 [10:21:19.719] INFO: archiver:lmdb:1 Creating archiver data store at directory /tmp/f57da7bf000e4c3c/7155eef4a940d40d/archiver with map size 134217728 KB (LMDB v2) 10:21:19 [10:21:19.720] INFO: archiver:lmdb:1 Starting data store with maxReaders 16 10:21:19 [10:21:19.721] VERBOSE: node:1 Closing temporary archiver data store {"archiverL2BlockNumber":0} 10:21:19 [10:21:19.725] INFO: node:1 Syncing from snapshot at L1 block 14 L2 block 4 {"snapshot":{"l2BlockNumber":4,"l2BlockHash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680","l1BlockNumber":14,"timestamp":1749723678700,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/l1-to-l2-message-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","archive-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/archive-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","public-data-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/public-data-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","note-hash-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/note-hash-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","nullifier-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/nullifier-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","archiver":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/archiver-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db"}},"snapshotsUrl":"file:///tmp/snapshots-QxpcEh"} 10:21:19 [10:21:19.725] INFO: node:1 Creating local file file store at /tmp/snapshots-QxpcEh 10:21:19 [10:21:19.726] INFO: node:1 Downloading snapshot to /tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC {"snapshot":{"l2BlockNumber":4,"l2BlockHash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680","l1BlockNumber":14,"timestamp":1749723678700,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/l1-to-l2-message-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","archive-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/archive-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","public-data-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/public-data-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","note-hash-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/note-hash-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","nullifier-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/nullifier-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","archiver":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/archiver-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db"}},"downloadPaths":{"archiver":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/archiver.db","nullifier-tree":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/nullifier-tree.db","public-data-tree":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/public-data-tree.db","note-hash-tree":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/note-hash-tree.db","archive-tree":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/archive-tree.db","l1-to-l2-message-tree":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/l1-to-l2-message-tree.db"}} 10:21:19 [10:21:19.727] INFO: node:1 Snapshot downloaded at /tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC {"snapshot":{"l2BlockNumber":4,"l2BlockHash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680","l1BlockNumber":14,"timestamp":1749723678700,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/l1-to-l2-message-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","archive-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/archive-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","public-data-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/public-data-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","note-hash-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/note-hash-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","nullifier-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/nullifier-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","archiver":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/archiver-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db"}},"downloadPaths":{"archiver":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/archiver.db","nullifier-tree":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/nullifier-tree.db","public-data-tree":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/public-data-tree.db","note-hash-tree":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/note-hash-tree.db","archive-tree":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/archive-tree.db","l1-to-l2-message-tree":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/download-MUcgaC/l1-to-l2-message-tree.db"}} 10:21:19 [10:21:19.728] INFO: node:1 Archiver database set up from snapshot {"path":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/archiver","dbVersion":2,"rollupAddress":"0x22c526e219d22f337bfaadcc36f833e71667b88e"} 10:21:19 [10:21:19.730] INFO: node:1 World state database l1-to-l2-message-tree set up from snapshot {"path":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/world_state/L1ToL2MessageTree","dbVersion":1,"rollupAddress":"0x22c526e219d22f337bfaadcc36f833e71667b88e"} 10:21:19 [10:21:19.730] INFO: node:1 World state database archive-tree set up from snapshot {"path":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/world_state/ArchiveTree","dbVersion":1,"rollupAddress":"0x22c526e219d22f337bfaadcc36f833e71667b88e"} 10:21:19 [10:21:19.730] INFO: node:1 World state database public-data-tree set up from snapshot {"path":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/world_state/PublicDataTree","dbVersion":1,"rollupAddress":"0x22c526e219d22f337bfaadcc36f833e71667b88e"} 10:21:19 [10:21:19.731] INFO: node:1 World state database note-hash-tree set up from snapshot {"path":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/world_state/NoteHashTree","dbVersion":1,"rollupAddress":"0x22c526e219d22f337bfaadcc36f833e71667b88e"} 10:21:19 [10:21:19.731] INFO: node:1 World state database nullifier-tree set up from snapshot {"path":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/world_state/NullifierTree","dbVersion":1,"rollupAddress":"0x22c526e219d22f337bfaadcc36f833e71667b88e"} 10:21:19 [10:21:19.731] INFO: node:1 P2P database cleared {"path":"/tmp/f57da7bf000e4c3c/7155eef4a940d40d/p2p"} 10:21:19 [10:21:19.731] INFO: node:1 Snapshot synced to L1 block 14 L2 block 4 {"snapshot":{"l2BlockNumber":4,"l2BlockHash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680","l1BlockNumber":14,"timestamp":1749723678700,"schemaVersions":{"archiver":2,"worldState":1},"dataUrls":{"l1-to-l2-message-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/l1-to-l2-message-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","archive-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/archive-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","public-data-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/public-data-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","note-hash-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/note-hash-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","nullifier-tree":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/nullifier-tree-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db","archiver":"file:///tmp/snapshots-QxpcEh/aztec-31337-1548034364-0x22c526e219d22f337bfaadcc36f833e71667b88e/archiver-20250612102118-0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680.db"}}} 10:21:19 [10:21:19.732] INFO: archiver:lmdb:1 Creating archiver data store at directory /tmp/f57da7bf000e4c3c/7155eef4a940d40d/archiver with map size 134217728 KB (LMDB v2) 10:21:19 [10:21:19.733] INFO: archiver:lmdb:1 Starting data store with maxReaders 16 10:21:19 [10:21:19.975] INFO: node:blob-sink:client:1 Testing configured blob sources {"blobSinkUrl":"http://localhost:42919"} 10:21:19 [10:21:19.976] INFO: node:blob-sink:client:1 Blob sink is reachable {"blobSinkUrl":"http://localhost:42919"} 10:21:19 [10:21:19.976] WARN: node:blob-sink:client:1 No L1 consensus host urls configured 10:21:19 [10:21:19.977] WARN: node:blob-sink:client:1 No archive client configured 10:21:19 [10:21:19.978] INFO: archiver:1 Starting archiver sync to rollup contract 0x22c526e219d22f337bfaadcc36f833e71667b88e from L1 block 14 to current L1 block 14 with hash 0x8a5fb65150a5857a8e788a1e04cb783cc3366bd86bc945c13f2ffcb2630b3c25 {"blocksSynchedTo":14,"messagesSynchedTo":{"l1BlockHash":"0x8a5fb65150a5857a8e788a1e04cb783cc3366bd86bc945c13f2ffcb2630b3c25","l1BlockNumber":14}} 10:21:19 [10:21:19.982] INFO: archiver:1 Initial archiver sync to L1 block 14 complete. {"l1BlockNumber":14,"syncPoint":{"blocksSynchedTo":14,"messagesSynchedTo":{"l1BlockHash":"0x8a5fb65150a5857a8e788a1e04cb783cc3366bd86bc945c13f2ffcb2630b3c25","l1BlockNumber":14}},"latest":{"number":4,"hash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680"},"proven":{"number":0},"finalized":{"number":0}} 10:21:19 [10:21:19.985] INFO: world-state:database:1 Creating world state data store at directory /tmp/f57da7bf000e4c3c/7155eef4a940d40d/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 10:21:19 [10:21:19.992] INFO: world_state:1 Created world state synchroniser with block history of 64 10:21:19 [10:21:19.993] WARN: node:1 Aztec node is accepting fake proofs 10:21:19 [10:21:20.000] INFO: p2p:lmdb-v2:1 Creating p2p data store at directory /tmp/f57da7bf000e4c3c/7155eef4a940d40d/p2p with map size 134217728 KB (LMDB v2) 10:21:20 [10:21:20.001] INFO: p2p:lmdb-v2:1 Starting data store with maxReaders 16 10:21:20 [10:21:20.002] INFO: p2p-archive:lmdb-v2:1 Creating p2p-archive data store at directory /tmp/f57da7bf000e4c3c/7155eef4a940d40d/p2p-archive with map size 134217728 KB (LMDB v2) 10:21:20 [10:21:20.003] INFO: p2p-archive:lmdb-v2:1 Starting data store with maxReaders 16 10:21:20 [10:21:20.004] INFO: p2p-peer:lmdb-v2:1 Creating p2p-peers data store at directory /tmp/f57da7bf000e4c3c/7155eef4a940d40d/p2p-peers with map size 134217728 KB (LMDB v2) 10:21:20 [10:21:20.004] INFO: p2p-peer:lmdb-v2:1 Starting data store with maxReaders 16 10:21:20 [10:21:20.005] INFO: p2p:tx_pool:1 Setting maximum tx mempool size {"maxTxPoolSize":100000000} 10:21:20 [10:21:20.005] VERBOSE: p2p:1 P2P is disabled. Using dummy P2P service 10:21:20 [10:21:20.006] VERBOSE: world-state:block_stream:1 Starting L2 block stream {"proven":false,"pollIntervalMS":100} 10:21:20 [10:21:20.007] INFO: world_state:1 Started world state synchronizer from block 5 10:21:20 [10:21:20.008] VERBOSE: world-state:block_stream:1 Starting sync from block number 4 10:21:20 [10:21:20.010] INFO: p2p:1 Starting p2p client from block 4 with empty mempools 10:21:20 [10:21:20.010] VERBOSE: p2p:l2-block-stream:1 Starting L2 block stream {"batchSize":20,"pollIntervalMS":100,"startingBlock":4} 10:21:20 [10:21:20.010] INFO: epoch-prune-watcher:1 EpochPruneWatcher initialized 10:21:20 [10:21:20.010] VERBOSE: node:1 All Aztec Node subsystems synced 10:21:20 [10:21:20.016] INFO: slasher:1 Starting Slasher client... 10:21:20 [10:21:20.017] INFO: node:1 Aztec Node version: 0.87.6 10:21:20 [10:21:20.017] INFO: node:1 Aztec Node started on chain 0x7a69 {"registryAddress":"0x992d1f24cc5f368188d936cf0b2a111cee586d4e","governanceAddress":"0x506150cab49dbc09c8b79d20ac5c79ca28220aea","governanceProposerAddress":"0xfdb60896b1920a10fd3aa268a292e51ebd5568a8","rollupAddress":"0x22c526e219d22f337bfaadcc36f833e71667b88e","inboxAddress":"0xd011bc17cf103a874287b684028feedd08533dda","outboxAddress":"0x7b7dace4d3ecf3263b7137bfa340c9b9395affc6","feeJuicePortalAddress":"0x65c65becd51d5c16aa739688dda2929d780481a1","feeJuiceAddress":"0xd8b56421e9b573ae62f2997b7b58858a4413a967","stakingAssetAddress":"0x026208fee3f4461826c8838c3569272e8c08e131","rewardDistributorAddress":"0xd462e23c2c8a9b4f83de76004a170d4cebb5d3e1","gseAddress":"0xad2120681b02de3e9b8afd325977cdeddf15f01c","coinIssuerAddress":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","slashFactoryAddress":"0x94d7eb9f5a68684efd66f848e9efba1b079cc9e0","feeAssetHandlerAddress":"0x3607dbafde17871e0d6a8f929151c30b83510d39","stakingAssetHandlerAddress":"0x499c89d6b68cbdca67c96bff13eb5b5a8fdb25a2","zkPassportVerifierAddress":"0xee9f10f38319eae2730dba28fb09081db806c5e5"} 10:21:20 [10:21:20.018] WARN: e2e:e2e_snapshot_sync New node synced 10:21:20 [10:21:20.027] VERBOSE: p2p:l2-block-stream:1 Starting sync from block number 3 10:21:20 [10:21:20.028] WARN: e2e:e2e_snapshot_sync Checking for L2 block 3 with hash 0x14a6778b3ff93b8e137fafe76b837fd631d18bc849bfecd903510245f82d69fa on both nodes 10:21:20 [10:21:20.030] VERBOSE: p2p:1 Synched to latest block 4 10:21:20 [10:21:20.032] WARN: e2e:e2e_snapshot_sync Stopping new node 10:21:20 [10:21:20.032] INFO: node:1 Stopping Aztec Node 10:21:20 [10:21:20.166] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:20 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:20 [10:21:20.166] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:20 [10:21:20.675] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:20 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:20 [10:21:20.675] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:21 [10:21:21.184] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:21 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:21 [10:21:21.184] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:21 [10:21:21.692] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:21 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:21 [10:21:21.693] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:22 [10:21:22.033] INFO: slasher:1 Slasher client stopped. 10:21:22 [10:21:22.034] INFO: p2p:1 P2P client stopped 10:21:22 [10:21:22.035] INFO: world_state:1 Stopped world state synchronizer 10:21:22 [10:21:22.035] INFO: archiver:1 Stopped. 10:21:22 [10:21:22.035] INFO: node:1 Stopped Aztec Node 10:21:22 [10:21:22.036] INFO: e2e:e2e_snapshot_sync Running test: e2e_snapshot_sync downloads snapshot when syncing new prover node 10:21:22 [10:21:22.036] WARN: e2e:e2e_snapshot_sync Syncing brand new prover node with snapshot sync 10:21:22 [10:21:22.036] WARN: e2e:e2e_snapshot_sync Creating and syncing a prover node... 10:21:22 [10:21:22.078] INFO: blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42919"} 10:21:22 [10:21:22.080] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/f57da7bf000e4c3c/8d21dff73c8c05d5/archiver with map size 134217728 KB (LMDB v2) 10:21:22 [10:21:22.081] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 10:21:22 [10:21:22.260] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:22 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:22 [10:21:22.261] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:22 [10:21:22.336] INFO: blob-sink:client:prover-node Testing configured blob sources {"blobSinkUrl":"http://localhost:42919"} 10:21:22 [10:21:22.338] INFO: blob-sink:client:prover-node Blob sink is reachable {"blobSinkUrl":"http://localhost:42919"} 10:21:22 [10:21:22.338] WARN: blob-sink:client:prover-node No L1 consensus host urls configured 10:21:22 [10:21:22.338] WARN: blob-sink:client:prover-node No archive client configured 10:21:22 [10:21:22.340] INFO: archiver:prover-node Starting archiver sync to rollup contract 0x22c526e219d22f337bfaadcc36f833e71667b88e from L1 block 4 to current L1 block 14 with hash 0x8a5fb65150a5857a8e788a1e04cb783cc3366bd86bc945c13f2ffcb2630b3c25 {"blocksSynchedTo":4,"messagesSynchedTo":{"l1BlockHash":"0x49bed39f610663ebc87ef29fef6989d015c4a5f5d5eb8219bc391923131dafa6","l1BlockNumber":4}} 10:21:22 [10:21:22.458] INFO: archiver:prover-node Downloaded L2 block 1 {"blockHash":"0x0c35e8e66dc553a6538a50685057a8804ea0894e538d19ea60218607f0715708","blockNumber":1,"txCount":0,"globalVariables":{"blockNumber":1,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":2,"timestamp":1749723637,"version":1548034364},"archiveRoot":"0x1a22b30ae45d6b4e0872b9d4a580170b3916dfe45d18c84c2114de74b04658e3","archiveNextLeafIndex":2} 10:21:22 [10:21:22.459] INFO: archiver:prover-node Downloaded L2 block 2 {"blockHash":"0x2d6df922757b0394a0358ccbeefc4348bdbd6cc1c4550d214cbe06758f4191c8","blockNumber":2,"txCount":0,"globalVariables":{"blockNumber":2,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":3,"timestamp":1749723653,"version":1548034364},"archiveRoot":"0x17e4b21e58c4a1674de74d7978d66891b274fd9c8a21d702593a70dfb8e4fe90","archiveNextLeafIndex":3} 10:21:22 [10:21:22.459] INFO: archiver:prover-node Downloaded L2 block 3 {"blockHash":"0x14a6778b3ff93b8e137fafe76b837fd631d18bc849bfecd903510245f82d69fa","blockNumber":3,"txCount":0,"globalVariables":{"blockNumber":3,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":316640,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":4,"timestamp":1749723669,"version":1548034364},"archiveRoot":"0x1a020bd8b627ed4656343d471ee1f3471a375b97b854aedf8da3719b3444f8d4","archiveNextLeafIndex":4} 10:21:22 [10:21:22.459] INFO: archiver:prover-node Downloaded L2 block 4 {"blockHash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680","blockNumber":4,"txCount":0,"globalVariables":{"blockNumber":4,"chainId":31337,"coinbase":"0xf39fd6e51aad88f6f4ce6ab8827279cfffb92266","feePerDaGas":0,"feePerL2Gas":249180,"feeRecipient":"0x0000000000000000000000000000000000000000000000000000000000000000","slotNumber":5,"timestamp":1749723685,"version":1548034364},"archiveRoot":"0x273bef51fbf97761dddfe7acd9388dc04741685db1338e79f73c8763f8447dfa","archiveNextLeafIndex":5} 10:21:22 [10:21:22.463] INFO: archiver:prover-node Initial archiver sync to L1 block 14 complete. {"l1BlockNumber":14,"syncPoint":{"blocksSynchedTo":14,"messagesSynchedTo":{"l1BlockHash":"0x8a5fb65150a5857a8e788a1e04cb783cc3366bd86bc945c13f2ffcb2630b3c25","l1BlockNumber":14}},"latest":{"number":4,"hash":"0x1c845b59979105fff2c7c8684ce44b7a91ed0158ff865613acc90597bedc7680"},"proven":{"number":0},"finalized":{"number":0}} 10:21:22 [10:21:22.466] INFO: prover-node:blob-sink:client:prover-node Creating HTTP blob sink client. {"blobSinkUrl":"http://localhost:42919"} 10:21:22 [10:21:22.466] INFO: prover-node:prover-node Creating local file file store at /tmp/snapshots-QxpcEh 10:21:22 [10:21:22.466] VERBOSE: prover-node:prover-node Creating temporary archiver data store 10:21:22 [10:21:22.467] INFO: archiver:lmdb:prover-node Creating archiver data store at directory /tmp/f57da7bf000e4c3c/8d21dff73c8c05d5/archiver with map size 134217728 KB (LMDB v2) 10:21:22 [10:21:22.469] INFO: archiver:lmdb:prover-node Starting data store with maxReaders 16 10:21:22 [10:21:22.471] VERBOSE: prover-node:prover-node Closing temporary archiver data store {"archiverL1BlockNumber":14,"archiverL2BlockNumber":4} 10:21:22 [10:21:22.471] VERBOSE: prover-node:prover-node Skipping non-forced snapshot sync as archiver is already synced to L2 block 4. 10:21:22 [10:21:22.472] VERBOSE: prover-node:prover-node Created archiver and synced to block 4 10:21:22 [10:21:22.474] INFO: world-state:database:prover-node Creating world state data store at directory /tmp/f57da7bf000e4c3c/8d21dff73c8c05d5/world_state with map sizes {"archiveTreeMapSizeKb":134217728,"nullifierTreeMapSizeKb":134217728,"noteHashTreeMapSizeKb":134217728,"messageTreeMapSizeKb":134217728,"publicDataTreeMapSizeKb":134217728} and 2 threads. 10:21:22 [10:21:22.496] INFO: world_state:prover-node Created world state synchroniser with block history of 64 10:21:22 [10:21:22.497] VERBOSE: world_state:prover-node Starting sync from 1 to latest block 4 10:21:22 [10:21:22.497] VERBOSE: world-state:block_stream:prover-node Starting L2 block stream {"proven":false,"pollIntervalMS":100} 10:21:22 [10:21:22.497] INFO: world_state:prover-node Started world state synchronizer from block 1 10:21:22 [10:21:22.500] VERBOSE: world-state:block_stream:prover-node Starting sync from block number 0 10:21:22 [10:21:22.506] INFO: world_state:prover-node World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":3.386585999993258,"unfinalisedBlockNumber":1,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":1,"blockTimestamp":1749723637,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:21:22 [10:21:22.510] INFO: world_state:prover-node World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":3.573489000002155,"unfinalisedBlockNumber":2,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":2,"blockTimestamp":1749723653,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:21:22 [10:21:22.517] INFO: world_state:prover-node World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":6.360486000005039,"unfinalisedBlockNumber":3,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":3,"blockTimestamp":1749723669,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:21:22 [10:21:22.521] INFO: world_state:prover-node World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":3.2544590000034077,"unfinalisedBlockNumber":4,"finalisedBlockNumber":0,"oldestHistoricBlock":1,"txCount":0,"blockNumber":4,"blockTimestamp":1749723685,"privateLogCount":0,"publicLogCount":0,"contractClassLogCount":0,"contractClassLogSize":0} 10:21:22 [10:21:22.526] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/f57da7bf000e4c3c/8d21dff73c8c05d5/archiver when loading epoch databases, ignoring 10:21:22 [10:21:22.527] WARN: prover-client:proving-broker-database:prover-node Found invalid epoch directory /tmp/f57da7bf000e4c3c/8d21dff73c8c05d5/world_state when loading epoch databases, ignoring 10:21:22 [10:21:22.528] INFO: prover-client:proving-broker:prover-node Proving Broker started 10:21:22 [10:21:22.539] INFO: prover-node:prover-coordination:prover-node Using prover coordination via aztec node 10:21:22 [10:21:22.540] INFO: e2e:e2e_snapshot_sync:prover-node Created and synced prover node {"publisherAddress":"0x9965507D1a55bcC2695C58ba16FB37d819B0A4dc"} 10:21:22 [10:21:22.541] INFO: prover-node:epoch-monitor:prover-node Started EpochMonitor {"pollingIntervalMs":200} 10:21:22 [10:21:22.543] VERBOSE: prover-node:prover-node Fetching 0 tx hashes for block number 4 from coordination 10:21:22 [10:21:22.544] INFO: prover-node:combined-prover-coordination:prover-node Check for 0 txs found all in the pool 10:21:22 [10:21:22.545] 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/f57da7bf000e4c3c/8d21dff73c8c05d5","l1ChainId":31337,"rollupVersion":1548034364} 10:21:22 [10:21:22.545] WARN: e2e:e2e_snapshot_sync New node prover synced 10:21:22 [10:21:22.548] WARN: e2e:e2e_snapshot_sync Stopping new prover node 10:21:22 [10:21:22.548] INFO: prover-node:prover-node Stopping ProverNode 10:21:22 [10:21:22.548] INFO: prover-node:epoch-monitor:prover-node Stopped EpochMonitor 10:21:22 [10:21:22.548] INFO: archiver:prover-node Stopped. 10:21:22 [10:21:22.549] INFO: world_state:prover-node Stopped world state synchronizer 10:21:22 [10:21:22.549] INFO: prover-node:prover-node Stopped ProverNode 10:21:22 [10:21:22.551] INFO: node Stopping Aztec Node 10:21:22 [10:21:22.777] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:22 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:22 [10:21:22.777] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:23 [10:21:23.287] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:23 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:23 [10:21:23.287] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:23 [10:21:23.798] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:23 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:23 [10:21:23.798] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:24 [10:21:24.306] WARN: sequencer:publisher Failed canProposeAtTime check with SlotAlreadyInChain 10:21:24 error: "Rollup__SlotAlreadyInChain(5, 5)" 10:21:24 [10:21:24.307] WARN: sequencer Cannot propose block 5 at slot 5 due to failed rollup contract check 10:21:24 [10:21:24.552] INFO: slasher Slasher client stopped. 10:21:24 [10:21:24.552] INFO: sequencer Stopped sequencer 10:21:24 [10:21:24.553] INFO: p2p P2P client stopped 10:21:24 [10:21:24.554] INFO: world_state Stopped world state synchronizer 10:21:24 [10:21:24.554] INFO: archiver Stopped. 10:21:24 [10:21:24.554] INFO: node Stopped Aztec Node 10:21:24 [10:21:24.563] INFO: blob-sink:server Stopping blob sink 10:21:24 [10:21:24.564] INFO: blob-sink:server Blob sink stopped 10:21:24 PASS src/e2e_snapshot_sync.test.ts 10:21:24 e2e_snapshot_sync 10:21:24 ✓ waits until a few L2 blocks have been mined and purges blobs (55012 ms) 10:21:24 ✓ creates a snapshot (1005 ms) 10:21:24 ✓ downloads snapshot when syncing new node (2340 ms) 10:21:24 ✓ downloads snapshot when syncing new prover node (515 ms) 10:21:24 10:21:24 Test Suites: 1 passed, 1 total 10:21:24 Tests: 4 passed, 4 total 10:21:24 Snapshots: 0 total 10:21:24 Time: 115.388 s 10:21:24 Ran all test suites matching /src\/e2e_snapshot_sync.test.ts/i. 10:21:24 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?