Build: #149 was successful

Job: Test on MariaDB was successful

Stages & jobs

  1. Update versions

  2. Build

  3. Push docker image

  4. Validate

  5. Release

    Requires a user to start manually
  6. Release 2nd stage

  7. Release 3rd stage

Build log

The build generated 1,032 lines of output.   The output is too long and has been truncated to the last 1,000 lines. Download or view full build log.

25-Jun-2025 23:01:20 [PredatorPreBuildAction] File /home/bamboo-agent/.docker/config.json does not exist.
25-Jun-2025 23:01:20 [PredatorPreBuildAction] File /home/bamboo-agent/.OpenMRS/liquibaseUpdateLogs.txt does not exist.
25-Jun-2025 23:01:20 [PredatorPreBuildAction] Final free space: 2.6884766 GB
25-Jun-2025 23:01:20 [PredatorPreBuildAction] Done
25-Jun-2025 23:01:20 Starting task 'Run docker-compose' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
25-Jun-2025 23:01:20
Beginning to execute external process for build 'OpenMRS Platform - OpenMRS Platform 2.2.x - Test on MariaDB #149 (OP-OP2-TOMAR-149)'
... running command line:
/home/bamboo-agent/bamboo-agent/temp/OP-OP2-TOMAR-149-ScriptBuildTask-7789910844810328824.sh
... in: /home/bamboo-agent/bamboo-agent/xml-data/build-dir/OP-OP2-TOMAR/docker-compose
25-Jun-2025 23:01:20 + docker-compose -f docker-compose.yml -f docker-compose.prod.yml -f docker-compose.mariadb.yml down -v
25-Jun-2025 23:01:20 Removing network docker-compose_default
25-Jun-2025 23:01:20 Network docker-compose_default not found.
25-Jun-2025 23:01:20 Removing volume docker-compose_db-data
25-Jun-2025 23:01:20 Volume docker-compose_db-data not found.
25-Jun-2025 23:01:20 Removing volume docker-compose_web-data
25-Jun-2025 23:01:20 Volume docker-compose_web-data not found.
25-Jun-2025 23:01:20 + docker-compose -f docker-compose.yml -f docker-compose.prod.yml -f docker-compose.mariadb.yml up --build -d
25-Jun-2025 23:01:20 Creating network "docker-compose_default" with the default driver
25-Jun-2025 23:01:20 Creating volume "docker-compose_db-data" with default driver
25-Jun-2025 23:01:20 Creating volume "docker-compose_web-data" with default driver
25-Jun-2025 23:01:20 Pulling db (mariadb:10)...
25-Jun-2025 23:01:21 10: Pulling from library/mariadb
25-Jun-2025 23:01:26 Digest: sha256:34adebbac117c8ce649040e009f520fb79e577c68cc4e57debdf91befa53907f
25-Jun-2025 23:01:26 Status: Downloaded newer image for mariadb:10
25-Jun-2025 23:01:26 Building web
25-Jun-2025 23:01:26 #1 [internal] load build definition from Dockerfile
25-Jun-2025 23:01:26 #1 transferring dockerfile: 751B done
25-Jun-2025 23:01:26 #1 DONE 0.0s
25-Jun-2025 23:01:26
25-Jun-2025 23:01:26 #2 [internal] load metadata for docker.io/library/tomcat:7-jre8
25-Jun-2025 23:01:27 #2 DONE 0.3s
25-Jun-2025 23:01:27
25-Jun-2025 23:01:27 #3 [internal] load .dockerignore
25-Jun-2025 23:01:27 #3 transferring context: 2B done
25-Jun-2025 23:01:27 #3 DONE 0.0s
25-Jun-2025 23:01:27
25-Jun-2025 23:01:27 #4 [ 1/10] FROM docker.io/library/tomcat:7-jre8@sha256:3d6475354578a0b083f2e91700dcb8a1275dc5f574435276ce0ec69be588d6a3
25-Jun-2025 23:01:27 #4 DONE 0.0s
25-Jun-2025 23:01:27
25-Jun-2025 23:01:27 #5 [internal] load build context
25-Jun-2025 23:01:27 #5 transferring context: 100.91MB 0.7s done
25-Jun-2025 23:01:28 #5 DONE 0.7s
25-Jun-2025 23:01:28
25-Jun-2025 23:01:28 #6 [ 6/10] RUN sed -i '/Connector port="8080"/a URIEncoding="UTF-8" relaxedPathChars="[]|" relaxedQueryChars="[]|{}^\`"<>"' /usr/local/tomcat/conf/server.xml
25-Jun-2025 23:01:28 #6 CACHED
25-Jun-2025 23:01:28
25-Jun-2025 23:01:28 #7 [ 9/10] COPY openmrs-distro.properties /root/openmrs-distro.properties
25-Jun-2025 23:01:28 #7 CACHED
25-Jun-2025 23:01:28
25-Jun-2025 23:01:28 #8 [ 5/10] COPY startup.sh /usr/local/tomcat/startup.sh
25-Jun-2025 23:01:28 #8 CACHED
25-Jun-2025 23:01:28
25-Jun-2025 23:01:28 #9 [ 7/10] RUN chmod +x /usr/local/tomcat/wait-for-it.sh
25-Jun-2025 23:01:28 #9 CACHED
25-Jun-2025 23:01:28
25-Jun-2025 23:01:28 #10 [ 2/10] COPY openmrs.war  /usr/local/tomcat/webapps/openmrs.war
25-Jun-2025 23:01:28 #10 CACHED
25-Jun-2025 23:01:28
25-Jun-2025 23:01:28 #11 [ 8/10] RUN chmod +x /usr/local/tomcat/startup.sh
25-Jun-2025 23:01:28 #11 CACHED
25-Jun-2025 23:01:28
25-Jun-2025 23:01:28 #12 [ 4/10] COPY wait-for-it.sh /usr/local/tomcat/wait-for-it.sh
25-Jun-2025 23:01:28 #12 CACHED
25-Jun-2025 23:01:28
25-Jun-2025 23:01:28 #13 [ 3/10] COPY setenv.sh /usr/local/tomcat/bin/setenv.sh
25-Jun-2025 23:01:28 #13 CACHED
25-Jun-2025 23:01:28
25-Jun-2025 23:01:28 #14 [10/10] COPY Dockerfile /root/Dockerfile
25-Jun-2025 23:01:28 #14 CACHED
25-Jun-2025 23:01:28
25-Jun-2025 23:01:28 #15 exporting to image
25-Jun-2025 23:01:28 #15 exporting layers done
25-Jun-2025 23:01:28 #15 writing image sha256:760c7e37d7870b5915f80dd3c34ccecc414618bce884bf5a5730df5936c019e3 done
25-Jun-2025 23:01:28 #15 naming to docker.io/library/platform:2.2.2-snapshot done
25-Jun-2025 23:01:28 #15 DONE 0.0s
25-Jun-2025 23:01:28 Creating docker-compose_db_1 ...
25-Jun-2025 23:01:28 Creating docker-compose_db_1 ... done
25-Jun-2025 23:01:28 Creating docker-compose_web_1 ...
25-Jun-2025 23:01:29 Creating docker-compose_web_1 ... done
25-Jun-2025 23:01:29 + sleep 500
25-Jun-2025 23:09:49 + docker ps
25-Jun-2025 23:09:49 CONTAINER ID   IMAGE                           COMMAND                  CREATED         STATUS         PORTS                                     NAMES
25-Jun-2025 23:09:49 8a30c625be90   platform:2.2.2-snapshot         "/usr/local/tomcat/s…"   8 minutes ago   Up 8 minutes   0.0.0.0:80->8080/tcp, [::]:80->8080/tcp   docker-compose_web_1
25-Jun-2025 23:09:49 3a09aa172d37   mariadb:10                      "docker-entrypoint.s…"   8 minutes ago   Up 8 minutes   3306/tcp                                  docker-compose_db_1
25-Jun-2025 23:09:49 05a378f00861   moby/buildkit:buildx-stable-1   "buildkitd"              2 days ago      Up 2 days                                                buildx_buildkit_modest_wiles0
25-Jun-2025 23:09:49 + docker-compose logs
25-Jun-2025 23:09:49 Attaching to docker-compose_web_1, docker-compose_db_1
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:28+00:00 [Note] [Entrypoint]: Entrypoint script for MariaDB Server 1:10.11.13+maria~ubu2204 started.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:29+00:00 [Warn] [Entrypoint]: /sys/fs/cgroup///memory.pressure not writable, functionality unavailable to MariaDB
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:29+00:00 [Note] [Entrypoint]: Switching to dedicated user 'mysql'
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:29+00:00 [Note] [Entrypoint]: Entrypoint script for MariaDB Server 1:10.11.13+maria~ubu2204 started.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:29+00:00 [Note] [Entrypoint]: Initializing database files
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:29 0 [Warning] mariadbd: io_uring_queue_init() failed with EPERM: sysctl kernel.io_uring_disabled has the value 2, or 1 and the user of the process is not a member of sysctl kernel.io_uring_group. (see man 2 io_uring_setup).
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:29 0 [Warning] InnoDB: liburing disabled: falling back to innodb_use_native_aio=OFF
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33+00:00 [Note] [Entrypoint]: Database files initialized
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33+00:00 [Note] [Entrypoint]: Starting temporary server
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33+00:00 [Note] [Entrypoint]: Waiting for server startup
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] Starting MariaDB 10.11.13-MariaDB-ubu2204 source revision 8fb09426b98583916ccfd4f8c49741adc115bac3 server_uid 72+4ASMvYxproTQgRqIDplDA1XA= as process 90
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: Compressed tables use zlib 1.2.11
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: Number of transaction pools: 1
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: Using crc32 + pclmulqdq instructions
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] mysqld: O_TMPFILE is not supported on /tmp (disabling future attempts)
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Warning] mysqld: io_uring_queue_init() failed with EPERM: sysctl kernel.io_uring_disabled has the value 2, or 1 and the user of the process is not a member of sysctl kernel.io_uring_group. (see man 2 io_uring_setup).
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Warning] InnoDB: liburing disabled: falling back to innodb_use_native_aio=OFF
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: innodb_buffer_pool_size_max=128m, innodb_buffer_pool_size=128m
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: Completed initialization of buffer pool
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: File system buffers for log disabled (block size=512 bytes)
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: End of log at LSN=46950
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: 128 rollback segments are active.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: Setting file './ibtmp1' size to 12.000MiB. Physically writing the file full; Please wait ...
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: File './ibtmp1' size is now 12.000MiB.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] InnoDB: log sequence number 46950; transaction id 14
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] Plugin 'FEEDBACK' is disabled.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:33 0 [Note] mysqld: ready for connections.
25-Jun-2025 23:09:49 db_1   | Version: '10.11.13-MariaDB-ubu2204'  socket: '/run/mysqld/mysqld.sock'  port: 0  mariadb.org binary distribution
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:34+00:00 [Note] [Entrypoint]: Temporary server started.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:36+00:00 [Note] [Entrypoint]: Creating database openmrs
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:36+00:00 [Note] [Entrypoint]: Creating user openmrs
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:36+00:00 [Note] [Entrypoint]: Giving user openmrs access to schema openmrs
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:36+00:00 [Note] [Entrypoint]: Securing system users (equivalent to running mysql_secure_installation)
25-Jun-2025 23:09:49 db_1   |
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:36+00:00 [Note] [Entrypoint]: /usr/local/bin/docker-entrypoint.sh: running /docker-entrypoint-initdb.d/dump.sql
25-Jun-2025 23:09:49 db_1   |
25-Jun-2025 23:09:49 db_1   |
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44+00:00 [Note] [Entrypoint]: Stopping temporary server
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] mysqld (initiated by: unknown): Normal shutdown
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: FTS optimize thread exiting.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: Starting shutdown...
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: Dumping buffer pool(s) to /var/lib/mysql/ib_buffer_pool
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: Buffer pool(s) dump completed at 250625 23:01:44
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: Removed temporary tablespace data file: "./ibtmp1"
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: Shutdown completed; log sequence number 1542828; transaction id 528
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] mysqld: Shutdown complete
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44+00:00 [Note] [Entrypoint]: Temporary server stopped
25-Jun-2025 23:09:49 db_1   |
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44+00:00 [Note] [Entrypoint]: MariaDB init process done. Ready for start up.
25-Jun-2025 23:09:49 db_1   |
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] Starting MariaDB 10.11.13-MariaDB-ubu2204 source revision 8fb09426b98583916ccfd4f8c49741adc115bac3 server_uid 72+4ASMvYxproTQgRqIDplDA1XA= as process 1
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: Compressed tables use zlib 1.2.11
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: Number of transaction pools: 1
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: Using crc32 + pclmulqdq instructions
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] mysqld: O_TMPFILE is not supported on /tmp (disabling future attempts)
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Warning] mysqld: io_uring_queue_init() failed with EPERM: sysctl kernel.io_uring_disabled has the value 2, or 1 and the user of the process is not a member of sysctl kernel.io_uring_group. (see man 2 io_uring_setup).
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Warning] InnoDB: liburing disabled: falling back to innodb_use_native_aio=OFF
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: innodb_buffer_pool_size_max=128m, innodb_buffer_pool_size=128m
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: Completed initialization of buffer pool
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: File system buffers for log disabled (block size=512 bytes)
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:44 0 [Note] InnoDB: End of log at LSN=1542828
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Note] InnoDB: 128 rollback segments are active.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Note] InnoDB: Setting file './ibtmp1' size to 12.000MiB. Physically writing the file full; Please wait ...
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Note] InnoDB: File './ibtmp1' size is now 12.000MiB.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Note] InnoDB: log sequence number 1542828; transaction id 528
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Note] InnoDB: Loading buffer pool(s) from /var/lib/mysql/ib_buffer_pool
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Note] Plugin 'FEEDBACK' is disabled.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Warning] You need to use --log-bin to make --expire-logs-days or --binlog-expire-logs-seconds work.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Note] Server socket created on IP: '0.0.0.0'.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Note] Server socket created on IP: '::'.
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Note] mysqld: ready for connections.
25-Jun-2025 23:09:49 db_1   | Version: '10.11.13-MariaDB-ubu2204'  socket: '/run/mysqld/mysqld.sock'  port: 3306  mariadb.org binary distribution
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 0 [Note] InnoDB: Buffer pool(s) load completed at 250625 23:01:45
25-Jun-2025 23:09:49 db_1   | 2025-06-25 23:01:45 3 [Warning] Aborted connection 3 to db: 'unconnected' user: 'unauthenticated' host: '172.18.0.3' (This connection closed normally without authentication)
25-Jun-2025 23:09:49 web_1  | + DB_CREATE_TABLES=false
25-Jun-2025 23:09:49 web_1  | + DB_AUTO_UPDATE=false
25-Jun-2025 23:09:49 web_1  | + MODULE_WEB_ADMIN=true
25-Jun-2025 23:09:49 web_1  | + DEBUG=false
25-Jun-2025 23:09:49 web_1  | + cat
25-Jun-2025 23:09:49 web_1  | ------  Starting distribution -----
25-Jun-2025 23:09:49 web_1  | + echo '------  Starting distribution -----'
25-Jun-2025 23:09:49 web_1  | + cat /root/openmrs-distro.properties
25-Jun-2025 23:09:49 web_1  | + echo -----------------------------------
25-Jun-2025 23:09:49 web_1  | + /usr/local/tomcat/wait-for-it.sh --timeout=3600 db:3306
25-Jun-2025 23:09:49 web_1  | #Wed Jun 25 22:48:14 UTC 2025
25-Jun-2025 23:09:49 web_1  | name=Platform
25-Jun-2025 23:09:49 web_1  | omod.fhir=1.20.0
25-Jun-2025 23:09:49 web_1  | omod.owa=1.15.0
25-Jun-2025 23:09:49 web_1  | omod.webservices.rest=2.23.0
25-Jun-2025 23:09:49 web_1  | owa.openmrs-owa-addonmanager=1.0.0
25-Jun-2025 23:09:49 web_1  | version=2.2.2-SNAPSHOT
25-Jun-2025 23:09:49 web_1  | war.openmrs=2.2.2-SNAPSHOT
25-Jun-2025 23:09:49 web_1  | -----------------------------------
25-Jun-2025 23:09:49 web_1  | wait-for-it.sh: waiting 3600 seconds for db:3306
25-Jun-2025 23:09:49 web_1  | wait-for-it.sh: db:3306 is available after 16 seconds
25-Jun-2025 23:09:49 web_1  | + '[' false ']'
25-Jun-2025 23:09:49 web_1  | + export JPDA_ADDRESS=1044
25-Jun-2025 23:09:49 web_1  | + JPDA_ADDRESS=1044
25-Jun-2025 23:09:49 web_1  | + export JPDA_TRANSPORT=dt_socket
25-Jun-2025 23:09:49 web_1  | + JPDA_TRANSPORT=dt_socket
25-Jun-2025 23:09:49 web_1  | + sleep 15
25-Jun-2025 23:09:49 web_1  | + /usr/local/tomcat/bin/catalina.sh jpda run
25-Jun-2025 23:09:49 web_1  | OpenJDK 64-Bit Server VM warning: ignoring option PermSize=256m; support was removed in 8.0
25-Jun-2025 23:09:49 web_1  | OpenJDK 64-Bit Server VM warning: ignoring option MaxPermSize=512m; support was removed in 8.0
25-Jun-2025 23:09:49 web_1  | Listening for transport dt_socket at address: 1044
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Server version:        Apache Tomcat/7.0.94
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Server built:          Apr 10 2019 16:56:40 UTC
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Server number:         7.0.94.0
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: OS Name:               Linux
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: OS Version:            5.15.0-142-generic
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Architecture:          amd64
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Java Home:             /usr/lib/jvm/java-8-openjdk-amd64/jre
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: JVM Version:           1.8.0_212-8u212-b01-1~deb9u1-b01
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: JVM Vendor:            Oracle Corporation
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: CATALINA_BASE:         /usr/local/tomcat
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: CATALINA_HOME:         /usr/local/tomcat
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -Djava.util.logging.config.file=/usr/local/tomcat/conf/logging.properties
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -Dfile.encoding=UTF-8
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -Xms256m
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -Xmx768m
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -XX:PermSize=256m
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -XX:MaxPermSize=512m
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -Djdk.tls.ephemeralDHKeySize=2048
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -agentlib:jdwp=transport=dt_socket,address=1044,server=y,suspend=n
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -DOPENMRS_INSTALLATION_SCRIPT=/usr/local/tomcat/openmrs-server.properties
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -DOPENMRS_APPLICATION_DATA_DIRECTORY=/usr/local/tomcat/.OpenMRS
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -Dignore.endorsed.dirs=
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -Dcatalina.base=/usr/local/tomcat
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -Dcatalina.home=/usr/local/tomcat
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.VersionLoggerListener log
25-Jun-2025 23:09:49 web_1  | INFO: Command line argument: -Djava.io.tmpdir=/usr/local/tomcat/temp
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
25-Jun-2025 23:09:49 web_1  | INFO: Loaded APR based Apache Tomcat Native library 1.2.21 using APR version 1.5.2.
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.core.AprLifecycleListener lifecycleEvent
25-Jun-2025 23:09:49 web_1  | INFO: APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.core.AprLifecycleListener initializeSSL
25-Jun-2025 23:09:49 web_1  | INFO: OpenSSL successfully initialized (OpenSSL 1.1.0j  20 Nov 2018)
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.coyote.AbstractProtocol init
25-Jun-2025 23:09:49 web_1  | INFO: Initializing ProtocolHandler ["http-apr-8080"]
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.coyote.AbstractProtocol init
25-Jun-2025 23:09:49 web_1  | INFO: Initializing ProtocolHandler ["ajp-apr-8009"]
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.Catalina load
25-Jun-2025 23:09:49 web_1  | INFO: Initialization processed in 889 ms
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.core.StandardService startInternal
25-Jun-2025 23:09:49 web_1  | INFO: Starting service Catalina
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.core.StandardEngine startInternal
25-Jun-2025 23:09:49 web_1  | INFO: Starting Servlet Engine: Apache Tomcat/7.0.94
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:46 PM org.apache.catalina.startup.HostConfig deployWAR
25-Jun-2025 23:09:49 web_1  | INFO: Deploying web application archive /usr/local/tomcat/webapps/openmrs.war
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:51 PM org.apache.catalina.startup.TldConfig execute
25-Jun-2025 23:09:49 web_1  | INFO: At least one JAR was scanned for TLDs yet contained no TLDs. Enable debug logging for this logger for a complete list of JARs that were scanned but no TLDs were found in them. Skipping unneeded JARs during scanning can improve startup time and JSP compilation time.
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2080) |2025-06-25 23:01:51,383| Unable to find a runtime properties file at /usr/local/tomcat/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2108) |2025-06-25 23:01:51,393| Unable to find properties file: /usr/local/tomcat/.OpenMRS/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimeProperties(2041) |2025-06-25 23:01:51,393| Unable to find a runtime properties file. Initial setup is needed. View the webapp to run the setup wizard.
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2080) |2025-06-25 23:01:51,605| Unable to find a runtime properties file at /usr/local/tomcat/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2108) |2025-06-25 23:01:51,606| Unable to find properties file: /usr/local/tomcat/.OpenMRS/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimeProperties(2041) |2025-06-25 23:01:51,606| Unable to find a runtime properties file. Initial setup is needed. View the webapp to run the setup wizard.
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:51 PM org.apache.catalina.startup.HostConfig deployWAR
25-Jun-2025 23:09:49 web_1  | INFO: Deployment of web application archive /usr/local/tomcat/webapps/openmrs.war has finished in 5,044 ms
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:51 PM org.apache.catalina.startup.HostConfig deployDirectory
25-Jun-2025 23:09:49 web_1  | INFO: Deploying web application directory /usr/local/tomcat/webapps/host-manager
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:51 PM org.apache.catalina.startup.HostConfig deployDirectory
25-Jun-2025 23:09:49 web_1  | INFO: Deployment of web application directory /usr/local/tomcat/webapps/host-manager has finished in 83 ms
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:51 PM org.apache.catalina.startup.HostConfig deployDirectory
25-Jun-2025 23:09:49 web_1  | INFO: Deploying web application directory /usr/local/tomcat/webapps/manager
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:51 PM org.apache.catalina.startup.HostConfig deployDirectory
25-Jun-2025 23:09:49 web_1  | INFO: Deployment of web application directory /usr/local/tomcat/webapps/manager has finished in 84 ms
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:51 PM org.apache.catalina.startup.HostConfig deployDirectory
25-Jun-2025 23:09:49 web_1  | INFO: Deploying web application directory /usr/local/tomcat/webapps/examples
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:51 PM org.apache.catalina.startup.HostConfig deployDirectory
25-Jun-2025 23:09:49 web_1  | INFO: Deployment of web application directory /usr/local/tomcat/webapps/examples has finished in 179 ms
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:51 PM org.apache.catalina.startup.HostConfig deployDirectory
25-Jun-2025 23:09:49 web_1  | INFO: Deploying web application directory /usr/local/tomcat/webapps/docs
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:52 PM org.apache.catalina.startup.HostConfig deployDirectory
25-Jun-2025 23:09:49 web_1  | INFO: Deployment of web application directory /usr/local/tomcat/webapps/docs has finished in 31 ms
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:52 PM org.apache.catalina.startup.HostConfig deployDirectory
25-Jun-2025 23:09:49 web_1  | INFO: Deploying web application directory /usr/local/tomcat/webapps/ROOT
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:52 PM org.apache.catalina.startup.HostConfig deployDirectory
25-Jun-2025 23:09:49 web_1  | INFO: Deployment of web application directory /usr/local/tomcat/webapps/ROOT has finished in 38 ms
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:52 PM org.apache.coyote.AbstractProtocol start
25-Jun-2025 23:09:49 web_1  | INFO: Starting ProtocolHandler ["http-apr-8080"]
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:52 PM org.apache.coyote.AbstractProtocol start
25-Jun-2025 23:09:49 web_1  | INFO: Starting ProtocolHandler ["ajp-apr-8009"]
25-Jun-2025 23:09:49 web_1  | Jun 25, 2025 11:01:52 PM org.apache.catalina.startup.Catalina start
25-Jun-2025 23:09:49 web_1  | INFO: Server startup in 5609 ms
25-Jun-2025 23:09:49 web_1  | + curl -L http://localhost:8080/openmrs/
25-Jun-2025 23:09:49 web_1  |   % Total    % Received % Xferd  Average Speed   Time    Time     Time  Current
25-Jun-2025 23:09:49 web_1  |                                  Dload  Upload   Total   Spent    Left  Speed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
25-Jun-2025 23:09:49   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
25-Jun-2025 23:09:49   0     0    0     0    0     0      0      0 --:--:-- --:--:-- --:--:--     0
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2080) |2025-06-25 23:02:01,211| Unable to find a runtime properties file at /usr/local/tomcat/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2108) |2025-06-25 23:02:01,213| Unable to find properties file: /usr/local/tomcat/.OpenMRS/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49   0     0    0     0    0     0      0      0 --:--:--  0:00:01 --:--:--     0
25-Jun-2025 23:09:49 100 10707    0 10707    0     0   7115      0 --:--:--  0:00:01 --:--:-- 39951
25-Jun-2025 23:09:49 web_1  | + sleep 15
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Reading from `liquibasechangelog`
25-Jun-2025 23:09:49 web_1  | WARNING 6/25/25 11:02 PM:liquibase: modifyDataType will lose primary key/autoincrement/not null settings for mysql.  Use <sql> and re-specify all configuration if this is the case
25-Jun-2025 23:09:49 web_1  | WARNING 6/25/25 11:02 PM:liquibase: modifyDataType will lose primary key/autoincrement/not null settings for mysql.  Use <sql> and re-specify all configuration if this is the case
25-Jun-2025 23:09:49 web_1  | WARNING 6/25/25 11:02 PM:liquibase: modifyDataType will lose primary key/autoincrement/not null settings for mysql.  Use <sql> and re-specify all configuration if this is the case
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Successfully acquired change log lock
25-Jun-2025 23:09:49 web_1  | WARNING 6/25/25 11:02 PM:liquibase: modifyDataType will lose primary key/autoincrement/not null settings for mysql.  Use <sql> and re-specify all configuration if this is the case
25-Jun-2025 23:09:49 web_1  | WARNING 6/25/25 11:02 PM:liquibase: modifyDataType will lose primary key/autoincrement/not null settings for mysql.  Use <sql> and re-specify all configuration if this is the case
25-Jun-2025 23:09:49 web_1  | WARNING 6/25/25 11:02 PM:liquibase: modifyDataType will lose primary key/autoincrement/not null settings for mysql.  Use <sql> and re-specify all configuration if this is the case
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Reading from `liquibasechangelog`
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20111218-1830-fix::sunbiz ran successfully in 46ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20120322-1510::wyclif ran successfully in 44ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20120504-1000::raff ran successfully in 20ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20120504-1010::raff ran successfully in 29ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20120504-1020::raff ran successfully in 930ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20120504-1030::raff ran successfully in 574ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20120504-1040::raff ran successfully in 475ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20120504-1050::raff ran successfully in 509ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::10-insert-new-app-privileges::dkayiwa ran successfully in 14ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::11-insert-new-api-privileges::dkayiwa ran successfully in 36ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::1-grant-new-dashboard-overview-tab-app-privileges::dkayiwa ran successfully in 4ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::2-role-assign-new-api-privileges-to-renamed-ones::dkayiwa ran successfully in 23ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::1-increase-privilege-col-size-privilege::dkayiwa ran successfully in 321ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::2-increase-privilege-col-size-rol-privilege::dkayiwa ran successfully in 182ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201205241728-1::mvorobey ran successfully in 129ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201205241728-2::mvorobey ran successfully in 127ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::20101209-1353::wyclif::(Checksum: 3:9d30d1435a6c10a4b135609dc8e925ca) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Column '`as_needed`' does not exist
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121007-test_order_laterality::djazayeri ran successfully in 26ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::20121008-order_specimen_source_fk::djazayeri::(Checksum: 3:99464e51d64e056a1e23b30c7aaaf47e) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121025-TRUNK-213::lluismf ran successfully in 138ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121021-TRUNK-333::lluismf ran successfully in 13ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121109-TRUNK-3474::patandre ran successfully in 64ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121112-TRUNK-3474::patandre ran successfully in 67ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121113-TRUNK-3474::patandre ran successfully in 78ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121113-TRUNK-3474-person-attribute-type::patandre ran successfully in 112ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121113-TRUNK-3474-privilege::patandre ran successfully in 66ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121114-TRUNK-3474-role::patandre ran successfully in 53ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121114-TRUNK-3474-relationship_type::patandre ran successfully in 69ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121114-TRUNK-3474-encounter_type::patandre ran successfully in 28ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20121212-TRUNK-2768::patandre ran successfully in 52ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20130626-TRUNK-439::jthoenes ran successfully in 3ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20131023-TRUNK-3903::k-joseph ran successfully in 32ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20130809-TRUNK-4044-duplicateEncounterRoleChangeSet::surangak ran successfully in 1ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::20130809-TRUNK-4044-duplicateEncounterTypeChangeSet::surangak::(Checksum: 3:01a7d7ae88b0280139178f1840d417bd) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20130809-TRUNK-4044-encounter_type_unique_name_constraint::surangak ran successfully in 414ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20130809-TRUNK-4044-encounter_role_unique_name_constraint::surangak ran successfully in 401ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201401101647-TRUNK-4187::wyclif ran successfully in 11ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140314-TRUNK-4283::dszafranek, wyclif ran successfully in 1ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140635-TRUNK-4283::dszafranek, wyclif ran successfully in 1ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140316-TRUNK-4283::dszafranek, wyclif ran successfully in 1ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201403262140-TRUNK-4265::wyclif ran successfully in 0ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201404091110::wyclif ran successfully in 3ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201406262016::wyclif ran successfully in 1ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201406211643-TRUNK-4401::harsz89 ran successfully in 4ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201406211703-TRUNK-4401::harsz89 ran successfully in 8ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201404091112::wyclif ran successfully in 63ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201404091128::wyclif ran successfully in 49ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201404091129::wyclif ran successfully in 36ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201404101130::wyclif ran successfully in 3ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201404091131::wyclif ran successfully in 84ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201403070132-TRUNK-4286::andras-szell ran successfully in 3ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201402241055::Akshika ran successfully in 118ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201402281648-TRUNK-4274::k-joseph ran successfully in 119ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201311041510::wyclif ran successfully in 66ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201311041511::wyclif ran successfully in 52ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201311041512::wyclif ran successfully in 40ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201311041513::wyclif::(Checksum: 3:b41217397a18dbe18e07266a9be4a523) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201311041515-TRUNK-4122::wyclif ran successfully in 118ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201310281153-TRUNK-4123::mujir,sushmitharaos ran successfully in 182ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201310281153-TRUNK-4124::mujir,sushmitharaos ran successfully in 157ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312141400-TRUNK-4126::arathy ran successfully in 119ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312141401-TRUNK-4126::wyclif ran successfully in 60ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201312141400-TRUNK-4127::arathy::(Checksum: 3:26f381a2b8f112d98f36c1d0b6cceebd) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20131210-TRUNK-4130::k-joseph ran successfully in 44ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312171559-TRUNK-4159::k-joseph ran successfully in 326ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20131217-TRUNK-4157::banka ran successfully in 56ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20131217-TRUNK-4142::banka ran successfully in 37ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312162044-TRUNK-4126::k-joseph ran successfully in 42ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312162059-TRUNK-4126::k-joseph ran successfully in 97ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312161618-TRUNK-4129::rkorytkowski ran successfully in 426ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312161713-TRUNK-4129::rkorytkowski ran successfully in 68ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312182214-TRUNK-4136::k-joseph ran successfully in 140ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312182223-TRUNK-4136::k-joseph ran successfully in 52ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312191200-TRUNK-4167::banka ran successfully in 48ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312191300-TRUNK-4167::banka ran successfully in 393ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201312201200-TRUNK-4167::banka::(Checksum: 3:c72cd1725e670ea735fc45e6f0f31001) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312201800-TRUNK-4167::banka ran successfully in 60ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312181649-TRUNK-4137::k-joseph ran successfully in 111ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312181650-TRUNK-4137::k-joseph ran successfully in 43ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312201640-TRUNK-4138::banka ran successfully in 37ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312201523-TRUNK-4138::banka ran successfully in 8ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201312201425-TRUNK-4138::wyclif::(Checksum: 3:e6e37b7b995e2da28448f815211648fd) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201312201525-TRUNK-4138::wyclif::(Checksum: 3:c751cbf452be8b2c05af6d6502ff5dc9) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312201651-TRUNK-4138::banka ran successfully in 56ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312201601-TRUNK-4138::wyclif ran successfully in 328ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312201700-TRUNK-4138::banka ran successfully in 42ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201401031433-TRUNK-4135::rkorytkowski ran successfully in 42ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201401031434-TRUNK-4135::rkorytkowski ran successfully in 429ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201301031440-TRUNK-4135::rkorytkowski ran successfully in 1ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201301031448-TRUNK-4135::rkorytkowski ran successfully in 4ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201301031455-TRUNK-4135::rkorytkowski ran successfully in 44ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312271822-TRUNK-4156::vinay ran successfully in 282ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312271823-TRUNK-4156::vinay ran successfully in 3ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312271824-TRUNK-4156::vinay ran successfully in 4ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312271826-TRUNK-4156::vinay ran successfully in 45ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201312271827-TRUNK-4156::vinay::(Checksum: 3:ba1d0716249a5f1bde5eec83c190400f) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312271828-TRUNK-4156::vinay ran successfully in 126ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201312271829-TRUNK-4156::vinay ran successfully in 438ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20131216-1637::gitahi ran successfully in 588ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201402041600-TRUNK-4138::wyclif ran successfully in 341ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201402041601-TRUNK-4138::wyclif ran successfully in 50ms
25-Jun-2025 23:09:49 web_1  | + wait 49
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201402041602-TRUNK-4138::wyclif ran successfully in 428ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201402041604-TRUNK-4138::wyclif ran successfully in 53ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201402051638-TRUNK-4202::wyclif ran successfully in 347ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201402042238-TRUNK-4202::wyclif::(Checksum: 3:e74c6d63ac01908cc6fb6f3e9b15e2e0) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201402051639-TRUNK-4202::wyclif ran successfully in 428ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201403011348::alexisduque ran successfully in 155ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201403061758-TRUNK-4284::Banka, Vinay ran successfully in 4ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140304816-TRUNK-4139::Akshika ran successfully in 46ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140313-TRUNK-4288::dszafranek ran successfully in 214ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140318-TRUNK-4265::jkondrat ran successfully in 147ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201404091516::wyclif ran successfully in 128ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201404091517::wyclif ran successfully in 42ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201406201443::wyclif ran successfully in 60ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201406201444::wyclif ran successfully in 89ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201402120720-TRUNK-3902::k-joseph ran successfully in 60ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::20140304-TRUNK-4170-duplicateLocationAttributeTypeNameChangeSet::harsz89::(Checksum: 3:b74878260cae25b9c209d1b6ea5ddb98) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140304-TRUNK-4170-location_attribute_type_unique_name::harsz89 ran successfully in 377ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140715-TRUNK-2999-remove_concept_word::rkorytkowski ran successfully in 22ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140718-TRUNK-2999-remove_update_concept_index_task::rkorytkowski ran successfully in 3ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140724-1528::wyclif ran successfully in 44ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140801-TRUNK-4443-rename_order_start_date_to_date_activated::bharti ran successfully in 122ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20140719-TRUNK-4445-update_dosing_type_to_varchar_255::mihir ran successfully in 106ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201408200733-TRUNK-4446::Deepak ran successfully in 112ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::20150428-TRUNK-4693-1::mseaton::(Checksum: 3:599624d822c5f7a0d9bc796c4e90a526) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Foreign Key order_type_parent does not exist
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20150428-TRUNK-4693-2::mseaton ran successfully in 510ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201409230113-TRUNK-3484::k-joseph ran successfully in 13ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::drop-tribe-foreign-key-TRUNK-4492::dkayiwa::(Checksum: 3:6f02e3203c3fe5414a44106b8f16e3cd) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Foreign Key belongs_to_tribe does not exist
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20141010-trunk-4492::alec ran successfully in 47ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201410291606-TRUNK-3474::jbuczynski ran successfully in 88ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201410291613-TRUNK-3474::jbuczynski ran successfully in 102ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201410291614-TRUNK-3474::jbuczynski ran successfully in 72ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201410291616-TRUNK-3474::jbuczynski ran successfully in 36ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20141103-1030::wyclif ran successfully in 35ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20141121-TRUNK-2193::raff ran successfully in 33ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20150108-TRUNK-3849::rpuzdrowski ran successfully in 8ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20150108-TRUNK-14::rpuzdrowski ran successfully in 3ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20150211-TRUNK-3709::jkondrat ran successfully in 0ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201411101055-TRUNK-3386::pmuchowski ran successfully in 415ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201411101056-TRUNK-3386::pmuchowski ran successfully in 317ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201411101057-TRUNK-3386::pmuchowski ran successfully in 40ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201411101058-TRUNK-3386::pmuchowski ran successfully in 424ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201411101106-TRUNK-3386::pmuchowski ran successfully in 49ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201411101107-TRUNK-3386::pmuchowski ran successfully in 339ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20150221-1644::sandeepraparthi ran successfully in 419ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201506051103-TRUNK-4727::Chethan, Preethi ran successfully in 48ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201506192000-TRUNK-4729::thomasvandoren ran successfully in 156ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201506192001-TRUNK-4729::thomasvandoren ran successfully in 44ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201508111304::sns.recommind ran successfully in 428ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201508111412::sns.recommind ran successfully in 299ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201508111415::sns.recommind ran successfully in 295ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::RA-354-create-allergy-table-rev1::fbiedrzycki ran successfully in 514ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::RA-355-create-allergy-reaction-table::fbiedrzycki ran successfully in 160ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::RA-360-Add-allergy-status-to-patient-2::rpuzdrowski ran successfully in 69ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::TRUNK-4548-MigrateAllergiesChangeSet1::dkayiwa::(Checksum: 3:aa4d81dae6a9f0ee7e6f032634cc266d) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20151007-TRUNK-4747-remove_active_list_problem::jdegraft ran successfully in 13ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20151007-TRUNK-4747-remove_active_list_allergy::jdegraft ran successfully in 22ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20151007-TRUNK-4747-remove_active_list::jdegraft ran successfully in 30ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20151007-TRUNK-4747-remove_active_list_type::jdegraft ran successfully in 27ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201509281653::Sravanthi ran successfully in 44ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20151022-TRUNK-4750::gwasilwa ran successfully in 695ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20160201-TRUNK-1505::mnagasowmya ran successfully in 51ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20160216-1700::bahmni ran successfully in 20ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20160202-1743::rkorytkowski ran successfully in 5128ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20151006-1530::bahmni ran successfully in 259ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20151006-1537::bahmni ran successfully in 538ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20151118-1630::bahmni ran successfully in 492ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20151118-1640::bahmni ran successfully in 183ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20160212-1020::bahmni ran successfully in 39ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201604281645::vishnuraom::(Checksum: 3:e7c592ad2ce7daac65ef41b156965b6f) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201604281646::vishnuraom::(Checksum: 3:1d1ab904f45990de4459c25c170947d9) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20160427-0950-create-concept-attribute-type-table::bahmni ran successfully in 250ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20160427-0954-create-concept-attribute-table::bahmni ran successfully in 440ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::TRUNK-3422-20160216-1700::Wyclif::(Checksum: 3:a517d5e30d3814f5b186cbc93aa359de) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : SQL Precondition failed.  Expected '0' got '1'
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::TRUNK-3422-20160216-1701::Wyclif::(Checksum: 3:e5e5b2b92bbceeb4041166cd3b86803e) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : SQL Precondition failed.  Expected '0' got '1'
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::TRUNK-3422-20160216-1702::Wyclif::(Checksum: 3:694bfb4f761bc423576faf8bb32354ab) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : SQL Precondition failed.  Expected '0' got '1'
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::TRUNK-3422-20160216-1703::PralayRamteke::(Checksum: 3:2188e5d96b696afc752217843a7fa697) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::TRUNK-3422-20160216-1704::PralayRamteke::(Checksum: 3:13b334dbd8fba2fea886d1c9aab40e16) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::TRUNK-3422-20160216-1705::Wyclif::(Checksum: 3:3a0b65a0166f9f5e205078dd7606dd8d) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::TRUNK-3422-20160216-1706::Wyclif::(Checksum: 3:104cd0df5fa332f59097b421cf67795f) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20170707-TRUNK-5185-1::mogoodrich ran successfully in 434ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20170707-TRUNK-5185-2::mogoodrich ran successfully in 373ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4936-20160930-1000::teleivo ran successfully in 116ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201609171146-1::vshankar ran successfully in 456ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201609171146-1.1::vshankar ran successfully in 356ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201609171146-1.2::vshankar ran successfully in 383ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201609171146-2::vshankar ran successfully in 43ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201609171146-2.1::vshankar::(Checksum: 3:64887895d69c4514681fdecfd041cccd) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201609171146-2.2::vshankar ran successfully in 55ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201609171146-2.3::vshankar ran successfully in 68ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201609171146-3::vshankar ran successfully in 41ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201610242135-3::vshankar::(Checksum: 3:a61042ee90a77f77fd9456dbe1afdfa9) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201609171146-4::vshankar ran successfully in 35ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201609171146-5::vshankar ran successfully in 47ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201609171146-5.1::vshankar::(Checksum: 3:28badb6004196919906fe8b95ef234b4) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201609171146-5.2::vshankar ran successfully in 63ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610042145-1::vshankar ran successfully in 41ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::201610042145-1.1::vshankar::(Checksum: 3:0b655a5bd27feb9c2612bfab99b43401) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Not precondition failed
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610131530-1::vshankar ran successfully in 43ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610131530-1.1::vshankar ran successfully in 45ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610131530-2::vshankar ran successfully in 41ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610131530-3::vshankar ran successfully in 37ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610131530-4::vshankar ran successfully in 37ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610042145-2::vshankar ran successfully in 42ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610042145-2.1::vshankar ran successfully in 1ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610042145-2.2::vshankar ran successfully in 51ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610242135-1::vshankar ran successfully in 76ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201610242135-2::vshankar ran successfully in 78ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201611121945-1::vshankar ran successfully in 38ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::201611121945-2::vshankar ran successfully in 33ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1000::manuelagrindei ran successfully in 45ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1001::manuelagrindei ran successfully in 136ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1002::manuelagrindei ran successfully in 43ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1003::manuelagrindei ran successfully in 124ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1004::manuelagrindei ran successfully in 48ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1005::manuelagrindei ran successfully in 153ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1006::manuelagrindei ran successfully in 34ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1007::manuelagrindei ran successfully in 130ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1008::manuelagrindei ran successfully in 45ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1009::manuelagrindei ran successfully in 114ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1010::manuelagrindei ran successfully in 36ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1011::manuelagrindei ran successfully in 129ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1012::manuelagrindei ran successfully in 39ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1013::manuelagrindei ran successfully in 118ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1014::manuelagrindei ran successfully in 44ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4730-20161114-1015::manuelagrindei ran successfully in 144ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4976-20170403-1::darius ran successfully in 40ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4976-20170403-2::darius ran successfully in 44ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-5140-20170404-1000::Shruthi,Salauddin ran successfully in 52ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4755::Rahul,Swathi ran successfully in 296ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20151218-1729::Rahul,Swathi ran successfully in 487ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::20180508-1000::Kelechi+iheanyi::(Checksum: 3:050e375040156548b441edc5aa21404b) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Table `conditions` does not exist
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20180508-1001::Kelechi+iheanyi ran successfully in 726ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::20180508-1002::Kelechi+iheanyi::(Checksum: 3:fada03fdd01a7fae80b74c5020fa498d) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Table `emrapi_conditions` does not exist
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20181402-TRUNK-5339::esirkings ran successfully in 1103ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Marking ChangeSet: liquibase-update-to-latest.xml::20180405131015-TRUNK-5333::alicerowan::(Checksum: 3:7ce90e7459b6b840b7d3f246b6ca697b) ran despite precondition failure due to onFail='MARK_RAN':
25-Jun-2025 23:09:49 web_1  |           liquibase-update-to-latest.xml : Column '`precise`' does not exist
25-Jun-2025 23:09:49 web_1  |
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4791-20180215::patrick ran successfully in 211ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4791-20180216::patrick ran successfully in 170ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-4505-20180804::fruether ran successfully in 55ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-5400-20180731-1::fruether ran successfully in 58ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-5400-201807311-2::fruether ran successfully in 52ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20180706-passwordreset::harisu+fanyui ran successfully in 60ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::20180808-passwordreset::harisu+fanyui ran successfully in 105ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: ChangeSet liquibase-update-to-latest.xml::TRUNK-5663-20191001::gitacliff ran successfully in 47ms
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Successfully released change log lock
25-Jun-2025 23:09:49 web_1  | INFO - EhCacheManagerFactoryBean.afterPropertiesSet(129) |2025-06-25 23:02:43,922| Initializing EhCache CacheManager
25-Jun-2025 23:09:49 web_1  | WARN - SimpleUrlHandlerMapping.registerHandlers(115) |2025-06-25 23:02:51,933| Neither 'urlMap' nor 'mappings' set on SimpleUrlHandlerMapping
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2080) |2025-06-25 23:02:51,951| Unable to find a runtime properties file at /usr/local/tomcat/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2108) |2025-06-25 23:02:51,952| Unable to find properties file: /usr/local/tomcat/.OpenMRS/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2080) |2025-06-25 23:02:51,952| Unable to find a runtime properties file at /usr/local/tomcat/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2080) |2025-06-25 23:02:51,953| Unable to find a runtime properties file at /usr/local/tomcat/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2080) |2025-06-25 23:02:51,953| Unable to find a runtime properties file at /usr/local/tomcat/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2080) |2025-06-25 23:02:51,999| Unable to find a runtime properties file at /usr/local/tomcat/openmrs-runtime.properties
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Reading from `liquibasechangelog`
25-Jun-2025 23:09:49 web_1  | WARNING 6/25/25 11:02 PM:liquibase: modifyDataType will lose primary key/autoincrement/not null settings for mysql.  Use <sql> and re-specify all configuration if this is the case
25-Jun-2025 23:09:49 web_1  | WARNING 6/25/25 11:02 PM:liquibase: modifyDataType will lose primary key/autoincrement/not null settings for mysql.  Use <sql> and re-specify all configuration if this is the case
25-Jun-2025 23:09:49 web_1  | WARNING 6/25/25 11:02 PM:liquibase: modifyDataType will lose primary key/autoincrement/not null settings for mysql.  Use <sql> and re-specify all configuration if this is the case
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,596| In method UserService.savePrivilege. Arguments: Privilege=Delete Diagnoses,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,645| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,661| In method UserService.savePrivilege. Arguments: Privilege=Task: Modify Allergies,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,673| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,675| In method UserService.savePrivilege. Arguments: Privilege=Get Notes,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,688| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,690| In method UserService.savePrivilege. Arguments: Privilege=Get Order Frequencies,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,706| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,708| In method UserService.savePrivilege. Arguments: Privilege=Delete Notes,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,714| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,716| In method UserService.savePrivilege. Arguments: Privilege=Delete Conditions,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,727| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,729| In method UserService.savePrivilege. Arguments: Privilege=Edit Conditions,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,735| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,738| In method UserService.savePrivilege. Arguments: Privilege=Edit Notes,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,746| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,749| In method UserService.savePrivilege. Arguments: Privilege=Manage Concept Attribute Types,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,755| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,757| In method UserService.savePrivilege. Arguments: Privilege=Manage Search Index,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,765| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,768| In method UserService.savePrivilege. Arguments: Privilege=Get Conditions,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,778| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,781| In method UserService.savePrivilege. Arguments: Privilege=Edit Diagnoses,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,791| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,792| In method UserService.savePrivilege. Arguments: Privilege=Get Care Settings,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,809| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,811| In method UserService.savePrivilege. Arguments: Privilege=Manage Order Frequencies,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,822| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,823| In method UserService.savePrivilege. Arguments: Privilege=Get Order Sets,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,829| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,831| In method UserService.savePrivilege. Arguments: Privilege=Manage Order Sets,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,850| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,851| In method UserService.savePrivilege. Arguments: Privilege=Get Diagnoses,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,862| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,863| In method UserService.savePrivilege. Arguments: Privilege=Get Concept Attribute Types,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,876| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,921| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: mail.smtp.starttls.enable value: false,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,946| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,947| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: host.url value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,963| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,964| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: datePicker.weekStart value: 0,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,984| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,985| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: security.validTime value: 600000,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:53,998| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:53,999| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: searchWidget.dateDisplayFormat value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,010| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,011| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: patientIdentifierSearch.matchMode value: EXACT,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,022| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,023| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: security.allowedFailedLoginsBeforeLockout value: 7,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,045| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,047| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: dashboard.metadata.caseConversion value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,065| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,066| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.allergen.ConceptClasses value: Drug,MedSet,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,093| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,097| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.reaction.ConceptClasses value: Symptom,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,116| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,121| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: search.indexVersion value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,200| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,201| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: forms.locked value: false,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,218| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,219| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: drugOrder.requireDrug value: false,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,226| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,227| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: personAttributeTypes.locked value: false,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,236| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,237| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: patientIdentifierTypes.locked value: false,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,243| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,256| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: order.nextOrderNumberSeed value: 1,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,266| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,267| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: order.orderNumberGeneratorBeanId value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,277| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,278| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: order.drugRoutesConceptUuid value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,289| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,290| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: order.drugDosingUnitsConceptUuid value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,300| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,301| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: order.drugDispensingUnitsConceptUuid value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,319| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,320| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: order.durationUnitsConceptUuid value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,334| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,335| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: order.testSpecimenSourcesConceptUuid value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,344| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,345| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: provider.unknownProviderUuid value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,362| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,365| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: providerSearch.matchMode value: EXACT,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,376| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,377| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: person.attributeSearchMatchMode value: EXACT,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,392| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,393| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: validation.disable value: false,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,403| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,404| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.concept.severity.mild value: 1498AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,425| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,426| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.concept.severity.moderate value: 1499AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,435| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,436| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.concept.severity.severe value: 1500AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,457| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,458| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.concept.allergen.food value: 162553AAAAAAAAAAAAAAAAAAAAAAAAAAAAAA,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,477| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,479| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.concept.allergen.drug value: 162552AAAAAAAAAAAAAAAAAAAAAAAAAAAAAA,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,486| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,488| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.concept.allergen.environment value: 162554AAAAAAAAAAAAAAAAAAAAAAAAAAAAAA,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,496| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,497| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.concept.reactions value: 162555AAAAAAAAAAAAAAAAAAAAAAAAAAAAAA,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,508| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,509| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.concept.otherNonCoded value: 5622AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,526| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,527| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: allergy.concept.unknown value: 1067AAAAAAAAAAAAAAAAAAAAAAAAAAAAAAAA,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,533| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,534| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: drugOrder.drugOther value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,547| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:54,548| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: login.url value: login.htm,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:54,554| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - HibernateContextDAO.updateSearchIndex(530) |2025-06-25 23:02:54,571| Updating the search index... It may take a few minutes.
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:55,439| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: search.indexVersion value: 7,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:55,464| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - HibernateContextDAO.updateSearchIndex(539) |2025-06-25 23:02:55,464| Finished updating the search index
25-Jun-2025 23:09:49 web_1  | WARN - Module.expandExtensionNames(573) |2025-06-25 23:02:55,603| webservices.rest: Unable to create instance of class defined for extension point: org.openmrs.admin.list
25-Jun-2025 23:09:49 web_1  | java.lang.NoClassDefFoundError: org/openmrs/module/web/extension/AdministrationSectionExt
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.defineClass1(Native Method)
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.defineClass(ClassLoader.java:763)
25-Jun-2025 23:09:49 web_1  |         at java.security.SecureClassLoader.defineClass(SecureClassLoader.java:142)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader.defineClass(URLClassLoader.java:468)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader.access$100(URLClassLoader.java:74)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader$1.run(URLClassLoader.java:369)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader$1.run(URLClassLoader.java:363)
25-Jun-2025 23:09:49 web_1  |         at java.security.AccessController.doPrivileged(Native Method)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader.findClass(URLClassLoader.java:362)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleClassLoader.loadClass(ModuleClassLoader.java:646)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleClassLoader.loadClass(ModuleClassLoader.java:565)
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.Module.expandExtensionNames(Module.java:565)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.Module.getExtensions(Module.java:492)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleFactory.startModuleInternal(ModuleFactory.java:675)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.api.context.Daemon$1.run(Daemon.java:80)
25-Jun-2025 23:09:49 web_1  | Caused by: java.lang.ClassNotFoundException: org.openmrs.module.web.extension.AdministrationSectionExt
25-Jun-2025 23:09:49 web_1  |         at org.apache.catalina.loader.WebappClassLoaderBase.loadClass(WebappClassLoaderBase.java:1955)
25-Jun-2025 23:09:49 web_1  |         at org.apache.catalina.loader.WebappClassLoaderBase.loadClass(WebappClassLoaderBase.java:1798)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleClassLoader.loadClass(ModuleClassLoader.java:572)
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
25-Jun-2025 23:09:49 web_1  |         ... 16 more
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:55,622| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: webservices.rest.started value: true,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:55,632| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:55,634| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: webservices.rest.mandatory value: false,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:55,639| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:55,665| In method UserService.savePrivilege. Arguments: Privilege=View RESTWS,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:55,671| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:55,672| In method UserService.savePrivilege. Arguments: Privilege=Manage RESTWS,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:55,676| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:55,697| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: webservices.rest.maxResultsDefault value: 50,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:55,708| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:55,709| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: webservices.rest.maxResultsAbsolute value: 100,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:55,718| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:55,719| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: webservices.rest.uriPrefix value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:55,733| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:55,735| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: webservices.rest.allowedips value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:55,761| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:55,762| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: webservices.rest.quietDocs value: true,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:55,769| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | WARN - Module.expandExtensionNames(573) |2025-06-25 23:02:56,169| fhir: Unable to create instance of class defined for extension point: org.openmrs.admin.list
25-Jun-2025 23:09:49 web_1  | java.lang.NoClassDefFoundError: org/openmrs/module/web/extension/AdministrationSectionExt
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.defineClass1(Native Method)
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.defineClass(ClassLoader.java:763)
25-Jun-2025 23:09:49 web_1  |         at java.security.SecureClassLoader.defineClass(SecureClassLoader.java:142)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader.defineClass(URLClassLoader.java:468)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader.access$100(URLClassLoader.java:74)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader$1.run(URLClassLoader.java:369)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader$1.run(URLClassLoader.java:363)
25-Jun-2025 23:09:49 web_1  |         at java.security.AccessController.doPrivileged(Native Method)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader.findClass(URLClassLoader.java:362)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleClassLoader.loadClass(ModuleClassLoader.java:646)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleClassLoader.loadClass(ModuleClassLoader.java:565)
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.Module.expandExtensionNames(Module.java:565)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.Module.getExtensions(Module.java:492)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleFactory.startModuleInternal(ModuleFactory.java:675)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.api.context.Daemon$1.run(Daemon.java:80)
25-Jun-2025 23:09:49 web_1  | Caused by: java.lang.ClassNotFoundException: org.openmrs.module.web.extension.AdministrationSectionExt
25-Jun-2025 23:09:49 web_1  |         at org.apache.catalina.loader.WebappClassLoaderBase.loadClass(WebappClassLoaderBase.java:1955)
25-Jun-2025 23:09:49 web_1  |         at org.apache.catalina.loader.WebappClassLoaderBase.loadClass(WebappClassLoaderBase.java:1798)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleClassLoader.loadClass(ModuleClassLoader.java:572)
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
25-Jun-2025 23:09:49 web_1  |         ... 16 more
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: liquibase.xml is using schema version 1.9 rather than version 2.0
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Reading from `liquibasechangelog`
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Successfully acquired change log lock
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: liquibase.xml is using schema version 1.9 rather than version 2.0
25-Jun-2025 23:09:49 web_1  | INFO 6/25/25 11:02 PM:liquibase: Successfully released change log lock
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,261| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.started value: true,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,270| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,276| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.mandatory value: false,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,284| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,329| In method UserService.savePrivilege. Arguments: Privilege=View FHIR Client,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,337| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,361| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.baseUrl value: http://localhost:8080/openmrs/ws/fhir,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,372| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,376| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.isCustomerNarrativesEnabled value: false,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,382| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,383| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.customNarrativePropertiesPath value: classpath:/com/foo/customnarrative.properties,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,395| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,396| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.allergy.strategy value: DefaultAllergyStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,404| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,413| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.person.strategy value: DefaultPersonStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,418| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,419| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.relatedPerson.strategy value: DefaultRelatedPersonStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,431| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,432| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.location.strategy value: DefaultLocationStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,438| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,439| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.patient.strategy value: DefaultPatientStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,444| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,445| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.group.strategy value: DefaultGroupStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,450| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,451| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.encounter.strategy value: DefaultEncounterStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,456| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,457| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.appointment.strategy value: DefaultAppointmentStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,462| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,463| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.practitioner.strategy value: DefaultPractitionerStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,467| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,468| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.allergy.strategy.concept.uuid value: 1234,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,476| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,477| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.observation.strategy value: DefaultObservationStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,481| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,482| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.condition.strategy value: DefaultConditionStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,487| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,488| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.medication.strategy value: DefaultMedicationStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,495| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,496| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.medicationRequest.strategy value: DefaultMedicationRequestStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,501| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,502| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.procedureRequest.strategy value: DefaultProcedureRequestStrategy,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,506| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,507| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.concept.codingSystem value: OPENMRS,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,512| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,512| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.encounter.encounterRoleUuid value: 73bbb069-9781-4afc-a9d1-54b6b2270e03,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,518| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,518| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.encounter.encounterType.DEFAULT value: 01234-abcde-56789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,528| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,529| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.encounter.encounterType.LAB value: 01234-abcde-56789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,536| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,539| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.encounter.encounterType.RAD value: 01234-abcde-56789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,547| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,549| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.diagnosticreport.name value: 0123456789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,558| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,559| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.diagnosticreport.status value: 0123456789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,566| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,569| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.diagnosticreport.result value: 0123456789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,578| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,580| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.diagnosticreport.imagingstudy value: 0123456789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,587| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,588| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.imagingstudy.series value: 0123456789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,595| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,596| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.imagingstudy.series.instance value: 0123456789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,602| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,603| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.diagnosticreport.presentedform value: 0123456789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,613| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,614| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.imagingstudy.series.instance.content value: 0123456789,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,621| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,622| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.diagnosticreport.radiology.server value: http://fhir-dev.healthintersections.com.au/open,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,627| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,628| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.concepts.conditions value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,633| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,634| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: fhir.uriPrefix value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,642| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | WARN - Module.expandExtensionNames(573) |2025-06-25 23:02:56,663| owa: Unable to create instance of class defined for extension point: org.openmrs.admin.list
25-Jun-2025 23:09:49 web_1  | java.lang.NoClassDefFoundError: org/openmrs/module/web/extension/AdministrationSectionExt
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.defineClass1(Native Method)
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.defineClass(ClassLoader.java:763)
25-Jun-2025 23:09:49 web_1  |         at java.security.SecureClassLoader.defineClass(SecureClassLoader.java:142)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader.defineClass(URLClassLoader.java:468)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader.access$100(URLClassLoader.java:74)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader$1.run(URLClassLoader.java:369)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader$1.run(URLClassLoader.java:363)
25-Jun-2025 23:09:49 web_1  |         at java.security.AccessController.doPrivileged(Native Method)
25-Jun-2025 23:09:49 web_1  |         at java.net.URLClassLoader.findClass(URLClassLoader.java:362)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleClassLoader.loadClass(ModuleClassLoader.java:646)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleClassLoader.loadClass(ModuleClassLoader.java:565)
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.Module.expandExtensionNames(Module.java:565)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.Module.getExtensions(Module.java:492)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleFactory.startModuleInternal(ModuleFactory.java:675)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.api.context.Daemon$1.run(Daemon.java:80)
25-Jun-2025 23:09:49 web_1  | Caused by: java.lang.ClassNotFoundException: org.openmrs.module.web.extension.AdministrationSectionExt
25-Jun-2025 23:09:49 web_1  |         at org.apache.catalina.loader.WebappClassLoaderBase.loadClass(WebappClassLoaderBase.java:1955)
25-Jun-2025 23:09:49 web_1  |         at org.apache.catalina.loader.WebappClassLoaderBase.loadClass(WebappClassLoaderBase.java:1798)
25-Jun-2025 23:09:49 web_1  |         at org.openmrs.module.ModuleClassLoader.loadClass(ModuleClassLoader.java:572)
25-Jun-2025 23:09:49 web_1  |         at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
25-Jun-2025 23:09:49 web_1  |         ... 16 more
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,671| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: owa.started value: true,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,680| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,683| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: owa.mandatory value: false,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,687| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,699| In method UserService.savePrivilege. Arguments: Privilege=Manage OWA,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,703| Exiting method savePrivilege
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,722| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: owa.appFolderPath value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,728| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,729| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: owa.appBaseUrl value: null,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,737| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,738| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: owa.appStoreUrl value: http://modules.openmrs.org,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,745| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:02:56,793| In method SchedulerService.saveToMemento. Arguments:
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:02:56,794| Exiting method saveToMemento
25-Jun-2025 23:09:49 web_1  | INFO - EhCacheManagerFactoryBean.destroy(181) |2025-06-25 23:02:56,830| Shutting down EhCache CacheManager
25-Jun-2025 23:09:49 web_1  | INFO - ServiceContext.startRefreshingContext(832) |2025-06-25 23:02:56,834| Refreshing Context
25-Jun-2025 23:09:49 web_1  | INFO - EhCacheManagerFactoryBean.afterPropertiesSet(129) |2025-06-25 23:02:57,829| Initializing EhCache CacheManager
25-Jun-2025 23:09:49 web_1  | WARN - SimpleUrlHandlerMapping.registerHandlers(115) |2025-06-25 23:02:59,631| Neither 'urlMap' nor 'mappings' set on SimpleUrlHandlerMapping
25-Jun-2025 23:09:49 web_1  | WARN - SimpleUrlHandlerMapping.registerHandlers(115) |2025-06-25 23:02:59,803| Neither 'urlMap' nor 'mappings' set on SimpleUrlHandlerMapping
25-Jun-2025 23:09:49 web_1  | INFO - ServiceContext.doneRefreshingContext(843) |2025-06-25 23:02:59,805| Done refreshing Context
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:03:01,380| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: owa.appFolderPath value: /usr/local/tomcat/.OpenMRS/owa,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:03:01,386| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(116) |2025-06-25 23:03:01,763| In method AdministrationService.saveGlobalProperty. Arguments: GlobalProperty=property: login.url value: owa/addonmanager/index.html,
25-Jun-2025 23:09:49 web_1  | INFO - LoggingAdvice.invoke(156) |2025-06-25 23:03:01,768| Exiting method saveGlobalProperty
25-Jun-2025 23:09:49 web_1  | WARN - OpenmrsUtil.getRuntimePropertiesFilePathName(2080) |2025-06-25 23:03:02,908| Unable to find a runtime properties file at /usr/local/tomcat/openmrs-runtime.properties
25-Jun-2025 23:09:49 Finished task 'Run docker-compose' with result: Success
25-Jun-2025 23:09:49 Starting task 'Test if OpenMRS is running' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
25-Jun-2025 23:09:49
Beginning to execute external process for build 'OpenMRS Platform - OpenMRS Platform 2.2.x - Test on MariaDB #149 (OP-OP2-TOMAR-149)'
... running command line:
/home/bamboo-agent/bamboo-agent/temp/OP-OP2-TOMAR-149-ScriptBuildTask-3338161176073769039.sh
... in: /home/bamboo-agent/bamboo-agent/xml-data/build-dir/OP-OP2-TOMAR
25-Jun-2025 23:09:49 + count=0
25-Jun-2025 23:09:49 + wget --spider http://localhost:80/openmrs/
25-Jun-2025 23:09:49 Spider mode enabled. Check if remote file exists.
25-Jun-2025 23:09:49 --2025-06-25 23:09:49--  http://localhost/openmrs/
25-Jun-2025 23:09:49 Resolving localhost (localhost)... 127.0.0.1
25-Jun-2025 23:09:49 Connecting to localhost (localhost)|127.0.0.1|:80... connected.
25-Jun-2025 23:09:49 HTTP request sent, awaiting response... 302 Found
25-Jun-2025 23:09:49 Location: /openmrs/owa/addonmanager/index.html [following]
25-Jun-2025 23:09:49 Spider mode enabled. Check if remote file exists.
25-Jun-2025 23:09:49 --2025-06-25 23:09:49--  http://localhost/openmrs/owa/addonmanager/index.html
25-Jun-2025 23:09:49 Connecting to localhost (localhost)|127.0.0.1|:80... connected.
25-Jun-2025 23:09:49 HTTP request sent, awaiting response... 200 OK
25-Jun-2025 23:09:49 Length: 1008 [text/html]
25-Jun-2025 23:09:49 Remote file exists and could contain further links,
25-Jun-2025 23:09:49 but recursion is disabled -- not retrieving.
25-Jun-2025 23:09:49
25-Jun-2025 23:09:49 + echo 'Server up!'
25-Jun-2025 23:09:49 Server up!
25-Jun-2025 23:09:49 Finished task 'Test if OpenMRS is running' with result: Success
25-Jun-2025 23:09:49 Skipping execution of task 'Checkout webservices.rest' as it is disabled
25-Jun-2025 23:09:49 Skipping execution of task 'Run integration tests' as it is disabled
25-Jun-2025 23:09:49 Starting task 'Stop docker-compose' of type 'com.atlassian.bamboo.plugins.scripttask:task.builder.script'
25-Jun-2025 23:09:49
Beginning to execute external process for build 'OpenMRS Platform - OpenMRS Platform 2.2.x - Test on MariaDB #149 (OP-OP2-TOMAR-149)'
... running command line:
/home/bamboo-agent/bamboo-agent/temp/OP-OP2-TOMAR-149-ScriptBuildTask-628327247983941483.sh
... in: /home/bamboo-agent/bamboo-agent/xml-data/build-dir/OP-OP2-TOMAR/docker-compose
25-Jun-2025 23:09:50 Stopping docker-compose_web_1 ...
25-Jun-2025 23:09:50 Stopping docker-compose_db_1  ...
25-Jun-2025 23:10:00 Stopping docker-compose_web_1 ... done
25-Jun-2025 23:10:01 Stopping docker-compose_db_1  ... done
25-Jun-2025 23:10:01 Removing docker-compose_web_1 ...
25-Jun-2025 23:10:01 Removing docker-compose_db_1  ...
25-Jun-2025 23:10:01 Removing docker-compose_db_1  ... done
25-Jun-2025 23:10:01 Removing docker-compose_web_1 ... done
25-Jun-2025 23:10:01 Removing network docker-compose_default
25-Jun-2025 23:10:01 Removing volume docker-compose_db-data
25-Jun-2025 23:10:01 Removing volume docker-compose_web-data
25-Jun-2025 23:10:01 Finished task 'Stop docker-compose' with result: Success
25-Jun-2025 23:10:01 Running post build plugin 'Docker Container Cleanup'
25-Jun-2025 23:10:01 Running post build plugin 'NCover Results Collector'
25-Jun-2025 23:10:01 Running post build plugin 'Build Results Label Collector'
25-Jun-2025 23:10:01 Running post build plugin 'Clover Results Collector'
25-Jun-2025 23:10:01 Running post build plugin 'npm Cache Cleanup'
25-Jun-2025 23:10:01 Running post build plugin 'Artifact Copier'
25-Jun-2025 23:10:01 Finalising the build...
25-Jun-2025 23:10:01 Stopping timer.
25-Jun-2025 23:10:01 Build OP-OP2-TOMAR-149 completed.
25-Jun-2025 23:10:01 Running on server: post build plugin 'Build Hanging Detection Configuration'
25-Jun-2025 23:10:01 Running on server: post build plugin 'NCover Results Collector'
25-Jun-2025 23:10:01 Running on server: post build plugin 'Build Labeller'
25-Jun-2025 23:10:01 Running on server: post build plugin 'Clover Delta Calculator'
25-Jun-2025 23:10:01 Running on server: post build plugin 'Maven Dependencies Postprocessor'
25-Jun-2025 23:10:01 All post build plugins have finished
25-Jun-2025 23:10:01 Generating build results summary...
25-Jun-2025 23:10:01 Saving build results to disk...
25-Jun-2025 23:10:01 Store variable context...
25-Jun-2025 23:10:01 Finished building OP-OP2-TOMAR-149.