Parent Log: http://ci.aztec-labs.com/810a77e866dce8f5 Command: 411627cf9c043d00 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/721a41c449eb0c4538a26180f6061f326128cf78 Env: REF_NAME=gh-readonly-queue/next/pr-14963-60e60f99f2634ad75a76b6e103858ff9ccd041d5 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 18:42:14 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14963_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 18:42:19 [18:42:19.010] INFO: world_state Created world state synchroniser with block history of infinity 18:42:19 [18:42:19.180] INFO: world_state Started world state synchronizer from block 1 18:42:19 [18:42:19.634] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":3.8359120000004623,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:19 [18:42:19.637] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.290353999999752,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:19 [18:42:19.639] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4289079999998648,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:19 [18:42:19.877] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.834208000000217,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:19 [18:42:19.884] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":6.196334999999635,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:19 [18:42:19.886] INFO: world_state Stopped world state synchronizer 18:42:19 [18:42:19.888] INFO: world_state Stopped world state synchronizer 18:42:19 [18:42:19.892] INFO: world_state Created world state synchroniser with block history of infinity 18:42:20 [18:42:20.078] INFO: world_state Started world state synchronizer from block 1 18:42:20 [18:42:20.362] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.645383999999467,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:20 [18:42:20.365] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5020400000003065,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:20 [18:42:20.368] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5423110000001543,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:20 [18:42:20.371] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.7170060000007652,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:20 [18:42:20.373] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.558191000000079,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:20 [18:42:20.375] INFO: world_state Stopped world state synchronizer 18:42:20 [18:42:20.377] INFO: world_state Created world state synchroniser with block history of infinity 18:42:20 [18:42:20.378] INFO: world_state Started world state synchronizer from block 1 18:42:20 [18:42:20.379] INFO: world_state Stopped world state synchronizer 18:42:20 [18:42:20.381] INFO: world_state Created world state synchroniser with block history of infinity 18:42:20 [18:42:20.381] INFO: world_state Started world state synchronizer from block 1 18:42:20 [18:42:20.382] INFO: world_state Stopped world state synchronizer 18:42:20 [18:42:20.401] INFO: world_state Stopped world state synchronizer 18:42:20 [18:42:20.402] INFO: world_state Created world state synchroniser with block history of infinity 18:42:20 [18:42:20.549] INFO: world_state Started world state synchronizer from block 1 18:42:20 [18:42:20.850] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5238609999996697,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:20 [18:42:20.852] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2156919999997626,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:20 [18:42:20.854] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2547230000000127,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:20 [18:42:20.856] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1564710000002378,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:20 [18:42:20.857] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1823509999994712,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.064] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5202300000000832,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.066] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3347149999999601,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.068] INFO: world_state Stopped world state synchronizer 18:42:21 [18:42:21.070] INFO: world_state Created world state synchroniser with block history of infinity 18:42:21 [18:42:21.273] INFO: world_state Started world state synchronizer from block 1 18:42:21 [18:42:21.570] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.2529340000000957,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.571] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.0715079999999944,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.573] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0225170000003345,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.574] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.979776000000129,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.576] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9870160000000396,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.854] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.176061000000118,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.856] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.0352969999994457,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.858] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":0.9594750000005661,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:21 [18:42:21.859] INFO: world_state Stopped world state synchronizer 18:42:21 [18:42:21.870] INFO: world_state Created world state synchroniser with block history of infinity 18:42:22 [18:42:22.091] INFO: world_state Started world state synchronizer from block 1 18:42:22 [18:42:22.403] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.169662000000244,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:22 [18:42:22.404] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.7041189999999915,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:22 [18:42:22.405] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.6373670000002676,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:22 [18:42:22.407] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8204319999995278,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:22 [18:42:22.408] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.6104559999994308,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:22 [18:42:22.410] INFO: world_state Stopped world state synchronizer 18:42:22 [18:42:22.412] INFO: world_state Created world state synchroniser with block history of infinity 18:42:22 [18:42:22.549] INFO: world_state Started world state synchronizer from block 1 18:42:22 [18:42:22.832] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.205562999999529,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:22 [18:42:22.833] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.9410449999995762,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:22 [18:42:22.834] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.7243390000003274,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:22 [18:42:22.836] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.7509799999997995,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:22 [18:42:22.837] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8648030000003928,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 18:42:22 [18:42:22.839] INFO: world_state Stopped world state synchronizer 18:42:22 [18:42:22.840] INFO: world_state Created world state synchroniser with block history of infinity 18:42:22 [18:42:22.843] INFO: world_state Stopped world state synchronizer 18:42:22 [18:42:22.845] INFO: world_state Created world state synchroniser with block history of infinity 18:42:22 [18:42:22.979] INFO: world_state Started world state synchronizer from block 1 18:42:23 [18:42:23.304] INFO: world_state Stopped world state synchronizer 18:42:23 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.968 s) 18:42:23 ServerWorldStateSynchronizer 18:42:23 ✓ updates sync progress (883 ms) 18:42:23 ✓ handles multiple calls to start (485 ms) 18:42:23 ✓ immediately syncs if no new blocks (4 ms) 18:42:23 ✓ cannot be started if already stopped (21 ms) 18:42:23 ✓ can immediately sync to latest (666 ms) 18:42:23 ✓ can immediately sync to a minimum block number (790 ms) 18:42:23 ✓ sync returns immediately if block was already synced (551 ms) 18:42:23 ✓ throws if you try to sync to an unavailable block (428 ms) 18:42:23 ✓ throws if you try to immediate sync when not running (5 ms) 18:42:23 ✓ throws if handling blocks fails (461 ms) 18:42:23 18:42:23 Test Suites: 1 passed, 1 total 18:42:23 Tests: 10 passed, 10 total 18:42:23 Snapshots: 0 total 18:42:23 Time: 7.107 s 18:42:23 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 18:42:23 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?