NOTE: Picked up JDK_JAVA_OPTIONS: --add-opens=java.base/java.lang=ALL-UNNAMED --add-opens=java.base/java.io=ALL-UNNAMED --add-opens=java.base/java.util=ALL-UNNAMED --add-opens=java.base/java.util.concurrent=ALL-UNNAMED --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED 16-Jun-2022 19:13:59.481 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version name: Apache Tomcat/8.5.81 16-Jun-2022 19:13:59.484 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server built: Jun 8 2022 21:30:15 UTC 16-Jun-2022 19:13:59.485 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Server version number: 8.5.81.0 16-Jun-2022 19:13:59.485 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Name: Windows 10 16-Jun-2022 19:13:59.485 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log OS Version: 10.0 16-Jun-2022 19:13:59.486 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Architecture: amd64 16-Jun-2022 19:13:59.486 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Java Home: C:\KillBillTest\jdk-18.0.1.1 16-Jun-2022 19:13:59.486 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Version: 18.0.1.1+2-6 16-Jun-2022 19:13:59.487 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log JVM Vendor: Oracle Corporation 16-Jun-2022 19:13:59.487 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_BASE: C:\KillBillTest\apache-tomcat-8.5.81 16-Jun-2022 19:13:59.487 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log CATALINA_HOME: C:\KillBillTest\apache-tomcat-8.5.81 16-Jun-2022 19:13:59.488 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.lang=ALL-UNNAMED 16-Jun-2022 19:13:59.488 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.io=ALL-UNNAMED 16-Jun-2022 19:13:59.488 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.util=ALL-UNNAMED 16-Jun-2022 19:13:59.488 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.base/java.util.concurrent=ALL-UNNAMED 16-Jun-2022 19:13:59.489 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: --add-opens=java.rmi/sun.rmi.transport=ALL-UNNAMED 16-Jun-2022 19:13:59.489 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.config.file=C:\KillBillTest\apache-tomcat-8.5.81\conf\logging.properties 16-Jun-2022 19:13:59.490 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.util.logging.manager=org.apache.juli.ClassLoaderLogManager 16-Jun-2022 19:13:59.490 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djdk.tls.ephemeralDHKeySize=2048 16-Jun-2022 19:13:59.491 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.protocol.handler.pkgs=org.apache.catalina.webresources 16-Jun-2022 19:13:59.492 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dignore.endorsed.dirs= 16-Jun-2022 19:13:59.493 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.base=C:\KillBillTest\apache-tomcat-8.5.81 16-Jun-2022 19:13:59.493 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Dcatalina.home=C:\KillBillTest\apache-tomcat-8.5.81 16-Jun-2022 19:13:59.494 INFO [main] org.apache.catalina.startup.VersionLoggerListener.log Command line argument: -Djava.io.tmpdir=C:\KillBillTest\apache-tomcat-8.5.81\temp 16-Jun-2022 19:13:59.494 INFO [main] org.apache.catalina.core.AprLifecycleListener.lifecycleEvent The Apache Tomcat Native library which allows using OpenSSL was not found on the java.library.path: [C:\KillBillTest\jdk-18.0.1.1\bin;C:\Windows\Sun\Java\bin;C:\Windows\system32;C:\Windows;C:\Python310\Scripts\;C:\Python310\;C:\Program Files (x86)\Common Files\Oracle\Java\javapath;C:\Windows\system32;C:\Windows;C:\Windows\System32\Wbem;C:\Windows\System32\WindowsPowerShell\v1.0\;C:\Windows\System32\OpenSSH\;C:\Program Files\PuTTY\;C:\Program Files\apache-maven-3.6.3\bin;C:\Program Files\Git\cmd;C:\Program Files\Amazon\AWSCLI\bin\;C:\OpenShift;C:\ampl.mswin64;C:\Program Files (x86)\nodejs\;C:\ProgramData\chocolatey\bin;;C:\Program Files\Docker\Docker\resources\bin;C:\ProgramData\DockerDesktop\version-bin;C:\Program Files\MySQL\MySQL Shell 8.0\bin\;C:\Ruby27\bin;C:\Users\m.cucciniello\AppData\Local\Programs\Python\Python39-32\Scripts\;C:\Users\m.cucciniello\AppData\Local\Programs\Python\Python39-32\;C:\Users\m.cucciniello\AppData\Local\Microsoft\WindowsApps;C:\Program Files\JetBrains\PyCharm 2020.3.3\bin;;C:\graphviz-2.38;C:\Users\m.cucciniello\AppData\Roaming\npm;.] 16-Jun-2022 19:13:59.597 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-8080"] 16-Jun-2022 19:13:59.631 INFO [main] org.apache.coyote.AbstractProtocol.init Initializing ProtocolHandler ["http-nio-9090"] 16-Jun-2022 19:13:59.633 INFO [main] org.apache.catalina.startup.Catalina.load Initialization processed in 654 ms 16-Jun-2022 19:13:59.687 INFO [main] org.apache.catalina.core.StandardService.startInternal Starting service [Catalina] 16-Jun-2022 19:13:59.687 INFO [main] org.apache.catalina.core.StandardEngine.startInternal Starting Servlet engine: [Apache Tomcat/8.5.81] 16-Jun-2022 19:13:59.713 INFO [localhost-startStop-1] org.apache.catalina.startup.HostConfig.deployWAR Deploying web application archive [C:\KillBillTest\apache-tomcat-8.5.81\webapps\ROOT.war] 16-Jun-2022 19:14:15.358 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. 2022-06-16T17:14:15,865+0000 lvl='INFO', log='DefaultKillbillConfigSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Overwrite of user.timezone system property with Europe/Rome may break database serialization of date. Kill Bill will overwrite to GMT 2022-06-16T17:14:15,874+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' 2022-06-16T17:14:16,231+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()] 2022-06-16T17:14:16,281+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()] 2022-06-16T17:14:16,298+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()] 2022-06-16T17:14:16,302+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()] 2022-06-16T17:14:16,303+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()] 2022-06-16T17:14:16,304+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()] 2022-06-16T17:14:16,307+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()] 2022-06-16T17:14:16,308+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()] 2022-06-16T17:14:16,309+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()] 2022-06-16T17:14:16,944+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()] 2022-06-16T17:14:16,947+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()] 2022-06-16T17:14:16,947+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()] 2022-06-16T17:14:16,948+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()] 2022-06-16T17:14:16,953+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()] 2022-06-16T17:14:16,960+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()] 2022-06-16T17:14:16,961+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()] 2022-06-16T17:14:16,961+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()] 2022-06-16T17:14:16,964+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()] 2022-06-16T17:14:16,967+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()] 2022-06-16T17:14:16,968+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()] 2022-06-16T17:14:16,969+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()] 2022-06-16T17:14:16,970+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()] 2022-06-16T17:14:18,500+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()] 2022-06-16T17:14:18,500+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()] 2022-06-16T17:14:18,502+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()] 2022-06-16T17:14:18,505+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()] 2022-06-16T17:14:18,507+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()] 2022-06-16T17:14:18,509+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()] 2022-06-16T17:14:18,512+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()] 2022-06-16T17:14:18,513+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()] 2022-06-16T17:14:18,514+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()] 2022-06-16T17:14:18,515+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()] 2022-06-16T17:14:18,516+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()] 2022-06-16T17:14:18,517+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()] 2022-06-16T17:14:18,518+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()] 2022-06-16T17:14:18,519+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()] 2022-06-16T17:14:18,524+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()] 2022-06-16T17:14:18,526+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()] 2022-06-16T17:14:18,527+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()] 2022-06-16T17:14:18,528+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()] 2022-06-16T17:14:18,529+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [jdbc:mysql://127.0.0.1:3306/killbill?allowPublicKeyRetrieval=true&useSSL=false] for [org.killbill.dao.url] on [org.killbill.commons.jdbi.guice.DaoConfig#getJdbcUrl()] 2022-06-16T17:14:18,531+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()] 2022-06-16T17:14:18,532+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()] 2022-06-16T17:14:18,533+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()] 2022-06-16T17:14:18,534+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()] 2022-06-16T17:14:18,538+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()] 2022-06-16T17:14:18,540+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()] 2022-06-16T17:14:18,565+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()] 2022-06-16T17:14:18,565+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()] 2022-06-16T17:14:18,566+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()] 2022-06-16T17:14:18,568+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()] 2022-06-16T17:14:18,572+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()] 2022-06-16T17:14:18,572+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()] 2022-06-16T17:14:18,573+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()] 2022-06-16T17:14:18,574+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()] 2022-06-16T17:14:18,575+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()] 2022-06-16T17:14:18,576+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()] 2022-06-16T17:14:18,576+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()] 2022-06-16T17:14:18,577+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()] 2022-06-16T17:14:18,578+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()] 2022-06-16T17:14:18,578+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()] 2022-06-16T17:14:18,579+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()] 2022-06-16T17:14:18,580+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()] 2022-06-16T17:14:18,581+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()] 2022-06-16T17:14:18,581+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()] 2022-06-16T17:14:18,582+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()] 2022-06-16T17:14:18,587+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()] 2022-06-16T17:14:18,588+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()] 2022-06-16T17:14:18,590+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()] 2022-06-16T17:14:18,590+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()] 2022-06-16T17:14:18,591+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()] 2022-06-16T17:14:18,592+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()] 2022-06-16T17:14:18,593+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()] 2022-06-16T17:14:22,243+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()] 2022-06-16T17:14:22,247+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()] 2022-06-16T17:14:22,247+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()] 2022-06-16T17:14:22,249+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()] 2022-06-16T17:14:22,252+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()] 2022-06-16T17:14:22,253+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()] 2022-06-16T17:14:22,254+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()] 2022-06-16T17:14:22,255+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()] 2022-06-16T17:14:22,255+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()] 2022-06-16T17:14:22,256+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()] 2022-06-16T17:14:22,257+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()] 2022-06-16T17:14:22,258+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()] 2022-06-16T17:14:22,258+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [15s] for [org.killbill.persistent.bus.${instanceName}.shutdownTimeout] on [org.killbill.bus.api.PersistentBusConfig#getShutdownTimeout()] 2022-06-16T17:14:22,259+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()] 2022-06-16T17:14:22,260+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()] 2022-06-16T17:14:22,260+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()] 2022-06-16T17:14:22,260+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()] 2022-06-16T17:14:22,261+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()] 2022-06-16T17:14:22,262+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()] 2022-06-16T17:14:22,276+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()] 2022-06-16T17:14:22,277+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()] 2022-06-16T17:14:22,278+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()] 2022-06-16T17:14:22,279+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()] 2022-06-16T17:14:22,280+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()] 2022-06-16T17:14:22,281+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()] 2022-06-16T17:14:22,281+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()] 2022-06-16T17:14:22,283+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()] 2022-06-16T17:14:22,286+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()] 2022-06-16T17:14:22,286+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()] 2022-06-16T17:14:22,288+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()] 2022-06-16T17:14:22,288+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()] 2022-06-16T17:14:22,289+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [15s] for [org.killbill.persistent.bus.${instanceName}.shutdownTimeout] on [org.killbill.bus.api.PersistentBusConfig#getShutdownTimeout()] 2022-06-16T17:14:22,290+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()] 2022-06-16T17:14:22,291+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()] 2022-06-16T17:14:22,292+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()] 2022-06-16T17:14:22,292+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()] 2022-06-16T17:14:22,293+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()] 2022-06-16T17:14:22,294+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()] 2022-06-16T17:14:22,311+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()] 2022-06-16T17:14:22,311+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()] 2022-06-16T17:14:22,312+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()] 2022-06-16T17:14:22,314+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()] 2022-06-16T17:14:22,314+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()] 2022-06-16T17:14:22,317+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()] 2022-06-16T17:14:22,318+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()] 2022-06-16T17:14:22,320+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()] 2022-06-16T17:14:22,321+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()] 2022-06-16T17:14:22,321+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()] 2022-06-16T17:14:22,322+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()] 2022-06-16T17:14:22,323+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()] 2022-06-16T17:14:22,324+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [15s] for [org.killbill.notificationq.${instanceName}.shutdownTimeout] on [org.killbill.notificationq.api.NotificationQueueConfig#getShutdownTimeout()] 2022-06-16T17:14:22,325+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()] 2022-06-16T17:14:22,325+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()] 2022-06-16T17:14:22,326+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()] 2022-06-16T17:14:22,327+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()] 2022-06-16T17:14:22,327+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()] 2022-06-16T17:14:22,328+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()] 2022-06-16T17:14:22,337+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()] 2022-06-16T17:14:22,337+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()] 2022-06-16T17:14:22,338+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()] 2022-06-16T17:14:22,340+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()] 2022-06-16T17:14:22,341+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()] 2022-06-16T17:14:22,341+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()] 2022-06-16T17:14:22,342+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()] 2022-06-16T17:14:22,343+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()] 2022-06-16T17:14:22,344+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()] 2022-06-16T17:14:22,345+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()] 2022-06-16T17:14:22,345+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()] 2022-06-16T17:14:22,346+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()] 2022-06-16T17:14:22,350+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()] 2022-06-16T17:14:22,351+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()] 2022-06-16T17:14:22,352+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()] 2022-06-16T17:14:22,353+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()] 2022-06-16T17:14:22,354+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning value [jdbc:mysql://127.0.0.1:3306/killbill?allowPublicKeyRetrieval=true&useSSL=false] for [org.killbill.billing.osgi.dao.url] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getJdbcUrl()] 2022-06-16T17:14:22,355+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()] 2022-06-16T17:14:22,355+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()] 2022-06-16T17:14:22,356+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()] 2022-06-16T17:14:22,357+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()] 2022-06-16T17:14:22,357+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()] 2022-06-16T17:14:22,357+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()] 2022-06-16T17:14:22,359+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()] 2022-06-16T17:14:22,359+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()] 2022-06-16T17:14:22,368+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()] 2022-06-16T17:14:22,369+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()] 2022-06-16T17:14:22,370+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [/var/tmp/felix] for [org.killbill.osgi.root.dir] on [org.killbill.billing.osgi.config.OSGIConfig#getOSGIBundleRootDir()] 2022-06-16T17:14:22,370+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [/var/tmp/bundles] for [org.killbill.osgi.bundle.install.dir] on [org.killbill.billing.osgi.config.OSGIConfig#getRootInstallationDir()] 2022-06-16T17:14:22,371+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()] 2022-06-16T17:14:22,371+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()] 2022-06-16T17:14:22,375+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()] 2022-06-16T17:14:22,395+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()] 2022-06-16T17:14:22,400+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.cache.disabled] on [org.killbill.billing.util.config.definition.CacheConfig#getDisabledCaches()] 2022-06-16T17:14:22,404+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()] 2022-06-16T17:14:22,406+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()] 2022-06-16T17:14:22,407+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()] 2022-06-16T17:14:22,408+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()] 2022-06-16T17:14:22,408+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()] 2022-06-16T17:14:22,431+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()] 2022-06-16T17:14:22,432+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()] 2022-06-16T17:14:22,434+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()] 2022-06-16T17:14:22,473+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()] 2022-06-16T17:14:22,474+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()] 2022-06-16T17:14:22,481+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()] 2022-06-16T17:14:22,485+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()] 2022-06-16T17:14:22,486+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()] 2022-06-16T17:14:22,486+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()] 2022-06-16T17:14:22,487+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()] 2022-06-16T17:14:22,488+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()] 2022-06-16T17:14:22,491+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()] 2022-06-16T17:14:22,491+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.invoice.usage.missing.lenient] on [org.killbill.billing.util.config.definition.InvoiceConfig#isUsageMissingLenient()] 2022-06-16T17:14:22,493+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()] 2022-06-16T17:14:22,493+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()] 2022-06-16T17:14:22,494+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()] 2022-06-16T17:14:22,495+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()] 2022-06-16T17:14:22,496+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()] 2022-06-16T17:14:22,497+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()] 2022-06-16T17:14:22,498+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()] 2022-06-16T17:14:22,499+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()] 2022-06-16T17:14:22,594+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()] 2022-06-16T17:14:22,608+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [org/killbill/billing/util/invoice/templates/HtmlInvoiceTemplate.mustache] for [org.killbill.template.name] on [org.killbill.billing.util.template.translation.TranslatorConfig#getTemplateName()] 2022-06-16T17:14:22,609+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()] 2022-06-16T17:14:22,609+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [org/killbill/billing/util/invoice/translation/InvoiceTranslation] for [org.killbill.template.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceTemplateBundlePath()] 2022-06-16T17:14:22,610+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()] 2022-06-16T17:14:22,611+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()] 2022-06-16T17:14:22,611+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()] 2022-06-16T17:14:22,618+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()] 2022-06-16T17:14:22,662+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()] 2022-06-16T17:14:22,662+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()] 2022-06-16T17:14:22,663+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()] 2022-06-16T17:14:22,664+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()] 2022-06-16T17:14:22,669+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()] 2022-06-16T17:14:22,669+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.jaxrs.get.ro] on [org.killbill.billing.util.config.definition.JaxrsConfig#shouldGETUseROConnection()] 2022-06-16T17:14:22,709+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()] 2022-06-16T17:14:22,710+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()] 2022-06-16T17:14:22,711+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.url] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0Url()] 2022-06-16T17:14:22,714+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()] 2022-06-16T17:14:22,715+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()] 2022-06-16T17:14:22,716+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()] 2022-06-16T17:14:22,717+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.clientId] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ClientId()] 2022-06-16T17:14:22,717+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.clientSecret] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ClientSecret()] 2022-06-16T17:14:22,718+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [sub] for [org.killbill.security.auth0.usernameClaim] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0UsernameClaim()] 2022-06-16T17:14:22,718+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()] 2022-06-16T17:14:22,719+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()] 2022-06-16T17:14:22,719+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()] 2022-06-16T17:14:22,720+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()] 2022-06-16T17:14:22,720+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()] 2022-06-16T17:14:22,721+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()] 2022-06-16T17:14:22,721+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()] 2022-06-16T17:14:22,722+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5s] for [org.killbill.security.auth0.connectTimeout] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ConnectTimeout()] 2022-06-16T17:14:22,722+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.security.auth0.readTimeout] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ReadTimeout()] 2022-06-16T17:14:22,723+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.security.auth0.requestTimeout] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0RequestTimeout()] 2022-06-16T17:14:22,727+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()] 2022-06-16T17:14:22,728+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.security.auth0.allowedClockSkew] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0AllowedClockSkew()] 2022-06-16T17:14:22,729+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()] 2022-06-16T17:14:22,729+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.apiIdentifier] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0APIIdentifier()] 2022-06-16T17:14:22,730+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.issuer] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0Issuer()] 2022-06-16T17:14:22,731+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.audience] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0Audience()] 2022-06-16T17:14:22,731+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()] 2022-06-16T17:14:22,734+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()] 2022-06-16T17:14:22,735+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.databaseConnectionName] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0DatabaseConnectionName()] 2022-06-16T17:14:22,735+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()] 2022-06-16T17:14:23,013+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()] 2022-06-16T17:14:23,014+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()] 2022-06-16T17:14:23,014+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()] 2022-06-16T17:14:23,018+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()] 2022-06-16T17:14:23,021+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()] 2022-06-16T17:14:23,022+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()] 2022-06-16T17:14:23,022+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.url] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0Url()] 2022-06-16T17:14:23,023+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()] 2022-06-16T17:14:23,024+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()] 2022-06-16T17:14:23,025+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()] 2022-06-16T17:14:23,026+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.clientId] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ClientId()] 2022-06-16T17:14:23,026+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.clientSecret] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ClientSecret()] 2022-06-16T17:14:23,027+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [sub] for [org.killbill.security.auth0.usernameClaim] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0UsernameClaim()] 2022-06-16T17:14:23,028+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()] 2022-06-16T17:14:23,029+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()] 2022-06-16T17:14:23,029+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()] 2022-06-16T17:14:23,030+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()] 2022-06-16T17:14:23,030+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()] 2022-06-16T17:14:23,031+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()] 2022-06-16T17:14:23,032+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()] 2022-06-16T17:14:23,033+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5s] for [org.killbill.security.auth0.connectTimeout] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ConnectTimeout()] 2022-06-16T17:14:23,033+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.security.auth0.readTimeout] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ReadTimeout()] 2022-06-16T17:14:23,034+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.security.auth0.requestTimeout] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0RequestTimeout()] 2022-06-16T17:14:23,035+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()] 2022-06-16T17:14:23,035+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.security.auth0.allowedClockSkew] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0AllowedClockSkew()] 2022-06-16T17:14:23,036+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()] 2022-06-16T17:14:23,037+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.apiIdentifier] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0APIIdentifier()] 2022-06-16T17:14:23,038+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.issuer] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0Issuer()] 2022-06-16T17:14:23,038+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.audience] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0Audience()] 2022-06-16T17:14:23,041+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()] 2022-06-16T17:14:23,042+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()] 2022-06-16T17:14:23,044+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.databaseConnectionName] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0DatabaseConnectionName()] 2022-06-16T17:14:23,044+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()] 2022-06-16T17:14:23,050+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()] 2022-06-16T17:14:23,093+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()] 2022-06-16T17:14:23,096+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()] 2022-06-16T17:14:23,101+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [false] for [org.killbill.payment.method.overwrite] on [org.killbill.billing.util.config.definition.PaymentConfig#isAllowedToOverwritePaymentMethodId()] 2022-06-16T17:14:23,110+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()] 2022-06-16T17:14:23,114+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()] 2022-06-16T17:14:23,115+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()] 2022-06-16T17:14:23,117+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()] 2022-06-16T17:14:23,118+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()] 2022-06-16T17:14:23,120+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()] 2022-06-16T17:14:23,121+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()] 2022-06-16T17:14:23,122+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()] 2022-06-16T17:14:23,123+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()] 2022-06-16T17:14:23,123+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()] 2022-06-16T17:14:23,124+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()] 2022-06-16T17:14:23,137+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()] 2022-06-16T17:14:23,137+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()] 2022-06-16T17:14:23,138+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.url] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0Url()] 2022-06-16T17:14:23,139+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()] 2022-06-16T17:14:23,140+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()] 2022-06-16T17:14:23,140+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()] 2022-06-16T17:14:23,141+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.clientId] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ClientId()] 2022-06-16T17:14:23,142+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.clientSecret] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ClientSecret()] 2022-06-16T17:14:23,142+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [sub] for [org.killbill.security.auth0.usernameClaim] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0UsernameClaim()] 2022-06-16T17:14:23,143+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()] 2022-06-16T17:14:23,144+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()] 2022-06-16T17:14:23,144+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()] 2022-06-16T17:14:23,145+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()] 2022-06-16T17:14:23,145+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()] 2022-06-16T17:14:23,146+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()] 2022-06-16T17:14:23,149+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()] 2022-06-16T17:14:23,151+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [5s] for [org.killbill.security.auth0.connectTimeout] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ConnectTimeout()] 2022-06-16T17:14:23,151+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.security.auth0.readTimeout] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0ReadTimeout()] 2022-06-16T17:14:23,152+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.security.auth0.requestTimeout] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0RequestTimeout()] 2022-06-16T17:14:23,152+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()] 2022-06-16T17:14:23,153+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [60s] for [org.killbill.security.auth0.allowedClockSkew] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0AllowedClockSkew()] 2022-06-16T17:14:23,153+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()] 2022-06-16T17:14:23,154+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.apiIdentifier] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0APIIdentifier()] 2022-06-16T17:14:23,155+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.issuer] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0Issuer()] 2022-06-16T17:14:23,155+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.audience] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0Audience()] 2022-06-16T17:14:23,156+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()] 2022-06-16T17:14:23,157+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()] 2022-06-16T17:14:23,158+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning null default value for [org.killbill.security.auth0.databaseConnectionName] on [org.killbill.billing.util.config.definition.SecurityConfig#getShiroAuth0DatabaseConnectionName()] 2022-06-16T17:14:23,158+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()] 2022-06-16T17:14:23,163+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()] 2022-06-16T17:14:23,169+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()] 2022-06-16T17:14:23,170+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()] 2022-06-16T17:14:23,170+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()] 2022-06-16T17:14:23,171+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()] 2022-06-16T17:14:23,172+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()] 2022-06-16T17:14:23,173+0000 lvl='INFO', log='ConfigurationObjectFactory', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Assigning default value [true] for [org.killbill.jaxrs.get.ro] on [org.killbill.billing.util.config.definition.JaxrsConfig#shouldGETUseROConnection()] 2022-06-16T17:14:23,176+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()] 2022-06-16T17:14:24,334+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', main - Starting... 2022-06-16T17:14:24,450+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', main - Start completed. 2022-06-16T17:14:24,947+0000 lvl='INFO', log='PersistentBusProvider', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Creating Persistent bus for bus_events 2022-06-16T17:14:25,141+0000 lvl='INFO', log='PersistentBusProvider', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Creating Persistent bus for bus_ext_events 2022-06-16T17:14:25,202+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', shiro - Starting... 2022-06-16T17:14:25,209+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', shiro - Start completed. 2022-06-16T17:14:26,789+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 2022-06-16T17:14:26,790+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache account-immutable will use expiry configuration from template defaultCacheConfiguration 2022-06-16T17:14:27,041+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'account-immutable' 2022-06-16T17:14:27,042+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'account-immutable' created in EhcacheManager. 2022-06-16T17:14:27,075+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=account-immutable 2022-06-16T17:14:27,078+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=account-immutable 2022-06-16T17:14:27,084+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 2022-06-16T17:14:27,084+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache account-bcd will use expiry configuration from template defaultCacheConfiguration 2022-06-16T17:14:27,088+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'account-bcd' 2022-06-16T17:14:27,088+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'account-bcd' created in EhcacheManager. 2022-06-16T17:14:27,088+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=account-bcd 2022-06-16T17:14:27,091+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=account-bcd 2022-06-16T17:14:27,093+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 2022-06-16T17:14:27,094+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache record-id will use expiry configuration from template defaultCacheConfiguration 2022-06-16T17:14:27,098+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'record-id' 2022-06-16T17:14:27,099+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'record-id' created in EhcacheManager. 2022-06-16T17:14:27,100+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=record-id 2022-06-16T17:14:27,100+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=record-id 2022-06-16T17:14:27,103+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 2022-06-16T17:14:27,103+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 2022-06-16T17:14:27,106+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'account-record-id' 2022-06-16T17:14:27,108+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'account-record-id' created in EhcacheManager. 2022-06-16T17:14:27,109+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=account-record-id 2022-06-16T17:14:27,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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=account-record-id 2022-06-16T17:14:27,113+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 2022-06-16T17:14:27,113+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 2022-06-16T17:14:27,116+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-record-id' 2022-06-16T17:14:27,117+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-record-id' created in EhcacheManager. 2022-06-16T17:14:27,118+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-record-id 2022-06-16T17:14:27,119+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-record-id 2022-06-16T17:14:27,121+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 2022-06-16T17:14:27,123+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache object-id will use expiry configuration from template defaultCacheConfiguration 2022-06-16T17:14:27,126+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'object-id' 2022-06-16T17:14:27,126+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'object-id' created in EhcacheManager. 2022-06-16T17:14:27,127+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=object-id 2022-06-16T17:14:27,128+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=object-id 2022-06-16T17:14:27,131+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 2022-06-16T17:14:27,131+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant-catalog will use expiry configuration from template defaultCacheConfiguration 2022-06-16T17:14:27,134+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-catalog' 2022-06-16T17:14:27,134+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-catalog' created in EhcacheManager. 2022-06-16T17:14:27,136+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-catalog 2022-06-16T17:14:27,136+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-catalog 2022-06-16T17:14:27,139+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 2022-06-16T17:14:27,141+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant-config will use expiry configuration from template defaultCacheConfiguration 2022-06-16T17:14:27,144+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-config' 2022-06-16T17:14:27,144+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-config' created in EhcacheManager. 2022-06-16T17:14:27,145+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-config 2022-06-16T17:14:27,146+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-config 2022-06-16T17:14:27,149+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 2022-06-16T17:14:27,149+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 2022-06-16T17:14:27,152+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-overdue-config' 2022-06-16T17:14:27,152+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-overdue-config' created in EhcacheManager. 2022-06-16T17:14:27,153+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-overdue-config 2022-06-16T17:14:27,156+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-overdue-config 2022-06-16T17:14:27,159+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 2022-06-16T17:14:27,159+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant-kv will use expiry configuration from template defaultCacheConfiguration 2022-06-16T17:14:27,163+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-kv' 2022-06-16T17:14:27,163+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-kv' created in EhcacheManager. 2022-06-16T17:14:27,164+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-kv 2022-06-16T17:14:27,165+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-kv 2022-06-16T17:14:27,168+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Configuration of cache tenant will be supplemented by template defaultCacheConfiguration 2022-06-16T17:14:27,168+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache tenant will use expiry configuration from template defaultCacheConfiguration 2022-06-16T17:14:27,172+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant' 2022-06-16T17:14:27,173+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant' created in EhcacheManager. 2022-06-16T17:14:27,174+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant 2022-06-16T17:14:27,175+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant 2022-06-16T17:14:27,178+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 2022-06-16T17:14:27,179+0000 lvl='INFO', log='ConfigurationMerger', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache overridden-plan will use expiry configuration from template defaultCacheConfiguration 2022-06-16T17:14:27,182+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'overridden-plan' 2022-06-16T17:14:27,182+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'overridden-plan' created in EhcacheManager. 2022-06-16T17:14:27,183+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=overridden-plan 2022-06-16T17:14:27,184+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=overridden-plan 2022-06-16T17:14:27,186+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 2022-06-16T17:14:27,188+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 2022-06-16T17:14:27,191+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'tenant-payment-state-machine-config' 2022-06-16T17:14:27,191+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'tenant-payment-state-machine-config' created in EhcacheManager. 2022-06-16T17:14:27,192+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-payment-state-machine-config 2022-06-16T17:14:27,193+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=tenant-payment-state-machine-config 2022-06-16T17:14:27,196+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 2022-06-16T17:14:27,196+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 2022-06-16T17:14:27,199+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'account-id-from-bundle-id' 2022-06-16T17:14:27,199+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'account-id-from-bundle-id' created in EhcacheManager. 2022-06-16T17:14:27,201+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=account-id-from-bundle-id 2022-06-16T17:14:27,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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=account-id-from-bundle-id 2022-06-16T17:14:27,207+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 2022-06-16T17:14:27,208+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 2022-06-16T17:14:27,210+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'bundle-id-from-subscription-id' 2022-06-16T17:14:27,210+0000 lvl='INFO', log='EhcacheManager', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Cache 'bundle-id-from-subscription-id' created in EhcacheManager. 2022-06-16T17:14:27,212+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=bundle-id-from-subscription-id 2022-06-16T17:14:27,212+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=bundle-id-from-subscription-id 2022-06-16T17:14:27,219+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. 2022-06-16T17:14:27,220+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 2022-06-16T17:14:27,221+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 2022-06-16T17:14:27,224+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' 2022-06-16T17:14:27,225+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. 2022-06-16T17:14:27,226+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=org.killbill.billing.util.security.shiro.realm.KillBillJdbcRealm.authorizationCache.1 2022-06-16T17:14:27,227+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=org.killbill.billing.util.security.shiro.realm.KillBillJdbcRealm.authorizationCache.1 2022-06-16T17:14:27,230+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] 2022-06-16T17:14:27,318+0000 lvl='INFO', log='BusOptimizerNoop', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Feature BusOptimizer is OFF 2022-06-16T17:14:27,332+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 2022-06-16T17:14:27,758+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 2022-06-16T17:14:27,805+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', osgi - Starting... 2022-06-16T17:14:27,810+0000 lvl='INFO', log='HikariDataSource', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', osgi - Start completed. 2022-06-16T17:14:27,815+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:/KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-payment-0.22.29.jar!/org/killbill/billing/payment/retry/RetryStates.xml 2022-06-16T17:14:27,860+0000 lvl='INFO', log='DefaultPaymentProviderPluginRegistry', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering service='__EXTERNAL_PAYMENT__' 2022-06-16T17:14:27,862+0000 lvl='INFO', log='DefaultPaymentProviderPluginRegistry', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering service='__DEFAULT_PAYMENT_CONTROL__' 2022-06-16T17:14:27,863+0000 lvl='INFO', log='DefaultPaymentProviderPluginRegistry', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Registering service='__INVOICE_PAYMENT_CONTROL_PLUGIN__' 2022-06-16T17:14:27,890+0000 lvl='INFO', log='InvoiceOptimizerNoop', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Feature InvoiceOptimizer is OFF 2022-06-16T17:14:28,719+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. 2022-06-16T17:14:28,720+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 2022-06-16T17:14:28,721+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 2022-06-16T17:14:28,723+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2' 2022-06-16T17:14:28,725+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. 2022-06-16T17:14:28,726+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2 2022-06-16T17:14:28,726+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=org.killbill.billing.server.security.KillbillJdbcTenantRealm.authenticationCache.2 2022-06-16T17:14:28,729+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] 2022-06-16T17:14:28,729+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. 2022-06-16T17:14:28,731+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 2022-06-16T17:14:28,731+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 2022-06-16T17:14:28,733+0000 lvl='INFO', log='EhcacheLoggingListener', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Added Ehcache 'org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2' 2022-06-16T17:14:28,734+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. 2022-06-16T17:14:28,735+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2 2022-06-16T17:14:28,735+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./KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-util-0.22.29.jar!/ehcache.xml,Cache=org.killbill.billing.server.security.KillbillJdbcTenantRealm.authorizationCache.2 2022-06-16T17:14:28,737+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] 2022-06-16T17:14:28,830+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage BOOT 2022-06-16T17:14:28,834+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler init for service nodes-service 2022-06-16T17:14:29,019+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage LOAD_CATALOG 2022-06-16T17:14:29,020+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler loadCatalog for service catalog-service 2022-06-16T17:14:29,021+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 2022-06-16T17:14:29,148+0000 lvl='INFO', log='DefaultCatalogService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Successfully loaded the default catalog SpyCarAdvanced.xml 2022-06-16T17:14:29,149+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler loadConfig for service overdue-service 2022-06-16T17:14:29,151+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 2022-06-16T17:14:29,173+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage INIT_BUS 2022-06-16T17:14:29,173+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initBus for service bus-service 2022-06-16T17:14:29,185+0000 lvl='INFO', log='DBBackedQueueWithInflightQueue', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', DBBackedQueue-bus_events Inserting 0 entries into inflightQ during initialization 2022-06-16T17:14:29,185+0000 lvl='INFO', log='DBBackedQueueWithInflightQueue', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', DBBackedQueue-bus_events Initialized with queueId=1, mode=STICKY_EVENTS 2022-06-16T17:14:29,186+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initBus for service external-bus-service 2022-06-16T17:14:29,191+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 2022-06-16T17:14:29,191+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 2022-06-16T17:14:29,192+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage INIT_PLUGIN 2022-06-16T17:14:29,192+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service osgi-service 2022-06-16T17:14:29,197+0000 lvl='INFO', log='DefaultOSGIService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Deleted recursively C:\var\tmp\felix\osgi-cache\bundle0 2022-06-16T17:14:29,203+0000 lvl='INFO', log='DefaultOSGIService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Deleted recursively C:\var\tmp\felix\osgi-cache Problem creating boot delegation class loader: java.lang.reflect.InaccessibleObjectException: Unable to make protected java.security.SecureClassLoader(java.lang.ClassLoader) accessible: module java.base does not "opens java.security" to unnamed module @1fefe45d ERROR: Unable to start system bundle. (java.lang.Error: factory already defined) java.lang.Error: factory already defined at java.base/java.net.URL.setURLStreamHandlerFactory(URL.java:1228) at org.apache.felix.framework.URLHandlers.(URLHandlers.java:188) at org.apache.felix.framework.URLHandlers.registerFrameworkInstance(URLHandlers.java:624) at org.apache.felix.framework.URLHandlersActivator.start(URLHandlersActivator.java:71) at org.apache.felix.framework.util.SecureAction.startActivator(SecureAction.java:645) at org.apache.felix.framework.Felix$SystemBundleActivator.start(Felix.java:4701) at org.apache.felix.framework.util.SecureAction.startActivator(SecureAction.java:645) at org.apache.felix.framework.Felix.init(Felix.java:791) at org.killbill.billing.osgi.DefaultOSGIService.createAndInitFelixFrameworkWithSystemBundle(DefaultOSGIService.java:174) at org.killbill.billing.osgi.DefaultOSGIService.createAndInitFramework(DefaultOSGIService.java:159) at org.killbill.billing.osgi.DefaultOSGIService.initialize(DefaultOSGIService.java:92) at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104) at java.base/java.lang.reflect.Method.invoke(Method.java:577) at org.killbill.billing.lifecycle.DefaultLifecycle.doFireStage(DefaultLifecycle.java:154) at org.killbill.billing.lifecycle.DefaultLifecycle.fireSequence(DefaultLifecycle.java:141) at org.killbill.billing.lifecycle.DefaultLifecycle.fireStartupSequencePriorEventRegistration(DefaultLifecycle.java:82) at org.killbill.billing.server.listeners.KillbillPlatformGuiceListener.startLifecycle(KillbillPlatformGuiceListener.java:299) at org.killbill.billing.server.listeners.KillbillPlatformGuiceListener.contextInitialized(KillbillPlatformGuiceListener.java:129) at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4763) at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5232) at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:183) at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:753) at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:727) at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:695) at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1016) at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1903) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:833) 2022-06-16T17:14:29,535+0000 lvl='WARN', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle failed to invoke lifecycle handler java.lang.reflect.InvocationTargetException: null at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:119) at java.base/java.lang.reflect.Method.invoke(Method.java:577) at org.killbill.billing.lifecycle.DefaultLifecycle.doFireStage(DefaultLifecycle.java:154) at org.killbill.billing.lifecycle.DefaultLifecycle.fireSequence(DefaultLifecycle.java:141) at org.killbill.billing.lifecycle.DefaultLifecycle.fireStartupSequencePriorEventRegistration(DefaultLifecycle.java:82) at org.killbill.billing.server.listeners.KillbillPlatformGuiceListener.startLifecycle(KillbillPlatformGuiceListener.java:299) at org.killbill.billing.server.listeners.KillbillPlatformGuiceListener.contextInitialized(KillbillPlatformGuiceListener.java:129) at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4763) at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5232) at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:183) at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:753) at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:727) at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:695) at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1016) at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1903) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:833) Caused by: java.lang.RuntimeException: Unable to start system bundle. at org.apache.felix.framework.Felix.init(Felix.java:798) at org.killbill.billing.osgi.DefaultOSGIService.createAndInitFelixFrameworkWithSystemBundle(DefaultOSGIService.java:174) at org.killbill.billing.osgi.DefaultOSGIService.createAndInitFramework(DefaultOSGIService.java:159) at org.killbill.billing.osgi.DefaultOSGIService.initialize(DefaultOSGIService.java:92) at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104) ... 19 common frames omitted 2022-06-16T17:14:29,536+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage INIT_SERVICE 2022-06-16T17:14:29,537+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service security-service 2022-06-16T17:14:29,540+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service config-service 2022-06-16T17:14:29,540+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service broadcast-service 2022-06-16T17:14:29,555+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service extBusEvent-listener-service 2022-06-16T17:14:29,561+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service tenant-service 2022-06-16T17:14:29,615+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service catalog-service 2022-06-16T17:14:29,616+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service subscription-service 2022-06-16T17:14:29,618+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service entitlement-service 2022-06-16T17:14:29,619+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service invoice-service 2022-06-16T17:14:29,623+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service invoice-listener-service 2022-06-16T17:14:29,623+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service payment-service 2022-06-16T17:14:29,625+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:/KillBillTest/apache-tomcat-8.5.81/webapps/ROOT/WEB-INF/lib/killbill-payment-0.22.29.jar!/org/killbill/billing/payment/PaymentStates.xml 2022-06-16T17:14:29,663+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service overdue-service 2022-06-16T17:14:29,665+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler initialize for service jaxrs-service 2022-06-16T17:14:29,666+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler registerForNotifications for service beatrix-service 2022-06-16T17:14:29,669+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler registerForNotifications for service server-service 2022-06-16T17:14:29,670+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage START_PLUGIN 2022-06-16T17:14:29,670+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service osgi-service 2022-06-16T17:14:29,672+0000 lvl='WARN', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle failed to invoke lifecycle handler java.lang.reflect.InvocationTargetException: null at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:116) at java.base/java.lang.reflect.Method.invoke(Method.java:577) at org.killbill.billing.lifecycle.DefaultLifecycle.doFireStage(DefaultLifecycle.java:154) at org.killbill.billing.lifecycle.DefaultLifecycle.fireSequence(DefaultLifecycle.java:141) at org.killbill.billing.lifecycle.DefaultLifecycle.fireStartupSequencePriorEventRegistration(DefaultLifecycle.java:82) at org.killbill.billing.server.listeners.KillbillPlatformGuiceListener.startLifecycle(KillbillPlatformGuiceListener.java:299) at org.killbill.billing.server.listeners.KillbillPlatformGuiceListener.contextInitialized(KillbillPlatformGuiceListener.java:129) at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4763) at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5232) at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:183) at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:753) at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:727) at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:695) at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1016) at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1903) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:833) Caused by: java.lang.NullPointerException: Cannot invoke "java.util.List.iterator()" because "this.bundleWithConfigs" is null at org.killbill.billing.osgi.BundleRegistry.startBundles(BundleRegistry.java:106) at org.killbill.billing.osgi.DefaultOSGIService.start(DefaultOSGIService.java:107) at java.base/jdk.internal.reflect.DirectMethodHandleAccessor.invoke(DirectMethodHandleAccessor.java:104) ... 19 common frames omitted 2022-06-16T17:14:29,673+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage START_SERVICE 2022-06-16T17:14:29,673+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service nodes-service 2022-06-16T17:14:29,723+0000 lvl='INFO', log='DefaultKillbillNodesService', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Created nodeInfo for SYN25164 2022-06-16T17:14:29,723+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service broadcast-service 2022-06-16T17:14:29,725+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service extBusEvent-listener-service 2022-06-16T17:14:29,728+0000 lvl='INFO', log='DBBackedQueue', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', DBBackedQueue-notifications Initialized mode=STICKY_POLLING 2022-06-16T17:14:29,729+0000 lvl='INFO', log='DefaultReaper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', NotificationReaper: Starting... reapThresholdMillis=600000, schedulePeriodMillis=180000 2022-06-16T17:14:29,732+0000 lvl='INFO', log='DefaultQueueLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', notifications: Starting... 2022-06-16T17:14:29,735+0000 lvl='INFO', log='DefaultQueueLifecycle', th='notifications-lifecycle-completion-th-1', xff='', rId='', tok='', aRId='', tRId='', notifications: Completion thread notifications-lifecycle-completion-th-1 [40] starting 2022-06-16T17:14:29,735+0000 lvl='INFO', log='DefaultQueueLifecycle', th='notifications-lifecycle-completion-th-2', xff='', rId='', tok='', aRId='', tRId='', notifications: Completion thread notifications-lifecycle-completion-th-2 [41] starting 2022-06-16T17:14:29,738+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service tenant-service 2022-06-16T17:14:29,740+0000 lvl='INFO', log='DefaultQueueLifecycle', th='notifications-lifecycle-dispatcher-th-1', xff='', rId='', tok='', aRId='', tRId='', notifications: Dispatching thread notifications-lifecycle-dispatcher-th-1 [42] starting 2022-06-16T17:14:29,741+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service subscription-service 2022-06-16T17:14:29,742+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service entitlement-service 2022-06-16T17:14:29,743+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service invoice-service 2022-06-16T17:14:29,744+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service invoice-listener-service 2022-06-16T17:14:29,745+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service payment-service 2022-06-16T17:14:29,746+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service overdue-service 2022-06-16T17:14:29,746+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler start for service server-service 2022-06-16T17:14:29,747+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle firing stage START_BUS 2022-06-16T17:14:29,747+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler startBus for service bus-service 2022-06-16T17:14:29,748+0000 lvl='INFO', log='DefaultReaper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', BusReaper: Starting... reapThresholdMillis=600000, schedulePeriodMillis=180000 2022-06-16T17:14:29,749+0000 lvl='INFO', log='DefaultQueueLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', bus_events: Starting... 2022-06-16T17:14:29,754+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_events-lifecycle-completion-th-1', xff='', rId='', tok='', aRId='', tRId='', bus_events: Completion thread bus_events-lifecycle-completion-th-1 [46] starting 2022-06-16T17:14:29,754+0000 lvl='INFO', log='DefaultLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Killbill lifecycle calling handler startBus for service external-bus-service 2022-06-16T17:14:29,755+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_events-lifecycle-completion-th-2', xff='', rId='', tok='', aRId='', tRId='', bus_events: Completion thread bus_events-lifecycle-completion-th-2 [47] starting 2022-06-16T17:14:29,755+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_events-lifecycle-dispatcher-th-1', xff='', rId='', tok='', aRId='', tRId='', bus_events: Dispatching thread bus_events-lifecycle-dispatcher-th-1 [48] starting 2022-06-16T17:14:29,756+0000 lvl='INFO', log='DefaultReaper', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', BusReaper: Starting... reapThresholdMillis=600000, schedulePeriodMillis=180000 2022-06-16T17:14:29,758+0000 lvl='INFO', log='DefaultQueueLifecycle', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', bus_ext_events: Starting... 2022-06-16T17:14:29,760+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_ext_events-lifecycle-completion-th-2', xff='', rId='', tok='', aRId='', tRId='', bus_ext_events: Completion thread bus_ext_events-lifecycle-completion-th-2 [51] starting 2022-06-16T17:14:29,760+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_ext_events-lifecycle-completion-th-1', xff='', rId='', tok='', aRId='', tRId='', bus_ext_events: Completion thread bus_ext_events-lifecycle-completion-th-1 [50] starting 2022-06-16T17:14:29,762+0000 lvl='INFO', log='DefaultQueueLifecycle', th='bus_ext_events-lifecycle-dispatcher-th-1', xff='', rId='', tok='', aRId='', tRId='', bus_ext_events: Dispatching thread bus_ext_events-lifecycle-dispatcher-th-1 [52] starting 2022-06-16T17:14:30,018+0000 lvl='INFO', log='Reflections', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Reflections took 181 ms to scan 1 urls, producing 307 keys and 668 values 2022-06-16T17:14:34,729+0000 lvl='WARN', log='SessionIdGeneratorBase', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Creation of SecureRandom instance for session ID generation using [SHA1PRNG] took [120] milliseconds. 2022-06-16T17:14:37,096+0000 lvl='INFO', log='KillbillGuiceFilter', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Kill Bill server has started 2022-06-16T17:14:37,097+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()] 2022-06-16T17:14:37,099+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()] 2022-06-16T17:14:37,099+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()] 2022-06-16T17:14:37,106+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 2022-06-16T17:14:37,108+0000 lvl='WARN', log='KillbillHealthcheck', th='localhost-startStop-1', xff='', rId='', tok='', aRId='', tRId='', Putting host in rotation 2022-06-16T17:15:23,913+0000 lvl='INFO', log='AbstractValidatingSessionManager', th='http-nio-8080-exec-1', xff='', rId='', tok='', aRId='', tRId='', Enabling session validation scheduler... 16-Jun-2022 19:16:30.346 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. 17:16:30,405 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback-test.xml] 17:16:30,406 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Could NOT find resource [logback.groovy] 17:16:30,408 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback.xml] at [file:/C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/classes/logback.xml] 17:16:30,514 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set 17:16:30,516 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender] 17:16:30,535 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [STDOUT] 17:16:30,546 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 17:16:30,624 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.rolling.RollingFileAppender] 17:16:30,631 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [MAIN] 17:16:30,656 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1107791402 - Will use gz compression 17:16:30,658 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1107791402 - Will use the pattern ./logs/kaui-%d{yyyy-MM-dd}.%i.out for the active file 17:16:30,664 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@193df356 - The date pattern is 'yyyy-MM-dd' from file name pattern './logs/kaui-%d{yyyy-MM-dd}.%i.out.gz'. 17:16:30,664 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@193df356 - Roll-over at midnight. 17:16:30,665 |-INFO in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@193df356 - Setting initial period to Thu Jun 16 17:09:31 GMT 2022 17:16:30,666 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@193df356 - SizeAndTimeBasedFNATP is deprecated. Use SizeAndTimeBasedRollingPolicy instead 17:16:30,666 |-WARN in ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP@193df356 - For more information see http://logback.qos.ch/manual/appenders.html#SizeAndTimeBasedRollingPolicy 17:16:30,670 |-INFO in c.q.l.core.rolling.TimeBasedRollingPolicy@1107791402 - Cleaning on start up 17:16:30,674 |-INFO in ch.qos.logback.core.joran.action.NestedComplexPropertyIA - Assuming default type [ch.qos.logback.classic.encoder.PatternLayoutEncoder] for [encoder] property 17:16:30,674 |-INFO in c.q.l.core.rolling.helper.TimeBasedArchiveRemover - first clean up after appender initialization 17:16:30,674 |-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. 17:16:30,677 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[MAIN] - Active log file name: ./logs/kaui.out 17:16:30,677 |-INFO in ch.qos.logback.core.rolling.RollingFileAppender[MAIN] - File property is set to [./logs/kaui.out] 17:16:30,680 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to INFO 17:16:30,680 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [MAIN] to Logger[ROOT] 17:16:30,682 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [STDOUT] to Logger[ROOT] 17:16:30,682 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration. 17:16:30,683 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@3e7db1f8 - Registering current configuration as safe fallback point 2022-06-16T17:16:31,186+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 18.0.1.1+2-6 on 18.0.1.1+2-6 +jit [mswin32-x86_64] 2022-06-16T17:16:31,193+0000 lvl='INFO', log='', th='localhost-startStop-1', xff='', rId='', aId='', tId='', using a shared (threadsafe!) runtime 2022-06-16T17:17:07,334+0000 lvl='INFO', log='', th='localhost-startStop-1', xff='', rId='', aId='', tId='', An exception happened during JRuby-Rack startup unsupported key algorithm (RSA) java.lang.reflect.InaccessibleObjectException: Unable to make protected java.security.KeyFactory(java.security.KeyFactorySpi,java.security.Provider,java.lang.String) accessible: module java.base does not "opens java.security" to unnamed module @5a403ebd --- System jruby 9.1.17.0 (2.3.3) 2018-04-20 d8b1ff9 Java HotSpot(TM) 64-Bit Server VM 18.0.1.1+2-6 on 18.0.1.1+2-6 +jit [mswin32-x86_64] Time: 2022-06-16 17:17:07 +0000 Server: Apache Tomcat/8.5.81 jruby.home: uri:classloader://META-INF/jruby.home --- Context Init Parameters: jruby.max.runtimes = 1 jruby.min.runtimes = 1 jruby.rack.logging = slf4j public.root = / rails.env = production --- Backtrace RuntimeError: unsupported key algorithm (RSA) java.lang.reflect.InaccessibleObjectException: Unable to make protected java.security.KeyFactory(java.security.KeyFactorySpi,java.security.Provider,java.lang.String) accessible: module java.base does not "opens java.security" to unnamed module @5a403ebd initialize at org/jruby/ext/openssl/PKeyRSA.java:254 initialize at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/key_encryption_key.rb:17 initialize at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/cipher.rb:230 block in extract_ciphers at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/config.rb:65 collect at org/jruby/RubyArray.java:2482 extract_ciphers at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/config.rb:64 load! at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/config.rb:13 block in Railtie at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:41 execute_hook at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/lazy_load_hooks.rb:43 block in on_load at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/lazy_load_hooks.rb:35 each at org/jruby/RubyArray.java:1735 on_load at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/lazy_load_hooks.rb:34 before_configuration at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/railtie/configuration.rb:53 at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:35 at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:3
at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:2 require at org/jruby/RubyKernel.java:956 block in require at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292 load_dependency at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258 require at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292
at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption.rb:1 require at org/jruby/RubyKernel.java:956 block in require at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292 load_dependency at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258 require at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292
at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption.rb:27 require at org/jruby/RubyKernel.java:956 block in require at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292 load_dependency at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258 require at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292
at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric-encryption.rb:1 load at org/jruby/RubyKernel.java:974 block in (root) at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric-encryption.rb:1 load_dependency at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258 (root) at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/config/initializers/encryption.rb:1 block in (root) at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/config/initializers/encryption.rb:1 (root) at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:1 load at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:286 block in load at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:286 each at org/jruby/RubyArray.java:1735 block in load_config_initializer at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:655 instance_exec at org/jruby/RubyBasicObject.java:1728 run at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:30 block in run_initializers at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:59 block in tsort_each at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:228 block in each_strongly_connected_component at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:350 block in each_strongly_connected_component_from at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:422 block in each_strongly_connected_component_from at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:422 block in each_strongly_connected_component_from at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:422 each_strongly_connected_component_from at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:431 block in each_strongly_connected_component_from at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:421 each at org/jruby/RubyArray.java:1735 tsort_each_child at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:48 call at org/jruby/RubyMethod.java:115 each_strongly_connected_component_from at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:415 block in each_strongly_connected_component_from at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:421 each at org/jruby/RubyArray.java:1735 tsort_each_child at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:48 call at org/jruby/RubyMethod.java:115 each_strongly_connected_component_from at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:415 block in each_strongly_connected_component_from at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:421 each at org/jruby/RubyArray.java:1735 tsort_each_child at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:48 call at org/jruby/RubyMethod.java:115 each_strongly_connected_component_from at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:415 block in each_strongly_connected_component at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:349 each at org/jruby/RubyArray.java:1735 call at org/jruby/RubyMethod.java:127 instrument at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/notifications.rb:168 load_config_initializer at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:654 Engine at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:612 Engine at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:611 each_strongly_connected_component at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:347
at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:226 require at org/jruby/RubyKernel.java:956 tsort_each at uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:205 run_initializers at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:58
at C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/application.rb:353 --- RubyGems Gem.dir: C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems Gem.path: C:/Users/m.cucciniello/.gem/jruby/2.3.0 uri:classloader:/META-INF/jruby.home/lib/ruby/gems/shared C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems Activated gems: did_you_mean-1.0.1 bundler-1.15.3 rake-13.0.6 concurrent-ruby-1.1.9 i18n-0.8.6 minitest-5.10.1 thread_safe-0.3.6-java tzinfo-1.2.9 activesupport-5.1.0 builder-3.2.4 erubi-1.10.0 nokogiri-1.10.10-java rails-dom-testing-2.0.3 crass-1.0.6 loofah-2.12.0 rails-html-sanitizer-1.4.2 actionview-5.1.0 rack-2.2.3 rack-test-0.6.3 actionpack-5.1.0 nio4r-2.5.2-java websocket-extensions-0.1.5 websocket-driver-0.6.5-java actioncable-5.1.0 globalid-0.4.2 activejob-5.1.0 mini_mime-1.1.1 mail-2.7.1 actionmailer-5.1.0 activemodel-5.1.0 arel-8.0.0 activerecord-5.1.0 activerecord-jdbc-adapter-51.8-java jdbc-mysql-5.1.47 activerecord-jdbcmysql-adapter-51.8-java jdbc-postgres-42.2.14 activerecord-jdbcpostgresql-adapter-51.8-java jdbc-sqlite3-3.28.0 activerecord-jdbcsqlite3-adapter-51.8-java bcrypt-3.1.16-java method_source-1.0.0 thor-1.1.0 railties-5.1.0 bootstrap-datepicker-rails-1.9.0.1 cancan-1.6.10 descendants_tracker-0.0.4 coercible-1.0.0 commonjs-0.2.7 i18n_data-0.8.0 money-6.16.0 sixarm_ruby_unaccent-1.2.0 unicode_utils-1.4.0 countries-2.1.4 sort_alphabetical-1.1.0 country_select-3.1.1 d3_rails-3.2.8 orm_adapter-0.5.0 responders-2.4.1 warden-1.2.9 devise-4.8.0 execjs-2.8.1 ffi-1.15.4-java font-awesome-rails-4.7.0.7 grease-0.3.2 hitimes-1.3.1-java http_tools-0.4.5 jquery-rails-4.4.0 rb-fsevent-0.11.0 rb-inotify-0.10.1 sass-listen-4.0.0 sass-3.7.4 sprockets-3.7.2 sprockets-rails-3.2.2 tilt-2.0.10 sass-rails-5.0.7 jquery-datatables-rails-3.4.0 jquery-ui-rails-6.0.1 jruby-jars-9.1.17.0 jruby-rack-1.1.21 js-routes-1.4.14 killbill-client-3.3.1 rails-5.1.0 spinjs-rails-1.4 less-2.6.0 less-rails-3.0.0 twitter-bootstrap-rails-3.2.2 kanaui-2.1.3 kenui-2.0.1 monetize-1.11.0 money-rails-1.15.0 mustache-js-rails-0.0.7 symmetric-encryption-3.9.1 kaui-2.1.0 killbill-avatax-2.1.0 killbill-deposit-0.0.4 socketry-0.5.1 ld-eventsource-1.0.3 killbill-kpm-ui-2.0.2 killbill-payment-test-ui-2.0.1 rubyzip-1.3.0 therubyrhino_jar-1.7.6 therubyrhino-2.0.5 tzinfo-data-1.2021.3 warbler-2.0.5 --- Bundler Bundler.bundle_path: C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems Bundler.root: C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF Gemfile: C:\KillBillTest\apache-tomcat-8.5.81\webapps2\ROOT\WEB-INF\Gemfile Settings: gemfile = C:\KillBillTest\apache-tomcat-8.5.81\webapps2\ROOT\WEB-INF\Gemfile without = development:test:assets bin_path = C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/bundler-1.15.3/exe/bundle --- JRuby-Rack Config compat_version = default_logger = org.jruby.rack.logging.StandardOutLogger@4d10855d equals = err = org.apache.tomcat.util.log.SystemLogHandler@23626e5d filter_adds_html = true filter_verifies_resource = false ignore_environment = false initial_memory_buffer_size = initial_runtimes = 1 jms_connection_factory = jms_jndi_properties = logger = org.jruby.rack.logging.Slf4jLogger@5af1b48 logger_class_name = slf4j logger_name = jruby.rack maximum_memory_buffer_size = maximum_runtimes = 1 num_initializer_threads = out = org.apache.tomcat.util.log.SystemLogHandler@252728c3 rackup = rackup_path = rewindable = true runtime_arguments = runtime_environment = runtime_timeout_seconds = serial_initialization = false servlet_context = org.apache.catalina.core.ApplicationContextFacade@b5cfec8 throw_init_exception = false 2022-06-16T17:17:07,343+0000 lvl='ERROR', log='', th='localhost-startStop-1', xff='', rId='', aId='', tId='', initialization failed org.jruby.rack.RackInitializationException: unsupported key algorithm (RSA) java.lang.reflect.InaccessibleObjectException: Unable to make protected java.security.KeyFactory(java.security.KeyFactorySpi,java.security.Provider,java.lang.String) accessible: module java.base does not "opens java.security" to unnamed module @5a403ebd from org/jruby/ext/openssl/PKeyRSA.java:254:in `initialize' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/key_encryption_key.rb:17:in `initialize' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/cipher.rb:230:in `initialize' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/config.rb:65:in `block in extract_ciphers' from org/jruby/RubyArray.java:2482:in `collect' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/config.rb:64:in `extract_ciphers' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/config.rb:13:in `load!' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:41:in `block in Railtie' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/lazy_load_hooks.rb:43:in `execute_hook' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/lazy_load_hooks.rb:35:in `block in on_load' from org/jruby/RubyArray.java:1735:in `each' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/lazy_load_hooks.rb:34:in `on_load' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/railtie/configuration.rb:53:in `before_configuration' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:35:in `' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:3:in `' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:2:in `
' from org/jruby/RubyKernel.java:956:in `require' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292:in `block in require' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258:in `load_dependency' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292:in `require' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption.rb:1:in `
' from org/jruby/RubyKernel.java:956:in `require' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292:in `block in require' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258:in `load_dependency' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292:in `require' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption.rb:27:in `
' from org/jruby/RubyKernel.java:956:in `require' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292:in `block in require' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258:in `load_dependency' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292:in `require' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric-encryption.rb:1:in `
' from org/jruby/RubyKernel.java:974:in `load' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric-encryption.rb:1:in `block in (root)' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258:in `load_dependency' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/config/initializers/encryption.rb:1:in `(root)' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/config/initializers/encryption.rb:1:in `block in (root)' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:1:in `(root)' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:286:in `load' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:286:in `block in load' from org/jruby/RubyArray.java:1735:in `each' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:655:in `block in load_config_initializer' from org/jruby/RubyBasicObject.java:1728:in `instance_exec' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:30:in `run' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:59:in `block in run_initializers' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:228:in `block in tsort_each' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:350:in `block in each_strongly_connected_component' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:422:in `block in each_strongly_connected_component_from' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:422:in `block in each_strongly_connected_component_from' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:422:in `block in each_strongly_connected_component_from' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:431:in `each_strongly_connected_component_from' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:421:in `block in each_strongly_connected_component_from' from org/jruby/RubyArray.java:1735:in `each' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:48:in `tsort_each_child' from org/jruby/RubyMethod.java:115:in `call' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:415:in `each_strongly_connected_component_from' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:421:in `block in each_strongly_connected_component_from' from org/jruby/RubyArray.java:1735:in `each' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:48:in `tsort_each_child' from org/jruby/RubyMethod.java:115:in `call' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:415:in `each_strongly_connected_component_from' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:421:in `block in each_strongly_connected_component_from' from org/jruby/RubyArray.java:1735:in `each' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:48:in `tsort_each_child' from org/jruby/RubyMethod.java:115:in `call' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:415:in `each_strongly_connected_component_from' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:349:in `block in each_strongly_connected_component' from org/jruby/RubyArray.java:1735:in `each' from org/jruby/RubyMethod.java:127:in `call' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/notifications.rb:168:in `instrument' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:654:in `load_config_initializer' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:612:in `Engine' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:611:in `Engine' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:347:in `each_strongly_connected_component' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:226:in `
' from org/jruby/RubyKernel.java:956:in `require' from uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:205:in `tsort_each' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:58:in `run_initializers' from C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/application.rb:353:in `
' at org.jruby.rack.RackInitializationException.wrap(RackInitializationException.java:29) at org.jruby.rack.RackApplicationFactoryDecorator.init(RackApplicationFactoryDecorator.java:104) at org.jruby.rack.RackServletContextListener.contextInitialized(RackServletContextListener.java:50) at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4763) at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5232) at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:183) at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:753) at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:727) at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:695) at org.apache.catalina.startup.HostConfig.deployWAR(HostConfig.java:1016) at org.apache.catalina.startup.HostConfig$DeployWar.run(HostConfig.java:1903) at java.base/java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:539) at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264) at java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1136) at java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at java.base/java.lang.Thread.run(Thread.java:833) Caused by: org.jruby.exceptions.RaiseException: (RuntimeError) unsupported key algorithm (RSA) java.lang.reflect.InaccessibleObjectException: Unable to make protected java.security.KeyFactory(java.security.KeyFactorySpi,java.security.Provider,java.lang.String) accessible: module java.base does not "opens java.security" to unnamed module @5a403ebd at org.jruby.ext.openssl.PKeyRSA.initialize(org/jruby/ext/openssl/PKeyRSA.java:254) at RUBY.initialize(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/key_encryption_key.rb:17) at RUBY.initialize(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/cipher.rb:230) at RUBY.block in extract_ciphers(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/config.rb:65) at org.jruby.RubyArray.collect(org/jruby/RubyArray.java:2482) at RUBY.extract_ciphers(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/config.rb:64) at RUBY.load!(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/config.rb:13) at RUBY.block in Railtie(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:41) at RUBY.execute_hook(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/lazy_load_hooks.rb:43) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.lazy_load_hooks.block in on_load(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/lazy_load_hooks.rb:35) at org.jruby.RubyArray.each(org/jruby/RubyArray.java:1735) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.lazy_load_hooks.on_load(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/lazy_load_hooks.rb:34) at RUBY.before_configuration(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/railtie/configuration.rb:53) at RUBY.(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:35) at RUBY.(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:3) at RUBY.
(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption/railtie.rb:2) at org.jruby.RubyKernel.require(org/jruby/RubyKernel.java:956) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.dependencies.block in require(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.dependencies.load_dependency(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.dependencies.require(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292) at RUBY.
(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption.rb:1) at org.jruby.RubyKernel.require(org/jruby/RubyKernel.java:956) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.dependencies.block in require(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.dependencies.load_dependency(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.dependencies.require(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292) at RUBY.
(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric_encryption.rb:27) at org.jruby.RubyKernel.require(org/jruby/RubyKernel.java:956) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.dependencies.block in require(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.dependencies.load_dependency(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.dependencies.require(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:292) at RUBY.
(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric-encryption.rb:1) at org.jruby.RubyKernel.load(org/jruby/RubyKernel.java:974) at RUBY.block in (root)(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/symmetric-encryption-3.9.1/lib/symmetric-encryption.rb:1) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.activesupport_minus_5_dot_1_dot_0.lib.active_support.dependencies.load_dependency(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:258) at RUBY.(root)(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/config/initializers/encryption.rb:1) at RUBY.block in (root)(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/config/initializers/encryption.rb:1) at RUBY.(root)(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:1) at RUBY.load(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:286) at RUBY.block in load(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/dependencies.rb:286) at org.jruby.RubyArray.each(org/jruby/RubyArray.java:1735) at RUBY.block in load_config_initializer(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:655) at org.jruby.RubyBasicObject.instance_exec(org/jruby/RubyBasicObject.java:1728) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.railties_minus_5_dot_1_dot_0.lib.rails.initializable.run(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:30) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.railties_minus_5_dot_1_dot_0.lib.rails.initializable.block in run_initializers(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:59) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.block in tsort_each(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:228) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.block in each_strongly_connected_component(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:350) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.block in each_strongly_connected_component_from(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:422) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.block in each_strongly_connected_component_from(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:422) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.block in each_strongly_connected_component_from(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:422) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.each_strongly_connected_component_from(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:431) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.block in each_strongly_connected_component_from(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:421) at org.jruby.RubyArray.each(org/jruby/RubyArray.java:1735) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.railties_minus_5_dot_1_dot_0.lib.rails.initializable.tsort_each_child(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:48) at org.jruby.RubyMethod.call(org/jruby/RubyMethod.java:115) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.each_strongly_connected_component_from(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:415) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.block in each_strongly_connected_component_from(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:421) at org.jruby.RubyArray.each(org/jruby/RubyArray.java:1735) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.railties_minus_5_dot_1_dot_0.lib.rails.initializable.tsort_each_child(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:48) at org.jruby.RubyMethod.call(org/jruby/RubyMethod.java:115) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.each_strongly_connected_component_from(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:415) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.block in each_strongly_connected_component_from(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:421) at org.jruby.RubyArray.each(org/jruby/RubyArray.java:1735) at C_3a_.KillBillTest.apache_minus_tomcat_minus_8_dot_5_dot_81.webapps2.ROOT.WEB_minus_INF.gems.gems.railties_minus_5_dot_1_dot_0.lib.rails.initializable.tsort_each_child(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:48) at org.jruby.RubyMethod.call(org/jruby/RubyMethod.java:115) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.each_strongly_connected_component_from(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:415) at uri_3a_classloader_3a_.META_minus_INF.jruby_dot_home.lib.ruby.stdlib.tsort.block in each_strongly_connected_component(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:349) at org.jruby.RubyArray.each(org/jruby/RubyArray.java:1735) at org.jruby.RubyMethod.call(org/jruby/RubyMethod.java:127) at RUBY.instrument(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/activesupport-5.1.0/lib/active_support/notifications.rb:168) at RUBY.load_config_initializer(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:654) at RUBY.Engine(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:612) at RUBY.Engine(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/engine.rb:611) at RUBY.each_strongly_connected_component(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:347) at RUBY.
(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:226) at org.jruby.RubyKernel.require(org/jruby/RubyKernel.java:956) at RUBY.tsort_each(uri:classloader:/META-INF/jruby.home/lib/ruby/stdlib/tsort.rb:205) at RUBY.run_initializers(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/initializable.rb:58) at RUBY.
(C:/KillBillTest/apache-tomcat-8.5.81/webapps2/ROOT/WEB-INF/gems/gems/railties-5.1.0/lib/rails/application.rb:353) (unknown):0: warning: already initialized constant Input (unknown):0: warning: already initialized constant Input (unknown):0: warning: already initialized constant Input WARNING: while creating new bindings for class org.jruby.rack.RackInput, found an existing binding; you may want to run a clean build. WARNING: while creating new bindings for class org.jruby.rack.RackInput, found an existing binding; you may want to run a clean build. WARNING: while creating new bindings for class org.jruby.rack.RackInput, found an existing binding; you may want to run a clean build.