ACI ·

Parent Log: http://ci.aztec-labs.com/3798e80704a63f3d Command: 6db87052395d3483 yarn-project/scripts/run_test.sh world-state/src/synchronizer/server_world_state_synchronizer.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/41cc1f518fed92110a82ce3c59385a3f5c0d8817 Env: REF_NAME=gh-readonly-queue/next/pr-15041-9cf4a24266245fa3ca003adb00e8ae759880c107 CURRENT_VERSION=0.87.6 CI_FULL=1 Date: Mon Jun 16 17:17:06 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-15041_amd64_x3-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/history_c070c71f57e89be8_next 17:17:10 [17:17:10.411] INFO: world_state Created world state synchroniser with block history of infinity 17:17:10 [17:17:10.535] INFO: world_state Started world state synchronizer from block 1 17:17:11 [17:17:11.043] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":6.589434999999867,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:11 [17:17:11.047] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.4411770000006072,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:11 [17:17:11.050] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.3608320000003005,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:11 [17:17:11.294] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":3.6146069999995234,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:11 [17:17:11.299] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":2.8884930000003806,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:11 [17:17:11.316] INFO: world_state Stopped world state synchronizer 17:17:11 [17:17:11.317] INFO: world_state Stopped world state synchronizer 17:17:11 [17:17:11.320] INFO: world_state Created world state synchroniser with block history of infinity 17:17:11 [17:17:11.516] INFO: world_state Started world state synchronizer from block 1 17:17:11 [17:17:11.860] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.082775999999285,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:11 [17:17:11.863] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":2.2352040000005218,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:11 [17:17:11.864] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.8841629999997167,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:11 [17:17:11.865] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.0453529999995226,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:11 [17:17:11.867] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.9684679999991204,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:11 [17:17:11.868] INFO: world_state Stopped world state synchronizer 17:17:11 [17:17:11.870] INFO: world_state Created world state synchroniser with block history of infinity 17:17:11 [17:17:11.870] INFO: world_state Started world state synchronizer from block 1 17:17:11 [17:17:11.871] INFO: world_state Stopped world state synchronizer 17:17:11 [17:17:11.872] INFO: world_state Created world state synchroniser with block history of infinity 17:17:11 [17:17:11.873] INFO: world_state Started world state synchronizer from block 1 17:17:11 [17:17:11.874] INFO: world_state Stopped world state synchronizer 17:17:11 [17:17:11.902] INFO: world_state Stopped world state synchronizer 17:17:11 [17:17:11.904] INFO: world_state Created world state synchroniser with block history of infinity 17:17:12 [17:17:12.114] INFO: world_state Started world state synchronizer from block 1 17:17:12 [17:17:12.380] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":23.164330999999947,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:12 [17:17:12.383] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.5389420000001337,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:12 [17:17:12.385] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.3969740000002275,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:12 [17:17:12.387] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.329939999999624,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:12 [17:17:12.389] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.2556759999997666,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:12 [17:17:12.609] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.5187910000004194,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:12 [17:17:12.612] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.4263860000000932,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:12 [17:17:12.613] INFO: world_state Stopped world state synchronizer 17:17:12 [17:17:12.615] INFO: world_state Created world state synchroniser with block history of infinity 17:17:12 [17:17:12.805] INFO: world_state Started world state synchronizer from block 1 17:17:13 [17:17:13.104] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.0032799999999042,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.105] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":0.864741999999751,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.107] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":0.843670999999631,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.108] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":0.8256089999995311,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.109] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":0.8219090000002325,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.440] INFO: world_state World state updated with L2 block 6 {"eventName":"l2-block-handled","duration":1.6095770000001721,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":6,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.442] INFO: world_state World state updated with L2 block 7 {"eventName":"l2-block-handled","duration":1.3043289999995977,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":7,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.444] INFO: world_state World state updated with L2 block 8 {"eventName":"l2-block-handled","duration":1.378643000000011,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":8,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.445] INFO: world_state Stopped world state synchronizer 17:17:13 [17:17:13.446] INFO: world_state Created world state synchroniser with block history of infinity 17:17:13 [17:17:13.627] INFO: world_state Started world state synchronizer from block 1 17:17:13 [17:17:13.963] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.5044200000002093,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.965] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.3846130000001722,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.967] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":1.2642260000002352,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.969] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.3789829999996073,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.971] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.4955899999995381,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:13 [17:17:13.978] INFO: world_state Stopped world state synchronizer 17:17:13 [17:17:13.980] INFO: world_state Created world state synchroniser with block history of infinity 17:17:14 [17:17:14.161] INFO: world_state Started world state synchronizer from block 1 17:17:14 [17:17:14.487] INFO: world_state World state updated with L2 block 1 {"eventName":"l2-block-handled","duration":1.416744999999537,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":1,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:14 [17:17:14.489] INFO: world_state World state updated with L2 block 2 {"eventName":"l2-block-handled","duration":1.2030219999996916,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":2,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:14 [17:17:14.492] INFO: world_state World state updated with L2 block 3 {"eventName":"l2-block-handled","duration":2.2540650000000824,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":3,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:14 [17:17:14.493] INFO: world_state World state updated with L2 block 4 {"eventName":"l2-block-handled","duration":1.1262870000000476,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":4,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:14 [17:17:14.495] INFO: world_state World state updated with L2 block 5 {"eventName":"l2-block-handled","duration":1.1912320000001273,"unfinalisedBlockNumber":0,"finalisedBlockNumber":0,"oldestHistoricBlock":0,"txCount":4,"blockNumber":5,"blockTimestamp":1796,"privateLogCount":128,"publicLogCount":12,"contractClassLogCount":4,"contractClassLogSize":6040} 17:17:14 [17:17:14.497] INFO: world_state Stopped world state synchronizer 17:17:14 [17:17:14.498] INFO: world_state Created world state synchroniser with block history of infinity 17:17:14 [17:17:14.500] INFO: world_state Stopped world state synchronizer 17:17:14 [17:17:14.501] INFO: world_state Created world state synchroniser with block history of infinity 17:17:14 [17:17:14.694] INFO: world_state Started world state synchronizer from block 1 17:17:15 [17:17:15.020] INFO: world_state Stopped world state synchronizer 17:17:15 PASS src/synchronizer/server_world_state_synchronizer.test.ts (7.022 s) 17:17:15 ServerWorldStateSynchronizer 17:17:15 ✓ updates sync progress (911 ms) 17:17:15 ✓ handles multiple calls to start (550 ms) 17:17:15 ✓ immediately syncs if no new blocks (2 ms) 17:17:15 ✓ cannot be started if already stopped (30 ms) 17:17:15 ✓ can immediately sync to latest (711 ms) 17:17:15 ✓ can immediately sync to a minimum block number (831 ms) 17:17:15 ✓ sync returns immediately if block was already synced (533 ms) 17:17:15 ✓ throws if you try to sync to an unavailable block (518 ms) 17:17:15 ✓ throws if you try to immediate sync when not running (3 ms) 17:17:15 ✓ throws if handling blocks fails (519 ms) 17:17:15 17:17:15 Test Suites: 1 passed, 1 total 17:17:15 Tests: 10 passed, 10 total 17:17:15 Snapshots: 0 total 17:17:15 Time: 7.132 s 17:17:15 Ran all test suites matching world-state/src/synchronizer/server_world_state_synchronizer.test.ts. 17:17:15 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?