Starting Jetty server on port: 8079 and contextPath: /app-core LogbackConfigurator INFO Setting up CUBA default logging configuration LogbackConfigurator INFO Could NOT find resource [/opt/core-home/logback.xml] LogbackConfigurator INFO Found resource [jar:file:/opt/primaries/app-core.jar!/app-logback.xml] 09:07:44.668 INFO org.eclipse.jetty.util.log - Logging initialized @1300ms to org.eclipse.jetty.util.log.Slf4jLog 09:07:44.962 INFO org.eclipse.jetty.server.Server - jetty-9.4.z-SNAPSHOT; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.7+10 09:07:45.270 INFO o.e.j.w.StandardDescriptorProcessor - NO JSP Support for /app-core, did not find org.eclipse.jetty.jsp.JettyJspServlet 09:07:45.392 INFO org.eclipse.jetty.server.session - DefaultSessionIdManager workerName=node0 09:07:45.393 INFO org.eclipse.jetty.server.session - No SessionScavenger set, using defaults 09:07:45.399 INFO org.eclipse.jetty.server.session - node0 Scavenging every 600000ms 09:07:45.431 INFO c.h.c.c.s.AbstractWebAppContextLoader - Initializing 'core' block, servlet context path: /app-core 09:07:45.685 INFO c.h.cuba.core.sys.AppComponents - Using app components: [com.haulmont.cuba, de.balvi.cuba.declarativecontrollers, com.haulmont.addon.helium, com.haulmont.addon.restapi, com.haulmont.addon.idp, com.haulmont.addon.globalevents, com.haulmont.addon.cubaaws, de.diedavids.cuba.dataimport, com.haulmont.addon.zookeeper] 09:07:45.748 INFO c.h.c.c.s.AbstractWebAppContextLoader - Loading app properties from classpath:com/ibec/primaries/app.properties 09:07:45.751 INFO c.h.c.c.s.AbstractWebAppContextLoader - Loading app properties from /WEB-INF/local.app.properties 09:07:45.783 INFO c.h.c.c.s.AbstractWebAppContextLoader - Loading app properties from file:/opt/core-home/local.app.properties 09:07:45.817 INFO c.h.c.c.s.AbstractWebAppContextLoader - cuba.webContextName: app-core 09:07:45.983 INFO c.h.cuba.core.sys.AppContextLoader - DbmsType of the main database is set to postgres 09:07:46.056 INFO c.h.c.c.s.e.DataStoresCheck - Checking connection to data store Main 09:07:46.338 INFO c.h.c.c.s.e.EnvironmentChecksRunner - Environment checks on core module completed successfully 09:07:47.167 INFO c.h.c.c.s.p.PersistenceConfigProcessor - Creating file /opt/core-home/app-core/work/persistence.xml 09:07:53.762 INFO com.zaxxer.hikari.HikariDataSource - Connection Pool-Main - Starting... 09:07:53.926 INFO com.zaxxer.hikari.HikariDataSource - Connection Pool-Main - Start completed. 09:08:02.428 INFO c.h.c.c.s.CubaThreadPoolTaskScheduler - Initializing ExecutorService 'scheduler' 09:08:02.768 INFO c.h.c.c.s.CubaThreadPoolTaskScheduler - Initializing ExecutorService 'restapi_scheduler' WARNING: An illegal reflective access operation has occurred WARNING: Illegal reflective access by org.codehaus.groovy.vmplugin.v7.Java7$1 (jar:file:/opt/primaries/app-core.jar!/LIB-INF/shared/) to constructor java.lang.invoke.MethodHandles$Lookup(java.lang.Class,int) WARNING: Please consider reporting this to the maintainers of org.codehaus.groovy.vmplugin.v7.Java7$1 WARNING: Use --illegal-access=warn to enable warnings of further illegal reflective access operations WARNING: All illegal access operations will be denied in a future release 09:08:07.052 INFO c.h.cuba.core.sys.jmx.MBeanExporter - Registering beans for JMX exposure: [app-core.cuba:type=PersistenceManager, app-core.cuba:type=ConfigStorage, app-core.cuba:type=UserSessions, app-core.cuba:type=UniqueNumbers, app-core.cuba:type=Emailer, app-core.cuba:type=EntityLog, app-core.cuba:type=FileStorage, app-core.cuba:type=LockManager, app-core.cuba:type=CachingFacade, app-core.cuba:type=ClusterManager, app-core.cuba:type=ScriptingManager, app-core.cuba:type=ServerInfo, app-core.cuba:type=Scheduling, app-core.cuba:type=PasswordEncryptionSupport, app-core.cuba:type=JmxNodeIdentifier, app-core.cuba:type=JmxLogControl, app-core.cuba:type=ClassLoaderManager, app-core.cuba:type=StatisticsCounter, app-core.cuba:type=BruteForceProtection, app-core.cuba:type=QueryCacheSupport] 09:08:07.636 INFO c.h.cuba.core.sys.jmx.MBeanExporter - Registering beans for JMX exposure: [app-core.restapi:type=ServerTokenStore] 09:08:07.661 INFO c.h.cuba.core.sys.jmx.MBeanExporter - Registering beans for JMX exposure: [app-core.cuba:type=IdpSessions] 09:08:07.696 INFO c.h.cuba.core.sys.MetadataImpl - Initializing metadata 09:08:08.849 INFO c.h.cuba.core.sys.MetadataImpl - Metadata initialized in 1151 ms 09:08:08.850 INFO c.h.cuba.core.app.ClusterManager - Starting cluster 09:08:08.852 INFO c.h.cuba.core.app.ClusterManager - Property 'cuba.cluster.jgroupsConfig' is not specified, using jgroups.xml 09:08:10.163 WARN org.jgroups.stack.Configurator - JGRP000014: GMS.view_bundling has been deprecated: view bundling is enabled by default 09:08:10.257 WARN org.jgroups.protocols.UDP - JGRP000015: the receive buffer of socket MulticastSocket was set to 500.00KB, but the OS only allocated 212.99KB ------------------------------------------------------------------- GMS: address=middleware-7b9f7468c8-l2nws-38455, cluster=cubaCluster, physical address=172.17.0.11:46005 ------------------------------------------------------------------- 09:08:10.792 INFO c.h.cuba.core.app.ClusterManager - New cluster view: [middleware-7b9f7468c8-hvwdg-16637|4] (3) [middleware-7b9f7468c8-hvwdg-16637, middleware-7b9f7468c8-k9h44-23195, middleware-7b9f7468c8-l2nws-38455] 09:08:10.825 INFO c.h.cuba.core.app.ClusterManager - Receiving cluster state... 09:08:15.282 INFO c.h.cuba.core.app.ConfigStorage - Loading DB-stored app properties cache 09:08:16.527 INFO c.h.c.s.a.AuthenticationManagerBean - Logged in: 5293ca1c-3d69-8476-e562-6aedf1803a6d [anonymous] 09:08:16.682 INFO c.h.c.s.a.AuthenticationManagerBean - Logged in: 8bda6e9b-7165-83cc-77ed-be6dd0ff4a4f [anonymous] 09:08:16.690 INFO c.h.a.z.discovery.ZkServerAdvertiser - Connecting to ZooKeeper at zoo:2181 09:08:16.898 INFO o.a.c.f.imps.CuratorFrameworkImpl - Starting 09:08:16.938 INFO org.apache.zookeeper.ZooKeeper - Client environment:zookeeper.version=3.4.8--1, built on 02/06/2016 03:18 GMT 09:08:16.942 INFO org.apache.zookeeper.ZooKeeper - Client environment:host.name=middleware-7b9f7468c8-l2nws 09:08:16.945 INFO org.apache.zookeeper.ZooKeeper - Client environment:java.version=11.0.7 09:08:16.947 INFO org.apache.zookeeper.ZooKeeper - Client environment:java.vendor=Oracle Corporation 09:08:16.950 INFO org.apache.zookeeper.ZooKeeper - Client environment:java.home=/usr/local/openjdk-11 09:08:16.953 INFO org.apache.zookeeper.ZooKeeper - Client environment:java.class.path=/opt/primaries/app-core.jar 09:08:16.956 INFO org.apache.zookeeper.ZooKeeper - Client environment:java.library.path=/usr/java/packages/lib:/usr/lib64:/lib64:/lib:/usr/lib 09:08:16.961 INFO org.apache.zookeeper.ZooKeeper - Client environment:java.io.tmpdir=/tmp 09:08:16.967 INFO org.apache.zookeeper.ZooKeeper - Client environment:java.compiler= 09:08:16.968 INFO org.apache.zookeeper.ZooKeeper - Client environment:os.name=Linux 09:08:16.970 INFO org.apache.zookeeper.ZooKeeper - Client environment:os.arch=amd64 09:08:16.974 INFO org.apache.zookeeper.ZooKeeper - Client environment:os.version=4.19.107 09:08:16.979 INFO org.apache.zookeeper.ZooKeeper - Client environment:user.name=root 09:08:16.983 INFO org.apache.zookeeper.ZooKeeper - Client environment:user.home=/root 09:08:16.986 INFO org.apache.zookeeper.ZooKeeper - Client environment:user.dir=/ 09:08:16.997 INFO org.apache.zookeeper.ZooKeeper - Initiating client connection, connectString=zoo:2181 sessionTimeout=60000 watcher=org.apache.curator.ConnectionState@30370ce 09:08:17.134 INFO org.apache.zookeeper.ClientCnxn - Opening socket connection to server zoo.default.svc.cluster.local/10.109.87.115:2181. Will not attempt to authenticate using SASL (unknown error) 09:08:17.260 INFO org.apache.zookeeper.ClientCnxn - Socket connection established to zoo.default.svc.cluster.local/10.109.87.115:2181, initiating session 09:08:17.293 INFO org.apache.zookeeper.ClientCnxn - Session establishment complete on server zoo.default.svc.cluster.local/10.109.87.115:2181, sessionid = 0x1000003c9840004, negotiated timeout = 40000 09:08:17.307 INFO o.a.c.f.state.ConnectionStateManager - State change: CONNECTED 09:08:17.353 INFO c.h.c.c.s.AbstractWebAppContextLoader - AppContext started 09:08:17.366 INFO o.e.j.s.h.ContextHandler.app_core - Initializing Spring WebSocketDispatcherServlet 'cubaglevt_ws_servlet' 09:08:17.369 INFO c.h.a.g.c.WebSocketDispatcherServlet - Initializing Servlet 'cubaglevt_ws_servlet' 09:08:17.618 WARN c.h.cuba.core.jmx.StatisticsCounter - Сonnection pool not found for statistics counting 09:08:19.446 INFO c.h.a.g.c.WebSocketDispatcherServlet - Completed initialization in 2076 ms 09:08:19.494 INFO o.e.j.s.h.ContextHandler.app_core - Initializing Spring RemotingServlet 'remoting' 09:08:19.496 INFO c.h.c.c.sys.remoting.RemotingServlet - Initializing Servlet 'remoting' 09:08:19.678 INFO c.h.c.c.s.r.RemoteServicesBeanCreator - Configuring remote services 09:08:20.274 INFO c.h.c.c.sys.remoting.RemotingServlet - Completed initialization in 777 ms 09:08:20.280 INFO o.e.j.server.handler.ContextHandler - Started o.e.j.w.WebAppContext@6e01f9b0{/app-core,jar:file:/opt/primaries/app-core.jar!/LIB-INF/app-core,AVAILABLE} 09:08:20.324 INFO o.e.jetty.server.AbstractConnector - Started ServerConnector@68267da0{HTTP/1.1,[http/1.1]}{0.0.0.0:8079} 09:08:20.329 INFO org.eclipse.jetty.server.Server - Started @36966ms 09:09:00.122 INFO c.h.cuba.core.sys.ServiceInterceptor - Exception in ConfigStorageService.getDbProperties(): com.haulmont.cuba.security.global.NoUserSessionException: User session not found: 5d88da28-10f6-92d5-3b08-8efd61b5ef40 09:10:24.044 INFO c.h.c.s.a.r.PredefinedRoleDefinitionRepository- Initializing predefined role definitions 09:10:24.133 INFO c.h.c.s.a.AuthenticationManagerBean - Logged in: bf5cf71c-66b8-e895-efb9-3266ca1c573e [admin]