Parent Log:
http://ci.aztec-labs.com/fcec035fcb93a883
Command: bdef8c432fe28910 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/a9f91dd1e5946aecfeb192ce869eb3e8eca2742e
Env: REF_NAME=gh-readonly-queue/next/pr-15099-a48851a8c6884f4b9615a154f8862a549722d25e CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Tue Jun 17 12:34:31 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15099_amd64_x1-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next
12:34:35 [12:34:35.933]
INFO:
world_state Created world state synchroniser with block history of infinity
12:34:36 [12:34:36.150]
INFO:
world_state Started world state synchronizer from block 1
12:34:36 [12:34:36.650]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":6.015997000000425,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:36 [12:34:36.654]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":2.5684790000004796,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:36 [12:34:36.657]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":2.001655000000028,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:36 [12:34:36.909]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":2.654645999999957,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:36 [12:34:36.912]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":2.2034810000004654,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:36 [12:34:36.915]
INFO:
world_state Stopped world state synchronizer
12:34:36 [12:34:36.917]
INFO:
world_state Stopped world state synchronizer
12:34:36 [12:34:36.921]
INFO:
world_state Created world state synchroniser with block history of infinity
12:34:37 [12:34:37.092]
INFO:
world_state Started world state synchronizer from block 1
12:34:37 [12:34:37.415]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.5666119999996226,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:37 [12:34:37.418]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.3899280000005092,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:37 [12:34:37.421]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":2.0608799999999974,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:37 [12:34:37.424]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":2.0701010000002498,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:37 [12:34:37.426]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.6681600000001708,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:37 [12:34:37.428]
INFO:
world_state Stopped world state synchronizer
12:34:37 [12:34:37.430]
INFO:
world_state Created world state synchroniser with block history of infinity
12:34:37 [12:34:37.431]
INFO:
world_state Started world state synchronizer from block 1
12:34:37 [12:34:37.432]
INFO:
world_state Stopped world state synchronizer
12:34:37 [12:34:37.433]
INFO:
world_state Created world state synchroniser with block history of infinity
12:34:37 [12:34:37.434]
INFO:
world_state Started world state synchronizer from block 1
12:34:37 [12:34:37.434]
INFO:
world_state Stopped world state synchronizer
12:34:37 [12:34:37.448]
INFO:
world_state Stopped world state synchronizer
12:34:37 [12:34:37.449]
INFO:
world_state Created world state synchroniser with block history of infinity
12:34:37 [12:34:37.637]
INFO:
world_state Started world state synchronizer from block 1
12:34:37 [12:34:37.961]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.6449670000001788,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:37 [12:34:37.964]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.4108189999997194,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:37 [12:34:37.965]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.3290430000006381,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:37 [12:34:37.967]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.2178850000000239,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:37 [12:34:37.969]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.182252000000517,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.183]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":1.6327069999997548,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.185]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":1.339694000000236,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.187]
INFO:
world_state Stopped world state synchronizer
12:34:38 [12:34:38.190]
INFO:
world_state Created world state synchroniser with block history of infinity
12:34:38 [12:34:38.369]
INFO:
world_state Started world state synchronizer from block 1
12:34:38 [12:34:38.664]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":0.9624750000002678,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.666]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":0.9661459999997533,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.667]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":0.7638790000000881,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.668]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":0.7137359999996988,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.669]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":0.7387779999999111,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.922]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":0.9838369999997667,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.923]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":0.8004220000002533,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.925]
INFO:
world_state World state updated with L2 block 8
{"eventName":"l2-block-handled","duration":1.047182000000248,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:38 [12:34:38.926]
INFO:
world_state Stopped world state synchronizer
12:34:38 [12:34:38.927]
INFO:
world_state Created world state synchroniser with block history of infinity
12:34:39 [12:34:39.076]
INFO:
world_state Started world state synchronizer from block 1
12:34:39 [12:34:39.363]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.41696999999931,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:39 [12:34:39.365]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.112767000000531,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:39 [12:34:39.367]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":0.9856669999999212,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:39 [12:34:39.368]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.0839740000001257,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:39 [12:34:39.370]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.0378710000004503,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:39 [12:34:39.372]
INFO:
world_state Stopped world state synchronizer
12:34:39 [12:34:39.374]
INFO:
world_state Created world state synchroniser with block history of infinity
12:34:39 [12:34:39.530]
INFO:
world_state Started world state synchronizer from block 1
12:34:39 [12:34:39.801]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.3899989999999889,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:39 [12:34:39.803]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":0.7628089999998338,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:39 [12:34:39.804]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":0.7416869999997289,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:39 [12:34:39.805]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":0.7126450000005207,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:39 [12:34:39.806]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":0.7358070000000225,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
12:34:39 [12:34:39.822]
INFO:
world_state Stopped world state synchronizer
12:34:39 [12:34:39.824]
INFO:
world_state Created world state synchroniser with block history of infinity
12:34:39 [12:34:39.826]
INFO:
world_state Stopped world state synchronizer
12:34:39 [12:34:39.828]
INFO:
world_state Created world state synchroniser with block history of infinity
12:34:39 [12:34:39.980]
INFO:
world_state Started world state synchronizer from block 1
12:34:40 [12:34:40.252]
INFO:
world_state Stopped world state synchronizer
12:34:40
PASS src/synchronizer/server_world_state_synchronizer.test.ts (
7.16 s)
12:34:40 ServerWorldStateSynchronizer
12:34:40
✓ updates sync progress (990 ms)
12:34:40
✓ handles multiple calls to start (509 ms)
12:34:40
✓ immediately syncs if no new blocks (3 ms)
12:34:40
✓ cannot be started if already stopped (15 ms)
12:34:40
✓ can immediately sync to latest (738 ms)
12:34:40
✓ can immediately sync to a minimum block number (737 ms)
12:34:40
✓ sync returns immediately if block was already synced (446 ms)
12:34:40
✓ throws if you try to sync to an unavailable block (449 ms)
12:34:40
✓ throws if you try to immediate sync when not running (4 ms)
12:34:40
✓ throws if handling blocks fails (425 ms)
12:34:40
12:34:40
Test Suites: 1 passed, 1 total
12:34:40
Tests: 10 passed, 10 total
12:34:40
Snapshots: 0 total
12:34:40
Time: 7.29 s
12:34:40
Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts
.
12:34:40
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?