Parent Log: http://ci.aztec-labs.com/2221392aab538d60 Command: 6e611b2acba6dc44 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/9a37be7dc4208f0eeb44ec50194c00ca3f5c4cc6 Env: REF_NAME=gh-readonly-queue/next/pr-15072-1e338a3fb2e2077f1feaee8b86c42644ff8a5352 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 16:43:15 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15072_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 16:43:19 [16:43:19.437] INFO: world_state Created world state synchroniser with block history of infinity 16:43:19 [16:43:19.563] INFO: world_state Started world state synchronizer from block 1 16:43:20 [16:43:20.098] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.576875000000655,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:20 [16:43:20.103] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":3.1877720000002228,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:20 [16:43:20.106] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.998316000000159,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:20 [16:43:20.364] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":2.0915619999996125,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:20 [16:43:20.367] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.55786100000023,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:20 [16:43:20.369] INFO: world_state Stopped world state synchronizer 16:43:20 [16:43:20.372] INFO: world_state Stopped world state synchronizer 16:43:20 [16:43:20.377] INFO: world_state Created world state synchroniser with block history of infinity 16:43:20 [16:43:20.580] INFO: world_state Started world state synchronizer from block 1 16:43:20 [16:43:20.949] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.114320000000589,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:20 [16:43:20.951] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3806669999994483,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:20 [16:43:20.953] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.194115000000238,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:20 [16:43:20.955] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1549030000005587,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:20 [16:43:20.957] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.5031849999995757,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:20 [16:43:20.959] INFO: world_state Stopped world state synchronizer 16:43:20 [16:43:20.961] INFO: world_state Created world state synchroniser with block history of infinity 16:43:20 [16:43:20.962] INFO: world_state Started world state synchronizer from block 1 16:43:20 [16:43:20.963] INFO: world_state Stopped world state synchronizer 16:43:20 [16:43:20.964] INFO: world_state Created world state synchroniser with block history of infinity 16:43:20 [16:43:20.965] INFO: world_state Started world state synchronizer from block 1 16:43:20 [16:43:20.966] INFO: world_state Stopped world state synchronizer 16:43:20 [16:43:20.989] INFO: world_state Stopped world state synchronizer 16:43:20 [16:43:20.990] INFO: world_state Created world state synchroniser with block history of infinity 16:43:21 [16:43:21.177] INFO: world_state Started world state synchronizer from block 1 16:43:21 [16:43:21.574] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5994810000001962,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:21 [16:43:21.577] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.383107999999993,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:21 [16:43:21.579] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.5222359999997934,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:21 [16:43:21.581] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4466809999994439,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:21 [16:43:21.583] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4440009999998438,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:21 [16:43:21.778] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.2081570000000283,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:21 [16:43:21.779] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.068876999999702,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:21 [16:43:21.781] INFO: world_state Stopped world state synchronizer 16:43:21 [16:43:21.783] INFO: world_state Created world state synchroniser with block history of infinity 16:43:21 [16:43:21.962] INFO: world_state Started world state synchronizer from block 1 16:43:22 [16:43:22.296] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.1120499999997264,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:22 [16:43:22.298] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3669959999997445,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:22 [16:43:22.301] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2866610000000946,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:22 [16:43:22.302] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0951390000000174,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:22 [16:43:22.304] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2757199999996374,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:22 [16:43:22.622] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5056549999999334,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:22 [16:43:22.624] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.279540999999881,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:22 [16:43:22.626] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.4067190000005212,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:22 [16:43:22.639] INFO: world_state Stopped world state synchronizer 16:43:22 [16:43:22.641] INFO: world_state Created world state synchroniser with block history of infinity 16:43:22 [16:43:22.810] INFO: world_state Started world state synchronizer from block 1 16:43:23 [16:43:23.133] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.519166000000041,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:23 [16:43:23.135] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3866180000004533,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:23 [16:43:23.137] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.1172910000004777,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:23 [16:43:23.139] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.4213190000000395,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:23 [16:43:23.141] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.3909780000003593,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:23 [16:43:23.144] INFO: world_state Stopped world state synchronizer 16:43:23 [16:43:23.145] INFO: world_state Created world state synchroniser with block history of infinity 16:43:23 [16:43:23.351] INFO: world_state Started world state synchronizer from block 1 16:43:23 [16:43:23.679] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.023935000000165,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:23 [16:43:23.681] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3839170000001104,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:23 [16:43:23.683] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.248449000000619,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:23 [16:43:23.685] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.163183000000572,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:23 [16:43:23.686] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1525629999996454,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 16:43:23 [16:43:23.689] INFO: world_state Stopped world state synchronizer 16:43:23 [16:43:23.691] INFO: world_state Created world state synchroniser with block history of infinity 16:43:23 [16:43:23.694] INFO: world_state Stopped world state synchronizer 16:43:23 [16:43:23.696] INFO: world_state Created world state synchroniser with block history of infinity 16:43:23 [16:43:23.854] INFO: world_state Started world state synchronizer from block 1 16:43:24 [16:43:24.217] INFO: world_state Stopped world state synchronizer 16:43:24 PASS src/synchronizer/server_world_state_synchronizer.test.ts (7.318 s) 16:43:24 ServerWorldStateSynchronizer 16:43:24 ✓ updates sync progress (940 ms) 16:43:24 ✓ handles multiple calls to start (584 ms) 16:43:24 ✓ immediately syncs if no new blocks (3 ms) 16:43:24 ✓ cannot be started if already stopped (26 ms) 16:43:24 ✓ can immediately sync to latest (792 ms) 16:43:24 ✓ can immediately sync to a minimum block number (857 ms) 16:43:24 ✓ sync returns immediately if block was already synced (503 ms) 16:43:24 ✓ throws if you try to sync to an unavailable block (544 ms) 16:43:24 ✓ throws if you try to immediate sync when not running (4 ms) 16:43:24 ✓ throws if handling blocks fails (523 ms) 16:43:24 16:43:24 Test Suites: 1 passed, 1 total 16:43:24 Tests: 10 passed, 10 total 16:43:24 Snapshots: 0 total 16:43:24 Time: 7.425 s 16:43:24 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 16:43:24 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?