Parent Log: http://ci.aztec-labs.com/d1a5498d1f5a5639 Command: 41adb1ae539b2f2b yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/a0944d6ab9d5708daa7ff219a932e7b3784c6637 Env: REF_NAME=gh-readonly-queue/next/pr-15020-90e495a77534c1d250949dbc053161959c9aadcc CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Tue Jun 17 15:08:43 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15020_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 15:08:47 [15:08:47.484] INFO: world_state Created world state synchroniser with block history of infinity 15:08:47 [15:08:47.660] INFO: world_state Started world state synchronizer from block 1 15:08:48 [15:08:48.088] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.306635999999344,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:48 [15:08:48.092] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.576592000000346,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:48 [15:08:48.095] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.3967679999996108,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:48 [15:08:48.260] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7685759999994843,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:48 [15:08:48.263] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4954109999998764,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:48 [15:08:48.265] INFO: world_state Stopped world state synchronizer 15:08:48 [15:08:48.266] INFO: world_state Stopped world state synchronizer 15:08:48 [15:08:48.269] INFO: world_state Created world state synchroniser with block history of infinity 15:08:48 [15:08:48.420] INFO: world_state Started world state synchronizer from block 1 15:08:48 [15:08:48.776] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.8746780000001309,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:48 [15:08:48.779] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5545710000005784,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:48 [15:08:48.781] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4883700000000317,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:48 [15:08:48.783] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7431449999994584,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:48 [15:08:48.785] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.7076539999998204,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:48 [15:08:48.787] INFO: world_state Stopped world state synchronizer 15:08:48 [15:08:48.789] INFO: world_state Created world state synchroniser with block history of infinity 15:08:48 [15:08:48.790] INFO: world_state Started world state synchronizer from block 1 15:08:48 [15:08:48.790] INFO: world_state Stopped world state synchronizer 15:08:48 [15:08:48.792] INFO: world_state Created world state synchroniser with block history of infinity 15:08:48 [15:08:48.792] INFO: world_state Started world state synchronizer from block 1 15:08:48 [15:08:48.792] INFO: world_state Stopped world state synchronizer 15:08:48 [15:08:48.814] INFO: world_state Stopped world state synchronizer 15:08:48 [15:08:48.815] INFO: world_state Created world state synchroniser with block history of infinity 15:08:49 [15:08:49.022] INFO: world_state Started world state synchronizer from block 1 15:08:49 [15:08:49.457] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.9009219999998095,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:49 [15:08:49.460] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5310730000001058,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:49 [15:08:49.462] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4510119999995368,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:49 [15:08:49.464] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.5303439999997863,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:49 [15:08:49.468] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.612057000000277,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:49 [15:08:49.676] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0838039999998728,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:49 [15:08:49.691] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.770817999999963,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:49 [15:08:49.693] INFO: world_state Stopped world state synchronizer 15:08:49 [15:08:49.695] INFO: world_state Created world state synchroniser with block history of infinity 15:08:49 [15:08:49.895] INFO: world_state Started world state synchronizer from block 1 15:08:50 [15:08:50.281] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.923772000000099,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.284] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2665080000006128,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.286] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2913879999996425,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.287] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.154076000000714,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.288] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9071290000001682,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.546] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.2353380000004108,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.548] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.2352670000000217,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.550] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.365219999999681,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.552] INFO: world_state Stopped world state synchronizer 15:08:50 [15:08:50.554] INFO: world_state Created world state synchroniser with block history of infinity 15:08:50 [15:08:50.688] INFO: world_state Started world state synchronizer from block 1 15:08:50 [15:08:50.978] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":0.9865009999994072,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.980] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1134339999998701,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.981] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0680329999995593,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.983] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0927040000005945,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.984] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.0215819999993982,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:50 [15:08:50.986] INFO: world_state Stopped world state synchronizer 15:08:50 [15:08:50.987] INFO: world_state Created world state synchroniser with block history of infinity 15:08:51 [15:08:51.174] INFO: world_state Started world state synchronizer from block 1 15:08:51 [15:08:51.528] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6346159999993688,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:51 [15:08:51.530] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4816529999998238,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:51 [15:08:51.532] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3354589999999007,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:51 [15:08:51.534] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.388409999999567,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:51 [15:08:51.536] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.349330000000009,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 15:08:51 [15:08:51.538] INFO: world_state Stopped world state synchronizer 15:08:51 [15:08:51.540] INFO: world_state Created world state synchroniser with block history of infinity 15:08:51 [15:08:51.544] INFO: world_state Stopped world state synchronizer 15:08:51 [15:08:51.546] INFO: world_state Created world state synchroniser with block history of infinity 15:08:51 [15:08:51.692] INFO: world_state Started world state synchronizer from block 1 15:08:52 [15:08:52.003] INFO: world_state Stopped world state synchronizer 15:08:52 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.993 s) 15:08:52 ServerWorldStateSynchronizer 15:08:52 ✓ updates sync progress (789 ms) 15:08:52 ✓ handles multiple calls to start (519 ms) 15:08:52 ✓ immediately syncs if no new blocks (3 ms) 15:08:52 ✓ cannot be started if already stopped (23 ms) 15:08:52 ✓ can immediately sync to latest (879 ms) 15:08:52 ✓ can immediately sync to a minimum block number (859 ms) 15:08:52 ✓ sync returns immediately if block was already synced (433 ms) 15:08:52 ✓ throws if you try to sync to an unavailable block (551 ms) 15:08:52 ✓ throws if you try to immediate sync when not running (6 ms) 15:08:52 ✓ throws if handling blocks fails (458 ms) 15:08:52 15:08:52 Test Suites: 1 passed, 1 total 15:08:52 Tests: 10 passed, 10 total 15:08:52 Snapshots: 0 total 15:08:52 Time: 7.135 s 15:08:52 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 15:08:52 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?