14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version name:   Apache Tomcat/8.5.65
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server built:          Mar 30 2021 12:28:40 UTC
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version number: 8.5.65.0
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name:               Windows Server 2016
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version:            10.0
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture:          amd64
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home:             C:\software\jdk1.8.0_291\jre
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version:           1.8.0_291-b10
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor:            Oracle Corporation
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE:         C:\Tomcat\apache-tomcat-8.5.65
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME:         C:\Tomcat\apache-tomcat-8.5.65
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=C:\Tomcat\apache-tomcat-8.5.65\conf\logging.properties
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dignore.endorsed.dirs=
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=C:\Tomcat\apache-tomcat-8.5.65
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=C:\Tomcat\apache-tomcat-8.5.65
14-Jul-2021 03:13:26.953 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=C:\Tomcat\apache-tomcat-8.5.65\temp
14-Jul-2021 03:13:26.969 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent Loaded Apache Tomcat Native library [1.2.27] using APR version [1.7.0].
14-Jul-2021 03:13:26.969 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR capabilities: IPv6 [true], sendfile [true], accept filters [false], random [true].
14-Jul-2021 03:13:26.969 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent APR/OpenSSL configuration: useAprConnector [false], useOpenSSL [true]
14-Jul-2021 03:13:26.984 INFO [main] org.apache.catalina.core.AprLifecycleListener.initializeSSL OpenSSL successfully initialized [OpenSSL 1.1.1k  25 Mar 2021]
14-Jul-2021 03:13:27.250 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8080"]
14-Jul-2021 03:13:27.328 INFO [main] org.apache.tomcat.util.net.NioSelectorPool.getSharedSelector Using a shared selector for servlet write/read
14-Jul-2021 03:13:27.344 INFO [main] org.apache.catalina.startup.Catalina.load Initialization processed in 957 ms
14-Jul-2021 03:13:27.453 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Catalina]
14-Jul-2021 03:13:27.453 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/8.5.65]
14-Jul-2021 03:13:27.500 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [C:\Tomcat\apache-tomcat-8.5.65\webapps\kaui.war]
14-Jul-2021 03:13:35.563 INFO [localhost-startStop-1] org.apache.jasper.servlet.TldScanner.scanJars 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.
03:13:35,672 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml]
03:13:35,672 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy]
03:13:35,672 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/classes/logback.xml]
03:13:35,828 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
03:13:35,828 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
03:13:35,859 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT]
03:13:35,875 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
03:13:35,984 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender]
03:13:35,984 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [MAIN]
03:13:36,031 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@263110044 - Will use gz compression
03:13:36,031 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@263110044 - Will use the pattern ./logs/kaui-%d{yyyy-MM-dd}.%i.out for the active file
03:13:36,031 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@618932db - The date pattern is 'yyyy-MM-dd' from file name pattern './logs/kaui-%d{yyyy-MM-dd}.%i.out.gz'.
03:13:36,031 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@618932db - Roll-over at midnight.
03:13:36,031 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@618932db - Setting initial period to Wed Jul 14 03:11:48 CDT 2021
03:13:36,047 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@618932db - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead
03:13:36,047 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@618932db - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy
03:13:36,047 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@263110044 - Cleaning on start up
03:13:36,063 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property
03:13:36,063 |-INFO in c.q.l.core.rolling.helper.TimeBasedArchiveRemover - first clean up after appender initialization
03:13:36,063 |-INFO in c.q.l.core.rolling.helper.TimeBasedArchiveRemover - Multiple periods, i.e. 32 periods, seem to have elapsed. This is expected at application start.
03:13:36,063 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[MAIN] - Active log file name: ./logs/kaui.out
03:13:36,063 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[MAIN] - File property is set to [./logs/kaui.out]
03:13:36,063 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO
03:13:36,063 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [MAIN] to Logger[ROOT]
03:13:36,063 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT]
03:13:36,063 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
03:13:36,063 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@7a357021 - Registering current configuration as safe fallback point

2021-07-14T08:13:36,656+0000 lvl='INFO', log='', th='localhost-startStop-1', xff='', rId='', aId='', tId='', jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]
2021-07-14T08:13:36,656+0000 lvl='INFO', log='', th='localhost-startStop-1', xff='', rId='', aId='', tId='', using a shared (threadsafe!) runtime
C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/js-routes-1.4.14/lib/js_routes.rb:22: warning: Dir.exists? is a deprecated name, use Dir.exist? instead
System property java.security.egd has not been set, this may cause some requests to hang because of a lack of entropy. You should probably set it to 'file:/dev/./urandom'
14-Jul-2021 03:14:25.282 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deployment of web application archive [C:\Tomcat\apache-tomcat-8.5.65\webapps\kaui.war] has finished in [57,782] ms
14-Jul-2021 03:14:25.282 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [C:\Tomcat\apache-tomcat-8.5.65\webapps\ROOT.war]
14-Jul-2021 03:14:37.735 INFO [localhost-startStop-1] org.apache.jasper.servlet.TldScanner.scanJars 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.
2021-07-14T08:14:38,344+0000 lvl='INFO', log='DefaultKillbillConfigSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Overwrite of user.timezone system property with America/Chicago may break database serialization of date. Kill Bill will overwrite to GMT
2021-07-14T08:14:38,360+0000 lvl='WARN', log='DefaultKillbillConfigSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', System property java.security.egd has not been set, this may cause some requests to hang because of a lack of entropy. You should probably set it to 'file:/dev/./urandom'
2021-07-14T08:14:38,438+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [local] for [org.killbill.server.region] on [org.killbill.billing.server.config.KillbillServerConfig#getRegion()]
2021-07-14T08:14:38,438+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [http://127.0.0.1:8080] for [org.killbill.server.baseUrl] on [org.killbill.billing.server.config.KillbillServerConfig#getBaseUrl()]
2021-07-14T08:14:38,438+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.server.test.mode] on [org.killbill.billing.server.config.KillbillServerConfig#isTestModeEnabled()]
2021-07-14T08:14:38,438+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.server.test.clock.redis] on [org.killbill.billing.server.config.KillbillServerConfig#isRedisClockEnabled()]
2021-07-14T08:14:38,438+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.server.test.clock.redis.connectionMinimumIdleSize] on [org.killbill.billing.server.config.KillbillServerConfig#getConnectionMinimumIdleSize()]
2021-07-14T08:14:38,438+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.server.multitenant] on [org.killbill.billing.server.config.KillbillServerConfig#isMultiTenancyEnabled()]
2021-07-14T08:14:38,453+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [redis://127.0.0.1:6379] for [org.killbill.server.test.clock.redis.url] on [org.killbill.billing.server.config.KillbillServerConfig#getUrl()]
2021-07-14T08:14:38,453+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.server.http.gzip] on [org.killbill.billing.server.config.KillbillServerConfig#isConfiguredToReturnGZIPResponses()]
2021-07-14T08:14:38,453+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [0s] for [org.killbill.server.shutdownDelay] on [org.killbill.billing.server.config.KillbillServerConfig#getShutdownDelay()]
2021-07-14T08:14:38,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [2003] for [org.killbill.metrics.graphite.port] on [org.killbill.billing.server.config.MetricsGraphiteConfig#getPort()]
2021-07-14T08:14:38,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [killbill] for [org.killbill.metrics.graphite.prefix] on [org.killbill.billing.server.config.MetricsGraphiteConfig#getPrefix()]
2021-07-14T08:14:38,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.metrics.graphite] on [org.killbill.billing.server.config.MetricsGraphiteConfig#isGraphiteReportingEnabled()]
2021-07-14T08:14:38,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [localhost] for [org.killbill.metrics.graphite.host] on [org.killbill.billing.server.config.MetricsGraphiteConfig#getHostname()]
2021-07-14T08:14:38,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [30] for [org.killbill.metrics.graphite.interval] on [org.killbill.billing.server.config.MetricsGraphiteConfig#getInterval()]
2021-07-14T08:14:38,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [2003] for [org.killbill.metrics.influxDb.port] on [org.killbill.billing.server.config.MetricsInfluxDbConfig#getPort()]
2021-07-14T08:14:38,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [killbill] for [org.killbill.metrics.influxDb.prefix] on [org.killbill.billing.server.config.MetricsInfluxDbConfig#getPrefix()]
2021-07-14T08:14:38,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.metrics.influxDb] on [org.killbill.billing.server.config.MetricsInfluxDbConfig#isInfluxDbReportingEnabled()]
2021-07-14T08:14:38,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1000] for [org.killbill.metrics.influxDb.socketTimeout] on [org.killbill.billing.server.config.MetricsInfluxDbConfig#getSocketTimeout()]
2021-07-14T08:14:38,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [localhost] for [org.killbill.metrics.influxDb.host] on [org.killbill.billing.server.config.MetricsInfluxDbConfig#getHostname()]
2021-07-14T08:14:38,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [HTTP] for [org.killbill.metrics.influxDb.senderType] on [org.killbill.billing.server.config.MetricsInfluxDbConfig#getSenderType()]
2021-07-14T08:14:38,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [killbill] for [org.killbill.metrics.influxDb.database] on [org.killbill.billing.server.config.MetricsInfluxDbConfig#getDatabase()]
2021-07-14T08:14:38,735+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [30] for [org.killbill.metrics.influxDb.interval] on [org.killbill.billing.server.config.MetricsInfluxDbConfig#getInterval()]
2021-07-14T08:14:40,891+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.dao.readOnly] on [org.killbill.commons.jdbi.guice.DaoConfig#isReadOnly()]
2021-07-14T08:14:40,891+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [killbill] for [org.killbill.dao.user] on [org.killbill.commons.jdbi.guice.DaoConfig#getUsername()]
2021-07-14T08:14:40,891+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [100] for [org.killbill.dao.maxActive] on [org.killbill.commons.jdbi.guice.DaoConfig#getMaxActive()]
2021-07-14T08:14:40,907+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [********] for [org.killbill.dao.password] on [org.killbill.commons.jdbi.guice.DaoConfig#getPassword()]
2021-07-14T08:14:40,907+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10s] for [org.killbill.dao.connectionTimeout] on [org.killbill.commons.jdbi.guice.DaoConfig#getConnectionTimeout()]
2021-07-14T08:14:40,907+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [2048] for [org.killbill.dao.prepStmtCacheSqlLimit] on [org.killbill.commons.jdbi.guice.DaoConfig#getPreparedStatementsCacheSqlLimit()]
2021-07-14T08:14:40,907+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.dao.useServerPrepStmts] on [org.killbill.commons.jdbi.guice.DaoConfig#isServerSidePreparedStatementsEnabled()]
2021-07-14T08:14:40,907+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [50ms] for [org.killbill.dao.healthCheckExpected99thPercentile] on [org.killbill.commons.jdbi.guice.DaoConfig#getHealthCheckExpected99thPercentile()]
2021-07-14T08:14:40,907+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [DEBUG] for [org.killbill.dao.logLevel] on [org.killbill.commons.jdbi.guice.DaoConfig#getLogLevel()]
2021-07-14T08:14:40,907+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [jdbc:mysql://127.0.0.1:3306/killbill] for [org.killbill.dao.url] on [org.killbill.commons.jdbi.guice.DaoConfig#getJdbcUrl()]
2021-07-14T08:14:40,907+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.dao.minIdle] on [org.killbill.commons.jdbi.guice.DaoConfig#getMinIdle()]
2021-07-14T08:14:40,922+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60m] for [org.killbill.dao.idleMaxAge] on [org.killbill.commons.jdbi.guice.DaoConfig#getIdleMaxAge()]
2021-07-14T08:14:40,922+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.dao.connectionInitSql] on [org.killbill.commons.jdbi.guice.DaoConfig#getConnectionInitSql()]
2021-07-14T08:14:40,922+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [TRANSACTION_READ_COMMITTED] for [org.killbill.dao.transactionIsolationLevel] on [org.killbill.commons.jdbi.guice.DaoConfig#getTransactionIsolationLevel()]
2021-07-14T08:14:40,938+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [500] for [org.killbill.dao.prepStmtCacheSize] on [org.killbill.commons.jdbi.guice.DaoConfig#getPreparedStatementsCacheSize()]
2021-07-14T08:14:40,938+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.dao.dataSourceClassName] on [org.killbill.commons.jdbi.guice.DaoConfig#getDataSourceClassName()]
2021-07-14T08:14:40,938+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [0m] for [org.killbill.dao.maxConnectionAge] on [org.killbill.commons.jdbi.guice.DaoConfig#getMaxConnectionAge()]
2021-07-14T08:14:40,938+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5m] for [org.killbill.dao.idleConnectionTestPeriod] on [org.killbill.commons.jdbi.guice.DaoConfig#getIdleConnectionTestPeriod()]
2021-07-14T08:14:40,938+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.dao.driverClassName] on [org.killbill.commons.jdbi.guice.DaoConfig#getDriverClassName()]
2021-07-14T08:14:40,938+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.dao.leakDetectionThreshold] on [org.killbill.commons.jdbi.guice.DaoConfig#getLeakDetectionThreshold()]
2021-07-14T08:14:40,938+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5.1] for [org.killbill.dao.mysqlServerVersion] on [org.killbill.commons.jdbi.guice.DaoConfig#getMySQLServerVersion()]
2021-07-14T08:14:40,938+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10s] for [org.killbill.dao.healthCheckConnectionTimeout] on [org.killbill.commons.jdbi.guice.DaoConfig#getHealthCheckConnectionTimeout()]
2021-07-14T08:14:40,938+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.dao.initializationFailFast] on [org.killbill.commons.jdbi.guice.DaoConfig#isInitializationFailFast()]
2021-07-14T08:14:40,954+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.dao.cachePrepStmts] on [org.killbill.commons.jdbi.guice.DaoConfig#isPreparedStatementsCacheEnabled()]
2021-07-14T08:14:40,954+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [HIKARICP] for [org.killbill.dao.poolingType] on [org.killbill.commons.jdbi.guice.DaoConfig#getConnectionPoolingType()]
2021-07-14T08:14:40,969+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.billing.main-ro.dao.readOnly] on [org.killbill.billing.server.modules.MainRoDaoConfig#isReadOnly()]
2021-07-14T08:14:40,969+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.billing.main-ro.dao.enabled] on [org.killbill.billing.server.modules.MainRoDaoConfig#isEnabled()]
2021-07-14T08:14:40,969+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [killbill] for [org.killbill.billing.main-ro.dao.user] on [org.killbill.billing.server.modules.MainRoDaoConfig#getUsername()]
2021-07-14T08:14:40,969+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [100] for [org.killbill.billing.main-ro.dao.maxActive] on [org.killbill.billing.server.modules.MainRoDaoConfig#getMaxActive()]
2021-07-14T08:14:40,985+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [killbill] for [org.killbill.billing.main-ro.dao.password] on [org.killbill.billing.server.modules.MainRoDaoConfig#getPassword()]
2021-07-14T08:14:40,985+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10s] for [org.killbill.billing.main-ro.dao.connectionTimeout] on [org.killbill.billing.server.modules.MainRoDaoConfig#getConnectionTimeout()]
2021-07-14T08:14:40,985+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [2048] for [org.killbill.billing.main-ro.dao.prepStmtCacheSqlLimit] on [org.killbill.billing.server.modules.MainRoDaoConfig#getPreparedStatementsCacheSqlLimit()]
2021-07-14T08:14:40,985+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.billing.main-ro.dao.useServerPrepStmts] on [org.killbill.billing.server.modules.MainRoDaoConfig#isServerSidePreparedStatementsEnabled()]
2021-07-14T08:14:41,000+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [DEBUG] for [org.killbill.billing.main-ro.dao.logLevel] on [org.killbill.billing.server.modules.MainRoDaoConfig#getLogLevel()]
2021-07-14T08:14:41,000+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [jdbc:h2:file:/var/tmp/killbill;MODE=MYSQL;DB_CLOSE_DELAY=-1;DB_CLOSE_ON_EXIT=FALSE;ACCESS_MODE_DATA=r] for [org.killbill.billing.main-ro.dao.url] on [org.killbill.billing.server.modules.MainRoDaoConfig#getJdbcUrl()]
2021-07-14T08:14:41,000+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.billing.main-ro.dao.minIdle] on [org.killbill.billing.server.modules.MainRoDaoConfig#getMinIdle()]
2021-07-14T08:14:41,000+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60m] for [org.killbill.billing.main-ro.dao.idleMaxAge] on [org.killbill.billing.server.modules.MainRoDaoConfig#getIdleMaxAge()]
2021-07-14T08:14:41,000+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [TRANSACTION_READ_COMMITTED] for [org.killbill.billing.main-ro.dao.transactionIsolationLevel] on [org.killbill.billing.server.modules.MainRoDaoConfig#getTransactionIsolationLevel()]
2021-07-14T08:14:41,000+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [500] for [org.killbill.billing.main-ro.dao.prepStmtCacheSize] on [org.killbill.billing.server.modules.MainRoDaoConfig#getPreparedStatementsCacheSize()]
2021-07-14T08:14:41,000+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.billing.main-ro.dao.dataSourceClassName] on [org.killbill.billing.server.modules.MainRoDaoConfig#getDataSourceClassName()]
2021-07-14T08:14:41,000+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [0m] for [org.killbill.billing.main-ro.dao.maxConnectionAge] on [org.killbill.billing.server.modules.MainRoDaoConfig#getMaxConnectionAge()]
2021-07-14T08:14:41,000+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5m] for [org.killbill.billing.main-ro.dao.idleConnectionTestPeriod] on [org.killbill.billing.server.modules.MainRoDaoConfig#getIdleConnectionTestPeriod()]
2021-07-14T08:14:41,016+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.billing.main-ro.dao.driverClassName] on [org.killbill.billing.server.modules.MainRoDaoConfig#getDriverClassName()]
2021-07-14T08:14:41,016+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.billing.main-ro.dao.leakDetectionThreshold] on [org.killbill.billing.server.modules.MainRoDaoConfig#getLeakDetectionThreshold()]
2021-07-14T08:14:41,016+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5.1] for [org.killbill.billing.main-ro.dao.mysqlServerVersion] on [org.killbill.billing.server.modules.MainRoDaoConfig#getMySQLServerVersion()]
2021-07-14T08:14:41,032+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.billing.main-ro.dao.initializationFailFast] on [org.killbill.billing.server.modules.MainRoDaoConfig#isInitializationFailFast()]
2021-07-14T08:14:41,032+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.billing.main-ro.dao.cachePrepStmts] on [org.killbill.billing.server.modules.MainRoDaoConfig#isPreparedStatementsCacheEnabled()]
2021-07-14T08:14:41,032+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [HIKARICP] for [org.killbill.billing.main-ro.dao.poolingType] on [org.killbill.billing.server.modules.MainRoDaoConfig#getConnectionPoolingType()]
2021-07-14T08:14:41,032+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [50ms] for [org.killbill.dao.healthCheckExpected99thPercentile] on [org.killbill.commons.jdbi.guice.DaoConfig#getHealthCheckExpected99thPercentile()]
2021-07-14T08:14:41,032+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.dao.connectionInitSql] on [org.killbill.commons.jdbi.guice.DaoConfig#getConnectionInitSql()]
2021-07-14T08:14:41,032+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10s] for [org.killbill.dao.healthCheckConnectionTimeout] on [org.killbill.commons.jdbi.guice.DaoConfig#getHealthCheckConnectionTimeout()]
2021-07-14T08:14:46,453+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [bus_events] for [org.killbill.persistent.bus.${instanceName}.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
2021-07-14T08:14:46,453+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [bus_events_history] for [org.killbill.persistent.bus.${instanceName}.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
2021-07-14T08:14:46,453+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getPollingSleepTimeMs()]
2021-07-14T08:14:46,453+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [30] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#geMaxDispatchThreads()]
2021-07-14T08:14:46,453+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [100] for [org.killbill.persistent.bus.${instanceName}.inflight.max] on [org.killbill.bus.api.PersistentBusConfig#getMaxInFlightEntries()]
2021-07-14T08:14:46,453+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
2021-07-14T08:14:46,453+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.persistent.bus.${instanceName}.lifecycle.dispatch.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#geNbLifecycleDispatchThreads()]
2021-07-14T08:14:46,469+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10] for [org.killbill.persistent.bus.${instanceName}.maxReDispatchCount] on [org.killbill.bus.api.PersistentBusConfig#getMaxReDispatchCount()]
2021-07-14T08:14:46,469+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.persistent.bus.${instanceName}.inflight.min] on [org.killbill.bus.api.PersistentBusConfig#getMinInFlightEntries()]
2021-07-14T08:14:46,469+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
2021-07-14T08:14:46,469+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [2] for [org.killbill.persistent.bus.${instanceName}.lifecycle.complete.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#geNbLifecycleCompleteThreads()]
2021-07-14T08:14:46,469+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [30000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getEventQueueCapacity()]
2021-07-14T08:14:46,485+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [STICKY_EVENTS] for [org.killbill.persistent.bus.${instanceName}.queue.mode] on [org.killbill.bus.api.PersistentBusConfig#getPersistentQueueMode()]
2021-07-14T08:14:46,485+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
2021-07-14T08:14:46,485+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.inMemory] on [org.killbill.bus.api.PersistentBusConfig#isInMemory()]
2021-07-14T08:14:46,485+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [3m] for [org.killbill.persistent.bus.${instanceName}.reapSchedule] on [org.killbill.bus.api.PersistentBusConfig#getReapSchedule()]
2021-07-14T08:14:46,500+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10m] for [org.killbill.persistent.bus.${instanceName}.reapThreshold] on [org.killbill.bus.api.PersistentBusConfig#getReapThreshold()]
2021-07-14T08:14:46,500+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
2021-07-14T08:14:46,516+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [bus_ext_events] for [org.killbill.persistent.bus.external.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
2021-07-14T08:14:46,516+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [bus_ext_events_history] for [org.killbill.persistent.bus.external.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
2021-07-14T08:14:46,516+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getPollingSleepTimeMs()]
2021-07-14T08:14:46,516+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [30] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#geMaxDispatchThreads()]
2021-07-14T08:14:46,516+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [100] for [org.killbill.persistent.bus.${instanceName}.inflight.max] on [org.killbill.bus.api.PersistentBusConfig#getMaxInFlightEntries()]
2021-07-14T08:14:46,516+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
2021-07-14T08:14:46,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.persistent.bus.${instanceName}.lifecycle.dispatch.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#geNbLifecycleDispatchThreads()]
2021-07-14T08:14:46,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10] for [org.killbill.persistent.bus.${instanceName}.maxReDispatchCount] on [org.killbill.bus.api.PersistentBusConfig#getMaxReDispatchCount()]
2021-07-14T08:14:46,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.persistent.bus.${instanceName}.inflight.min] on [org.killbill.bus.api.PersistentBusConfig#getMinInFlightEntries()]
2021-07-14T08:14:46,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
2021-07-14T08:14:46,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [2] for [org.killbill.persistent.bus.${instanceName}.lifecycle.complete.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#geNbLifecycleCompleteThreads()]
2021-07-14T08:14:46,547+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [30000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getEventQueueCapacity()]
2021-07-14T08:14:46,547+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [STICKY_EVENTS] for [org.killbill.persistent.bus.${instanceName}.queue.mode] on [org.killbill.bus.api.PersistentBusConfig#getPersistentQueueMode()]
2021-07-14T08:14:46,547+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
2021-07-14T08:14:46,563+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.inMemory] on [org.killbill.bus.api.PersistentBusConfig#isInMemory()]
2021-07-14T08:14:46,563+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [3m] for [org.killbill.persistent.bus.${instanceName}.reapSchedule] on [org.killbill.bus.api.PersistentBusConfig#getReapSchedule()]
2021-07-14T08:14:46,563+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10m] for [org.killbill.persistent.bus.${instanceName}.reapThreshold] on [org.killbill.bus.api.PersistentBusConfig#getReapThreshold()]
2021-07-14T08:14:46,563+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
2021-07-14T08:14:46,578+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [notifications] for [org.killbill.notificationq.${instanceName}.tableName] on [org.killbill.notificationq.api.NotificationQueueConfig#getTableName()]
2021-07-14T08:14:46,578+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [notifications_history] for [org.killbill.notificationq.${instanceName}.historyTableName] on [org.killbill.notificationq.api.NotificationQueueConfig#getHistoryTableName()]
2021-07-14T08:14:46,578+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [3000] for [org.killbill.notificationq.${instanceName}.sleep] on [org.killbill.notificationq.api.NotificationQueueConfig#getPollingSleepTimeMs()]
2021-07-14T08:14:46,578+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10] for [org.killbill.notificationq.${instanceName}.notification.nbThreads] on [org.killbill.notificationq.api.NotificationQueueConfig#geMaxDispatchThreads()]
2021-07-14T08:14:46,578+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [-1] for [org.killbill.persistent.bus.${instanceName}.inflight.max] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxInFlightEntries()]
2021-07-14T08:14:46,594+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10] for [org.killbill.notificationq.${instanceName}.claimed] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxEntriesClaimed()]
2021-07-14T08:14:46,594+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.notificationq.${instanceName}.lifecycle.dispatch.nbThreads] on [org.killbill.notificationq.api.NotificationQueueConfig#geNbLifecycleDispatchThreads()]
2021-07-14T08:14:46,594+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10] for [org.killbill.notificationq.${instanceName}.maxReDispatchCount] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxReDispatchCount()]
2021-07-14T08:14:46,594+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [-1] for [org.killbill.persistent.bus.${instanceName}.inflight.min] on [org.killbill.notificationq.api.NotificationQueueConfig#getMinInFlightEntries()]
2021-07-14T08:14:46,594+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [3] for [org.killbill.notificationq.${instanceName}.max.failure.retry] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxFailureRetries()]
2021-07-14T08:14:46,594+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [2] for [org.killbill.notificationq.${instanceName}.lifecycle.complete.nbThreads] on [org.killbill.notificationq.api.NotificationQueueConfig#geNbLifecycleCompleteThreads()]
2021-07-14T08:14:46,594+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [100] for [org.killbill.notificationq.${instanceName}.queue.capacity] on [org.killbill.notificationq.api.NotificationQueueConfig#getEventQueueCapacity()]
2021-07-14T08:14:46,594+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [STICKY_POLLING] for [org.killbill.notificationq.${instanceName}.queue.mode] on [org.killbill.notificationq.api.NotificationQueueConfig#getPersistentQueueMode()]
2021-07-14T08:14:46,610+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.notificationq.${instanceName}.notification.off] on [org.killbill.notificationq.api.NotificationQueueConfig#isProcessingOff()]
2021-07-14T08:14:46,625+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.notificationq.${instanceName}.inMemory] on [org.killbill.notificationq.api.NotificationQueueConfig#isInMemory()]
2021-07-14T08:14:46,625+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [3m] for [org.killbill.notificationq.${instanceName}.reapSchedule] on [org.killbill.notificationq.api.NotificationQueueConfig#getReapSchedule()]
2021-07-14T08:14:46,625+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10m] for [org.killbill.notificationq.${instanceName}.reapThreshold] on [org.killbill.notificationq.api.NotificationQueueConfig#getReapThreshold()]
2021-07-14T08:14:46,625+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5m] for [org.killbill.notificationq.${instanceName}.claim.time] on [org.killbill.notificationq.api.NotificationQueueConfig#getClaimedTime()]
2021-07-14T08:14:46,641+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.billing.osgi.dao.readOnly] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#isReadOnly()]
2021-07-14T08:14:46,641+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [killbill] for [org.killbill.billing.osgi.dao.user] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getUsername()]
2021-07-14T08:14:46,641+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [100] for [org.killbill.billing.osgi.dao.maxActive] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMaxActive()]
2021-07-14T08:14:46,641+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [********] for [org.killbill.billing.osgi.dao.password] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getPassword()]
2021-07-14T08:14:46,641+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10s] for [org.killbill.billing.osgi.dao.connectionTimeout] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getConnectionTimeout()]
2021-07-14T08:14:46,641+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [2048] for [org.killbill.billing.osgi.dao.prepStmtCacheSqlLimit] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getPreparedStatementsCacheSqlLimit()]
2021-07-14T08:14:46,657+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.billing.osgi.dao.useServerPrepStmts] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#isServerSidePreparedStatementsEnabled()]
2021-07-14T08:14:46,657+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [DEBUG] for [org.killbill.billing.osgi.dao.logLevel] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getLogLevel()]
2021-07-14T08:14:46,657+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [jdbc:mysql://127.0.0.1:3306/killbill] for [org.killbill.billing.osgi.dao.url] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getJdbcUrl()]
2021-07-14T08:14:46,657+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.billing.osgi.dao.minIdle] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMinIdle()]
2021-07-14T08:14:46,657+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60m] for [org.killbill.billing.osgi.dao.idleMaxAge] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getIdleMaxAge()]
2021-07-14T08:14:46,672+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [TRANSACTION_READ_COMMITTED] for [org.killbill.billing.osgi.dao.transactionIsolationLevel] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getTransactionIsolationLevel()]
2021-07-14T08:14:46,672+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [500] for [org.killbill.billing.osgi.dao.prepStmtCacheSize] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getPreparedStatementsCacheSize()]
2021-07-14T08:14:46,672+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.billing.osgi.dao.dataSourceClassName] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getDataSourceClassName()]
2021-07-14T08:14:46,672+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [0m] for [org.killbill.billing.osgi.dao.maxConnectionAge] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMaxConnectionAge()]
2021-07-14T08:14:46,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5m] for [org.killbill.billing.osgi.dao.idleConnectionTestPeriod] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getIdleConnectionTestPeriod()]
2021-07-14T08:14:46,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.billing.osgi.dao.driverClassName] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getDriverClassName()]
2021-07-14T08:14:46,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.billing.osgi.dao.leakDetectionThreshold] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getLeakDetectionThreshold()]
2021-07-14T08:14:46,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5.1] for [org.killbill.billing.osgi.dao.mysqlServerVersion] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMySQLServerVersion()]
2021-07-14T08:14:46,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.billing.osgi.dao.initializationFailFast] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#isInitializationFailFast()]
2021-07-14T08:14:46,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.billing.osgi.dao.cachePrepStmts] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#isPreparedStatementsCacheEnabled()]
2021-07-14T08:14:46,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [HIKARICP] for [org.killbill.billing.osgi.dao.poolingType] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getConnectionPoolingType()]
2021-07-14T08:14:46,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [50ms] for [org.killbill.dao.healthCheckExpected99thPercentile] on [org.killbill.commons.jdbi.guice.DaoConfig#getHealthCheckExpected99thPercentile()]
2021-07-14T08:14:46,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.dao.connectionInitSql] on [org.killbill.commons.jdbi.guice.DaoConfig#getConnectionInitSql()]
2021-07-14T08:14:46,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10s] for [org.killbill.dao.healthCheckConnectionTimeout] on [org.killbill.commons.jdbi.guice.DaoConfig#getHealthCheckConnectionTimeout()]
2021-07-14T08:14:46,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [D:/KillBill Files/KPM Bundles] for [org.killbill.osgi.bundle.install.dir] on [org.killbill.billing.osgi.config.OSGIConfig#getRootInstallationDir()]
2021-07-14T08:14:46,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [com.sun.xml.internal.ws,com.sun.xml.internal.ws.addressing,com.sun.xml.internal.ws.addressing.model,com.sun.xml.internal.ws.addressing.policy,com.sun.xml.internal.ws.addressing.v200408,com.sun.xml.internal.ws.api,com.sun.xml.internal.ws.api.addressing,com.sun.xml.internal.ws.api.client,com.sun.xml.internal.ws.api.config.management,com.sun.xml.internal.ws.api.config.management.policy,com.sun.xml.internal.ws.api.fastinfoset,com.sun.xml.internal.ws.api.ha,com.sun.xml.internal.ws.api.handler,com.sun.xml.internal.ws.api.message,com.sun.xml.internal.ws.api.message.stream,com.sun.xml.internal.ws.api.model,com.sun.xml.internal.ws.api.model.soap,com.sun.xml.internal.ws.api.model.wsdl,com.sun.xml.internal.ws.api.pipe,com.sun.xml.internal.ws.api.pipe.helper,com.sun.xml.internal.ws.api.policy,com.sun.xml.internal.ws.api.server,com.sun.xml.internal.ws.api.streaming,com.sun.xml.internal.ws.api.wsdl.parser,com.sun.xml.internal.ws.api.wsdl.writer,com.sun.xml.internal.ws.binding,com.sun.xml.internal.ws.client,com.sun.xml.internal.ws.client.dispatch,com.sun.xml.internal.ws.client.sei,com.sun.xml.internal.ws.config.management.policy,com.sun.xml.internal.ws.developer,com.sun.xml.internal.ws.encoding,com.sun.xml.internal.ws.encoding.fastinfoset,com.sun.xml.internal.ws.encoding.policy,com.sun.xml.internal.ws.encoding.soap,com.sun.xml.internal.ws.encoding.soap.streaming,com.sun.xml.internal.ws.encoding.xml,com.sun.xml.internal.ws.fault,com.sun.xml.internal.ws.handler,com.sun.xml.internal.ws.message,com.sun.xml.internal.ws.message.jaxb,com.sun.xml.internal.ws.message.saaj,com.sun.xml.internal.ws.message.source,com.sun.xml.internal.ws.message.stream,com.sun.xml.internal.ws.model,com.sun.xml.internal.ws.model.soap,com.sun.xml.internal.ws.model.wsdl,com.sun.xml.internal.ws.org.objectweb.asm,com.sun.xml.internal.ws.policy,com.sun.xml.internal.ws.policy.jaxws,com.sun.xml.internal.ws.policy.jaxws.spi,com.sun.xml.internal.ws.policy.privateutil,com.sun.xml.internal.ws.policy.sourcemodel,com.sun.xml.internal.ws.policy.sourcemodel.attach,com.sun.xml.internal.ws.policy.sourcemodel.wspolicy,com.sun.xml.internal.ws.policy.spi,com.sun.xml.internal.ws.policy.subject,com.sun.xml.internal.ws.protocol.soap,com.sun.xml.internal.ws.protocol.xml,com.sun.xml.internal.ws.resources,com.sun.xml.internal.ws.server,com.sun.xml.internal.ws.server.provider,com.sun.xml.internal.ws.server.sei,com.sun.xml.internal.ws.spi,com.sun.xml.internal.ws.streaming,com.sun.xml.internal.ws.transport,com.sun.xml.internal.ws.transport.http,com.sun.xml.internal.ws.transport.http.client,com.sun.xml.internal.ws.transport.http.server,com.sun.xml.internal.ws.util,com.sun.xml.internal.ws.util.exception,com.sun.xml.internal.ws.util.localization,com.sun.xml.internal.ws.util.pipe,com.sun.xml.internal.ws.util.xml,com.sun.xml.internal.ws.wsdl,com.sun.xml.internal.ws.wsdl.parser,com.sun.xml.internal.ws.wsdl.writer,com.sun.xml.internal.ws.wsdl.writer.document,com.sun.xml.internal.ws.wsdl.writer.document.http,com.sun.xml.internal.ws.wsdl.writer.document.soap,com.sun.xml.internal.ws.wsdl.writer.document.soap12,com.sun.xml.internal.ws.wsdl.writer.document.xsd,javax.annotation,javax.management,javax.naming,javax.naming.ldap,javax.net,javax.net.ssl,javax.crypto,javax.crypto.spec,javax.sql,javax.sql.rowset,javax.sql.rowset.serial,javax.transaction,javax.transaction.xa,javax.xml,javax.xml.bind,javax.xml.validation,javax.xml.namespace,javax.xml.parsers,javax.xml.validation,javax.xml.stream,javax.xml.stream.events,javax.xml.stream.util,javax.xml.transform,javax.xml.transform.dom,javax.xml.transform.sax,javax.xml.transform.stax,javax.xml.transform.stream,javax.xml.xpath,javax.jws.soap,javax.security,javax.security.cert,com.sun.org,com.sun.org.apache,com.sun.org.apache.xml,com.sun.org.apache.xml.internal,com.sun.org.apache.xml.internal.utils,com.sun.org.apache.xpath,com.sun.org.apache.xpath.internal,com.sun.org.apache.xpath.internal.jaxp,com.sun.org.apache.xpath.internal.objects,org.w3c.dom,org.w3c.dom.bootstrap,org.w3c.dom.events,org.w3c.dom.ls,org.w3c.dom.css,org.w3c.dom.html,org.w3c.dom.ranges,org.w3c.dom.stylesheets,org.w3c.dom.traversal,org.w3c.dom.views,org.xml.sax,org.xml.sax.ext,org.xml.sax.helpers,sun.misc,sun.misc.unsafe,sun.security,sun.security.util,javax.servlet;version=3.1,javax.servlet.http;version=3.1] for [org.killbill.osgi.system.bundle.export.packages.java] on [org.killbill.billing.osgi.config.OSGIConfig#getSystemBundleExportPackagesJava()]
2021-07-14T08:14:46,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [] for [org.killbill.osgi.system.bundle.export.packages.extra] on [org.killbill.billing.osgi.config.OSGIConfig#getSystemBundleExportPackagesExtra()]
2021-07-14T08:14:46,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [killbill.properties] for [org.killbill.osgi.bundle.property.name] on [org.killbill.billing.osgi.config.OSGIConfig#getOSGIKillbillPropertyName()]
2021-07-14T08:14:46,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [D:/var/tmp/felix] for [org.killbill.osgi.root.dir] on [org.killbill.billing.osgi.config.OSGIConfig#getOSGIBundleRootDir()]
2021-07-14T08:14:46,735+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [osgi-cache] for [org.killbill.osgi.bundle.cache.name] on [org.killbill.billing.osgi.config.OSGIConfig#getOSGIBundleCacheName()]
2021-07-14T08:14:46,735+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [org.killbill.billing.account.api,org.killbill.billing.analytics.api.sanity,org.killbill.billing.analytics.api.user,org.killbill.billing.beatrix.bus.api,org.killbill.billing.catalog.api,org.killbill.billing.catalog.api.rules,org.killbill.billing.invoice.plugin.api,org.killbill.billing.invoice.api,org.killbill.billing.invoice.api.formatters,org.killbill.billing.entitlement.api,org.killbill.billing,org.killbill.clock,org.killbill.billing.notification.api,org.killbill.billing.notification.plugin.api,org.killbill.billing.notification.plugin,org.killbill.billing.osgi.api,org.killbill.billing.osgi.api.config,org.killbill.billing.overdue,org.killbill.billing.overdue.api,org.killbill.billing.payment.api,org.killbill.billing.payment.plugin.api,org.killbill.billing.control.plugin.api,org.killbill.billing.tenant.api,org.killbill.billing.usage.api,org.killbill.billing.util.api,org.killbill.billing.util.nodes,org.killbill.billing.util.audit,org.killbill.billing.util.callcontext,org.killbill.billing.util.customfield,org.killbill.billing.util.email,org.killbill.billing.util.entity,org.killbill.billing.util.tag,org.killbill.billing.util.template,org.killbill.billing.util.template.translation,org.killbill.billing.currency.plugin.api,org.killbill.billing.catalog.plugin.api,org.killbill.billing.entitlement.plugin.api,org.killbill.billing.currency.api,org.killbill.billing.usage.plugin.api,org.killbill.billing.security,org.killbill.billing.security.api,org.killbill.billing.osgi.libs.killbill,org.joda.time;org.joda.time.format;version=2.9,org.apache.shiro;org.apache.shiro.subject;org.apache.shiro.util;version=1.3,org.slf4j;version=1.7.2,org.slf4j.event;version=1.7.2,org.slf4j.helpers;version=1.7.2,org.slf4j.spi;version=1.7.2,org.osgi.service.log;version=1.3,org.osgi.service.http;version=1.2.0,org.osgi.service.deploymentadmin;version=1.1.0,org.osgi.service.event;version=1.2.0] for [org.killbill.osgi.system.bundle.export.packages.api] on [org.killbill.billing.osgi.config.OSGIConfig#getSystemBundleExportPackagesApi()]
2021-07-14T08:14:46,766+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5s] for [org.killbill.billing.util.broadcast.rate] on [org.killbill.billing.util.config.definition.BroadcastConfig#getBroadcastServiceRunningRate()]
2021-07-14T08:14:46,766+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [ehcache.xml] for [org.killbill.cache.config.location] on [org.killbill.billing.util.config.definition.EhCacheConfig#getCacheConfigLocation()]
2021-07-14T08:14:46,766+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.cache.config.redis.password] on [org.killbill.billing.util.config.definition.RedisCacheConfig#getPassword()]
2021-07-14T08:14:46,766+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.cache.config.redis] on [org.killbill.billing.util.config.definition.RedisCacheConfig#isRedisCachingEnabled()]
2021-07-14T08:14:46,782+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.cache.config.redis.connectionMinimumIdleSize] on [org.killbill.billing.util.config.definition.RedisCacheConfig#getConnectionMinimumIdleSize()]
2021-07-14T08:14:46,782+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [redis://127.0.0.1:6379] for [org.killbill.cache.config.redis.url] on [org.killbill.billing.util.config.definition.RedisCacheConfig#getUrl()]
2021-07-14T08:14:46,797+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.billing.server.event.bulk.subscription.aggregate] on [org.killbill.billing.util.config.definition.EventConfig#isAggregateBulkSubscriptionEvents()]
2021-07-14T08:14:46,797+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [] for [org.killbill.billing.server.event.post.type.skip] on [org.killbill.billing.util.config.definition.EventConfig#getSkipPostBusEventTypeList()]
2021-07-14T08:14:46,797+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [] for [org.killbill.billing.server.event.dispatch.type.skip] on [org.killbill.billing.util.config.definition.EventConfig#getSkipDispatchBusEventTypeList()]
2021-07-14T08:14:46,813+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [SpyCarAdvanced.xml] for [org.killbill.catalog.uri] on [org.killbill.billing.util.config.definition.CatalogConfig#getCatalogURI()]
2021-07-14T08:14:46,813+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.catalog.loader.threads.pool.nb] on [org.killbill.billing.util.config.definition.CatalogConfig#getCatalogThreadNb()]
2021-07-14T08:14:46,813+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [killbill-currency-plugin] for [org.killbill.currency.provider.default] on [org.killbill.billing.util.config.definition.CurrencyConfig#getDefaultCurrencyProvider()]
2021-07-14T08:14:46,813+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [AGGREGATE] for [org.killbill.invoice.item.result.behavior.mode] on [org.killbill.billing.util.config.definition.InvoiceConfig#getItemResultBehaviorMode()]
2021-07-14T08:14:46,828+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [36] for [org.killbill.invoice.maxNumberOfMonthsInFuture] on [org.killbill.billing.util.config.definition.InvoiceConfig#getNumberOfMonthsInFuture()]
2021-07-14T08:14:46,828+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.invoice.disable.usage.zero.amount] on [org.killbill.billing.util.config.definition.InvoiceConfig#isUsageZeroAmountDisabled()]
2021-07-14T08:14:46,828+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.invoice.sanitySafetyBoundEnabled] on [org.killbill.billing.util.config.definition.InvoiceConfig#isSanitySafetyBoundEnabled()]
2021-07-14T08:14:46,828+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.invoice.enabled] on [org.killbill.billing.util.config.definition.InvoiceConfig#isInvoicingSystemEnabled()]
2021-07-14T08:14:46,844+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [50] for [org.killbill.invoice.globalLock.retries] on [org.killbill.billing.util.config.definition.InvoiceConfig#getMaxGlobalLockRetries()]
2021-07-14T08:14:46,844+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [2] for [org.killbill.invoice.readMaxRawUsagePreviousPeriod] on [org.killbill.billing.util.config.definition.InvoiceConfig#getMaxRawUsagePreviousPeriod()]
2021-07-14T08:14:46,844+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [23:59:59.999] for [org.killbill.invoice.parent.commit.local.utc.time] on [org.killbill.billing.util.config.definition.InvoiceConfig#getParentAutoCommitUtcTime()]
2021-07-14T08:14:46,844+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [0s] for [org.killbill.invoice.rescheduleIntervalOnLock] on [org.killbill.billing.util.config.definition.InvoiceConfig#getRescheduleIntervalOnLock()]
2021-07-14T08:14:46,844+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.invoice.emailNotificationsEnabled] on [org.killbill.billing.util.config.definition.InvoiceConfig#isEmailNotificationsEnabled()]
2021-07-14T08:14:46,844+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [] for [org.killbill.invoice.plugin] on [org.killbill.billing.util.config.definition.InvoiceConfig#getInvoicePluginNames()]
2021-07-14T08:14:47,016+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [P200Y] for [org.killbill.invoice.maxInvoiceLimit] on [org.killbill.billing.util.config.definition.InvoiceConfig#getMaxInvoiceLimit()]
2021-07-14T08:14:47,016+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [0s] for [org.killbill.invoice.dryRunNotificationSchedule] on [org.killbill.billing.util.config.definition.InvoiceConfig#getDryRunNotificationSchedule()]
2021-07-14T08:14:47,032+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [15] for [org.killbill.invoice.maxDailyNumberOfItemsSafetyBound] on [org.killbill.billing.util.config.definition.InvoiceConfig#getMaxDailyNumberOfItemsSafetyBound()]
2021-07-14T08:14:47,032+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.invoice.parkAccountsWithUnknownUsage] on [org.killbill.billing.util.config.definition.InvoiceConfig#shouldParkAccountsWithUnknownUsage()]
2021-07-14T08:14:47,032+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [org.killbill.billing.invoice.template.formatters.DefaultInvoiceFormatterFactory] for [org.killbill.template.invoiceFormatterFactoryClass] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceFormatterFactoryClass()]
2021-07-14T08:14:47,032+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [org/killbill/billing/util/template/translation/InvoiceTranslation] for [org.killbill.template.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceTemplateBundlePath()]
2021-07-14T08:14:47,047+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [org/killbill/billing/util/email/templates/HtmlInvoiceTemplate.mustache] for [org.killbill.manualPayTemplate.name] on [org.killbill.billing.util.template.translation.TranslatorConfig#getManualPayTemplateName()]
2021-07-14T08:14:47,047+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [org/killbill/billing/util/template/translation/CatalogTranslation] for [org.killbill.catalog.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getCatalogBundlePath()]
2021-07-14T08:14:47,047+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [en_US] for [org.killbill.default.locale] on [org.killbill.billing.util.template.translation.TranslatorConfig#getDefaultLocale()]
2021-07-14T08:14:47,047+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [org/killbill/billing/util/email/templates/HtmlInvoiceTemplate.mustache] for [org.killbill.template.name] on [org.killbill.billing.util.template.translation.TranslatorConfig#getTemplateName()]
2021-07-14T08:14:47,063+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [NoOverdueConfig.xml] for [org.killbill.overdue.uri] on [org.killbill.billing.overdue.OverdueProperties#getConfigURI()]
2021-07-14T08:14:47,172+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [classpath:shiro.ini] for [org.killbill.security.shiroResourcePath] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroResourcePath()]
2021-07-14T08:14:47,172+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [simple] for [org.killbill.security.ldap.authenticationMechanism] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPAuthenticationMechanism()]
2021-07-14T08:14:47,172+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [200000] for [org.killbill.security.shiroNbHashIterations] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroNbHashIterations()]
2021-07-14T08:14:47,172+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.searchBase] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPSearchBase()]
2021-07-14T08:14:47,172+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [memberOf=uid={0}] for [org.killbill.security.ldap.groupSearchFilter] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPGroupSearchFilter()]
2021-07-14T08:14:47,172+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.userDnTemplate] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPUserDnTemplate()]
2021-07-14T08:14:47,172+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.dnSearchTemplate] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPDnSearchTemplate()]
2021-07-14T08:14:47,188+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.systemUsername] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPSystemUsername()]
2021-07-14T08:14:47,188+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.systemPassword] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPSystemPassword()]
2021-07-14T08:14:47,188+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [memberOf] for [org.killbill.security.ldap.groupNameId] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPGroupNameID()]
2021-07-14T08:14:47,188+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [admin = *:*
finance = invoice:*, payment:*
support = entitlement:*, invoice:item_adjust] for [org.killbill.security.okta.permissionsByGroup] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroOktaPermissionsByGroup()]
2021-07-14T08:14:47,188+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.security.ldap.disableSSLCheck] on [org.killbill.billing.util.config.definition.SecurityConfig#disableShiroLDAPSSLCheck()]
2021-07-14T08:14:47,203+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.security.ldap.followReferrals] on [org.killbill.billing.util.config.definition.SecurityConfig#followShiroLDAPReferrals()]
2021-07-14T08:14:47,203+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [admin = *:*
finance = invoice:*, payment:*
support = entitlement:*, invoice:item_adjust] for [org.killbill.security.ldap.permissionsByGroup] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPPermissionsByGroup()]
2021-07-14T08:14:47,203+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.okta.apiToken] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroOktaAPIToken()]
2021-07-14T08:14:47,203+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [ldap://127.0.0.1:389] for [org.killbill.security.ldap.url] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPUrl()]
2021-07-14T08:14:47,219+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.okta.url] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroOktaUrl()]
2021-07-14T08:14:47,516+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.cache.config.redis.password] on [org.killbill.billing.util.config.definition.RedisCacheConfig#getPassword()]
2021-07-14T08:14:47,516+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.cache.config.redis] on [org.killbill.billing.util.config.definition.RedisCacheConfig#isRedisCachingEnabled()]
2021-07-14T08:14:47,516+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1] for [org.killbill.cache.config.redis.connectionMinimumIdleSize] on [org.killbill.billing.util.config.definition.RedisCacheConfig#getConnectionMinimumIdleSize()]
2021-07-14T08:14:47,516+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [redis://127.0.0.1:6379] for [org.killbill.cache.config.redis.url] on [org.killbill.billing.util.config.definition.RedisCacheConfig#getUrl()]
2021-07-14T08:14:47,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [classpath:shiro.ini] for [org.killbill.security.shiroResourcePath] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroResourcePath()]
2021-07-14T08:14:47,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [simple] for [org.killbill.security.ldap.authenticationMechanism] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPAuthenticationMechanism()]
2021-07-14T08:14:47,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [200000] for [org.killbill.security.shiroNbHashIterations] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroNbHashIterations()]
2021-07-14T08:14:47,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.searchBase] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPSearchBase()]
2021-07-14T08:14:47,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [memberOf=uid={0}] for [org.killbill.security.ldap.groupSearchFilter] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPGroupSearchFilter()]
2021-07-14T08:14:47,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.userDnTemplate] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPUserDnTemplate()]
2021-07-14T08:14:47,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.dnSearchTemplate] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPDnSearchTemplate()]
2021-07-14T08:14:47,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.systemUsername] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPSystemUsername()]
2021-07-14T08:14:47,532+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.systemPassword] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPSystemPassword()]
2021-07-14T08:14:47,547+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [memberOf] for [org.killbill.security.ldap.groupNameId] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPGroupNameID()]
2021-07-14T08:14:47,547+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [admin = *:*
finance = invoice:*, payment:*
support = entitlement:*, invoice:item_adjust] for [org.killbill.security.okta.permissionsByGroup] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroOktaPermissionsByGroup()]
2021-07-14T08:14:47,547+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.security.ldap.disableSSLCheck] on [org.killbill.billing.util.config.definition.SecurityConfig#disableShiroLDAPSSLCheck()]
2021-07-14T08:14:47,563+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.security.ldap.followReferrals] on [org.killbill.billing.util.config.definition.SecurityConfig#followShiroLDAPReferrals()]
2021-07-14T08:14:47,563+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [admin = *:*
finance = invoice:*, payment:*
support = entitlement:*, invoice:item_adjust] for [org.killbill.security.ldap.permissionsByGroup] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPPermissionsByGroup()]
2021-07-14T08:14:47,563+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.okta.apiToken] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroOktaAPIToken()]
2021-07-14T08:14:47,563+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [ldap://127.0.0.1:389] for [org.killbill.security.ldap.url] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPUrl()]
2021-07-14T08:14:47,563+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.okta.url] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroOktaUrl()]
2021-07-14T08:14:47,563+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1h] for [org.killbill.rbac.globalSessionTimeout] on [org.killbill.billing.util.config.definition.RbacConfig#getGlobalSessionTimeout()]
2021-07-14T08:14:47,610+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [50] for [org.killbill.payment.globalLock.retries] on [org.killbill.billing.util.config.definition.PaymentConfig#getMaxGlobalLockRetries()]
2021-07-14T08:14:47,610+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [] for [org.killbill.payment.invoice.plugin] on [org.killbill.billing.util.config.definition.PaymentConfig#getPaymentControlPluginNames()]
2021-07-14T08:14:47,625+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [30s] for [org.killbill.payment.plugin.timeout] on [org.killbill.billing.util.config.definition.PaymentConfig#getPaymentPluginTimeout()]
2021-07-14T08:14:47,625+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10] for [org.killbill.payment.plugin.threads.nb] on [org.killbill.billing.util.config.definition.PaymentConfig#getPaymentPluginThreadNb()]
2021-07-14T08:14:47,625+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1h] for [org.killbill.payment.janitor.rate] on [org.killbill.billing.util.config.definition.PaymentConfig#getJanitorRunningRate()]
2021-07-14T08:14:47,625+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [8,8,8] for [org.killbill.payment.retry.days] on [org.killbill.billing.util.config.definition.PaymentConfig#getPaymentFailureRetryDays()]
2021-07-14T08:14:47,625+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [8] for [org.killbill.payment.failure.retry.max.attempts] on [org.killbill.billing.util.config.definition.PaymentConfig#getPluginFailureRetryMaxAttempts()]
2021-07-14T08:14:47,625+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [1h, 1d] for [org.killbill.payment.janitor.pending.retries] on [org.killbill.billing.util.config.definition.PaymentConfig#getPendingTransactionsRetries()]
2021-07-14T08:14:47,641+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [2] for [org.killbill.payment.failure.retry.multiplier] on [org.killbill.billing.util.config.definition.PaymentConfig#getPluginFailureRetryMultiplier()]
2021-07-14T08:14:47,641+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [__external_payment__] for [org.killbill.payment.provider.default] on [org.killbill.billing.util.config.definition.PaymentConfig#getDefaultPaymentProvider()]
2021-07-14T08:14:47,641+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5m,1h,1d,1d,1d,1d,1d] for [org.killbill.payment.janitor.unknown.retries] on [org.killbill.billing.util.config.definition.PaymentConfig#getUnknownTransactionsRetries()]
2021-07-14T08:14:47,641+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [12h] for [org.killbill.payment.janitor.attempts.delay] on [org.killbill.billing.util.config.definition.PaymentConfig#getIncompleteAttemptsTimeSpanDelay()]
2021-07-14T08:14:47,657+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [300] for [org.killbill.payment.failure.retry.start.sec] on [org.killbill.billing.util.config.definition.PaymentConfig#getPluginFailureInitialRetryInSec()]
2021-07-14T08:14:47,657+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [classpath:shiro.ini] for [org.killbill.security.shiroResourcePath] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroResourcePath()]
2021-07-14T08:14:47,657+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [simple] for [org.killbill.security.ldap.authenticationMechanism] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPAuthenticationMechanism()]
2021-07-14T08:14:47,672+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [200000] for [org.killbill.security.shiroNbHashIterations] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroNbHashIterations()]
2021-07-14T08:14:47,672+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.searchBase] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPSearchBase()]
2021-07-14T08:14:47,672+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [memberOf=uid={0}] for [org.killbill.security.ldap.groupSearchFilter] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPGroupSearchFilter()]
2021-07-14T08:14:47,672+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.userDnTemplate] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPUserDnTemplate()]
2021-07-14T08:14:47,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.dnSearchTemplate] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPDnSearchTemplate()]
2021-07-14T08:14:47,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.systemUsername] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPSystemUsername()]
2021-07-14T08:14:47,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.ldap.systemPassword] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPSystemPassword()]
2021-07-14T08:14:47,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [memberOf] for [org.killbill.security.ldap.groupNameId] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPGroupNameID()]
2021-07-14T08:14:47,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [admin = *:*
finance = invoice:*, payment:*
support = entitlement:*, invoice:item_adjust] for [org.killbill.security.okta.permissionsByGroup] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroOktaPermissionsByGroup()]
2021-07-14T08:14:47,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.security.ldap.disableSSLCheck] on [org.killbill.billing.util.config.definition.SecurityConfig#disableShiroLDAPSSLCheck()]
2021-07-14T08:14:47,688+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.security.ldap.followReferrals] on [org.killbill.billing.util.config.definition.SecurityConfig#followShiroLDAPReferrals()]
2021-07-14T08:14:47,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [admin = *:*
finance = invoice:*, payment:*
support = entitlement:*, invoice:item_adjust] for [org.killbill.security.ldap.permissionsByGroup] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPPermissionsByGroup()]
2021-07-14T08:14:47,703+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.okta.apiToken] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroOktaAPIToken()]
2021-07-14T08:14:47,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [ldap://127.0.0.1:389] for [org.killbill.security.ldap.url] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroLDAPUrl()]
2021-07-14T08:14:47,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.okta.url] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroOktaUrl()]
2021-07-14T08:14:47,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5s] for [org.killbill.tenant.broadcast.rate] on [org.killbill.billing.util.config.definition.TenantConfig#getTenantBroadcastServiceRunningRate()]
2021-07-14T08:14:47,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.jaxrs.location.full.url] on [org.killbill.billing.util.config.definition.JaxrsConfig#isJaxrsLocationFullUrl()]
2021-07-14T08:14:47,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.jaxrs.location.useForwardHeaders] on [org.killbill.billing.util.config.definition.JaxrsConfig#isJaxrsLocationUseForwardHeaders()]
2021-07-14T08:14:47,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.jaxrs.location.host] on [org.killbill.billing.util.config.definition.JaxrsConfig#getJaxrsLocationHost()]
2021-07-14T08:14:47,719+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [10] for [org.killbill.jaxrs.threads.pool.nb] on [org.killbill.billing.util.config.definition.JaxrsConfig#getJaxrsThreadNb()]
2021-07-14T08:14:47,735+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [30s] for [org.killbill.jaxrs.timeout] on [org.killbill.billing.util.config.definition.JaxrsConfig#getJaxrsTimeout()]
2021-07-14T08:14:47,750+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [15m,30m,2h,12h,1d] for [org.killbill.billing.server.notifications.retries] on [org.killbill.billing.util.config.definition.NotificationConfig#getPushNotificationsRetries()]
2021-07-14T08:14:49,235+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', main - Starting...
2021-07-14T08:14:49,360+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', main - Start completed.
2021-07-14T08:14:50,047+0000 lvl='INFO', log='PersistentBusProvider', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Creating Persistent bus for bus_events
2021-07-14T08:14:50,157+0000 lvl='INFO', log='PersistentBusProvider', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Creating Persistent bus for bus_ext_events
2021-07-14T08:14:50,204+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', shiro - Starting...
2021-07-14T08:14:50,219+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', shiro - Start completed.
2021-07-14T08:14:51,594+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache account-immutable will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:51,594+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache account-immutable will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,000+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'account-immutable'
2021-07-14T08:14:52,000+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'account-immutable' created in EhcacheManager.
2021-07-14T08:14:52,047+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=account-immutable
2021-07-14T08:14:52,047+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=account-immutable
2021-07-14T08:14:52,063+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache account-bcd will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,063+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache account-bcd will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,063+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'account-bcd'
2021-07-14T08:14:52,063+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'account-bcd' created in EhcacheManager.
2021-07-14T08:14:52,063+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=account-bcd
2021-07-14T08:14:52,063+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=account-bcd
2021-07-14T08:14:52,079+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache record-id will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,079+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache record-id will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,094+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'record-id'
2021-07-14T08:14:52,094+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'record-id' created in EhcacheManager.
2021-07-14T08:14:52,094+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=record-id
2021-07-14T08:14:52,094+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=record-id
2021-07-14T08:14:52,094+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache account-record-id will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,094+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache account-record-id will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,094+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'account-record-id'
2021-07-14T08:14:52,094+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'account-record-id' created in EhcacheManager.
2021-07-14T08:14:52,110+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=account-record-id
2021-07-14T08:14:52,110+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=account-record-id
2021-07-14T08:14:52,110+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache tenant-record-id will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,110+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant-record-id will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,125+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-record-id'
2021-07-14T08:14:52,125+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-record-id' created in EhcacheManager.
2021-07-14T08:14:52,125+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-record-id
2021-07-14T08:14:52,125+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-record-id
2021-07-14T08:14:52,125+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache object-id will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,125+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache object-id will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,141+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'object-id'
2021-07-14T08:14:52,141+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'object-id' created in EhcacheManager.
2021-07-14T08:14:52,141+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=object-id
2021-07-14T08:14:52,141+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=object-id
2021-07-14T08:14:52,157+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache tenant-catalog will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,157+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant-catalog will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,157+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-catalog'
2021-07-14T08:14:52,157+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-catalog' created in EhcacheManager.
2021-07-14T08:14:52,157+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-catalog
2021-07-14T08:14:52,157+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-catalog
2021-07-14T08:14:52,157+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache tenant-config will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,157+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant-config will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,172+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-config'
2021-07-14T08:14:52,172+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-config' created in EhcacheManager.
2021-07-14T08:14:52,172+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-config
2021-07-14T08:14:52,172+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-config
2021-07-14T08:14:52,172+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache tenant-overdue-config will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,172+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant-overdue-config will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,188+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-overdue-config'
2021-07-14T08:14:52,188+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-overdue-config' created in EhcacheManager.
2021-07-14T08:14:52,188+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-overdue-config
2021-07-14T08:14:52,188+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-overdue-config
2021-07-14T08:14:52,204+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache tenant-kv will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,204+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant-kv will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,204+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-kv'
2021-07-14T08:14:52,204+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-kv' created in EhcacheManager.
2021-07-14T08:14:52,204+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-kv
2021-07-14T08:14:52,204+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-kv
2021-07-14T08:14:52,204+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache tenant will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,219+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,219+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant'
2021-07-14T08:14:52,219+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant' created in EhcacheManager.
2021-07-14T08:14:52,219+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant
2021-07-14T08:14:52,235+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant
2021-07-14T08:14:52,235+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache overridden-plan will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,235+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache overridden-plan will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,235+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'overridden-plan'
2021-07-14T08:14:52,250+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'overridden-plan' created in EhcacheManager.
2021-07-14T08:14:52,266+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=overridden-plan
2021-07-14T08:14:52,266+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=overridden-plan
2021-07-14T08:14:52,266+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache tenant-payment-state-machine-config will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,266+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant-payment-state-machine-config will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,266+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-payment-state-machine-config'
2021-07-14T08:14:52,266+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-payment-state-machine-config' created in EhcacheManager.
2021-07-14T08:14:52,282+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-payment-state-machine-config
2021-07-14T08:14:52,297+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=tenant-payment-state-machine-config
2021-07-14T08:14:52,297+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache account-id-from-bundle-id will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,297+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache account-id-from-bundle-id will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,297+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'account-id-from-bundle-id'
2021-07-14T08:14:52,297+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'account-id-from-bundle-id' created in EhcacheManager.
2021-07-14T08:14:52,297+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=account-id-from-bundle-id
2021-07-14T08:14:52,297+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=account-id-from-bundle-id
2021-07-14T08:14:52,313+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache bundle-id-from-subscription-id will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,313+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache bundle-id-from-subscription-id will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,329+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'bundle-id-from-subscription-id'
2021-07-14T08:14:52,329+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'bundle-id-from-subscription-id' created in EhcacheManager.
2021-07-14T08:14:52,329+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=bundle-id-from-subscription-id
2021-07-14T08:14:52,329+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=bundle-id-from-subscription-id
2021-07-14T08:14:52,329+0000 lvl='INFO', log='EhcacheShiroManagerProvider$EhcacheShiroManagerWrapper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache with name org.killbill.billing.util.security.shiro.realm.KillBillJdbcRealm.authorizationCache.1 does not yet exist.  Creating now.
2021-07-14T08:14:52,329+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache org.killbill.billing.util.security.shiro.realm.KillBillJdbcRealm.authorizationCache.1 will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:52,329+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache org.killbill.billing.util.security.shiro.realm.KillBillJdbcRealm.authorizationCache.1 will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:52,344+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'org.killbill.billing.util.security.shiro.realm.KillBillJdbcRealm.authorizationCache.1'
2021-07-14T08:14:52,344+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'org.killbill.billing.util.security.shiro.realm.KillBillJdbcRealm.authorizationCache.1' created in EhcacheManager.
2021-07-14T08:14:52,344+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=org.killbill.billing.util.security.shiro.realm.KillBillJdbcRealm.authorizationCache.1
2021-07-14T08:14:52,344+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=org.killbill.billing.util.security.shiro.realm.KillBillJdbcRealm.authorizationCache.1
2021-07-14T08:14:52,344+0000 lvl='INFO', log='EhcacheShiroManagerProvider$EhcacheShiroManagerWrapper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added EhcacheShiro named [org.killbill.billing.util.security.shiro.realm.KillBillJdbcRealm.authorizationCache.1]
2021-07-14T08:14:52,422+0000 lvl='INFO', log='BusOptimizerNoop', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Feature BusOptimizer is OFF
2021-07-14T08:14:52,438+0000 lvl='INFO', log='XMLLoader', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Initializing an object of class org.killbill.billing.catalog.StandaloneCatalog from xml file at: EmptyCatalog.xml
2021-07-14T08:14:52,719+0000 lvl='INFO', log='InvoiceOptimizerNoop', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Feature InvoiceOptimizer is OFF
2021-07-14T08:14:52,735+0000 lvl='INFO', log='DefaultPaymentProviderPluginRegistry', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering service='__EXTERNAL_PAYMENT__'
2021-07-14T08:14:52,735+0000 lvl='INFO', log='DefaultPaymentProviderPluginRegistry', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering service='__DEFAULT_PAYMENT_CONTROL__'
2021-07-14T08:14:52,735+0000 lvl='INFO', log='DefaultPaymentProviderPluginRegistry', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering service='__INVOICE_PAYMENT_CONTROL_PLUGIN__'
2021-07-14T08:14:52,735+0000 lvl='INFO', log='XMLLoader', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Initializing an object of class org.killbill.automaton.DefaultStateMachineConfig from xml file at: jar:file:/C:/Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-payment-0.22.24.jar!/org/killbill/billing/payment/retry/RetryStates.xml
2021-07-14T08:14:52,797+0000 lvl='INFO', log='XMLLoader', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Initializing an object of class org.killbill.billing.overdue.config.DefaultOverdueConfig from xml file at: NoOverdueConfig.xml
2021-07-14T08:14:53,867+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', osgi - Starting...
2021-07-14T08:14:53,867+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', osgi - Start completed.
2021-07-14T08:14:54,136+0000 lvl='INFO', log='EhcacheShiroManagerProvider$EhcacheShiroManagerWrapper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache with name org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2 does not yet exist.  Creating now.
2021-07-14T08:14:54,136+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2 will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:54,136+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2 will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:54,152+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2'
2021-07-14T08:14:54,152+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2' created in EhcacheManager.
2021-07-14T08:14:54,152+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2
2021-07-14T08:14:54,152+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2
2021-07-14T08:14:54,152+0000 lvl='INFO', log='EhcacheShiroManagerProvider$EhcacheShiroManagerWrapper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added EhcacheShiro named [org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2]
2021-07-14T08:14:54,152+0000 lvl='INFO', log='EhcacheShiroManagerProvider$EhcacheShiroManagerWrapper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache with name org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2 does not yet exist.  Creating now.
2021-07-14T08:14:54,152+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2 will be supplemented by template defaultCacheConfiguration
2021-07-14T08:14:54,152+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2 will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:14:54,168+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2'
2021-07-14T08:14:54,168+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2' created in EhcacheManager.
2021-07-14T08:14:54,168+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2
2021-07-14T08:14:54,168+0000 lvl='INFO', log='Eh107CacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2
2021-07-14T08:14:54,183+0000 lvl='INFO', log='EhcacheShiroManagerProvider$EhcacheShiroManagerWrapper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added EhcacheShiro named [org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2]
2021-07-14T08:14:54,324+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage BOOT
2021-07-14T08:14:54,324+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler init for service nodes-service
2021-07-14T08:14:54,674+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage LOAD_CATALOG
2021-07-14T08:14:54,674+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler loadCatalog for service catalog-service
2021-07-14T08:14:54,690+0000 lvl='INFO', log='XMLLoader', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Initializing an object of class org.killbill.billing.catalog.StandaloneCatalog from xml file at: SpyCarAdvanced.xml
2021-07-14T08:14:54,790+0000 lvl='INFO', log='DefaultCatalogService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Successfully loaded the default catalog SpyCarAdvanced.xml
2021-07-14T08:14:54,790+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler loadConfig for service overdue-service
2021-07-14T08:14:54,790+0000 lvl='INFO', log='XMLLoader', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Initializing an object of class org.killbill.billing.overdue.config.DefaultOverdueConfig from xml file at: NoOverdueConfig.xml
2021-07-14T08:14:54,868+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage INIT_BUS
2021-07-14T08:14:54,868+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initBus for service bus-service
2021-07-14T08:14:54,900+0000 lvl='INFO', log='DBBackedQueueWithInflightQueue', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', DBBackedQueue-bus_events Inserting 0 entries into inflightQ during initialization
2021-07-14T08:14:54,900+0000 lvl='INFO', log='DBBackedQueueWithInflightQueue', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', DBBackedQueue-bus_events Initialized with queueId=1, mode=STICKY_EVENTS
2021-07-14T08:14:54,900+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initBus for service external-bus-service
2021-07-14T08:14:54,900+0000 lvl='INFO', log='DBBackedQueueWithInflightQueue', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', DBBackedQueue-bus_ext_events Inserting 0 entries into inflightQ during initialization
2021-07-14T08:14:54,900+0000 lvl='INFO', log='DBBackedQueueWithInflightQueue', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', DBBackedQueue-bus_ext_events Initialized with queueId=2, mode=STICKY_EVENTS
2021-07-14T08:14:54,900+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage INIT_PLUGIN
2021-07-14T08:14:54,900+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service osgi-service
2021-07-14T08:14:54,915+0000 lvl='INFO', log='DefaultOSGIService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Deleted recursively D:\var\tmp\felix\osgi-cache\bundle0
2021-07-14T08:14:54,931+0000 lvl='INFO', log='DefaultOSGIService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Deleted recursively D:\var\tmp\felix\osgi-cache\bundle1\version0.0
2021-07-14T08:14:54,931+0000 lvl='INFO', log='DefaultOSGIService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Deleted recursively D:\var\tmp\felix\osgi-cache\bundle1
2021-07-14T08:14:54,931+0000 lvl='INFO', log='DefaultOSGIService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Deleted recursively D:\var\tmp\felix\osgi-cache\bundle2\version0.0
2021-07-14T08:14:54,931+0000 lvl='INFO', log='DefaultOSGIService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Deleted recursively D:\var\tmp\felix\osgi-cache\bundle2
2021-07-14T08:14:54,946+0000 lvl='INFO', log='DefaultOSGIService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Deleted recursively D:\var\tmp\felix\osgi-cache
2021-07-14T08:14:55,483+0000 lvl='WARN', log='JRubyJarHelper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Unable to find the JRuby bundle at D:/KillBill Files/KPM Bundles/platform/jruby.jar, ruby plugins won't be started!
2021-07-14T08:14:55,483+0000 lvl='INFO', log='FileInstall', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Installing Java OSGI bundle from D:\KillBill Files\KPM Bundles\platform\killbill-platform-osgi-bundles-kpm-0.40.7.jar
2021-07-14T08:14:55,877+0000 lvl='INFO', log='FileInstall', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Installing Java OSGI bundle from D:\KillBill Files\KPM Bundles\platform\killbill-platform-osgi-bundles-logger-0.40.7.jar
2021-07-14T08:14:56,224+0000 lvl='WARN', log='PluginFinder', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', File non existent: Skipping parsing of plugin_identifiers.json
2021-07-14T08:14:56,224+0000 lvl='WARN', log='PluginFinder', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration root dir D:/KillBill Files/KPM Bundles/plugins/ruby is not a valid directory
2021-07-14T08:14:56,224+0000 lvl='WARN', log='PluginFinder', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration root dir D:/KillBill Files/KPM Bundles/plugins/java is not a valid directory
2021-07-14T08:14:56,224+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage INIT_SERVICE
2021-07-14T08:14:56,224+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service security-service
2021-07-14T08:14:56,240+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service config-service
2021-07-14T08:14:56,240+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service broadcast-service
2021-07-14T08:14:56,259+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service extBusEvent-listener-service
2021-07-14T08:14:56,274+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service tenant-service
2021-07-14T08:14:56,358+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service catalog-service
2021-07-14T08:14:56,358+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service subscription-service
2021-07-14T08:14:56,358+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service entitlement-service
2021-07-14T08:14:56,374+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service invoice-service
2021-07-14T08:14:56,374+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service invoice-listener-service
2021-07-14T08:14:56,374+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service payment-service
2021-07-14T08:14:56,374+0000 lvl='INFO', log='XMLLoader', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Initializing an object of class org.killbill.automaton.DefaultStateMachineConfig from xml file at: jar:file:/C:/Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-payment-0.22.24.jar!/org/killbill/billing/payment/PaymentStates.xml
2021-07-14T08:14:56,452+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service overdue-service
2021-07-14T08:14:56,452+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service jaxrs-service
2021-07-14T08:14:56,467+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler registerForNotifications for service beatrix-service
2021-07-14T08:14:56,467+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler registerForNotifications for service server-service
2021-07-14T08:14:56,467+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage START_PLUGIN
2021-07-14T08:14:56,467+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service osgi-service
2021-07-14T08:14:56,467+0000 lvl='INFO', log='FileInstall', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Starting bundle file:D:\KillBill Files\KPM Bundles\platform\killbill-platform-osgi-bundles-kpm-0.40.7.jar
2021-07-14T08:14:57,898+0000 lvl='INFO', log='PluginApp', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', [dev@servletcontainer]: Server started in 603ms

  GET /plugins    [*/*]     [*/*]    (/PluginsResource.getAvailablePlugins)

listening on:
  http://localhost:8080/plugins/killbill-kpm/

2021-07-14T08:14:57,914+0000 lvl='INFO', log='DefaultServletRouter', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering OSGI servlet at /killbill-kpm
2021-07-14T08:14:57,914+0000 lvl='INFO', log='FileInstall', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Starting bundle file:D:\KillBill Files\KPM Bundles\platform\killbill-platform-osgi-bundles-logger-0.40.7.jar
2021-07-14T08:14:57,929+0000 lvl='INFO', log='LogEntriesManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Created new cache 27e78717-4fa7-4f05-9b8a-1afb726b6b10 (1 active)
2021-07-14T08:14:58,121+0000 lvl='INFO', log='KillbillLogWriter', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', [org.kill-bill.billing.killbill-platform-osgi-bundles-logger] ServiceEvent REGISTERED
2021-07-14T08:14:58,751+0000 lvl='INFO', log='PluginApp', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', [dev@servletcontainer]: Server started in 499ms

  GET /    [text/event-stream]     [*/*]    (/anonymous)

listening on:
  http://localhost:8080/plugins/killbill-osgi-logger/

2021-07-14T08:14:58,767+0000 lvl='INFO', log='DefaultServletRouter', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering OSGI servlet at /killbill-osgi-logger
2021-07-14T08:14:58,767+0000 lvl='INFO', log='KillbillLogWriter', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', [org.kill-bill.billing.killbill-platform-osgi-bundles-logger] ServiceEvent REGISTERED
2021-07-14T08:14:58,767+0000 lvl='INFO', log='KillbillLogWriter', th='FelixDispatchQueue', xff='', rId='', tok='', aRId='', tRId='', [org.kill-bill.billing.killbill-platform-osgi-bundles-logger] BundleEvent STARTED
2021-07-14T08:14:58,782+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage START_SERVICE
2021-07-14T08:14:58,782+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service nodes-service
2021-07-14T08:14:58,829+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service broadcast-service
2021-07-14T08:14:58,829+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service extBusEvent-listener-service
2021-07-14T08:14:58,829+0000 lvl='INFO', log='DBBackedQueue', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', DBBackedQueue-notifications Initialized  mode=STICKY_POLLING
2021-07-14T08:14:58,845+0000 lvl='INFO', log='DefaultReaper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', NotificationReaper: Starting... reapThresholdMillis=600000, schedulePeriodMillis=180000
2021-07-14T08:14:58,860+0000 lvl='INFO', log='DefaultQueueLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', notifications: Starting...
2021-07-14T08:14:58,876+0000 lvl='INFO', log='DefaultQueueLifecycle', th='notifications-lifecycle-th-1', xff='', rId='', tok='', aRId='', tRId='', notifications: Thread notifications-lifecycle-th-1-dispatcher [51] starting
2021-07-14T08:14:58,876+0000 lvl='INFO', log='DefaultQueueLifecycle', th='notifications-lifecycle-th-2', xff='', rId='', tok='', aRId='', tRId='', notifications: Thread notifications-lifecycle-th-2-completion [52] starting
2021-07-14T08:14:58,892+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service tenant-service
2021-07-14T08:14:58,892+0000 lvl='INFO', log='DefaultQueueLifecycle', th='notifications-lifecycle-th-3', xff='', rId='', tok='', aRId='', tRId='', notifications: Thread notifications-lifecycle-th-3-completion [53] starting
2021-07-14T08:14:58,892+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service subscription-service
2021-07-14T08:14:58,907+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service entitlement-service
2021-07-14T08:14:58,907+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service invoice-service
2021-07-14T08:14:58,907+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service invoice-listener-service
2021-07-14T08:14:58,907+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service payment-service
2021-07-14T08:14:58,923+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service overdue-service
2021-07-14T08:14:58,923+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service server-service
2021-07-14T08:14:58,923+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage START_BUS
2021-07-14T08:14:58,923+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler startBus for service bus-service
2021-07-14T08:14:58,923+0000 lvl='INFO', log='DefaultReaper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', BusReaper: Starting... reapThresholdMillis=600000, schedulePeriodMillis=180000
2021-07-14T08:14:58,939+0000 lvl='INFO', log='DefaultQueueLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', bus_events: Starting...
2021-07-14T08:14:58,954+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_events-lifecycle-th-1', xff='', rId='', tok='', aRId='', tRId='', bus_events: Thread bus_events-lifecycle-th-1-dispatcher [57] starting
2021-07-14T08:14:58,960+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler startBus for service external-bus-service
2021-07-14T08:14:58,960+0000 lvl='INFO', log='DefaultReaper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', BusReaper: Starting... reapThresholdMillis=600000, schedulePeriodMillis=180000
2021-07-14T08:14:58,960+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_events-lifecycle-th-2', xff='', rId='', tok='', aRId='', tRId='', bus_events: Thread bus_events-lifecycle-th-2-completion [58] starting
2021-07-14T08:14:58,960+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_events-lifecycle-th-3', xff='', rId='', tok='', aRId='', tRId='', bus_events: Thread bus_events-lifecycle-th-3-completion [59] starting
2021-07-14T08:14:58,960+0000 lvl='INFO', log='DefaultQueueLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', bus_ext_events: Starting...
2021-07-14T08:14:58,975+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_ext_events-lifecycle-th-1', xff='', rId='', tok='', aRId='', tRId='', bus_ext_events: Thread bus_ext_events-lifecycle-th-1-dispatcher [61] starting
2021-07-14T08:14:59,007+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_ext_events-lifecycle-th-2', xff='', rId='', tok='', aRId='', tRId='', bus_ext_events: Thread bus_ext_events-lifecycle-th-2-completion [62] starting
2021-07-14T08:14:59,007+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_ext_events-lifecycle-th-3', xff='', rId='', tok='', aRId='', tRId='', bus_ext_events: Thread bus_ext_events-lifecycle-th-3-completion [63] starting
2021-07-14T08:14:59,352+0000 lvl='INFO', log='Reflections', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Reflections took 262 ms to scan 1 urls, producing 306 keys and 665 values
2021-07-14T08:15:05,220+0000 lvl='INFO', log='KillbillGuiceFilter', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Kill Bill server has started
2021-07-14T08:15:05,235+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [3000] for [org.killbill.server.updateCheck.connectTimeout] on [org.killbill.billing.server.config.UpdateCheckConfig#updateCheckConnectionTimeout()]
2021-07-14T08:15:05,235+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.server.updateCheck.skip] on [org.killbill.billing.server.config.UpdateCheckConfig#shouldSkipUpdateCheck()]
2021-07-14T08:15:05,235+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [https://raw.github.com/killbill/killbill/master/profiles/killbill/src/main/resources/update-checker/killbill-server-update-list.properties] for [org.killbill.server.updateCheck.url] on [org.killbill.billing.server.config.UpdateCheckConfig#updateCheckURL()]
2021-07-14T08:15:05,235+0000 lvl='INFO', log='UpdateChecker', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', For Kill Bill Commercial Support, visit http://thebillingproject.com or send an email to support@thebillingproject.com
2021-07-14T08:15:05,251+0000 lvl='WARN', log='KillbillHealthcheck', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Putting host in rotation
2021-07-14T08:15:33,290+0000 lvl='INFO', log='', th='http-nio-8080-exec-1', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:33.273000 #10364]  INFO -- : Started GET "/kaui/users/sign_in" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:33 -0500

2021-07-14T08:15:33,572+0000 lvl='INFO', log='', th='http-nio-8080-exec-1', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:33.571000 #10364]  INFO -- : Processing by Kaui::SessionsController#new as HTML

2021-07-14T08:15:33,850+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:33.850000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/sessions/new.html.erb within kaui/layouts/kaui_application

2021-07-14T08:15:34,049+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:34.048000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/sessions/_form.html.erb (182.0ms) [cache miss]

2021-07-14T08:15:34,050+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:34.050000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/sessions/new.html.erb within kaui/layouts/kaui_application (198.0ms)

2021-07-14T08:15:34,063+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:34.062000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_header.html.erb

2021-07-14T08:15:37,136+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:37.136000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_header.html.erb (3069.0ms)

2021-07-14T08:15:37,149+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:37.149000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_navbar.html.erb

2021-07-14T08:15:37,177+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:37.176000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_navbar.html.erb (25.0ms)

2021-07-14T08:15:37,184+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:37.183000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_flash.html.erb

2021-07-14T08:15:37,193+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:37.192000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_flash.html.erb (7.0ms)

2021-07-14T08:15:37,201+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:37.200000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_footer.html.erb

2021-07-14T08:15:37,204+0000 lvl='INFO', log='sessions#new', th='http-nio-8080-exec-1', xff='', rId='f9dadfe3-a3b1-4acb-9934-af5cb75d932d', aId='', tId='', I, [2021-07-14T03:15:37.203000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_footer.html.erb (2.0ms)

2021-07-14T08:15:37,211+0000 lvl='INFO', log='', th='http-nio-8080-exec-1', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:37.210000 #10364]  INFO -- : Completed 200 OK in 3637ms (Views: 3386.5ms | ActiveRecord: 11.0ms)

2021-07-14T08:15:37,988+0000 lvl='INFO', log='', th='http-nio-8080-exec-2', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:37.988000 #10364]  INFO -- : Started GET "/kaui/main/available_engines.json" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:37 -0500

2021-07-14T08:15:38,025+0000 lvl='INFO', log='', th='http-nio-8080-exec-2', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:38.014000 #10364]  INFO -- : Processing by MainController#available_engines as JSON

2021-07-14T08:15:38,031+0000 lvl='INFO', log='', th='http-nio-8080-exec-2', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:38.030000 #10364]  INFO -- :   Parameters: {"main"=>{}}

2021-07-14T08:15:38,057+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-2', xff='', rId='b4803686-18ce-468d-b4a5-68b16a2eb2f6', aId='', tId='', I, [2021-07-14T03:15:38.054000 #10364]  INFO -- : Completed 401 Unauthorized in 18ms (ActiveRecord: 0.0ms)

2021-07-14T08:15:38,256+0000 lvl='INFO', log='AbstractValidatingSessionManager', th='http-nio-8080-exec-3', xff='', rId='', tok='', aRId='', tRId='', Enabling session validation scheduler...
2021-07-14T08:15:43,957+0000 lvl='INFO', log='', th='http-nio-8080-exec-4', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:43.957000 #10364]  INFO -- : Started POST "/kaui/users/sign_in" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:43 -0500

2021-07-14T08:15:43,966+0000 lvl='INFO', log='', th='http-nio-8080-exec-4', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:43.966000 #10364]  INFO -- : Processing by Kaui::SessionsController#create as HTML

2021-07-14T08:15:43,970+0000 lvl='INFO', log='', th='http-nio-8080-exec-4', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:43.970000 #10364]  INFO -- :   Parameters: {"utf8"=>"?", "authenticity_token"=>"krsIr3q0FBzpEXMq5Tc7JWGFOOS/t2BMuUMMoCWa8APMzeHjGc2rV8VdY3IOCOWR3NqN8efZPTYfSMsaRZGnxw==", "user"=>{"kb_username"=>"admin", "password"=>"[FILTERED]"}, "commit"=>"Sign in"}

2021-07-14T08:15:44,045+0000 lvl='INFO', log='sessions#create', th='http-nio-8080-exec-4', xff='', rId='82cde1ec-3c11-4ce1-ae91-bf3267ab743c', aId='', tId='', I, [2021-07-14T03:15:44.045000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/permissions'

2021-07-14T08:15:44,189+0000 lvl='INFO', log='EhcacheShiroManagerProvider$EhcacheShiroManagerWrapper', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', Cache with name shiro-activeSessionCache does not yet exist.  Creating now.
2021-07-14T08:15:44,191+0000 lvl='INFO', log='ConfigurationMerger', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache shiro-activeSessionCache will be supplemented by template defaultCacheConfiguration
2021-07-14T08:15:44,194+0000 lvl='INFO', log='ConfigurationMerger', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', Cache shiro-activeSessionCache will use expiry configuration from template defaultCacheConfiguration
2021-07-14T08:15:44,210+0000 lvl='INFO', log='EhcacheLoggingListener', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'shiro-activeSessionCache'
2021-07-14T08:15:44,211+0000 lvl='INFO', log='EhcacheManager', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', Cache 'shiro-activeSessionCache' created in EhcacheManager.
2021-07-14T08:15:44,212+0000 lvl='INFO', log='Eh107CacheManager', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheConfiguration,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=shiro-activeSessionCache
2021-07-14T08:15:44,213+0000 lvl='INFO', log='Eh107CacheManager', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', Registering Ehcache MBean javax.cache:type=CacheStatistics,CacheManager=jar.file./C./Tomcat/apache-tomcat-8.5.65/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.24.jar!/ehcache.xml,Cache=shiro-activeSessionCache
2021-07-14T08:15:44,232+0000 lvl='INFO', log='EhcacheShiroManagerProvider$EhcacheShiroManagerWrapper', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', Added EhcacheShiro named [shiro-activeSessionCache]
2021-07-14T08:15:44,458+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', 1 * Server has received a request on thread http-nio-8080-exec-5
1 > GET http://127.0.0.1:8080/1.0/kb/security/permissions
1 > accept: application/json
1 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
1 > authorization: **************************
1 > host: 127.0.0.1:8080
1 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:44,655+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-5', xff='', rId='8251d084-dfbd-4ce7-81bc-855b5f0cecba', tok='', aRId='', tRId='', 1 * Server responded with a response on thread http-nio-8080-exec-5
1 < 200
1 < Content-Type: application/json

2021-07-14T08:15:44,707+0000 lvl='INFO', log='sessions#create', th='http-nio-8080-exec-4', xff='', rId='82cde1ec-3c11-4ce1-ae91-bf3267ab743c', aId='', tId='', I, [2021-07-14T03:15:44.706000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='659.0'

2021-07-14T08:15:44,764+0000 lvl='INFO', log='sessions#create', th='http-nio-8080-exec-4', xff='', rId='82cde1ec-3c11-4ce1-ae91-bf3267ab743c', aId='', tId='', I, [2021-07-14T03:15:44.764000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/subject'

2021-07-14T08:15:44,802+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-7', xff='', rId='', tok='', aRId='', tRId='', 2 * Server has received a request on thread http-nio-8080-exec-7
2 > GET http://127.0.0.1:8080/1.0/kb/security/subject
2 > accept: application/json
2 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
2 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
2 > host: 127.0.0.1:8080
2 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:44,807+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-7', xff='', rId='53567972-97cc-41ba-8029-4b5a19c85da3', tok='', aRId='', tRId='', 2 * Server responded with a response on thread http-nio-8080-exec-7
2 < 200
2 < Content-Type: application/json

2021-07-14T08:15:44,828+0000 lvl='INFO', log='sessions#create', th='http-nio-8080-exec-4', xff='', rId='82cde1ec-3c11-4ce1-ae91-bf3267ab743c', aId='', tId='', I, [2021-07-14T03:15:44.828000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='62.0'

2021-07-14T08:15:44,911+0000 lvl='INFO', log='sessions#create', th='http-nio-8080-exec-4', xff='', rId='82cde1ec-3c11-4ce1-ae91-bf3267ab743c', aId='', tId='', I, [2021-07-14T03:15:44.911000 #10364]  INFO -- : Redirected to http://localhost:8080/kaui/tenants

2021-07-14T08:15:44,913+0000 lvl='INFO', log='', th='http-nio-8080-exec-4', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:44.913000 #10364]  INFO -- : Completed 302 Found in 937ms (ActiveRecord: 33.0ms)

2021-07-14T08:15:44,944+0000 lvl='INFO', log='', th='http-nio-8080-exec-9', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:44.944000 #10364]  INFO -- : Started GET "/kaui/tenants" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:44 -0500

2021-07-14T08:15:44,953+0000 lvl='INFO', log='', th='http-nio-8080-exec-9', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:44.953000 #10364]  INFO -- : Processing by Kaui::TenantsController#index as HTML

2021-07-14T08:15:44,966+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:44.966000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/subject'

2021-07-14T08:15:44,983+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-10', xff='', rId='', tok='', aRId='', tRId='', 3 * Server has received a request on thread http-nio-8080-exec-10
3 > GET http://127.0.0.1:8080/1.0/kb/security/subject
3 > accept: application/json
3 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
3 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
3 > host: 127.0.0.1:8080
3 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:44,988+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-10', xff='', rId='56c7b2b9-66d5-4c92-ba3e-d4a500772e8e', tok='', aRId='', tRId='', 3 * Server responded with a response on thread http-nio-8080-exec-10
3 < 200
3 < Content-Type: application/json

2021-07-14T08:15:44,993+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:44.993000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='25.0'

2021-07-14T08:15:45,241+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.241000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/tenants/index.html.erb within kaui/layouts/kaui_application

2021-07-14T08:15:45,284+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.284000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/tenants/_form.html.erb (34.0ms) [cache miss]

2021-07-14T08:15:45,285+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.285000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/tenants/index.html.erb within kaui/layouts/kaui_application (43.0ms)

2021-07-14T08:15:45,290+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.289000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_header.html.erb

2021-07-14T08:15:45,301+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.301000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_header.html.erb (11.0ms)

2021-07-14T08:15:45,303+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.302000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_navbar.html.erb

2021-07-14T08:15:45,309+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.309000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/permissions'

2021-07-14T08:15:45,325+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-2', xff='', rId='', tok='', aRId='', tRId='', 4 * Server has received a request on thread http-nio-8080-exec-2
4 > GET http://127.0.0.1:8080/1.0/kb/security/permissions
4 > accept: application/json
4 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
4 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
4 > host: 127.0.0.1:8080
4 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:45,338+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-2', xff='', rId='95e3414d-abd6-4ef3-9980-7228c25d1059', tok='', aRId='', tRId='', 4 * Server responded with a response on thread http-nio-8080-exec-2
4 < 200
4 < Content-Type: application/json

2021-07-14T08:15:45,343+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.343000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='29.0'

2021-07-14T08:15:45,351+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.350000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_navbar.html.erb (46.0ms)

2021-07-14T08:15:45,352+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.352000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_flash.html.erb

2021-07-14T08:15:45,354+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.354000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_flash.html.erb (1.0ms)

2021-07-14T08:15:45,357+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.356000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_footer.html.erb

2021-07-14T08:15:45,358+0000 lvl='INFO', log='tenants#index', th='http-nio-8080-exec-9', xff='', rId='157e7979-36bc-41dc-a300-28769edd96de', aId='', tId='', I, [2021-07-14T03:15:45.358000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_footer.html.erb (1.0ms)

2021-07-14T08:15:45,360+0000 lvl='INFO', log='', th='http-nio-8080-exec-9', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:45.360000 #10364]  INFO -- : Completed 200 OK in 407ms (Views: 116.9ms | ActiveRecord: 45.0ms)

2021-07-14T08:15:45,606+0000 lvl='INFO', log='', th='http-nio-8080-exec-5', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:45.606000 #10364]  INFO -- : Started GET "/kaui/main/available_engines.json" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:45 -0500

2021-07-14T08:15:45,614+0000 lvl='INFO', log='', th='http-nio-8080-exec-5', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:45.614000 #10364]  INFO -- : Processing by MainController#available_engines as JSON

2021-07-14T08:15:45,615+0000 lvl='INFO', log='', th='http-nio-8080-exec-5', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:45.615000 #10364]  INFO -- :   Parameters: {"main"=>{}}

2021-07-14T08:15:45,631+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-5', xff='', rId='9396b65e-7414-41c3-8049-0a88ab1408db', aId='', tId='', I, [2021-07-14T03:15:45.631000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/subject'

2021-07-14T08:15:45,671+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-6', xff='', rId='', tok='', aRId='', tRId='', 5 * Server has received a request on thread http-nio-8080-exec-6
5 > GET http://127.0.0.1:8080/1.0/kb/security/subject
5 > accept: application/json
5 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
5 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
5 > host: 127.0.0.1:8080
5 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:45,676+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-6', xff='', rId='f6c10759-2080-4e24-a91c-bcc139ab9212', tok='', aRId='', tRId='', 5 * Server responded with a response on thread http-nio-8080-exec-6
5 < 200
5 < Content-Type: application/json

2021-07-14T08:15:45,682+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-5', xff='', rId='9396b65e-7414-41c3-8049-0a88ab1408db', aId='', tId='', I, [2021-07-14T03:15:45.682000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='49.0'

2021-07-14T08:15:45,689+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-5', xff='', rId='9396b65e-7414-41c3-8049-0a88ab1408db', aId='', tId='', I, [2021-07-14T03:15:45.688000 #10364]  INFO -- : Filter chain halted as :check_for_redirect_to_tenant_screen rendered or redirected

2021-07-14T08:15:45,704+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-5', xff='', rId='9396b65e-7414-41c3-8049-0a88ab1408db', aId='', tId='', I, [2021-07-14T03:15:45.704000 #10364]  INFO -- : Completed 200 OK in 73ms (Views: 1.0ms | ActiveRecord: 2.0ms)

2021-07-14T08:15:50,687+0000 lvl='INFO', log='', th='http-nio-8080-exec-8', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:50.683000 #10364]  INFO -- : Started POST "/kaui/tenants/select_tenant" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:50 -0500

2021-07-14T08:15:50,697+0000 lvl='INFO', log='', th='http-nio-8080-exec-8', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:50.696000 #10364]  INFO -- : Processing by Kaui::TenantsController#select_tenant as HTML

2021-07-14T08:15:50,698+0000 lvl='INFO', log='', th='http-nio-8080-exec-8', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:50.697000 #10364]  INFO -- :   Parameters: {"utf8"=>"?", "authenticity_token"=>"+dHw7JftJ4Rjm69+XhMRoD8bm6HCerYAhdcWstVgJJ5OSnd4x5lBjjnqe+Ij5e2V5nsCxa27oERe1mGc2HRHVA==", "kb_tenant_id"=>"5b04e2f1-6b6b-466e-a98b-f8e669601351", "commit"=>"Save"}

2021-07-14T08:15:50,713+0000 lvl='INFO', log='tenants#select_tenant', th='http-nio-8080-exec-8', xff='', rId='6adfbb39-f0aa-4fed-b441-5b0c7ec27616', aId='', tId='', I, [2021-07-14T03:15:50.713000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/subject'

2021-07-14T08:15:50,770+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-4', xff='', rId='', tok='', aRId='', tRId='', 6 * Server has received a request on thread http-nio-8080-exec-4
6 > GET http://127.0.0.1:8080/1.0/kb/security/subject
6 > accept: application/json
6 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
6 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
6 > host: 127.0.0.1:8080
6 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:50,774+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-4', xff='', rId='0911e3c8-b213-4b3a-b8e5-58ced3f4b495', tok='', aRId='', tRId='', 6 * Server responded with a response on thread http-nio-8080-exec-4
6 < 200
6 < Content-Type: application/json

2021-07-14T08:15:50,780+0000 lvl='INFO', log='tenants#select_tenant', th='http-nio-8080-exec-8', xff='', rId='6adfbb39-f0aa-4fed-b441-5b0c7ec27616', aId='', tId='', I, [2021-07-14T03:15:50.779000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='65.0'

2021-07-14T08:15:50,797+0000 lvl='INFO', log='tenants#select_tenant', th='http-nio-8080-exec-8', xff='', rId='6adfbb39-f0aa-4fed-b441-5b0c7ec27616', aId='', tId='', I, [2021-07-14T03:15:50.797000 #10364]  INFO -- : Redirected to http://localhost:8080/kaui/home

2021-07-14T08:15:50,799+0000 lvl='INFO', log='', th='http-nio-8080-exec-8', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:50.799000 #10364]  INFO -- : Completed 302 Found in 100ms (ActiveRecord: 7.0ms)

2021-07-14T08:15:50,823+0000 lvl='INFO', log='', th='http-nio-8080-exec-1', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:50.823000 #10364]  INFO -- : Started GET "/kaui/home" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:50 -0500

2021-07-14T08:15:50,835+0000 lvl='INFO', log='', th='http-nio-8080-exec-1', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:50.835000 #10364]  INFO -- : Processing by Kaui::HomeController#index as HTML

2021-07-14T08:15:50,853+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:50.853000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/subject'

2021-07-14T08:15:50,869+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-2', xff='', rId='', tok='', aRId='', tRId='', 7 * Server has received a request on thread http-nio-8080-exec-2
7 > GET http://127.0.0.1:8080/1.0/kb/security/subject
7 > accept: application/json
7 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
7 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
7 > host: 127.0.0.1:8080
7 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:50,871+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-2', xff='', rId='b7cd8259-93b3-4481-84c3-fbdeaf6d69da', tok='', aRId='', tRId='', 7 * Server responded with a response on thread http-nio-8080-exec-2
7 < 200
7 < Content-Type: application/json

2021-07-14T08:15:50,875+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:50.875000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='20.0'

2021-07-14T08:15:50,919+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:50.919000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/home/index.html.erb within kaui/layouts/kaui_application

2021-07-14T08:15:50,949+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:50.949000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/home/_advanced_search_modal.html.erb (14.0ms) [cache miss]

2021-07-14T08:15:50,950+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:50.950000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/home/index.html.erb within kaui/layouts/kaui_application (30.0ms)

2021-07-14T08:15:50,954+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:50.954000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_header.html.erb

2021-07-14T08:15:50,968+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:50.967000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_header.html.erb (10.0ms)

2021-07-14T08:15:50,969+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:50.969000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_navbar.html.erb

2021-07-14T08:15:50,980+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:50.980000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/permissions'

2021-07-14T08:15:50,995+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-9', xff='', rId='', tok='', aRId='', tRId='', 8 * Server has received a request on thread http-nio-8080-exec-9
8 > GET http://127.0.0.1:8080/1.0/kb/security/permissions
8 > accept: application/json
8 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
8 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
8 > host: 127.0.0.1:8080
8 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:51,001+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-9', xff='', rId='9e443054-b3a2-4b0b-b883-4c0a0f809994', tok='', aRId='', tRId='', 8 * Server responded with a response on thread http-nio-8080-exec-9
8 < 200
8 < Content-Type: application/json

2021-07-14T08:15:51,012+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:51.011000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='30.0'

2021-07-14T08:15:51,023+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:51.022000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_navbar.html.erb (53.0ms)

2021-07-14T08:15:51,024+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:51.024000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_flash.html.erb

2021-07-14T08:15:51,027+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:51.027000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_flash.html.erb (1.0ms)

2021-07-14T08:15:51,033+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:51.033000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_footer.html.erb

2021-07-14T08:15:51,035+0000 lvl='INFO', log='home#index', th='http-nio-8080-exec-1', xff='', rId='32bed339-c770-4eb1-95c6-33baf4da68d1', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:51.035000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_footer.html.erb (0.0ms)

2021-07-14T08:15:51,038+0000 lvl='INFO', log='', th='http-nio-8080-exec-1', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:51.038000 #10364]  INFO -- : Completed 200 OK in 201ms (Views: 121.2ms | ActiveRecord: 8.0ms)

2021-07-14T08:15:51,555+0000 lvl='INFO', log='', th='http-nio-8080-exec-7', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:51.554000 #10364]  INFO -- : Started GET "/kaui/main/available_engines.json" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:51 -0500

2021-07-14T08:15:51,564+0000 lvl='INFO', log='', th='http-nio-8080-exec-7', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:51.564000 #10364]  INFO -- : Processing by MainController#available_engines as JSON

2021-07-14T08:15:51,565+0000 lvl='INFO', log='', th='http-nio-8080-exec-7', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:51.565000 #10364]  INFO -- :   Parameters: {"main"=>{}}

2021-07-14T08:15:51,580+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-7', xff='', rId='db3cfecb-edeb-4fd9-99c9-6c00fc529cad', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:51.580000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/subject'

2021-07-14T08:15:51,610+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', 9 * Server has received a request on thread http-nio-8080-exec-5
9 > GET http://127.0.0.1:8080/1.0/kb/security/subject
9 > accept: application/json
9 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
9 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
9 > host: 127.0.0.1:8080
9 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:51,613+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-5', xff='', rId='37729f63-5486-4e85-a155-9f08132c39e6', tok='', aRId='', tRId='', 9 * Server responded with a response on thread http-nio-8080-exec-5
9 < 200
9 < Content-Type: application/json

2021-07-14T08:15:51,621+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-7', xff='', rId='db3cfecb-edeb-4fd9-99c9-6c00fc529cad', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:51.620000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='39.0'

2021-07-14T08:15:51,722+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-7', xff='', rId='db3cfecb-edeb-4fd9-99c9-6c00fc529cad', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:51.722000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/nodesInfo'

2021-07-14T08:15:52,036+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-10', xff='', rId='', tok='', aRId='', tRId='8', 10 * Server has received a request on thread http-nio-8080-exec-10
10 > GET http://127.0.0.1:8080/1.0/kb/nodesInfo
10 > accept: application/json
10 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
10 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
10 > host: 127.0.0.1:8080
10 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]
10 > x-killbill-apikey: lanstore
10 > x-killbill-apisecret: ********

2021-07-14T08:15:52,235+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-10', xff='', rId='0206c7de-347e-401b-b68b-6c3a018fb5e5', tok='', aRId='', tRId='8', 10 * Server responded with a response on thread http-nio-8080-exec-10
10 < 200
10 < Content-Type: application/json

2021-07-14T08:15:52,250+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-7', xff='', rId='db3cfecb-edeb-4fd9-99c9-6c00fc529cad', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:52.250000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='527.0'

2021-07-14T08:15:52,250+0000 lvl='INFO', log='', th='http-nio-8080-exec-7', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:52.250000 #10364]  INFO -- : Completed 200 OK in 684ms (Views: 1.4ms | ActiveRecord: 10.0ms)

2021-07-14T08:15:54,367+0000 lvl='INFO', log='', th='http-nio-8080-exec-3', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:54.367000 #10364]  INFO -- : Started GET "/kaui/kpm" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:54 -0500

2021-07-14T08:15:54,415+0000 lvl='INFO', log='', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:54.415000 #10364]  INFO -- : Processing by KPM::NodesInfoController#index as HTML

2021-07-14T08:15:54,430+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.429000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/subject'

2021-07-14T08:15:54,474+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-9', xff='', rId='', tok='', aRId='', tRId='', 11 * Server has received a request on thread http-nio-8080-exec-9
11 > GET http://127.0.0.1:8080/1.0/kb/security/subject
11 > accept: application/json
11 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
11 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
11 > host: 127.0.0.1:8080
11 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:54,477+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-9', xff='', rId='2621da04-511b-4eda-aa32-39ff15f6454b', tok='', aRId='', tRId='', 11 * Server responded with a response on thread http-nio-8080-exec-9
11 < 200
11 < Content-Type: application/json

2021-07-14T08:15:54,484+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.484000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='52.0'

2021-07-14T08:15:54,516+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.516000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/nodesInfo'

2021-07-14T08:15:54,725+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-1', xff='', rId='', tok='', aRId='', tRId='8', 12 * Server has received a request on thread http-nio-8080-exec-1
12 > GET http://127.0.0.1:8080/1.0/kb/nodesInfo
12 > accept: application/json
12 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
12 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
12 > host: 127.0.0.1:8080
12 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]
12 > x-killbill-apikey: lanstore
12 > x-killbill-apisecret: ********

2021-07-14T08:15:54,733+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-1', xff='', rId='1bcfc6cc-747a-4a48-b231-5fc71de6a861', tok='', aRId='', tRId='8', 12 * Server responded with a response on thread http-nio-8080-exec-1
12 < 200
12 < Content-Type: application/json

2021-07-14T08:15:54,738+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.737000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='220.0'

2021-07-14T08:15:54,758+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.758000 #10364]  INFO -- :   Rendering gems/gems/killbill-kpm-ui-2.0.2/app/views/kpm/nodes_info/index.html.erb within kaui/layouts/kaui_application

2021-07-14T08:15:54,812+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.812000 #10364]  INFO -- :   Rendered gems/gems/killbill-kpm-ui-2.0.2/app/views/kpm/nodes_info/_nodes_table.html.erb (16.0ms) [cache miss]

2021-07-14T08:15:54,829+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.829000 #10364]  INFO -- :   Rendered gems/gems/killbill-kpm-ui-2.0.2/app/views/kpm/nodes_info/_logs_table.html.erb (6.0ms) [cache miss]

2021-07-14T08:15:54,832+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.832000 #10364]  INFO -- :   Rendered gems/gems/killbill-kpm-ui-2.0.2/app/views/kpm/nodes_info/index.html.erb within kaui/layouts/kaui_application (72.0ms)

2021-07-14T08:15:54,833+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.833000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_header.html.erb

2021-07-14T08:15:54,840+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.840000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_header.html.erb (7.0ms)

2021-07-14T08:15:54,843+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.843000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_navbar.html.erb

2021-07-14T08:15:54,852+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.852000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/permissions'

2021-07-14T08:15:54,863+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-4', xff='', rId='', tok='', aRId='', tRId='', 13 * Server has received a request on thread http-nio-8080-exec-4
13 > GET http://127.0.0.1:8080/1.0/kb/security/permissions
13 > accept: application/json
13 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
13 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
13 > host: 127.0.0.1:8080
13 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:54,866+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-4', xff='', rId='106e7253-4010-418b-8266-73d003be81b6', tok='', aRId='', tRId='', 13 * Server responded with a response on thread http-nio-8080-exec-4
13 < 200
13 < Content-Type: application/json

2021-07-14T08:15:54,874+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.874000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='16.0'

2021-07-14T08:15:54,881+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.881000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_navbar.html.erb (38.0ms)

2021-07-14T08:15:54,883+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.883000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_flash.html.erb

2021-07-14T08:15:54,885+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.885000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_flash.html.erb (0.0ms)

2021-07-14T08:15:54,886+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.886000 #10364]  INFO -- :   Rendering gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_footer.html.erb

2021-07-14T08:15:54,889+0000 lvl='INFO', log='nodes_info#index', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='878b3000-1e98-481a-83f8-487b163ed1b7', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:54.889000 #10364]  INFO -- :   Rendered gems/gems/kaui-2.1.0/app/views/kaui/layouts/kaui_footer.html.erb (1.0ms)

2021-07-14T08:15:54,893+0000 lvl='INFO', log='', th='Ruby-0-Thread-1: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:54.892000 #10364]  INFO -- : Completed 200 OK in 477ms (Views: 136.5ms | ActiveRecord: 8.0ms)

2021-07-14T08:15:55,121+0000 lvl='INFO', log='', th='http-nio-8080-exec-8', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:55.121000 #10364]  INFO -- : Started GET "/kaui/main/available_engines.json" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:55 -0500

2021-07-14T08:15:55,130+0000 lvl='INFO', log='', th='http-nio-8080-exec-8', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:55.129000 #10364]  INFO -- : Processing by MainController#available_engines as JSON

2021-07-14T08:15:55,131+0000 lvl='INFO', log='', th='http-nio-8080-exec-8', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:55.130000 #10364]  INFO -- :   Parameters: {"main"=>{}}

2021-07-14T08:15:55,158+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-8', xff='', rId='8a1d14ed-068b-47ab-b6eb-67842bf165d2', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:55.158000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/subject'

2021-07-14T08:15:55,164+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-7', xff='', rId='', tok='', aRId='', tRId='', 14 * Server has received a request on thread http-nio-8080-exec-7
14 > GET http://127.0.0.1:8080/1.0/kb/security/subject
14 > accept: application/json
14 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
14 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
14 > host: 127.0.0.1:8080
14 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:55,166+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-7', xff='', rId='3f34c649-9716-450c-9dc8-b8bd7f65eb87', tok='', aRId='', tRId='', 14 * Server responded with a response on thread http-nio-8080-exec-7
14 < 200
14 < Content-Type: application/json

2021-07-14T08:15:55,169+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-8', xff='', rId='8a1d14ed-068b-47ab-b6eb-67842bf165d2', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:55.169000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='9.0'

2021-07-14T08:15:55,196+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-8', xff='', rId='8a1d14ed-068b-47ab-b6eb-67842bf165d2', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:55.196000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/nodesInfo'

2021-07-14T08:15:55,383+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-9', xff='', rId='', tok='', aRId='', tRId='8', 15 * Server has received a request on thread http-nio-8080-exec-9
15 > GET http://127.0.0.1:8080/1.0/kb/nodesInfo
15 > accept: application/json
15 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
15 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
15 > host: 127.0.0.1:8080
15 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]
15 > x-killbill-apikey: lanstore
15 > x-killbill-apisecret: ********

2021-07-14T08:15:55,389+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-9', xff='', rId='986bf9dc-6a02-41a8-b769-852589b4486f', tok='', aRId='', tRId='8', 15 * Server responded with a response on thread http-nio-8080-exec-9
15 < 200
15 < Content-Type: application/json

2021-07-14T08:15:55,397+0000 lvl='INFO', log='main#available_engines', th='http-nio-8080-exec-8', xff='', rId='8a1d14ed-068b-47ab-b6eb-67842bf165d2', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:55.397000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='200.0'

2021-07-14T08:15:55,406+0000 lvl='INFO', log='', th='http-nio-8080-exec-8', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:55.406000 #10364]  INFO -- : Completed 200 OK in 272ms (Views: 2.3ms | ActiveRecord: 9.0ms)

2021-07-14T08:15:55,414+0000 lvl='INFO', log='', th='http-nio-8080-exec-1', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:55.413000 #10364]  INFO -- : Started GET "/kaui/kpm/nodes_info/refresh.js?kb_host=http%3A%2F%2F127.0.0.1%3A8080" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:15:55 -0500

2021-07-14T08:15:55,433+0000 lvl='INFO', log='', th='Ruby-0-Thread-2: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:55.433000 #10364]  INFO -- : Processing by KPM::NodesInfoController#refresh as JS

2021-07-14T08:15:55,434+0000 lvl='INFO', log='', th='Ruby-0-Thread-2: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:55.434000 #10364]  INFO -- :   Parameters: {"kb_host"=>"http://127.0.0.1:8080"}

2021-07-14T08:15:55,474+0000 lvl='INFO', log='nodes_info#refresh', th='Ruby-0-Thread-2: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='48a9635e-0333-4302-8401-71d657e2e9e6', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:55.474000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/subject'

2021-07-14T08:15:55,482+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', 16 * Server has received a request on thread http-nio-8080-exec-5
16 > GET http://127.0.0.1:8080/1.0/kb/security/subject
16 > accept: application/json
16 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
16 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
16 > host: 127.0.0.1:8080
16 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:15:55,485+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-5', xff='', rId='2a2cdeef-d41b-4b6b-8aee-fece895ec36f', tok='', aRId='', tRId='', 16 * Server responded with a response on thread http-nio-8080-exec-5
16 < 200
16 < Content-Type: application/json

2021-07-14T08:15:55,489+0000 lvl='INFO', log='nodes_info#refresh', th='Ruby-0-Thread-2: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='48a9635e-0333-4302-8401-71d657e2e9e6', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:15:55.489000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='13.0'

2021-07-14T08:15:55,521+0000 lvl='INFO', log='', th='Ruby-0-Thread-3: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:55.520000 #10364]  INFO -- : Will retry connection after 0.699 seconds

2021-07-14T08:15:56,221+0000 lvl='INFO', log='', th='Ruby-0-Thread-3: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:56.221000 #10364]  INFO -- : Connecting to event stream at http://127.0.0.1:8080/plugins/killbill-osgi-logger

2021-07-14T08:15:56,263+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-10', xff='', rId='', tok='', aRId='', tRId='', 17 * Server has received a request on thread http-nio-8080-exec-10
17 > GET http://127.0.0.1/plugins/killbill-osgi-logger
17 > accept: text/event-stream
17 > cache-control: no-cache
17 > host: 127.0.0.1

2021-07-14T08:15:56,382+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-10', xff='', rId='b6c19567-9f53-4441-be8e-7f018f6083d0', tok='', aRId='', tRId='', 17 * Server responded with a response on thread http-nio-8080-exec-10
17 < 200
17 < Content-Type: text/event-stream

2021-07-14T08:15:56,384+0000 lvl='INFO', log='LogEntriesManager', th='http-nio-8080-exec-3', xff='', rId='', tok='', aRId='', tRId='', Created new cache 88ea9b43-d431-4c28-babe-454ebd745879 (2 active)
2021-07-14T08:15:56,466+0000 lvl='INFO', log='', th='Ruby-0-Thread-3: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:56.465000 #10364]  INFO -- : Will retry connection after 1.207 seconds

2021-07-14T08:15:57,673+0000 lvl='INFO', log='', th='Ruby-0-Thread-3: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:15:57.673000 #10364]  INFO -- : Connecting to event stream at http://127.0.0.1:8080/plugins/killbill-osgi-logger

2021-07-14T08:15:57,680+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-7', xff='', rId='', tok='', aRId='', tRId='', 18 * Server has received a request on thread http-nio-8080-exec-7
18 > GET http://127.0.0.1/plugins/killbill-osgi-logger
18 > accept: text/event-stream
18 > cache-control: no-cache
18 > host: 127.0.0.1

2021-07-14T08:15:57,685+0000 lvl='INFO', log='LogEntriesManager', th='http-nio-8080-exec-2', xff='', rId='', tok='', aRId='', tRId='', Created new cache bdb31e8e-8066-48d2-afbf-29ca25245878 (3 active)
2021-07-14T08:15:57,685+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-7', xff='', rId='453d44e3-b964-41b4-ab7c-c4bf1045fc7e', tok='', aRId='', tRId='', 18 * Server responded with a response on thread http-nio-8080-exec-7
18 < 200
18 < Content-Type: text/event-stream

2021-07-14T08:16:25,577+0000 lvl='INFO', log='', th='Ruby-0-Thread-3: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:25.576000 #10364]  INFO -- : Stream connection closed

2021-07-14T08:16:25,636+0000 lvl='INFO', log='', th='Ruby-0-Thread-2: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:25.635000 #10364]  INFO -- : Completed 200 OK in 30199ms (ActiveRecord: 9.0ms)

2021-07-14T08:16:27,096+0000 lvl='INFO', log='', th='http-nio-8080-exec-8', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:27.096000 #10364]  INFO -- : Started GET "/kaui/kpm/nodes_info/refresh.js?kb_host=http%3A%2F%2F127.0.0.1%3A8080" for 0:0:0:0:0:0:0:1 at 2021-07-14 03:16:27 -0500

2021-07-14T08:16:27,111+0000 lvl='INFO', log='', th='Ruby-0-Thread-4: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:27.111000 #10364]  INFO -- : Processing by KPM::NodesInfoController#refresh as JS

2021-07-14T08:16:27,111+0000 lvl='INFO', log='', th='Ruby-0-Thread-4: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:27.111000 #10364]  INFO -- :   Parameters: {"kb_host"=>"http://127.0.0.1:8080"}

2021-07-14T08:16:27,143+0000 lvl='INFO', log='nodes_info#refresh', th='Ruby-0-Thread-4: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='04c2ce99-3b55-4924-a60a-5094e3eb6991', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:16:27.143000 #10364]  INFO -- KillBillClient: Request method='GET', uri='http://127.0.0.1:8080/1.0/kb/security/subject'

2021-07-14T08:16:27,158+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', 19 * Server has received a request on thread http-nio-8080-exec-5
19 > GET http://127.0.0.1:8080/1.0/kb/security/subject
19 > accept: application/json
19 > accept-encoding: gzip;q=1.0,deflate;q=0.6,identity;q=0.3
19 > cookie: JSESSIONID=b1e3e826-87cd-41c9-99d7-8679e61a4689
19 > host: 127.0.0.1:8080
19 > user-agent: killbill/3.2.0; jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 25.291-b10 on 1.8.0_291-b10 +jit [mswin32-x86_64]

2021-07-14T08:16:27,158+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-5', xff='', rId='61c2f30f-41ba-4338-b538-f1d3e9bd9542', tok='', aRId='', tRId='', 19 * Server responded with a response on thread http-nio-8080-exec-5
19 < 200
19 < Content-Type: application/json

2021-07-14T08:16:27,158+0000 lvl='INFO', log='nodes_info#refresh', th='Ruby-0-Thread-4: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/actionpack-5.1.0/lib/action_controller/metal/live.rb:286', xff='', rId='04c2ce99-3b55-4924-a60a-5094e3eb6991', aId='', tId='5b04e2f1-6b6b-466e-a98b-f8e669601351', I, [2021-07-14T03:16:27.158000 #10364]  INFO -- KillBillClient: Response code='200', reason='OK', latency='15.0'

2021-07-14T08:16:27,205+0000 lvl='INFO', log='', th='Ruby-0-Thread-5: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:27.205000 #10364]  INFO -- : Will retry connection after 0.671 seconds

2021-07-14T08:16:27,883+0000 lvl='INFO', log='', th='Ruby-0-Thread-5: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:27.883000 #10364]  INFO -- : Connecting to event stream at http://127.0.0.1:8080/plugins/killbill-osgi-logger

2021-07-14T08:16:27,883+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-10', xff='', rId='', tok='', aRId='', tRId='', 20 * Server has received a request on thread http-nio-8080-exec-10
20 > GET http://127.0.0.1/plugins/killbill-osgi-logger
20 > accept: text/event-stream
20 > cache-control: no-cache
20 > host: 127.0.0.1
20 > last-event-id: 1f12fa7d-16a6-4521-baf7-4fffffd7d062

2021-07-14T08:16:27,883+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-10', xff='', rId='8149b1c6-2871-432c-b605-e2642ac2b3b8', tok='', aRId='', tRId='', 20 * Server responded with a response on thread http-nio-8080-exec-10
20 < 200
20 < Content-Type: text/event-stream

2021-07-14T08:16:27,883+0000 lvl='INFO', log='LogEntriesManager', th='http-nio-8080-exec-3', xff='', rId='', tok='', aRId='', tRId='', Created new cache f58fa9ba-43d8-47dd-9304-7b8491d0c908 (4 active)
2021-07-14T08:16:27,883+0000 lvl='INFO', log='', th='Ruby-0-Thread-5: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:27.883000 #10364]  INFO -- : Will retry connection after 1.201 seconds

2021-07-14T08:16:29,099+0000 lvl='INFO', log='', th='Ruby-0-Thread-5: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:29.099000 #10364]  INFO -- : Connecting to event stream at http://127.0.0.1:8080/plugins/killbill-osgi-logger

2021-07-14T08:16:29,106+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-7', xff='', rId='', tok='', aRId='', tRId='', 21 * Server has received a request on thread http-nio-8080-exec-7
21 > GET http://127.0.0.1/plugins/killbill-osgi-logger
21 > accept: text/event-stream
21 > cache-control: no-cache
21 > host: 127.0.0.1
21 > last-event-id: 1f12fa7d-16a6-4521-baf7-4fffffd7d062

2021-07-14T08:16:29,106+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-7', xff='', rId='4cc202f6-806b-4f63-bc51-40eae648e2b6', tok='', aRId='', tRId='', 21 * Server responded with a response on thread http-nio-8080-exec-7
21 < 200
21 < Content-Type: text/event-stream

2021-07-14T08:16:29,106+0000 lvl='INFO', log='LogEntriesManager', th='http-nio-8080-exec-2', xff='', rId='', tok='', aRId='', tRId='', Created new cache ba56c63d-65cb-4322-bf0c-5717ea6250f6 (5 active)
2021-07-14T08:16:29,106+0000 lvl='INFO', log='', th='Ruby-0-Thread-5: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:29.106000 #10364]  INFO -- : Will retry connection after 3.840 seconds

2021-07-14T08:16:32,954+0000 lvl='INFO', log='', th='Ruby-0-Thread-5: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:32.954000 #10364]  INFO -- : Connecting to event stream at http://127.0.0.1:8080/plugins/killbill-osgi-logger

2021-07-14T08:16:32,954+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-9', xff='', rId='', tok='', aRId='', tRId='', 22 * Server has received a request on thread http-nio-8080-exec-9
22 > GET http://127.0.0.1/plugins/killbill-osgi-logger
22 > accept: text/event-stream
22 > cache-control: no-cache
22 > host: 127.0.0.1
22 > last-event-id: 1f12fa7d-16a6-4521-baf7-4fffffd7d062

2021-07-14T08:16:32,954+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-9', xff='', rId='5675d972-7b13-45f6-8ab0-5c0b033b2940', tok='', aRId='', tRId='', 22 * Server responded with a response on thread http-nio-8080-exec-9
22 < 200
22 < Content-Type: text/event-stream

2021-07-14T08:16:32,954+0000 lvl='INFO', log='LogEntriesManager', th='http-nio-8080-exec-1', xff='', rId='', tok='', aRId='', tRId='', Created new cache 4e1e851d-5fbb-4131-8ff3-99c2c7fc939a (6 active)
2021-07-14T08:16:32,954+0000 lvl='INFO', log='', th='Ruby-0-Thread-5: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:32.954000 #10364]  INFO -- : Will retry connection after 6.250 seconds

2021-07-14T08:16:39,220+0000 lvl='INFO', log='', th='Ruby-0-Thread-5: C:/Tomcat/apache-tomcat-8.5.65/webapps/kaui/WEB-INF/gems/gems/ld-eventsource-1.0.3/lib/ld-eventsource/client.rb:119', xff='', rId='', aId='', tId='', I, [2021-07-14T03:16:39.220000 #10364]  INFO -- : Connecting to event stream at http://127.0.0.1:8080/plugins/killbill-osgi-logger

2021-07-14T08:16:39,220+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-6', xff='', rId='', tok='', aRId='', tRId='', 23 * Server has received a request on thread http-nio-8080-exec-6
23 > GET http://127.0.0.1/plugins/killbill-osgi-logger
23 > accept: text/event-stream
23 > cache-control: no-cache
23 > host: 127.0.0.1
23 > last-event-id: 1f12fa7d-16a6-4521-baf7-4fffffd7d062

2021-07-14T08:16:39,236+0000 lvl='INFO', log='LogEntriesManager', th='http-nio-8080-exec-5', xff='', rId='', tok='', aRId='', tRId='', Created new cache 8a0cdff5-c5e9-4b89-8bab-9df1e9521d10 (7 active)
2021-07-14T08:16:39,236+0000 lvl='INFO', log='LoggingFeature', th='http-nio-8080-exec-6', xff='', rId='b154bb33-86e8-4b60-98e6-679eee0ad6ac', tok='', aRId='', tRId='', 23 * Server responded with a response on thread http-nio-8080-exec-6
23 < 200
23 < Content-Type: text/event-stream