Uploaded image for project: 'OpenMRS Core'
  1. OpenMRS Core
  2. TRUNK-6132

OpenMRS startup time greatly increased in 2.5+

    XMLWordPrintable

Details

    • Story
    • Status: Ready for Work
    • Should
    • Resolution: Unresolved
    • None
    • None
    • None
    • Undetermined

    Description

      Starting with OpenMRS 2.5, the startup time of the server has increased considerably. Doing some simply analysis of this, I created 4 SDK instances on my machine and followed the same process for each. The only difference in setup is in the OpenMRS platform version used - 2.3.5, 2.4.5, 2.5.4, 2.6.0-SNAPSHOT. For each, I did the initial setup and measured the time, did a re-start and measured the time, and then installed the legacyui module and did another restart and measured the time. Here are the timings i pulled from the logs for each:

      1. platform 2.3.5
      initial install 2022-08-17 19:30:54,647 - Aug 17, 2022 7:31:21 PM (27 seconds)
      taken to addonmanager page. fhir, owa, webservices.rest installed
      re-start Aug 17, 2022 7:35:40 PM - Aug 17, 2022 7:36:42 PM (62 seconds)
      installed legacyui
      re-start Aug 17, 2022 7:38:40 PM - Aug 17, 2022 7:38:56 (16 seconds)
      re-start Aug 17, 2022 7:53:18 PM - Aug 17, 2022 7:53:35 PM (17 seconds)
      2. platform 2.4.5
      initial install Aug 17, 2022 7:40:49 PM - Aug 17, 2022 7:42:07 PM (78 seconds)
      taken to addonmanager page. fhir, owa, webservices.rest installed
      re-start Aug 17, 2022 7:42:50 PM - Aug 17, 2022 7:43:12 PM (22 seconds)
      installed legacyui
      re-start Aug 17, 2022 7:44:02 PM - Aug 17, 2022 7:44:25 PM (23 seconds)
      3. platform 2.5.4
      initial install Aug 17, 2022 7:46:09 PM - Aug 17, 2022 7:48:22 PM (133 seconds)
      re-start Aug 17, 2022 7:49:51 PM - Aug 17, 2022 7:50:52 PM (61 seconds)
      installed legacyui
      re-start Aug 17, 2022 7:51:41 PM - Aug 17, 2022 7:52:45 PM (64 seconds)
      4. platform 2.6.0-SNAPSHOT
      initial install Aug 17, 2022 7:54:52 PM - Aug 17, 2022 7:56:13 PM (81 seconds)
      re-start Aug 17, 2022 7:56:58 PM - Aug 17, 2022 7:57:55 PM (57 seconds)
      installed legacyui
      re-start Aug 17, 2022 7:58:42 PM - Aug 17, 2022 8:00:21 PM (99 seconds)

      Note, I believe that the 62 seconds for the restart of platform 2.3.5 was an anomoly or a mistake in my analysis - I couldn't reproduce it and it is generally in the 16-17 second range to start up.

      Not a scientific test, but clearly things started slowing down considerably starting in 2.5.x. Note that it may be related or separate, but the logs when starting up are almost entirely filled with changlogdetective statements about checking various liquibase files for unrun changes, and warnings from slf4j about failing to restore autocommit to true.

      dkayiwa / ibacher / mogoodrich / burke FYI, as discussed on Slack.

      Gliffy Diagrams

        Attachments

          Activity

            People

              Unassigned Unassigned
              mseaton Mike Seaton
              Votes:
              0 Vote for this issue
              Watchers:
              6 Start watching this issue

              Dates

                Created:
                Updated: