Parent Log:
http://ci.aztec-labs.com/cd2fcd12fef4c4a3
Command: 8e1bd0706feebe1f yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/227fd751f8d3e07a96e4c1564665f0676f8222af
Env: REF_NAME=gh-readonly-queue/next/pr-15209-c245b3e704a64008c8dea40ee7b26418fd59554d CURRENT_VERSION=0.87.6 CI_FULL=1
Date: Mon Jun 23 11:50:55 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15209_amd64_x3-full
Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next
11:50:59 [11:50:59.385]
INFO:
world_state Created world state synchroniser with block history of infinity
11:50:59 [11:50:59.544]
INFO:
world_state Started world state synchronizer from block 1
11:50:59 [11:50:59.973]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":10.335912000000008,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:50:59 [11:50:59.978]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":2.4484510000002047,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:50:59 [11:50:59.980]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.5565230000001975,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:00 [11:51:00.151]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.7756650000001173,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:00 [11:51:00.154]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":2.0805710000004183,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:00 [11:51:00.156]
INFO:
world_state Stopped world state synchronizer
11:51:00 [11:51:00.158]
INFO:
world_state Stopped world state synchronizer
11:51:00 [11:51:00.160]
INFO:
world_state Created world state synchroniser with block history of infinity
11:51:00 [11:51:00.344]
INFO:
world_state Started world state synchronizer from block 1
11:51:00 [11:51:00.678]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.8262679999998,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:00 [11:51:00.681]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.8091370000001916,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:00 [11:51:00.683]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.6684489999997822,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:00 [11:51:00.686]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.8301579999997557,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:00 [11:51:00.688]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.6143959999999424,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:00 [11:51:00.690]
INFO:
world_state Stopped world state synchronizer
11:51:00 [11:51:00.691]
INFO:
world_state Created world state synchroniser with block history of infinity
11:51:00 [11:51:00.692]
INFO:
world_state Started world state synchronizer from block 1
11:51:00 [11:51:00.693]
INFO:
world_state Stopped world state synchronizer
11:51:00 [11:51:00.694]
INFO:
world_state Created world state synchroniser with block history of infinity
11:51:00 [11:51:00.695]
INFO:
world_state Started world state synchronizer from block 1
11:51:00 [11:51:00.695]
INFO:
world_state Stopped world state synchronizer
11:51:00 [11:51:00.723]
INFO:
world_state Stopped world state synchronizer
11:51:00 [11:51:00.725]
INFO:
world_state Created world state synchroniser with block history of infinity
11:51:00 [11:51:00.884]
INFO:
world_state Started world state synchronizer from block 1
11:51:01 [11:51:01.224]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.8892100000002756,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.227]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.559573999999884,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.236]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":8.834122000000207,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.238]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.064237000000503,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.239]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":0.8949470000006841,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.420]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":1.660109000000375,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.422]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":1.516131000000314,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.424]
INFO:
world_state Stopped world state synchronizer
11:51:01 [11:51:01.426]
INFO:
world_state Created world state synchroniser with block history of infinity
11:51:01 [11:51:01.587]
INFO:
world_state Started world state synchronizer from block 1
11:51:01 [11:51:01.901]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.7522829999998066,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.905]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.5842139999995197,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.907]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.6157460000003994,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.909]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.5078899999998612,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:01 [11:51:01.911]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.4599379999999655,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:02 [11:51:02.217]
INFO:
world_state World state updated with L2 block 6
{"eventName":"l2-block-handled","duration":2.1870770000004995,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:02 [11:51:02.220]
INFO:
world_state World state updated with L2 block 7
{"eventName":"l2-block-handled","duration":1.5635849999998754,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:02 [11:51:02.226]
INFO:
world_state World state updated with L2 block 8
{"eventName":"l2-block-handled","duration":1.6560090000002674,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:02 [11:51:02.230]
INFO:
world_state Stopped world state synchronizer
11:51:02 [11:51:02.233]
INFO:
world_state Created world state synchroniser with block history of infinity
11:51:02 [11:51:02.447]
INFO:
world_state Started world state synchronizer from block 1
11:51:02 [11:51:02.783]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.3265810000002602,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:02 [11:51:02.784]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.0233149999994566,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:02 [11:51:02.786]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.013184000000365,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:02 [11:51:02.787]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.1020189999999275,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:02 [11:51:02.789]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.094528999999966,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:02 [11:51:02.791]
INFO:
world_state Stopped world state synchronizer
11:51:02 [11:51:02.793]
INFO:
world_state Created world state synchroniser with block history of infinity
11:51:02 [11:51:02.967]
INFO:
world_state Started world state synchronizer from block 1
11:51:03 [11:51:03.282]
INFO:
world_state World state updated with L2 block 1
{"eventName":"l2-block-handled","duration":1.4905500000004395,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:03 [11:51:03.284]
INFO:
world_state World state updated with L2 block 2
{"eventName":"l2-block-handled","duration":1.28396900000007,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:03 [11:51:03.286]
INFO:
world_state World state updated with L2 block 3
{"eventName":"l2-block-handled","duration":1.3395719999998619,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:03 [11:51:03.288]
INFO:
world_state World state updated with L2 block 4
{"eventName":"l2-block-handled","duration":1.428777000000082,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:03 [11:51:03.289]
INFO:
world_state World state updated with L2 block 5
{"eventName":"l2-block-handled","duration":1.1162500000000364,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040}
11:51:03 [11:51:03.293]
INFO:
world_state Stopped world state synchronizer
11:51:03 [11:51:03.295]
INFO:
world_state Created world state synchroniser with block history of infinity
11:51:03 [11:51:03.298]
INFO:
world_state Stopped world state synchronizer
11:51:03 [11:51:03.300]
INFO:
world_state Created world state synchroniser with block history of infinity
11:51:03 [11:51:03.472]
INFO:
world_state Started world state synchronizer from block 1
11:51:03 [11:51:03.809]
INFO:
world_state Stopped world state synchronizer
11:51:03
PASS src/synchronizer/server_world_state_synchronizer.test.ts (
6.861 s)
11:51:03 ServerWorldStateSynchronizer
11:51:03
✓ updates sync progress (776 ms)
11:51:03
✓ handles multiple calls to start (531 ms)
11:51:03
✓ immediately syncs if no new blocks (2 ms)
11:51:03
✓ cannot be started if already stopped (30 ms)
11:51:03
✓ can immediately sync to latest (700 ms)
11:51:03
✓ can immediately sync to a minimum block number (806 ms)
11:51:03
✓ sync returns immediately if block was already synced (560 ms)
11:51:03
✓ throws if you try to sync to an unavailable block (501 ms)
11:51:03
✓ throws if you try to immediate sync when not running (5 ms)
11:51:03
✓ throws if handling blocks fails (510 ms)
11:51:03
11:51:03
Test Suites: 1 passed, 1 total
11:51:03
Tests: 10 passed, 10 total
11:51:03
Snapshots: 0 total
11:51:03
Time: 6.959 s
11:51:03
Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts
.
11:51:03
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?