После установки или в процессе работы сервера eltex-ems может возникнуть проблема перехода состояния сервиса с active на inactive.
Для выяснения проблем прекращения работы сервиса есть несколько способов:
Функционал linux системы journalctl
Эта команда позволит вывести события произошедшие в системе отсортировав их по сервису eltex-ems.sudo journalctl -ex | grep eltex-ems
В системном журнале будут выводится сообщения запуска и следующей работы процесса. В случае сбоя будет выводится причина прекращения работы процесса.sudo journalctl -ex | grep eltex-ems сен 23 11:30:01 tester-acs CRON[29245]: (root) CMD (/usr/lib/eltex-ems/scripts/check_ems_srv.sh > /dev/null) сен 23 11:33:02 tester-acs sudo[29378]: tester : TTY=pts/11 ; PWD=/home/tester ; USER=root ; COMMAND=/usr/sbin/service eltex-ems restart -- Subject: Unit eltex-ems.service has begun shutting down -- Unit eltex-ems.service has begun shutting down. сен 23 11:33:02 tester-acs eltex-ems[29384]: * Stopping Eltex.EMS Server eltex-ems сен 23 11:33:04 tester-acs eltex-ems[29048]: eltex-ems: client (pid 29049) exited with 143 status сен 23 11:33:05 tester-acs eltex-ems[29384]: ...done. -- Subject: Unit eltex-ems.service has finished shutting down -- Unit eltex-ems.service has finished shutting down. -- Subject: Unit eltex-ems.service has begun start-up -- Unit eltex-ems.service has begun starting up. сен 23 11:33:05 tester-acs eltex-ems[29446]: * Starting Eltex.EMS Server eltex-ems сен 23 11:33:06 tester-acs eltex-ems[29446]: ...done. сен 23 11:33:06 tester-acs systemd[1]: eltex-ems.service: Can't open PID file /var/run/eltex-ems/eltex-ems.pid (yet?) after start: No such file or directory -- Subject: Unit eltex-ems.service has finished start-up -- Unit eltex-ems.service has finished starting up.
В примере приведена программная перезагрузка процесса(В системном журнале будут выводится сообщения запуска и следующей работы процесса), так же сообщения о проблеме обращения к файлу в системе(eltex-ems.service: Can't open PID file /var/run/eltex-ems/eltex-ems.pid (yet?) after start: No such file or directory)Краткий вывод логирования сервиса, который записывается при каждом запуске сервиса и записывает статус сервиса раз в 5 минут:
В этот файл собирается информация по используемой версии linux, нагрузке используемой сервером и используемые версии смежных приложений(java). Так же статус работы сервиса(команда service eltex-ems status) и прослушиваемые порты.----------------------------- (START) ------------------------------ 23-09-2025 16:15:01: System information: 23-09-2025 16:15:01: Linux tester-acs 4.15.0-142-generic #146~16.04.1-Ubuntu SMP Tue Apr 13 09:27:15 UTC 2021 x86_64 x86_64 x86_64 GNU/Linux 23-09-2025 16:15:01: openjdk version "1.8.0_292" OpenJDK Runtime Environment (build 1.8.0_292-8u292-b10-0ubuntu1~16.04.1-b10) OpenJDK 64-Bit Server VM (build 25.292-b10, mixed mode) 23-09-2025 16:15:01: LoadAverage info 23-09-2025 16:15:01: 1min 5min 15min 23-09-2025 16:15:01: 0.01 0.08 0.05 1/551 8130 23-09-2025 16:15:01: RAM MemFree: 2609468 kB Disk info Disk Size Used Available Used % Mount /dev/sda1 451G 88G 341G 21% / tmpfs 7,7G 188K 7,7G 1% /dev/shm 23-09-2025 16:15:01: EMS status: ● eltex-ems.service - Eltex EMS Loaded: loaded (/usr/lib/systemd/system/eltex-ems.service; enabled; vendor preset: enabled) Active: active (running) since Вт 2025-09-23 14:05:34 +07; 2h 9min ago Process: 3344 ExecStop=/etc/init.d/eltex-ems stop (code=exited, status=0/SUCCESS) Process: 3440 ExecStart=/etc/init.d/eltex-ems start (code=exited, status=0/SUCCESS) Main PID: 3484 (daemon) CGroup: /system.slice/eltex-ems.service ├─3484 /usr/bin/daemon --name=eltex-ems --inherit --unsafe --pidfile=/var/run/eltex-ems/eltex-ems.pid -- /usr/bin/java -XX:+HeapDumpOnOutOfMemoryError -XX:HeapDumpPath=/var/log/eltex-ems -Djava.security.egd=file:/dev/./urandom -XX:+UseParallelGC -XX:MaxPermSize=512m -XX:PermSize=200m -XX:+PrintGCDateStamps -XX:+PrintGCDetails -XX:+UseGCLogFileRotation -XX:NumberOfGCLogFiles=7 -XX:GCLogFileSize=5M -Xloggc:/var/log/eltex-ems/gc.log -Djava.security.egd=file:/dev/./urandom -Xms256m -Xmx1024m -Dmodule.home=/usr/lib/eltex-ems -Dlog4j.configurationFile=/usr/lib/eltex-ems/conf/log4j2.xml -Dfile.encoding=UTF-8 -jar /usr/lib/eltex-ems/lib/ems_server.jar └─3485 /usr/bin/java -XX:+HeapDumpOnOutOfMemoryError -XX:HeapDumpPath=/var/log/eltex-ems -Djava.security.egd=file:/dev/./urandom -XX:+UseParallelGC -XX:MaxPermSize=512m -XX:PermSize=200m -XX:+PrintGCDateStamps -XX:+PrintGCDetails -XX:+UseGCLogFileRotation -XX:NumberOfGCLogFiles=7 -XX:GCLogFileSize=5M -Xloggc:/var/log/eltex-ems/gc.log -Djava.security.egd=file:/dev/./urandom -Xms256m -Xmx1024m -Dmodule.home=/usr/lib/eltex-ems -Dlog4j.configurationFile=/usr/lib/eltex-ems/conf/log4j2.xml -Dfile.encoding=UTF-8 -jar /usr/lib/eltex-ems/lib/ems_server.jar сен 23 14:05:32 tester-acs systemd[1]: Starting Eltex EMS... сен 23 14:05:32 tester-acs eltex-ems[3440]: * Starting Eltex.EMS Server eltex-ems сен 23 14:05:34 tester-acs eltex-ems[3440]: ...done. сен 23 14:05:34 tester-acs systemd[1]: eltex-ems.service: Can't open PID file /var/run/eltex-ems/eltex-ems.pid (yet?) after start: No such file or directory сен 23 14:05:34 tester-acs systemd[1]: Started Eltex EMS. 23-09-2025 16:15:01: Tomcat status: ● tomcat7.service - LSB: Start Tomcat. Loaded: loaded (/etc/init.d/tomcat7; bad; vendor preset: enabled) Active: active (running) since Пн 2025-06-16 12:25:27 +07; 3 months 7 days ago Docs: man:systemd-sysv-generator(8) Process: 4883 ExecStart=/etc/init.d/tomcat7 start (code=exited, status=0/SUCCESS) CGroup: /system.slice/tomcat7.service └─4909 /usr/lib/jvm/default-java/bin/java -Djava.util.logging.config.file=/var/lib/tomcat7/conf/logging.properties -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager -Djava.awt.headless=true -Xmx128m -XX:+UseConcMarkSweepGC -Djava.endorsed.dirs=/usr/share/tomcat7/endorsed -classpath /usr/share/tomcat7/bin/bootstrap.jar:/usr/share/tomcat7/bin/tomcat-juli.jar -Dcatalina.base=/var/lib/tomcat7 -Dcatalina.home=/usr/share/tomcat7 -Djava.io.tmpdir=/tmp/tomcat7-tomcat7-tmp org.apache.catalina.startup.Bootstrap start Warning: Journal has been rotated since unit was started. Log output is incomplete or unavailable. 23-09-2025 16:15:01: ports (9310, 9340, 8080) status: tcp6 0 0 :::9310 :::* LISTEN 3485/java tcp6 0 0 :::9340 :::* LISTEN 3485/java tcp6 0 0 :::8080 :::* LISTEN 4909/java 23-09-2025: Northbound is working 23-09-2025: EMS and Northbound are working
при возникновении проблемы взаимодействия сервиса с другими сервисами(как пример закрыт порт, не запущен процесс) или не хватка hardware ресурсов для работы. Файл частично дублирует информацию из 1 пункта.Логирование сервиса:
В этом файле будет подробно описываться все ошибки которые возникли при работе сервиса.cat /var/log/eltex-ems/black_box.txt
Самое подробное описание возникшей проблем в работе сервиса. Сюда попадают все системные сообщения в процессе работы сервиса(вызовы команд, взаимодействие с оборудованием и взаимодействие сервиса с другими сервисами).-------------------------------------- START EMS_SERVER -------------------------------------------- 2024-09-13T12:47:34,551 [main] ERROR Kernel Server.main(line:182). EMS version (from server.jar manifest) : 3.18-205 (11.12.19 16:09:05) 2024-09-13T12:47:34,565 [main] INFO Kernel ServerShutdownHook.<init>(line:22). Set Shutdown 2024-09-13T12:47:34,566 [main] INFO Kernel ServerBuilder.createServerShutdownHook(line:47). init: Add ShutdownHook. 2024-09-13T12:47:34,601 [main] ERROR Kernel Server.init(line:389). init: Server version = 3.18-205 (11.12.19 16:09:05) 2024-09-13T12:47:34,663 [main] INFO Kernel ConfigManager.<init>(line:65). Loading params from file: /usr/lib/eltex-ems/conf/config.txt 2024-09-13T12:47:34,695 [main] INFO Kernel ConfigManager.<init>(line:65). Loading params from file: /usr/lib/eltex-ems/conf/system-config.txt 2024-09-13T12:47:34,710 [main] INFO Kernel ConfigManager.<init>(line:65). Loading params from file: /usr/lib/eltex-ems/conf/snmp/OntActivationSender.cfg 2024-09-13T12:47:34,724 [main] INFO Kernel Server.init(line:403). init: ACCESS_TYPE from system-config.txt = BY_ROLE 2024-09-13T12:47:35,027 [main] INFO Kernel ServerModule.initDBPools(line:121). Initialize pools for module 'system'. pools: [tree, event, ont, syslog] 2024-09-13T12:47:35,058 [main] INFO Kernel AConnectionPool.<init>(line:26). Start. dbPar = DBPar{dbURL='jdbc:mysql://localhost/eltex_ems?useUnicode=true&characterEncoding=utf8&relaxAutoCommit=true&connectTimeout=5000&noAccessToProcedureBodies=true', user='javauser', password='***', driverClassName='org.gjt.mm.mysql.Driver', poolName='tree', maxPoolSize=20, inUse=true, sshPort=0} 2024-09-13T12:47:35,554 [main] INFO Kernel AConnectionPool.<init>(line:43). Created Connection pool tree 2024-09-13T12:47:40,240 [main] ERROR Kernel ServerBuilder.createSystemModule(line:88). checkDbSystem: error com.zaxxer.hikari.pool.HikariPool$PoolInitializationException: Failed to initialize pool: Communications link failure The last packet successfully received from the server was 1 961 milliseconds ago. The last packet sent successfully to the server was 1 232 milliseconds ago. at com.zaxxer.hikari.pool.HikariPool.throwPoolInitializationException(HikariPool.java:576) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:562) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.<init>(HikariPool.java:115) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.HikariDataSource.<init>(HikariDataSource.java:81) ~[HikariCP-3.2.0.jar:?] at org.eltex.ems.web.server.db.HikariConnectionPool.<init>(HikariConnectionPool.java:45) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.createPool(MultiConnectionPool.java:71) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.<init>(MultiConnectionPool.java:42) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.ConnectionsDB.init(ConnectionsDB.java:234) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.module.ServerModule.initDBPools(ServerModule.java:122) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.ServerBuilder.createSystemModule(ServerBuilder.java:76) [ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.Server.init(Server.java:414) [ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.Server.main(Server.java:202) [ems_server.jar:3.18-205 (11.12.19 16:09:05)] Caused by: com.mysql.jdbc.exceptions.jdbc4.CommunicationsException: Communications link failure The last packet successfully received from the server was 1 961 milliseconds ago. The last packet sent successfully to the server was 1 232 milliseconds ago. at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_292] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) ~[?:1.8.0_292] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:1.8.0_292] at java.lang.reflect.Constructor.newInstance(Constructor.java:423) ~[?:1.8.0_292] at com.mysql.jdbc.Util.handleNewInstance(Util.java:404) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.SQLError.createCommunicationsException(SQLError.java:988) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ExportControlled.transformSocketToSSLSocket(ExportControlled.java:164) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.negotiateSSLConnection(MysqlIO.java:4894) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.proceedHandshakeWithPluggableAuthentication(MysqlIO.java:1661) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.doHandshake(MysqlIO.java:1228) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.coreConnect(ConnectionImpl.java:2253) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.connectOneTryOnly(ConnectionImpl.java:2284) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.createNewIO(ConnectionImpl.java:2083) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.<init>(ConnectionImpl.java:806) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.JDBC4Connection.<init>(JDBC4Connection.java:47) ~[mysql-connector-java-5.1.39.jar:5.1.39] at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_292] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) ~[?:1.8.0_292] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:1.8.0_292] at java.lang.reflect.Constructor.newInstance(Constructor.java:423) ~[?:1.8.0_292] at com.mysql.jdbc.Util.handleNewInstance(Util.java:404) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.getInstance(ConnectionImpl.java:410) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.NonRegisteringDriver.connect(NonRegisteringDriver.java:328) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:136) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newConnection(PoolBase.java:369) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newPoolEntry(PoolBase.java:198) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.createPoolEntry(HikariPool.java:467) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:541) ~[HikariCP-3.2.0.jar:?] ... 10 more Caused by: javax.net.ssl.SSLHandshakeException: No appropriate protocol (protocol is disabled or cipher suites are inappropriate) at sun.security.ssl.HandshakeContext.<init>(HandshakeContext.java:171) ~[?:1.8.0_292] at sun.security.ssl.ClientHandshakeContext.<init>(ClientHandshakeContext.java:98) ~[?:1.8.0_292] at sun.security.ssl.TransportContext.kickstart(TransportContext.java:220) ~[?:1.8.0_292] at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:428) ~[?:1.8.0_292] at com.mysql.jdbc.ExportControlled.transformSocketToSSLSocket(ExportControlled.java:149) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.negotiateSSLConnection(MysqlIO.java:4894) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.proceedHandshakeWithPluggableAuthentication(MysqlIO.java:1661) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.doHandshake(MysqlIO.java:1228) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.coreConnect(ConnectionImpl.java:2253) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.connectOneTryOnly(ConnectionImpl.java:2284) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.createNewIO(ConnectionImpl.java:2083) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.<init>(ConnectionImpl.java:806) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.JDBC4Connection.<init>(JDBC4Connection.java:47) ~[mysql-connector-java-5.1.39.jar:5.1.39] at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_292] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) ~[?:1.8.0_292] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:1.8.0_292] at java.lang.reflect.Constructor.newInstance(Constructor.java:423) ~[?:1.8.0_292] at com.mysql.jdbc.Util.handleNewInstance(Util.java:404) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.getInstance(ConnectionImpl.java:410) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.NonRegisteringDriver.connect(NonRegisteringDriver.java:328) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:136) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newConnection(PoolBase.java:369) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newPoolEntry(PoolBase.java:198) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.createPoolEntry(HikariPool.java:467) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:541) ~[HikariCP-3.2.0.jar:?] ... 10 more 2024-09-13T12:47:40,334 [main] ERROR Kernel Server.init(line:563). error org.eltex.ems.web.common.exception.SystemErrorException: System error : com.zaxxer.hikari.pool.HikariPool$PoolInitializationException: Failed to initialize pool: Communications link failure The last packet successfully received from the server was 1 961 milliseconds ago. The last packet sent successfully to the server was 1 232 milliseconds ago. at org.eltex.ems.web.server.ServerBuilder.createSystemModule(ServerBuilder.java:89) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.Server.init(Server.java:414) [ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.Server.main(Server.java:202) [ems_server.jar:3.18-205 (11.12.19 16:09:05)] Caused by: com.zaxxer.hikari.pool.HikariPool$PoolInitializationException: Failed to initialize pool: Communications link failure The last packet successfully received from the server was 1 961 milliseconds ago. The last packet sent successfully to the server was 1 232 milliseconds ago. at com.zaxxer.hikari.pool.HikariPool.throwPoolInitializationException(HikariPool.java:576) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:562) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.<init>(HikariPool.java:115) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.HikariDataSource.<init>(HikariDataSource.java:81) ~[HikariCP-3.2.0.jar:?] at org.eltex.ems.web.server.db.HikariConnectionPool.<init>(HikariConnectionPool.java:45) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.createPool(MultiConnectionPool.java:71) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.<init>(MultiConnectionPool.java:42) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.ConnectionsDB.init(ConnectionsDB.java:234) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.module.ServerModule.initDBPools(ServerModule.java:122) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.ServerBuilder.createSystemModule(ServerBuilder.java:76) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] ... 2 more Caused by: com.mysql.jdbc.exceptions.jdbc4.CommunicationsException: Communications link failure The last packet successfully received from the server was 1 961 milliseconds ago. The last packet sent successfully to the server was 1 232 milliseconds ago. at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_292] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) ~[?:1.8.0_292] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:1.8.0_292] at java.lang.reflect.Constructor.newInstance(Constructor.java:423) ~[?:1.8.0_292] at com.mysql.jdbc.Util.handleNewInstance(Util.java:404) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.SQLError.createCommunicationsException(SQLError.java:988) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ExportControlled.transformSocketToSSLSocket(ExportControlled.java:164) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.negotiateSSLConnection(MysqlIO.java:4894) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.proceedHandshakeWithPluggableAuthentication(MysqlIO.java:1661) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.doHandshake(MysqlIO.java:1228) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.coreConnect(ConnectionImpl.java:2253) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.connectOneTryOnly(ConnectionImpl.java:2284) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.createNewIO(ConnectionImpl.java:2083) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.<init>(ConnectionImpl.java:806) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.JDBC4Connection.<init>(JDBC4Connection.java:47) ~[mysql-connector-java-5.1.39.jar:5.1.39] at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_292] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) ~[?:1.8.0_292] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:1.8.0_292] at java.lang.reflect.Constructor.newInstance(Constructor.java:423) ~[?:1.8.0_292] at com.mysql.jdbc.Util.handleNewInstance(Util.java:404) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.getInstance(ConnectionImpl.java:410) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.NonRegisteringDriver.connect(NonRegisteringDriver.java:328) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:136) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newConnection(PoolBase.java:369) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newPoolEntry(PoolBase.java:198) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.createPoolEntry(HikariPool.java:467) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:541) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.<init>(HikariPool.java:115) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.HikariDataSource.<init>(HikariDataSource.java:81) ~[HikariCP-3.2.0.jar:?] at org.eltex.ems.web.server.db.HikariConnectionPool.<init>(HikariConnectionPool.java:45) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.createPool(MultiConnectionPool.java:71) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.<init>(MultiConnectionPool.java:42) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.ConnectionsDB.init(ConnectionsDB.java:234) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.module.ServerModule.initDBPools(ServerModule.java:122) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.ServerBuilder.createSystemModule(ServerBuilder.java:76) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] ... 2 more Caused by: javax.net.ssl.SSLHandshakeException: No appropriate protocol (protocol is disabled or cipher suites are inappropriate) at sun.security.ssl.HandshakeContext.<init>(HandshakeContext.java:171) ~[?:1.8.0_292] at sun.security.ssl.ClientHandshakeContext.<init>(ClientHandshakeContext.java:98) ~[?:1.8.0_292] at sun.security.ssl.TransportContext.kickstart(TransportContext.java:220) ~[?:1.8.0_292] at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:428) ~[?:1.8.0_292] at com.mysql.jdbc.ExportControlled.transformSocketToSSLSocket(ExportControlled.java:149) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.negotiateSSLConnection(MysqlIO.java:4894) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.proceedHandshakeWithPluggableAuthentication(MysqlIO.java:1661) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.doHandshake(MysqlIO.java:1228) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.coreConnect(ConnectionImpl.java:2253) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.connectOneTryOnly(ConnectionImpl.java:2284) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.createNewIO(ConnectionImpl.java:2083) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.<init>(ConnectionImpl.java:806) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.JDBC4Connection.<init>(JDBC4Connection.java:47) ~[mysql-connector-java-5.1.39.jar:5.1.39] at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_292] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) ~[?:1.8.0_292] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:1.8.0_292] at java.lang.reflect.Constructor.newInstance(Constructor.java:423) ~[?:1.8.0_292] at com.mysql.jdbc.Util.handleNewInstance(Util.java:404) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.getInstance(ConnectionImpl.java:410) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.NonRegisteringDriver.connect(NonRegisteringDriver.java:328) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:136) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newConnection(PoolBase.java:369) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newPoolEntry(PoolBase.java:198) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.createPoolEntry(HikariPool.java:467) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:541) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.<init>(HikariPool.java:115) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.HikariDataSource.<init>(HikariDataSource.java:81) ~[HikariCP-3.2.0.jar:?] at org.eltex.ems.web.server.db.HikariConnectionPool.<init>(HikariConnectionPool.java:45) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.createPool(MultiConnectionPool.java:71) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.<init>(MultiConnectionPool.java:42) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.ConnectionsDB.init(ConnectionsDB.java:234) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.module.ServerModule.initDBPools(ServerModule.java:122) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.ServerBuilder.createSystemModule(ServerBuilder.java:76) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] ... 2 more 2024-09-13T12:47:40,357 [main] ERROR Kernel Server.main(line:278). server error. stop server. org.eltex.ems.web.common.exception.SystemErrorException: System error : com.zaxxer.hikari.pool.HikariPool$PoolInitializationException: Failed to initialize pool: Communications link failure The last packet successfully received from the server was 1 961 milliseconds ago. The last packet sent successfully to the server was 1 232 milliseconds ago. at org.eltex.ems.web.server.ServerBuilder.createSystemModule(ServerBuilder.java:89) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.Server.init(Server.java:414) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.Server.main(Server.java:202) [ems_server.jar:3.18-205 (11.12.19 16:09:05)] Caused by: com.zaxxer.hikari.pool.HikariPool$PoolInitializationException: Failed to initialize pool: Communications link failure The last packet successfully received from the server was 1 961 milliseconds ago. The last packet sent successfully to the server was 1 232 milliseconds ago. at com.zaxxer.hikari.pool.HikariPool.throwPoolInitializationException(HikariPool.java:576) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:562) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.<init>(HikariPool.java:115) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.HikariDataSource.<init>(HikariDataSource.java:81) ~[HikariCP-3.2.0.jar:?] at org.eltex.ems.web.server.db.HikariConnectionPool.<init>(HikariConnectionPool.java:45) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.createPool(MultiConnectionPool.java:71) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.<init>(MultiConnectionPool.java:42) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.ConnectionsDB.init(ConnectionsDB.java:234) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.module.ServerModule.initDBPools(ServerModule.java:122) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.ServerBuilder.createSystemModule(ServerBuilder.java:76) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] ... 2 more Caused by: com.mysql.jdbc.exceptions.jdbc4.CommunicationsException: Communications link failure The last packet successfully received from the server was 1 961 milliseconds ago. The last packet sent successfully to the server was 1 232 milliseconds ago. at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_292] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) ~[?:1.8.0_292] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:1.8.0_292] at java.lang.reflect.Constructor.newInstance(Constructor.java:423) ~[?:1.8.0_292] at com.mysql.jdbc.Util.handleNewInstance(Util.java:404) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.SQLError.createCommunicationsException(SQLError.java:988) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ExportControlled.transformSocketToSSLSocket(ExportControlled.java:164) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.negotiateSSLConnection(MysqlIO.java:4894) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.proceedHandshakeWithPluggableAuthentication(MysqlIO.java:1661) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.doHandshake(MysqlIO.java:1228) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.coreConnect(ConnectionImpl.java:2253) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.connectOneTryOnly(ConnectionImpl.java:2284) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.createNewIO(ConnectionImpl.java:2083) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.<init>(ConnectionImpl.java:806) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.JDBC4Connection.<init>(JDBC4Connection.java:47) ~[mysql-connector-java-5.1.39.jar:5.1.39] at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_292] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) ~[?:1.8.0_292] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:1.8.0_292] at java.lang.reflect.Constructor.newInstance(Constructor.java:423) ~[?:1.8.0_292] at com.mysql.jdbc.Util.handleNewInstance(Util.java:404) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.getInstance(ConnectionImpl.java:410) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.NonRegisteringDriver.connect(NonRegisteringDriver.java:328) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:136) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newConnection(PoolBase.java:369) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newPoolEntry(PoolBase.java:198) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.createPoolEntry(HikariPool.java:467) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:541) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.<init>(HikariPool.java:115) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.HikariDataSource.<init>(HikariDataSource.java:81) ~[HikariCP-3.2.0.jar:?] at org.eltex.ems.web.server.db.HikariConnectionPool.<init>(HikariConnectionPool.java:45) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.createPool(MultiConnectionPool.java:71) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.<init>(MultiConnectionPool.java:42) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.ConnectionsDB.init(ConnectionsDB.java:234) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.module.ServerModule.initDBPools(ServerModule.java:122) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.ServerBuilder.createSystemModule(ServerBuilder.java:76) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] ... 2 more Caused by: javax.net.ssl.SSLHandshakeException: No appropriate protocol (protocol is disabled or cipher suites are inappropriate) at sun.security.ssl.HandshakeContext.<init>(HandshakeContext.java:171) ~[?:1.8.0_292] at sun.security.ssl.ClientHandshakeContext.<init>(ClientHandshakeContext.java:98) ~[?:1.8.0_292] at sun.security.ssl.TransportContext.kickstart(TransportContext.java:220) ~[?:1.8.0_292] at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:428) ~[?:1.8.0_292] at com.mysql.jdbc.ExportControlled.transformSocketToSSLSocket(ExportControlled.java:149) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.negotiateSSLConnection(MysqlIO.java:4894) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.proceedHandshakeWithPluggableAuthentication(MysqlIO.java:1661) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.MysqlIO.doHandshake(MysqlIO.java:1228) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.coreConnect(ConnectionImpl.java:2253) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.connectOneTryOnly(ConnectionImpl.java:2284) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.createNewIO(ConnectionImpl.java:2083) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.<init>(ConnectionImpl.java:806) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.JDBC4Connection.<init>(JDBC4Connection.java:47) ~[mysql-connector-java-5.1.39.jar:5.1.39] at sun.reflect.NativeConstructorAccessorImpl.newInstance0(Native Method) ~[?:1.8.0_292] at sun.reflect.NativeConstructorAccessorImpl.newInstance(NativeConstructorAccessorImpl.java:62) ~[?:1.8.0_292] at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) ~[?:1.8.0_292] at java.lang.reflect.Constructor.newInstance(Constructor.java:423) ~[?:1.8.0_292] at com.mysql.jdbc.Util.handleNewInstance(Util.java:404) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.ConnectionImpl.getInstance(ConnectionImpl.java:410) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.mysql.jdbc.NonRegisteringDriver.connect(NonRegisteringDriver.java:328) ~[mysql-connector-java-5.1.39.jar:5.1.39] at com.zaxxer.hikari.util.DriverDataSource.getConnection(DriverDataSource.java:136) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newConnection(PoolBase.java:369) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.PoolBase.newPoolEntry(PoolBase.java:198) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.createPoolEntry(HikariPool.java:467) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.checkFailFast(HikariPool.java:541) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.pool.HikariPool.<init>(HikariPool.java:115) ~[HikariCP-3.2.0.jar:?] at com.zaxxer.hikari.HikariDataSource.<init>(HikariDataSource.java:81) ~[HikariCP-3.2.0.jar:?] at org.eltex.ems.web.server.db.HikariConnectionPool.<init>(HikariConnectionPool.java:45) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.createPool(MultiConnectionPool.java:71) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.MultiConnectionPool.<init>(MultiConnectionPool.java:42) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.db.ConnectionsDB.init(ConnectionsDB.java:234) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.module.ServerModule.initDBPools(ServerModule.java:122) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] at org.eltex.ems.web.server.ServerBuilder.createSystemModule(ServerBuilder.java:76) ~[ems_server.jar:3.18-205 (11.12.19 16:09:05)] ... 2 more 2024-09-13T12:47:40,454 [Shutdown] ERROR Kernel ServerShutdownHook.run(line:47). ============== Start shutdown. Waiting for real work is finished. =========== 2024-09-13T12:47:40,455 [Shutdown] ERROR Kernel ServerShutdownHook.run(line:68). EMS server not running. Nothing do. 2024-09-13T12:47:40,455 [Shutdown] ERROR Kernel ServerShutdownHook.run(line:71). ================== Server Finish ==========================
В примере используется ошибка связности между модулями mysql и eltex-ems. Выше сообщения "Start shutdown. Waiting for real work is finished." описана причина остановки сервиса.