Parent Log:
http://ci.aztec-labs.com/d240895a55e41983
Command: 53eb328a1446f762 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/a48851a8c6884f4b9615a154f8862a549722d25e
Env: REF_NAME=gh-readonly-queue/next/pr-14680-3b5835195491b53670250790b18c14d922718574 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Tue Jun 17 11:29:37 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14680_amd64_x1-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next
11:29:41 [11:29:41.224]
INFO:
world_state Created world state synchroniser with block history of infinity
11:29:41 [11:29:41.384]
INFO:
world_state Started world state synchronizer from block 1
11:29:41 [11:29:41.832]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":3.892381999999998,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:41 [11:29:41.836]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":2.2890830000001188,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:41 [11:29:41.840]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":2.84871800000019,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:42 [11:29:42.030]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.7660409999998592,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:42 [11:29:42.032]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.4322039999997287,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:42 [11:29:42.033]
INFO:
world_state Stopped world state synchronizer
11:29:42 [11:29:42.036]
INFO:
world_state Stopped world state synchronizer
11:29:42 [11:29:42.044]
INFO:
world_state Created world state synchroniser with block history of infinity
11:29:42 [11:29:42.198]
INFO:
world_state Started world state synchronizer from block 1
11:29:42 [11:29:42.498]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.1993170000005193,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:42 [11:29:42.500]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.152617000000646,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:42 [11:29:42.503]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.6818199999997887,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:42 [11:29:42.506]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":2.5154789999996865,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:42 [11:29:42.509]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":2.025007000000187,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:42 [11:29:42.512]
INFO:
world_state Stopped world state synchronizer
11:29:42 [11:29:42.514]
INFO:
world_state Created world state synchroniser with block history of infinity
11:29:42 [11:29:42.515]
INFO:
world_state Started world state synchronizer from block 1
11:29:42 [11:29:42.516]
INFO:
world_state Stopped world state synchronizer
11:29:42 [11:29:42.518]
INFO:
world_state Created world state synchroniser with block history of infinity
11:29:42 [11:29:42.518]
INFO:
world_state Started world state synchronizer from block 1
11:29:42 [11:29:42.519]
INFO:
world_state Stopped world state synchronizer
11:29:42 [11:29:42.550]
INFO:
world_state Stopped world state synchronizer
11:29:42 [11:29:42.557]
INFO:
world_state Created world state synchroniser with block history of infinity
11:29:42 [11:29:42.769]
INFO:
world_state Started world state synchronizer from block 1
11:29:43 [11:29:43.118]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.5927169999995385,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.120]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.3237710000003062,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.122]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":0.8900499999999738,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.123]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":0.8322399999997288,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.124]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":0.7671579999996538,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.336]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":1.3085199999995893,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.341]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":4.3283910000000105,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.343]
INFO:
world_state Stopped world state synchronizer
11:29:43 [11:29:43.345]
INFO:
world_state Created world state synchroniser with block history of infinity
11:29:43 [11:29:43.538]
INFO:
world_state Started world state synchronizer from block 1
11:29:43 [11:29:43.900]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":0.8743109999995795,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.901]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":0.7764079999997193,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.902]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":0.6896459999998115,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.903]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":0.6656550000006973,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:43 [11:29:43.904]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":0.664745000000039,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:44 [11:29:44.187]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":1.326441000000159,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:44 [11:29:44.189]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":1.1884580000005371,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:44 [11:29:44.191]
INFO:
world_state World state updated with L2 block 8
{"eventName":"l2-block-handled","duration":1.1137760000001435,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:44 [11:29:44.203]
INFO:
world_state Stopped world state synchronizer
11:29:44 [11:29:44.205]
INFO:
world_state Created world state synchroniser with block history of infinity
11:29:44 [11:29:44.374]
INFO:
world_state Started world state synchronizer from block 1
11:29:44 [11:29:44.667]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.2577900000005684,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:44 [11:29:44.669]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.1962379999995392,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:44 [11:29:44.671]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.1941870000000563,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:44 [11:29:44.673]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.1932170000000042,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:44 [11:29:44.674]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.0720249999994849,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:44 [11:29:44.676]
INFO:
world_state Stopped world state synchronizer
11:29:44 [11:29:44.678]
INFO:
world_state Created world state synchroniser with block history of infinity
11:29:44 [11:29:44.853]
INFO:
world_state Started world state synchronizer from block 1
11:29:45 [11:29:45.166]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.3527020000001357,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:45 [11:29:45.168]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.1672269999999116,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:45 [11:29:45.169]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.1053150000007008,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:45 [11:29:45.171]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.077024999999594,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:45 [11:29:45.172]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.0596949999999197,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:29:45 [11:29:45.174]
INFO:
world_state Stopped world state synchronizer
11:29:45 [11:29:45.176]
INFO:
world_state Created world state synchroniser with block history of infinity
11:29:45 [11:29:45.178]
INFO:
world_state Stopped world state synchronizer
11:29:45 [11:29:45.180]
INFO:
world_state Created world state synchroniser with block history of infinity
11:29:45 [11:29:45.355]
INFO:
world_state Started world state synchronizer from block 1
11:29:45 [11:29:45.649]
INFO:
world_state Stopped world state synchronizer
11:29:45
PASS src/synchronizer/server_world_state_synchronizer.test.ts (
6.778 s)
11:29:45 ServerWorldStateSynchronizer
11:29:45
✓ updates sync progress (822 ms)
11:29:45
✓ handles multiple calls to start (469 ms)
11:29:45
✓ immediately syncs if no new blocks (3 ms)
11:29:45
✓ cannot be started if already stopped (35 ms)
11:29:45
✓ can immediately sync to latest (789 ms)
11:29:45
✓ can immediately sync to a minimum block number (860 ms)
11:29:45
✓ sync returns immediately if block was already synced (473 ms)
11:29:45
✓ throws if you try to sync to an unavailable block (498 ms)
11:29:45
✓ throws if you try to immediate sync when not running (4 ms)
11:29:45
✓ throws if handling blocks fails (471 ms)
11:29:45
11:29:45
Test Suites: 1 passed, 1 total
11:29:45
Tests: 10 passed, 10 total
11:29:45
Snapshots: 0 total
11:29:45
Time: 6.89 s
11:29:45
Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts
.
11:29:45
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?