Parent Log: http://ci.aztec-labs.com/70b89db270779f49 Command: a852c28f8f853b32 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/ffc8af0c47dad3be6fb4bfb9f3f5af6cd3a05a67 Env: REF_NAME=gh-readonly-queue/next/pr-15214-69efc9daf98e823f486416900de52fe8a44f25d9 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 23 16:13:00 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15214_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 16:13:03 [16:13:03.962] INFO: world_state Created world state synchroniser with block history of infinity 16:13:04 [16:13:04.101] INFO: world_state Started world state synchronizer from block 1 16:13:04 [16:13:04.513] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.628345999999965,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:04 [16:13:04.517] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.6597170000000006,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:04 [16:13:04.520] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.4520110000003115,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:04 [16:13:04.684] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3220329999999194,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:04 [16:13:04.686] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1117279999998573,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:04 [16:13:04.687] INFO: world_state Stopped world state synchronizer 16:13:04 [16:13:04.688] INFO: world_state Stopped world state synchronizer 16:13:04 [16:13:04.691] INFO: world_state Created world state synchroniser with block history of infinity 16:13:04 [16:13:04.857] INFO: world_state Started world state synchronizer from block 1 16:13:05 [16:13:05.193] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.8203160000002754,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:05 [16:13:05.196] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.6018199999998615,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:05 [16:13:05.198] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.4580459999997402,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:05 [16:13:05.200] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.727882999999565,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:05 [16:13:05.202] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.6095100000002276,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:05 [16:13:05.204] INFO: world_state Stopped world state synchronizer 16:13:05 [16:13:05.206] INFO: world_state Created world state synchroniser with block history of infinity 16:13:05 [16:13:05.207] INFO: world_state Started world state synchronizer from block 1 16:13:05 [16:13:05.207] INFO: world_state Stopped world state synchronizer 16:13:05 [16:13:05.209] INFO: world_state Created world state synchroniser with block history of infinity 16:13:05 [16:13:05.209] INFO: world_state Started world state synchronizer from block 1 16:13:05 [16:13:05.209] INFO: world_state Stopped world state synchronizer 16:13:05 [16:13:05.230] INFO: world_state Stopped world state synchronizer 16:13:05 [16:13:05.231] INFO: world_state Created world state synchroniser with block history of infinity 16:13:05 [16:13:05.441] INFO: world_state Started world state synchronizer from block 1 16:13:05 [16:13:05.793] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.6677220000001398,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:05 [16:13:05.796] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.4330849999996644,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:05 [16:13:05.813] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":17.220829999999296,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:05 [16:13:05.816] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4825080000000526,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:05 [16:13:05.818] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4005850000003193,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.007] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.3799040000003515,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.008] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1450889999996434,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.010] INFO: world_state Stopped world state synchronizer 16:13:06 [16:13:06.011] INFO: world_state Created world state synchroniser with block history of infinity 16:13:06 [16:13:06.158] INFO: world_state Started world state synchronizer from block 1 16:13:06 [16:13:06.447] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4371860000001107,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.449] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.1622690000003786,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.450] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.0941069999998945,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.452] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1275679999998829,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.453] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9979750000002241,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.751] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.0228649999999107,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.752] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.1396689999992304,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.754] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.2584619999997813,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:06 [16:13:06.755] INFO: world_state Stopped world state synchronizer 16:13:06 [16:13:06.757] INFO: world_state Created world state synchroniser with block history of infinity 16:13:06 [16:13:06.919] INFO: world_state Started world state synchronizer from block 1 16:13:07 [16:13:07.254] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.4723170000006576,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:07 [16:13:07.256] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2612309999994977,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:07 [16:13:07.258] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1868199999998978,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:07 [16:13:07.259] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.2242599999999584,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:07 [16:13:07.262] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.4770819999994274,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:07 [16:13:07.265] INFO: world_state Stopped world state synchronizer 16:13:07 [16:13:07.266] INFO: world_state Created world state synchroniser with block history of infinity 16:13:07 [16:13:07.430] INFO: world_state Started world state synchronizer from block 1 16:13:07 [16:13:07.733] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.588079000000107,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:07 [16:13:07.735] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2694209999999657,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:07 [16:13:07.737] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2772919999997612,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:07 [16:13:07.738] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3412039999993794,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:07 [16:13:07.745] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.6083800000005795,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:13:07 [16:13:07.748] INFO: world_state Stopped world state synchronizer 16:13:07 [16:13:07.750] INFO: world_state Created world state synchroniser with block history of infinity 16:13:07 [16:13:07.753] INFO: world_state Stopped world state synchronizer 16:13:07 [16:13:07.755] INFO: world_state Created world state synchroniser with block history of infinity 16:13:07 [16:13:07.917] INFO: world_state Started world state synchronizer from block 1 16:13:08 [16:13:08.176] INFO: world_state Stopped world state synchronizer 16:13:08 PASS src/synchronizer/server_world_state_synchronizer.test.ts (6.393 s) 16:13:08 ServerWorldStateSynchronizer 16:13:08 ✓ updates sync progress (733 ms) 16:13:08 ✓ handles multiple calls to start (514 ms) 16:13:08 ✓ immediately syncs if no new blocks (3 ms) 16:13:08 ✓ cannot be started if already stopped (22 ms) 16:13:08 ✓ can immediately sync to latest (780 ms) 16:13:08 ✓ can immediately sync to a minimum block number (744 ms) 16:13:08 ✓ sync returns immediately if block was already synced (509 ms) 16:13:08 ✓ throws if you try to sync to an unavailable block (482 ms) 16:13:08 ✓ throws if you try to immediate sync when not running (5 ms) 16:13:08 ✓ throws if handling blocks fails (423 ms) 16:13:08 16:13:08 Test Suites: 1 passed, 1 total 16:13:08 Tests: 10 passed, 10 total 16:13:08 Snapshots: 0 total 16:13:08 Time: 6.484 s 16:13:08 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 16:13:08 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?