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?