Parent Log:
http://ci.aztec-labs.com/5b78f67da94557f7
Command: e4e37220d2336322 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/282da3bd25d49b92970e6fc85f110092e8566299
Env: REF_NAME=gh-readonly-queue/next/pr-14610-ee24aac96469b4f1cb8d70e614b2dd27bf0eb134 CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Tue Jun 24 14:18:43 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14610_amd64_x3-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next
14:18:46 [14:18:46.875]
INFO:
world_state Created world state synchroniser with block history of infinity
14:18:47 [14:18:47.027]
INFO:
world_state Started world state synchronizer from block 1
14:18:47 [14:18:47.434]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":7.254545000000235,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:47 [14:18:47.438]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":2.7900759999997717,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:47 [14:18:47.442]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":2.208498999999847,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:47 [14:18:47.616]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.6929120000004332,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:47 [14:18:47.627]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":10.319083999999748,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:47 [14:18:47.629]
INFO:
world_state Stopped world state synchronizer
14:18:47 [14:18:47.631]
INFO:
world_state Stopped world state synchronizer
14:18:47 [14:18:47.634]
INFO:
world_state Created world state synchroniser with block history of infinity
14:18:47 [14:18:47.828]
INFO:
world_state Started world state synchronizer from block 1
14:18:48 [14:18:48.116]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.633560999999645,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.118]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.562170000000151,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.121]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.3995770000001357,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.123]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.503549000000021,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.124]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.3748679999998785,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.126]
INFO:
world_state Stopped world state synchronizer
14:18:48 [14:18:48.128]
INFO:
world_state Created world state synchroniser with block history of infinity
14:18:48 [14:18:48.128]
INFO:
world_state Started world state synchronizer from block 1
14:18:48 [14:18:48.129]
INFO:
world_state Stopped world state synchronizer
14:18:48 [14:18:48.130]
INFO:
world_state Created world state synchroniser with block history of infinity
14:18:48 [14:18:48.131]
INFO:
world_state Started world state synchronizer from block 1
14:18:48 [14:18:48.131]
INFO:
world_state Stopped world state synchronizer
14:18:48 [14:18:48.149]
INFO:
world_state Stopped world state synchronizer
14:18:48 [14:18:48.150]
INFO:
world_state Created world state synchroniser with block history of infinity
14:18:48 [14:18:48.319]
INFO:
world_state Started world state synchronizer from block 1
14:18:48 [14:18:48.588]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":12.424827000000732,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.589]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":0.9305910000002768,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.592]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.1575940000002447,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.593]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.1159239999997226,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.595]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":0.9468220000007932,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.721]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":0.967572000000473,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.722]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":1.0288030000001527,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:48 [14:18:48.723]
INFO:
world_state Stopped world state synchronizer
14:18:48 [14:18:48.725]
INFO:
world_state Created world state synchroniser with block history of infinity
14:18:48 [14:18:48.884]
INFO:
world_state Started world state synchronizer from block 1
14:18:49 [14:18:49.207]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":0.9784920000001875,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.209]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.0220030000000406,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.210]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":0.9542019999998956,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.211]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":0.9429319999999279,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.212]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":0.9489619999994829,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.512]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":1.2057560000002923,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.514]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":1.3374770000000353,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.516]
INFO:
world_state World state updated with L2 block 8
{"eventName":"l2-block-handled","duration":1.1509649999998146,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.518]
INFO:
world_state Stopped world state synchronizer
14:18:49 [14:18:49.519]
INFO:
world_state Created world state synchroniser with block history of infinity
14:18:49 [14:18:49.682]
INFO:
world_state Started world state synchronizer from block 1
14:18:49 [14:18:49.946]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":0.9054509999996299,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.948]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":0.9139809999996942,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.949]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":0.8348509999996168,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.950]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":0.8383199999998396,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.952]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.1150539999998728,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:49 [14:18:49.954]
INFO:
world_state Stopped world state synchronizer
14:18:49 [14:18:49.955]
INFO:
world_state Created world state synchroniser with block history of infinity
14:18:50 [14:18:50.116]
INFO:
world_state Started world state synchronizer from block 1
14:18:50 [14:18:50.459]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.844662999999855,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:50 [14:18:50.461]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.2518260000006194,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:50 [14:18:50.463]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.202954999999747,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:50 [14:18:50.464]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.3011360000000423,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:50 [14:18:50.466]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.2437760000002527,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
14:18:50 [14:18:50.469]
INFO:
world_state Stopped world state synchronizer
14:18:50 [14:18:50.471]
INFO:
world_state Created world state synchroniser with block history of infinity
14:18:50 [14:18:50.475]
INFO:
world_state Stopped world state synchronizer
14:18:50 [14:18:50.477]
INFO:
world_state Created world state synchroniser with block history of infinity
14:18:50 [14:18:50.648]
INFO:
world_state Started world state synchronizer from block 1
14:18:50 [14:18:50.968]
INFO:
world_state Stopped world state synchronizer
14:18:50
PASS src/synchronizer/server_world_state_synchronizer.test.ts (
6.48 s)
14:18:50 ServerWorldStateSynchronizer
14:18:50
✓ updates sync progress (762 ms)
14:18:50
✓ handles multiple calls to start (493 ms)
14:18:50
✓ immediately syncs if no new blocks (3 ms)
14:18:50
✓ cannot be started if already stopped (19 ms)
14:18:50
✓ can immediately sync to latest (574 ms)
14:18:50
✓ can immediately sync to a minimum block number (794 ms)
14:18:50
✓ sync returns immediately if block was already synced (435 ms)
14:18:50
✓ throws if you try to sync to an unavailable block (514 ms)
14:18:50
✓ throws if you try to immediate sync when not running (5 ms)
14:18:50
✓ throws if handling blocks fails (493 ms)
14:18:50
14:18:50
Test Suites: 1 passed, 1 total
14:18:50
Tests: 10 passed, 10 total
14:18:50
Snapshots: 0 total
14:18:50
Time: 6.568 s
14:18:50
Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts
.
14:18:50
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?