Error injecting constructor (Guice creation errors)
1,091 views
Skip to first unread message
Valentin Crettaz
Apr 28, 2014, 9:47:39 AM4/28/14
to killbill...@googlegroups.com, valentin...@consulthys.com
Hi,
I'm trying a normal KillBill install (using killbill-server-0.10.2-jar-with-dependencies.war) on Tomcat 7 (with JRE 1.7.0_55-b13) as described in the user guide at http://docs.kill-bill.org/userguide.html#deployment-tomcat
During the Tomcat startup I get the following in the tomcat logs
Apr 28, 2014 3:32:25 PM org.apache.catalina.core.StandardContext listenerStart
Grave: Exception lors de l'envoi de l'évènement contexte initialisé (context initialized) à l'instance de classe d'écoute (listener) org.killbill.billing.server.listeners.KillbillGuiceListener
com.google.inject.CreationException: Guice creation errors:
1) Error injecting constructor, org.weakref.jmx.JmxException: org.killbill.billing.server.healthchecks:name=KillbillHealthcheck
at org.weakref.jmx.guice.GuiceMBeanExporter.<init>(GuiceMBeanExporter.java:29)
at org.weakref.jmx.guice.InternalMBeanModule.configure(InternalMBeanModule.java:30)
while locating org.weakref.jmx.guice.GuiceMBeanExporter
1 error
at com.google.inject.internal.Errors.throwCreationExceptionIfErrorsExist(Errors.java:435)
at com.google.inject.internal.InternalInjectorCreator.injectDynamically(InternalInjectorCreator.java:183)
at com.google.inject.internal.InternalInjectorCreator.build(InternalInjectorCreator.java:109)
at com.google.inject.Guice.createInjector(Guice.java:95)
at org.killbill.commons.skeleton.listeners.GuiceServletContextListener.getInjector(GuiceServletContextListener.java:92)
at com.google.inject.servlet.GuiceServletContextListener.contextInitialized(GuiceServletContextListener.java:45)
at org.killbill.commons.skeleton.listeners.GuiceServletContextListener.contextInitialized(GuiceServletContextListener.java:54)
at org.killbill.billing.server.listeners.KillbillGuiceListener.contextInitialized(KillbillGuiceListener.java:111)
at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4939)
at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5434)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:901)
at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:877)
at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:633)
at org.apache.catalina.startup.HostConfig.deployDirectory(HostConfig.java:1113)
at org.apache.catalina.startup.HostConfig$DeployDirectory.run(HostConfig.java:1671)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: org.weakref.jmx.JmxException: org.killbill.billing.server.healthchecks:name=KillbillHealthcheck
at org.weakref.jmx.MBeanExporter.export(MBeanExporter.java:71)
at org.weakref.jmx.guice.GuiceMBeanExporter.<init>(GuiceMBeanExporter.java:31)
at org.weakref.jmx.guice.GuiceMBeanExporter$$FastClassByGuice$$6cc63b28.newInstance(<generated>)
at com.google.inject.internal.cglib.reflect.$FastConstructor.newInstance(FastConstructor.java:40)
at com.google.inject.internal.DefaultConstructionProxyFactory$1.newInstance(DefaultConstructionProxyFactory.java:60)
at com.google.inject.internal.ConstructorInjector.construct(ConstructorInjector.java:85)
at com.google.inject.internal.ConstructorBindingImpl$Factory.get(ConstructorBindingImpl.java:254)
at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1031)
at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
at com.google.inject.Scopes$1$1.get(Scopes.java:65)
at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:40)
at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:204)
at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:198)
at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1024)
at com.google.inject.internal.InternalInjectorCreator.loadEagerSingletons(InternalInjectorCreator.java:198)
at com.google.inject.internal.InternalInjectorCreator.injectDynamically(InternalInjectorCreator.java:179)
... 19 more
It's not really clear what this means and how I can get rid of it. I appreciate any insights.
Thanks,
Val
I'm trying a normal KillBill install (using killbill-server-0.10.2-jar-with-dependencies.war) on Tomcat 7 (with JRE 1.7.0_55-b13) as described in the user guide at http://docs.kill-bill.org/userguide.html#deployment-tomcat
During the Tomcat startup I get the following in the tomcat logs
Apr 28, 2014 3:32:25 PM org.apache.catalina.core.StandardContext listenerStart
Grave: Exception lors de l'envoi de l'évènement contexte initialisé (context initialized) à l'instance de classe d'écoute (listener) org.killbill.billing.server.listeners.KillbillGuiceListener
com.google.inject.CreationException: Guice creation errors:
1) Error injecting constructor, org.weakref.jmx.JmxException: org.killbill.billing.server.healthchecks:name=KillbillHealthcheck
at org.weakref.jmx.guice.GuiceMBeanExporter.<init>(GuiceMBeanExporter.java:29)
at org.weakref.jmx.guice.InternalMBeanModule.configure(InternalMBeanModule.java:30)
while locating org.weakref.jmx.guice.GuiceMBeanExporter
1 error
at com.google.inject.internal.Errors.throwCreationExceptionIfErrorsExist(Errors.java:435)
at com.google.inject.internal.InternalInjectorCreator.injectDynamically(InternalInjectorCreator.java:183)
at com.google.inject.internal.InternalInjectorCreator.build(InternalInjectorCreator.java:109)
at com.google.inject.Guice.createInjector(Guice.java:95)
at org.killbill.commons.skeleton.listeners.GuiceServletContextListener.getInjector(GuiceServletContextListener.java:92)
at com.google.inject.servlet.GuiceServletContextListener.contextInitialized(GuiceServletContextListener.java:45)
at org.killbill.commons.skeleton.listeners.GuiceServletContextListener.contextInitialized(GuiceServletContextListener.java:54)
at org.killbill.billing.server.listeners.KillbillGuiceListener.contextInitialized(KillbillGuiceListener.java:111)
at org.apache.catalina.core.StandardContext.listenerStart(StandardContext.java:4939)
at org.apache.catalina.core.StandardContext.startInternal(StandardContext.java:5434)
at org.apache.catalina.util.LifecycleBase.start(LifecycleBase.java:150)
at org.apache.catalina.core.ContainerBase.addChildInternal(ContainerBase.java:901)
at org.apache.catalina.core.ContainerBase.addChild(ContainerBase.java:877)
at org.apache.catalina.core.StandardHost.addChild(StandardHost.java:633)
at org.apache.catalina.startup.HostConfig.deployDirectory(HostConfig.java:1113)
at org.apache.catalina.startup.HostConfig$DeployDirectory.run(HostConfig.java:1671)
at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471)
at java.util.concurrent.FutureTask.run(FutureTask.java:262)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1145)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:615)
at java.lang.Thread.run(Thread.java:745)
Caused by: org.weakref.jmx.JmxException: org.killbill.billing.server.healthchecks:name=KillbillHealthcheck
at org.weakref.jmx.MBeanExporter.export(MBeanExporter.java:71)
at org.weakref.jmx.guice.GuiceMBeanExporter.<init>(GuiceMBeanExporter.java:31)
at org.weakref.jmx.guice.GuiceMBeanExporter$$FastClassByGuice$$6cc63b28.newInstance(<generated>)
at com.google.inject.internal.cglib.reflect.$FastConstructor.newInstance(FastConstructor.java:40)
at com.google.inject.internal.DefaultConstructionProxyFactory$1.newInstance(DefaultConstructionProxyFactory.java:60)
at com.google.inject.internal.ConstructorInjector.construct(ConstructorInjector.java:85)
at com.google.inject.internal.ConstructorBindingImpl$Factory.get(ConstructorBindingImpl.java:254)
at com.google.inject.internal.ProviderToInternalFactoryAdapter$1.call(ProviderToInternalFactoryAdapter.java:46)
at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1031)
at com.google.inject.internal.ProviderToInternalFactoryAdapter.get(ProviderToInternalFactoryAdapter.java:40)
at com.google.inject.Scopes$1$1.get(Scopes.java:65)
at com.google.inject.internal.InternalFactoryToProviderAdapter.get(InternalFactoryToProviderAdapter.java:40)
at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:204)
at com.google.inject.internal.InternalInjectorCreator$1.call(InternalInjectorCreator.java:198)
at com.google.inject.internal.InjectorImpl.callInContext(InjectorImpl.java:1024)
at com.google.inject.internal.InternalInjectorCreator.loadEagerSingletons(InternalInjectorCreator.java:198)
at com.google.inject.internal.InternalInjectorCreator.injectDynamically(InternalInjectorCreator.java:179)
... 19 more
It's not really clear what this means and how I can get rid of it. I appreciate any insights.
Thanks,
Val
Pierre-Alexandre Meyer
Apr 28, 2014, 9:56:39 AM4/28/14
to Valentin Crettaz, killbill...@googlegroups.com, valentin...@consulthys.com
Salut !
On Mon, Apr 28, 2014 at 9:47 AM, Valentin Crettaz <valentin...@gmail.com> wrote:
Caused by: org.weakref.jmx.JmxException: org.killbill.billing.server.healthchecks:name=KillbillHealthcheck
at org.weakref.jmx.MBeanExporter.export(MBeanExporter.java:71)
That's odd - the error seems to indicate the JMX instance already exists.
Is there anything specific to your setup (Java security, disabled JMX, etc.) or is it standard Tomcat / JDK?
Could you share the entire Tomcat logs as well as your config?
Thanks,
Pierre
Valentin Crettaz
Apr 28, 2014, 10:14:32 AM4/28/14
to killbill...@googlegroups.com, valentin...@consulthys.com
Thanks for your answer Pierre.
Of course I should have shared all that, please find the whole startup sequence logs below. Note that the log I pasted in my previous message was from the localhost.log file.
My install is completely standard, i.e. I installed JDK 1.7 straight from Oracle's website with the Mac OS X installer and the Tomcat install comes from the link pasted in the user guide (https://s3.amazonaws.com/kb-binaries/apache-tomcat-7.0.42.tar.gz). Then I followed the instructions in the user guide and ended up with the following Tomcat settings:
In $TOMCAT/conf/Catalina/localhost/Root.xml:
<Context docBase="/home/me/workspaces/ij/kb.war"></Context>
At the end of $TOMCAT/conf/catalina.properties:
# Kill Bill properties
org.killbill.dao.url=jdbc:mysql://127.0.0.1:3306/billing
org.killbill.dao.user=killbill
org.killbill.dao.password=killbill
ANTLR_USE_DIRECT_CLASS_LOADING=true
And here is the full output for catalina.out:
avr. 28, 2014 4:01:53 PM org.apache.catalina.core.AprLifecycleListener init
Infos: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /home/me/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
avr. 28, 2014 4:01:54 PM org.apache.coyote.AbstractProtocol init
Infos: Initializing ProtocolHandler ["http-bio-8080"]
avr. 28, 2014 4:01:54 PM org.apache.coyote.AbstractProtocol init
Infos: Initializing ProtocolHandler ["ajp-bio-8009"]
avr. 28, 2014 4:01:54 PM org.apache.catalina.startup.Catalina load
Infos: Initialization processed in 476 ms
avr. 28, 2014 4:01:54 PM org.apache.catalina.core.StandardService startInternal
Infos: Démarrage du service Catalina
avr. 28, 2014 4:01:54 PM org.apache.catalina.core.StandardEngine startInternal
Infos: Starting Servlet Engine: Apache Tomcat/7.0.42
avr. 28, 2014 4:01:54 PM org.apache.catalina.startup.HostConfig deployDescriptor
Infos: Déploiement du descripteur de configuration /home/me/workspaces/ij/tomcat7/conf/Catalina/localhost/Root.xml
16:02:19.027 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [true] for [org.killbill.server.multitenant] on [org.killbill.billing.server.config.KillbillServerConfig#isMultiTenancyEnabled()]
16:02:19.031 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.server.test.mode] on [org.killbill.billing.server.config.KillbillServerConfig#isTestModeEnabled()]
16:02:19.474 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [30] for [org.killbill.dao.maxActive] on [org.killbill.billing.server.config.DaoConfig#getMaxActive()]
16:02:19.474 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [org.killbill.dao.connectionTimeout] on [org.killbill.billing.server.config.DaoConfig#getConnectionTimeout()]
16:02:19.477 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [killbill] for [org.killbill.dao.password] on [org.killbill.billing.server.config.DaoConfig#getPassword()]
16:02:19.478 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [C3P0] for [org.killbill.dao.poolingType] on [org.killbill.billing.server.config.DaoConfig#getConnectionPoolingType()]
16:02:19.479 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [jdbc:mysql://127.0.0.1:3306/billing] for [org.killbill.dao.url] on [org.killbill.billing.server.config.DaoConfig#getJdbcUrl()]
16:02:19.480 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.dao.minIdle] on [org.killbill.billing.server.config.DaoConfig#getMinIdle()]
16:02:19.480 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [60m] for [org.killbill.dao.idleMaxAge] on [org.killbill.billing.server.config.DaoConfig#getIdleMaxAge()]
16:02:19.480 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [0m] for [org.killbill.dao.maxConnectionAge] on [org.killbill.billing.server.config.DaoConfig#getMaxConnectionAge()]
16:02:19.480 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.dao.idleConnectionTestPeriod] on [org.killbill.billing.server.config.DaoConfig#getIdleConnectionTestPeriod()]
16:02:19.481 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org.killbill.commons.jdbi.transaction.RestartTransactionRunner] for [org.killbill.dao.transactionHandler] on [org.killbill.billing.server.config.DaoConfig#getTransactionHandlerClass()]
16:02:19.481 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [WARN] for [org.killbill.dao.logLevel] on [org.killbill.billing.server.config.DaoConfig#getLogLevel()]
16:02:19.481 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [killbill] for [org.killbill.dao.user] on [org.killbill.billing.server.config.DaoConfig#getUsername()]
16:02:19.500 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.user] on [org.killbill.billing.util.email.EmailConfig#getSmtpUserName()]
16:02:19.500 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.password] on [org.killbill.billing.util.email.EmailConfig#getSmtpPassword()]
16:02:19.501 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [sup...@example.com] for [org.killbill.mail.from] on [org.killbill.billing.util.email.EmailConfig#getDefaultFrom()]
16:02:19.501 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [Your invoice] for [org.killbill.mail.invoiceEmailSubject] on [org.killbill.billing.util.email.EmailConfig#getInvoiceEmailSubject()]
16:02:19.501 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.port] on [org.killbill.billing.util.email.EmailConfig#getSmtpPort()]
16:02:19.502 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.mail.smtp.auth] on [org.killbill.billing.util.email.EmailConfig#useSmtpAuth()]
16:02:19.502 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.host] on [org.killbill.billing.util.email.EmailConfig#getSmtpServerName()]
16:02:19.502 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.mail.useSSL] on [org.killbill.billing.util.email.EmailConfig#useSSL()]
16:02:19.509 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [ehcache.xml] for [org.killbill.cache.config.location] on [org.killbill.billing.util.config.CacheConfig#getCacheConfigLocation()]
16:02:19.524 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [SpyCarBasic.xml] for [org.killbill.catalog.uri] on [org.killbill.billing.util.config.CatalogConfig#getCatalogURI()]
16:02:19.535 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:19.535 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:19.535 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:19.536 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:19.536 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:19.536 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:19.537 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:19.537 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:19.537 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:19.537 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events] for [org.killbill.persistent.bus.${instanceName}.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:19.538 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events_history] for [org.killbill.persistent.bus.${instanceName}.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:19.550 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.sticky] on [org.killbill.notificationq.api.NotificationQueueConfig#isSticky()]
16:02:19.551 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.notificationq.${instanceName}.max.failure.retry] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxFailureRetries()]
16:02:19.551 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [7] for [org.killbill.notificationq.${instanceName}.claimed] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxEntriesClaimed()]
16:02:19.551 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.notificationq.${instanceName}.claim.time] on [org.killbill.notificationq.api.NotificationQueueConfig#getClaimedTime()]
16:02:19.551 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.notificationq.${instanceName}.sleep] on [org.killbill.notificationq.api.NotificationQueueConfig#getSleepTimeMs()]
16:02:19.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.notification.off] on [org.killbill.notificationq.api.NotificationQueueConfig#isProcessingOff()]
16:02:19.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.notificationq.${instanceName}.notification.nbThreads] on [org.killbill.notificationq.api.NotificationQueueConfig#getNbThreads()]
16:02:19.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.useInflightQ] on [org.killbill.notificationq.api.NotificationQueueConfig#isUsingInflightQueue()]
16:02:19.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [0] for [org.killbill.notificationq.${instanceName}.queue.capacity] on [org.killbill.notificationq.api.NotificationQueueConfig#getQueueCapacity()]
16:02:19.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [notifications] for [org.killbill.notificationq.${instanceName}.tableName] on [org.killbill.notificationq.api.NotificationQueueConfig#getTableName()]
16:02:19.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [notifications_history] for [org.killbill.notificationq.${instanceName}.historyTableName] on [org.killbill.notificationq.api.NotificationQueueConfig#getHistoryTableName()]
16:02:19.577 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [36] for [org.killbill.invoice.maxNumberOfMonthsInFuture] on [org.killbill.billing.util.config.InvoiceConfig#getNumberOfMonthsInFuture()]
16:02:19.577 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.invoice.emailNotificationsEnabled] on [org.killbill.billing.util.config.InvoiceConfig#isEmailNotificationsEnabled()]
16:02:19.584 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org.killbill.billing.invoice.template.formatters.DefaultInvoiceFormatterFactory] for [org.killbill.template.invoiceFormatterFactoryClass] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceFormatterFactoryClass()]
16:02:19.585 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/template/translation/CatalogTranslation] for [org.killbill.catalog.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getCatalogBundlePath()]
16:02:19.586 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [en_US] for [org.killbill.default.locale] on [org.killbill.billing.util.template.translation.TranslatorConfig#getDefaultLocale()]
16:02:19.586 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/template/translation/InvoiceTranslation] for [org.killbill.template.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceTemplateBundlePath()]
16:02:19.586 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/email/templates/HtmlInvoiceTemplate.mustache] for [org.killbill.template.name] on [org.killbill.billing.util.template.translation.TranslatorConfig#getTemplateName()]
16:02:19.586 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - 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()]
16:02:19.622 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10] for [org.killbill.payment.plugin.threads.nb] on [org.killbill.billing.util.config.PaymentConfig#getPaymentPluginThreadNb()]
16:02:19.622 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [__external_payment__] for [org.killbill.payment.provider.default] on [org.killbill.billing.util.config.PaymentConfig#getDefaultPaymentProvider()]
16:02:19.623 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8,8,8] for [org.killbill.payment.retry.days] on [org.killbill.billing.util.config.PaymentConfig#getPaymentRetryDays()]
16:02:19.623 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [300] for [org.killbill.payment.failure.retry.start.sec] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryStart()]
16:02:19.623 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [2] for [org.killbill.payment.failure.retry.multiplier] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryMultiplier()]
16:02:19.623 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8] for [org.killbill.payment.failure.retry.max.attempts] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryMaxAttempts()]
16:02:19.624 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [90s] for [org.killbill.payment.plugin.timeout] on [org.killbill.billing.util.config.PaymentConfig#getPaymentPluginTimeout()]
16:02:19.624 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.payment.off] on [org.killbill.billing.util.config.PaymentConfig#isPaymentOff()]
16:02:19.642 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:19.642 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:19.642 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:19.642 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:19.643 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:19.643 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:19.643 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:19.643 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:19.643 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:19.644 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events] for [org.killbill.persistent.bus.${instanceName}.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:19.644 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events_history] for [org.killbill.persistent.bus.${instanceName}.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:19.644 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:19.644 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:19.644 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:19.645 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:19.645 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:19.645 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:19.645 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:19.645 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:19.646 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:19.646 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [bus_ext_events] for [org.killbill.persistent.bus.external.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:19.646 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [bus_ext_events_history] for [org.killbill.persistent.bus.external.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:19.653 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [NoOverdueConfig.xml] for [org.killbill.overdue.uri] on [org.killbill.billing.overdue.OverdueProperties#getConfigURI()]
16:02:19.660 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill-currency-plugin] for [org.killbill.currency.provider.default] on [org.killbill.billing.util.config.CurrencyConfig#getDefaultCurrencyProvider()]
16:02:19.674 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill.properties] for [org.killbill.osgi.bundle.property.name] on [org.killbill.billing.util.config.OSGIConfig#getOSGIKillbillPropertyName()]
16:02:19.674 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/var/tmp/felix] for [org.killbill.osgi.root.dir] on [org.killbill.billing.util.config.OSGIConfig#getOSGIBundleRootDir()]
16:02:19.674 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [osgi-cache] for [org.killbill.osgi.bundle.cache.name] on [org.killbill.billing.util.config.OSGIConfig#getOSGIBundleCacheName()]
16:02:19.674 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/var/tmp/bundles] for [org.killbill.osgi.bundle.install.dir] on [org.killbill.billing.util.config.OSGIConfig#getRootInstallationDir()]
16:02:19.675 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - 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.invoice.api,org.killbill.billing.entitlement.api,org.killbill.billing,org.killbill.billing.notification.api,org.killbill.billing.notification.plugin.api,org.killbill.billing.osgi.api,org.killbill.billing.osgi.api.config,org.killbill.billing.overdue,org.killbill.billing.payment.api,org.killbill.billing.payment.plugin.api,org.killbill.billing.tenant.api,org.killbill.billing.usage.api,org.killbill.billing.util.api,org.killbill.billing.util.audit,org.killbill.billing.util.callcontext,org.killbill.billing.util.customfield,org.killbill.billing.notification.plugin,org.killbill.billing.currency.plugin.api,org.killbill.billing.currency.api,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,sun.misc,sun.misc.unsafe,javax.crypto,javax.crypto.spec,javax.management,javax.servlet;version=3.0,javax.servlet.http;version=3.0,org.joda.time;org.joda.time.format;version=2.3,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,org.slf4j;version=1.7.2] for [org.killbill.osgi.system.bundle.export.packages] on [org.killbill.billing.util.config.OSGIConfig#getSystemBundleExportPackages()]
16:02:19.679 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [30] for [org.killbill.billing.osgi.jdbc.maxActive] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMaxActive()]
16:02:19.679 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [org.killbill.billing.osgi.jdbc.connectionTimeout] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getConnectionTimeout()]
16:02:19.679 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill] for [org.killbill.billing.osgi.jdbc.password] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getPassword()]
16:02:19.680 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [jdbc:h2:file:killbill;MODE=MYSQL;DB_CLOSE_DELAY=-1;MVCC=true;DB_CLOSE_ON_EXIT=FALSE] for [org.killbill.billing.osgi.jdbc.url] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getJdbcUrl()]
16:02:19.680 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.billing.osgi.jdbc.minIdle] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMinIdle()]
16:02:19.680 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill] for [org.killbill.billing.osgi.jdbc.user] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getUsername()]
16:02:19.799 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1h] for [org.killbill.rbac.globalSessionTimeout] on [org.killbill.billing.util.config.RbacConfig#getGlobalSessionTimeout()]
16:02:19.829 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [classpath:shiro.ini] for [org.killbill.security.shiroResourcePath] on [org.killbill.billing.util.config.SecurityConfig#getShiroResourcePath()]
16:02:19.829 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [memberOf=uid={0}] for [org.killbill.security.ldap.groupSearchFilter] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPGroupSearchFilter()]
16:02:19.829 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [memberOf] for [org.killbill.security.ldap.groupNameId] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPGroupNameID()]
16:02:19.829 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [admin = *:*
finance = invoice:*, payment:*
support = entitlement:*, invoice:item_adjust] for [org.killbill.security.ldap.permissionsByGroup] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPPermissionsByGroup()]
16:02:19.829 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [ldap://127.0.0.1:389] for [org.killbill.security.ldap.url] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPUrl()]
16:02:19.830 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.systemUsername] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSystemUsername()]
16:02:19.830 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.systemPassword] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSystemPassword()]
16:02:19.830 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [simple] for [org.killbill.security.ldap.authenticationMechanism] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPAuthenticationMechanism()]
16:02:19.830 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.searchBase] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSearchBase()]
16:02:19.830 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.userDnTemplate] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPUserDnTemplate()]
16:02:19.831 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.security.ldap.disableSSLCheck] on [org.killbill.billing.util.config.SecurityConfig#disableShiroLDAPSSLCheck()]
16:02:20.851 [localhost-startStop-1] INFO com.mchange.v2.log.MLog - MLog clients using java 1.4+ standard logging.
16:02:20.878 [localhost-startStop-1] INFO com.mchange.v2.c3p0.C3P0Registry - Initializing c3p0-0.9.2 [built 09-February-2013 02:13:17 +0000; debug? true; trace: 10]
16:02:20.957 [localhost-startStop-1] INFO o.k.b.server.modules.DBIProvider - Using org.killbill.commons.jdbi.transaction.RestartTransactionRunner as a transaction handler class
16:02:21.351 [localhost-startStop-1] INFO o.k.b.p.p.DefaultPaymentProviderPluginRegistry - DefaultPaymentProviderPluginRegistry registering service __EXTERNAL_PAYMENT__
16:02:21.823 [localhost-startStop-1] INFO o.k.b.s.l.KillbillGuiceListener - KillbillLifecycleListener : contextInitialized
16:02:21.858 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage LOAD_CATALOG
16:02:21.860 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler loadCatalog for service catalog-service
16:02:21.861 [localhost-startStop-1] INFO o.k.b.util.config.catalog.XMLLoader - Initializing an object of class org.killbill.billing.catalog.StandaloneCatalog from xml file at: file:/home/me/workspaces/ij/tomcat7/work/Catalina/localhost/Root/WEB-INF/classes/SpyCarBasic.xml
16:02:22.198 [localhost-startStop-1] INFO o.k.b.util.config.catalog.XMLLoader - Errors: 0 for file:/home/me/workspaces/ij/tomcat7/work/Catalina/localhost/Root/WEB-INF/classes/SpyCarBasic.xml
16:02:22.198 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler loadConfig for service overdue-service
16:02:22.198 [localhost-startStop-1] INFO o.k.b.util.config.catalog.XMLLoader - Initializing an object of class org.killbill.billing.overdue.config.OverdueConfig from xml file at: NoOverdueConfig.xml
16:02:22.237 [localhost-startStop-1] INFO o.k.b.util.config.catalog.XMLLoader - Errors: 0 for NoOverdueConfig.xml
16:02:22.238 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage INIT_BUS
16:02:22.238 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler startBus for service bus-service
16:02:22.238 [localhost-startStop-1] INFO org.killbill.queue.DBBackedQueue - DBBackedQueue-bus-bus_events: Initialized with isQueueOpenForWrite = false, isQueueOpenForRead = false
16:02:22.238 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - Bus: Starting with 3 threads
16:02:22.240 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [28] starting
16:02:22.240 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [30] starting
16:02:22.240 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [29] starting
16:02:22.241 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - Bus: Done waiting for all threads to be started, got 3/3
16:02:22.241 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler startBus for service beatrix-service
16:02:22.241 [localhost-startStop-1] INFO org.killbill.queue.DBBackedQueue - DBBackedQueue-bus-bus_ext_events: Initialized with isQueueOpenForWrite = false, isQueueOpenForRead = false
16:02:22.241 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - Bus: Starting with 3 threads
16:02:22.242 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [31] starting
16:02:22.242 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [32] starting
16:02:22.243 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [33] starting
16:02:22.243 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - Bus: Done waiting for all threads to be started, got 3/3
16:02:22.244 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage INIT_PLUGIN
16:02:22.244 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service osgi-service
16:02:22.250 [localhost-startStop-1] INFO o.k.billing.osgi.DefaultOSGIService - Deleted recursively /var/tmp/felix/osgi-cache/bundle0
16:02:22.250 [localhost-startStop-1] INFO o.k.billing.osgi.DefaultOSGIService - Deleted recursively /var/tmp/felix/osgi-cache
16:02:22.286 [bus-th] INFO c.m.v.c.i.AbstractPoolBackedDataSource - Initializing c3p0 pool... com.mchange.v2.c3p0.ComboPooledDataSource [ acquireIncrement -> 3, acquireRetryAttempts -> 30, acquireRetryDelay -> 1000, autoCommitOnClose -> false, automaticTestTable -> null, breakAfterAcquireFailure -> false, checkoutTimeout -> 10000, connectionCustomizerClassName -> null, connectionTesterClassName -> com.mchange.v2.c3p0.impl.DefaultConnectionTester, dataSourceName -> 1hge15w911asj7ly15d2osm|70bf46e1, debugUnreturnedConnectionStackTraces -> false, description -> null, driverClass -> null, factoryClassLocation -> null, forceIgnoreUnresolvedTransactions -> false, identityToken -> 1hge15w911asj7ly15d2osm|70bf46e1, idleConnectionTestPeriod -> 300, initialPoolSize -> 3, jdbcUrl -> jdbc:mysql://127.0.0.1:3306/billing, maxAdministrativeTaskTime -> 0, maxConnectionAge -> 0, maxIdleTime -> 3600, maxIdleTimeExcessConnections -> 0, maxPoolSize -> 30, maxStatements -> 0, maxStatementsPerConnection -> 0, minPoolSize -> 1, numHelperThreads -> 3, preferredTestQuery -> null, properties -> {user=******, password=******}, propertyCycle -> 0, statementCacheNumDeferredCloseThreads -> 0, testConnectionOnCheckin -> false, testConnectionOnCheckout -> false, unreturnedConnectionTimeout -> 0, userOverrides -> {}, usesTraditionalReflectiveProxies -> false ]
16:02:22.464 [localhost-startStop-1] WARN o.killbill.billing.osgi.FileInstall - Unable to find the JRuby bundle at /var/tmp/bundles/platform/jruby.jar, ruby plugins won't be started!
16:02:22.464 [localhost-startStop-1] WARN org.slf4j.Logger - Configuration root dir /var/tmp/bundles/platform/ is not a valid directory
16:02:22.465 [localhost-startStop-1] WARN o.k.b.osgi.pluginconf.PluginFinder - Configuration root dir /var/tmp/bundles/plugins/ruby is not a valid directory
16:02:22.465 [localhost-startStop-1] WARN o.k.b.osgi.pluginconf.PluginFinder - Configuration root dir /var/tmp/bundles/plugins/java is not a valid directory
16:02:22.465 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage INIT_SERVICE
16:02:22.465 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service subscription-service
16:02:22.466 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service entitlement-service
16:02:22.467 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler registerForNotifications for service beatrix-service
16:02:22.467 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service security-service
16:02:22.470 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler registerForNotifications for service server-service
16:02:22.471 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service payment-service
16:02:22.472 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service invoice-service
16:02:22.474 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service overdue-service
16:02:22.474 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage START_PLUGIN
16:02:22.474 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service osgi-service
16:02:22.475 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage START_SERVICE
16:02:22.476 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service subscription-service
16:02:22.476 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - NotificationQ: Starting with 1 threads
16:02:22.478 [Notification-queue-dispatch] INFO o.k.queue.DefaultQueueLifecycle - NotificationQ: Thread Notification-queue-dispatch [40] starting
16:02:22.479 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - NotificationQ: Done waiting for all threads to be started, got 1/1
16:02:22.479 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service entitlement-service
16:02:22.479 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service payment-service
16:02:22.479 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service invoice-service
16:02:22.479 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service overdue-service
16:02:22.555 [localhost-startStop-1] INFO c.s.j.a.core.PackagesResourceConfig - Scanning for root resource and provider classes in the packages:
org.killbill.billing.jaxrs.mappers
org.killbill.billing.jaxrs.resources
16:02:22.802 [localhost-startStop-1] INFO c.s.j.a.core.ScanningResourceConfig - Root resource classes found:
class org.killbill.billing.jaxrs.resources.InvoiceResource
class org.killbill.billing.jaxrs.resources.ExportResource
class org.killbill.billing.jaxrs.resources.UsageResource
class org.killbill.billing.jaxrs.resources.ChargebackResource
class org.killbill.billing.jaxrs.resources.PaymentResource
class org.killbill.billing.jaxrs.resources.SubscriptionResource
class org.killbill.billing.jaxrs.resources.CatalogResource
class org.killbill.billing.jaxrs.resources.BundleResource
class org.killbill.billing.jaxrs.resources.TagResource
class org.killbill.billing.jaxrs.resources.CreditResource
class org.killbill.billing.jaxrs.resources.PaymentMethodResource
class org.killbill.billing.jaxrs.resources.TenantResource
class org.killbill.billing.jaxrs.resources.TagDefinitionResource
class org.killbill.billing.jaxrs.resources.CustomFieldResource
class org.killbill.billing.jaxrs.resources.SecurityResource
class org.killbill.billing.jaxrs.resources.RefundResource
class org.killbill.billing.jaxrs.resources.AccountResource
class org.killbill.billing.jaxrs.resources.PluginResource
class org.killbill.billing.jaxrs.resources.TestResource
16:02:22.813 [localhost-startStop-1] INFO c.s.j.a.core.ScanningResourceConfig - Provider classes found:
class org.killbill.billing.jaxrs.mappers.PaymentApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.EntityPersistenceExceptionMapper
class org.killbill.billing.jaxrs.mappers.CurrencyValueNullMapper
class org.killbill.billing.jaxrs.mappers.EmailApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.OverdueErrorMapper
class org.killbill.billing.jaxrs.mappers.CatalogApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.BlockingApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.SubscriptionRepairExceptionMapper
class org.killbill.billing.jaxrs.mappers.SubscriptionApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.EntitlementApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.RuntimeExceptionMapper
class org.killbill.billing.jaxrs.mappers.InvoiceApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.ShiroExceptionMapper
class org.killbill.billing.jaxrs.mappers.SubscriptionBillingApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.OverdueApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.IllegalArgumentExceptionMapper
class org.killbill.billing.jaxrs.mappers.BillingExceptionBaseMapper
class org.killbill.billing.jaxrs.mappers.IllegalPlanChangeMapper
class org.killbill.billing.jaxrs.mappers.TagDefinitionApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.TagApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.AccountApiExceptionMapper
16:02:23.120 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.fasterxml.jackson.jaxrs.json.JacksonJsonProvider as a provider class
16:02:23.121 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.AccountResource as a root resource class
16:02:23.121 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.BundleResource as a root resource class
16:02:23.121 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.SubscriptionResource as a root resource class
16:02:23.121 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.InvoiceResource as a root resource class
16:02:23.121 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.CustomFieldResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.TagResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.TagDefinitionResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.CatalogResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.PaymentMethodResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.PaymentResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.PluginResource as a root resource class
16:02:23.123 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.RefundResource as a root resource class
16:02:23.123 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.TenantResource as a root resource class
16:02:23.123 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.ExportResource as a root resource class
16:02:23.127 [localhost-startStop-1] INFO c.s.j.s.i.a.WebApplicationImpl - Initiating Jersey application, version 'Jersey: 1.18.1 02/19/2014 03:28 AM'
16:02:23.290 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.fasterxml.jackson.jaxrs.json.JacksonJsonProvider to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.822 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.AccountResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.836 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.BundleResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.840 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.CatalogResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.846 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.ChargebackResource to GuiceInstantiatedComponentProvider
16:02:23.856 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.CreditResource to GuiceInstantiatedComponentProvider
16:02:23.859 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.CustomFieldResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.870 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.ExportResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.892 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.InvoiceResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.897 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.PaymentMethodResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.912 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.PaymentResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.917 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.PluginResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.922 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.RefundResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.927 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.SecurityResource to GuiceInstantiatedComponentProvider
16:02:23.941 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.SubscriptionResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.944 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.TagDefinitionResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.946 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.TagResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.950 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.TenantResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.960 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.TestResource to GuiceInstantiatedComponentProvider
16:02:23.965 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.UsageResource to GuiceInstantiatedComponentProvider
16:02:23.987 [localhost-startStop-1] INFO o.k.b.s.filters.KillbillGuiceFilter - Kill Bill server has started
16:02:23.988 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [https://raw.github.com/killbill/killbill/master/server/src/main/resources/update-checker/killbill-server-update-list.properties] for [org.killbill.server.updateCheck.url] on [org.killbill.billing.server.config.UpdateCheckConfig#updateCheckURL()]
16:02:23.988 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.server.updateCheck.connectTimeout] on [org.killbill.billing.server.config.UpdateCheckConfig#updateCheckConnectionTimeout()]
16:02:23.988 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.server.updateCheck.skip] on [org.killbill.billing.server.config.UpdateCheckConfig#shouldSkipUpdateCheck()]
16:02:23.991 [localhost-startStop-1] INFO o.k.b.s.updatechecker.UpdateChecker - For Kill Bill Commercial Support, visit http://thebillingproject.com or send an email to sup...@thebillingproject.com
avr. 28, 2014 4:02:24 PM org.apache.catalina.startup.HostConfig deployDirectory
Infos: Déploiement du répertoire /home/me/workspaces/ij/tomcat7/webapps/kb de l'application web
16:02:25.746 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [true] for [org.killbill.server.multitenant] on [org.killbill.billing.server.config.KillbillServerConfig#isMultiTenancyEnabled()]
16:02:25.754 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.server.test.mode] on [org.killbill.billing.server.config.KillbillServerConfig#isTestModeEnabled()]
16:02:26.170 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [30] for [org.killbill.dao.maxActive] on [org.killbill.billing.server.config.DaoConfig#getMaxActive()]
16:02:26.170 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [org.killbill.dao.connectionTimeout] on [org.killbill.billing.server.config.DaoConfig#getConnectionTimeout()]
16:02:26.171 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [killbill] for [org.killbill.dao.password] on [org.killbill.billing.server.config.DaoConfig#getPassword()]
16:02:26.172 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [C3P0] for [org.killbill.dao.poolingType] on [org.killbill.billing.server.config.DaoConfig#getConnectionPoolingType()]
16:02:26.174 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [jdbc:mysql://127.0.0.1:3306/billing] for [org.killbill.dao.url] on [org.killbill.billing.server.config.DaoConfig#getJdbcUrl()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.dao.minIdle] on [org.killbill.billing.server.config.DaoConfig#getMinIdle()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [60m] for [org.killbill.dao.idleMaxAge] on [org.killbill.billing.server.config.DaoConfig#getIdleMaxAge()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [0m] for [org.killbill.dao.maxConnectionAge] on [org.killbill.billing.server.config.DaoConfig#getMaxConnectionAge()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.dao.idleConnectionTestPeriod] on [org.killbill.billing.server.config.DaoConfig#getIdleConnectionTestPeriod()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org.killbill.commons.jdbi.transaction.RestartTransactionRunner] for [org.killbill.dao.transactionHandler] on [org.killbill.billing.server.config.DaoConfig#getTransactionHandlerClass()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [WARN] for [org.killbill.dao.logLevel] on [org.killbill.billing.server.config.DaoConfig#getLogLevel()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [killbill] for [org.killbill.dao.user] on [org.killbill.billing.server.config.DaoConfig#getUsername()]
16:02:26.211 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.user] on [org.killbill.billing.util.email.EmailConfig#getSmtpUserName()]
16:02:26.211 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.password] on [org.killbill.billing.util.email.EmailConfig#getSmtpPassword()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [sup...@example.com] for [org.killbill.mail.from] on [org.killbill.billing.util.email.EmailConfig#getDefaultFrom()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [Your invoice] for [org.killbill.mail.invoiceEmailSubject] on [org.killbill.billing.util.email.EmailConfig#getInvoiceEmailSubject()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.port] on [org.killbill.billing.util.email.EmailConfig#getSmtpPort()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.mail.smtp.auth] on [org.killbill.billing.util.email.EmailConfig#useSmtpAuth()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.host] on [org.killbill.billing.util.email.EmailConfig#getSmtpServerName()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.mail.useSSL] on [org.killbill.billing.util.email.EmailConfig#useSSL()]
16:02:26.219 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [ehcache.xml] for [org.killbill.cache.config.location] on [org.killbill.billing.util.config.CacheConfig#getCacheConfigLocation()]
16:02:26.233 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [SpyCarBasic.xml] for [org.killbill.catalog.uri] on [org.killbill.billing.util.config.CatalogConfig#getCatalogURI()]
16:02:26.246 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:26.248 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events] for [org.killbill.persistent.bus.${instanceName}.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:26.248 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events_history] for [org.killbill.persistent.bus.${instanceName}.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.sticky] on [org.killbill.notificationq.api.NotificationQueueConfig#isSticky()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.notificationq.${instanceName}.max.failure.retry] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxFailureRetries()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [7] for [org.killbill.notificationq.${instanceName}.claimed] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxEntriesClaimed()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.notificationq.${instanceName}.claim.time] on [org.killbill.notificationq.api.NotificationQueueConfig#getClaimedTime()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.notificationq.${instanceName}.sleep] on [org.killbill.notificationq.api.NotificationQueueConfig#getSleepTimeMs()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.notification.off] on [org.killbill.notificationq.api.NotificationQueueConfig#isProcessingOff()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.notificationq.${instanceName}.notification.nbThreads] on [org.killbill.notificationq.api.NotificationQueueConfig#getNbThreads()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.useInflightQ] on [org.killbill.notificationq.api.NotificationQueueConfig#isUsingInflightQueue()]
16:02:26.266 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [0] for [org.killbill.notificationq.${instanceName}.queue.capacity] on [org.killbill.notificationq.api.NotificationQueueConfig#getQueueCapacity()]
16:02:26.266 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [notifications] for [org.killbill.notificationq.${instanceName}.tableName] on [org.killbill.notificationq.api.NotificationQueueConfig#getTableName()]
16:02:26.266 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [notifications_history] for [org.killbill.notificationq.${instanceName}.historyTableName] on [org.killbill.notificationq.api.NotificationQueueConfig#getHistoryTableName()]
16:02:26.281 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [36] for [org.killbill.invoice.maxNumberOfMonthsInFuture] on [org.killbill.billing.util.config.InvoiceConfig#getNumberOfMonthsInFuture()]
16:02:26.281 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.invoice.emailNotificationsEnabled] on [org.killbill.billing.util.config.InvoiceConfig#isEmailNotificationsEnabled()]
16:02:26.289 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org.killbill.billing.invoice.template.formatters.DefaultInvoiceFormatterFactory] for [org.killbill.template.invoiceFormatterFactoryClass] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceFormatterFactoryClass()]
16:02:26.290 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/template/translation/CatalogTranslation] for [org.killbill.catalog.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getCatalogBundlePath()]
16:02:26.291 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [en_US] for [org.killbill.default.locale] on [org.killbill.billing.util.template.translation.TranslatorConfig#getDefaultLocale()]
16:02:26.291 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/template/translation/InvoiceTranslation] for [org.killbill.template.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceTemplateBundlePath()]
16:02:26.291 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/email/templates/HtmlInvoiceTemplate.mustache] for [org.killbill.template.name] on [org.killbill.billing.util.template.translation.TranslatorConfig#getTemplateName()]
16:02:26.291 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - 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()]
16:02:26.330 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10] for [org.killbill.payment.plugin.threads.nb] on [org.killbill.billing.util.config.PaymentConfig#getPaymentPluginThreadNb()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [__external_payment__] for [org.killbill.payment.provider.default] on [org.killbill.billing.util.config.PaymentConfig#getDefaultPaymentProvider()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8,8,8] for [org.killbill.payment.retry.days] on [org.killbill.billing.util.config.PaymentConfig#getPaymentRetryDays()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [300] for [org.killbill.payment.failure.retry.start.sec] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryStart()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [2] for [org.killbill.payment.failure.retry.multiplier] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryMultiplier()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8] for [org.killbill.payment.failure.retry.max.attempts] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryMaxAttempts()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [90s] for [org.killbill.payment.plugin.timeout] on [org.killbill.billing.util.config.PaymentConfig#getPaymentPluginTimeout()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.payment.off] on [org.killbill.billing.util.config.PaymentConfig#isPaymentOff()]
16:02:26.354 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:26.354 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:26.354 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:26.354 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events] for [org.killbill.persistent.bus.${instanceName}.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events_history] for [org.killbill.persistent.bus.${instanceName}.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:26.356 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:26.356 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:26.356 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:26.356 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [bus_ext_events] for [org.killbill.persistent.bus.external.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [bus_ext_events_history] for [org.killbill.persistent.bus.external.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:26.364 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [NoOverdueConfig.xml] for [org.killbill.overdue.uri] on [org.killbill.billing.overdue.OverdueProperties#getConfigURI()]
16:02:26.372 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill-currency-plugin] for [org.killbill.currency.provider.default] on [org.killbill.billing.util.config.CurrencyConfig#getDefaultCurrencyProvider()]
16:02:26.388 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill.properties] for [org.killbill.osgi.bundle.property.name] on [org.killbill.billing.util.config.OSGIConfig#getOSGIKillbillPropertyName()]
16:02:26.388 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/var/tmp/felix] for [org.killbill.osgi.root.dir] on [org.killbill.billing.util.config.OSGIConfig#getOSGIBundleRootDir()]
16:02:26.388 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [osgi-cache] for [org.killbill.osgi.bundle.cache.name] on [org.killbill.billing.util.config.OSGIConfig#getOSGIBundleCacheName()]
16:02:26.388 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/var/tmp/bundles] for [org.killbill.osgi.bundle.install.dir] on [org.killbill.billing.util.config.OSGIConfig#getRootInstallationDir()]
16:02:26.388 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - 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.invoice.api,org.killbill.billing.entitlement.api,org.killbill.billing,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.payment.api,org.killbill.billing.payment.plugin.api,org.killbill.billing.tenant.api,org.killbill.billing.usage.api,org.killbill.billing.util.api,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.currency.api,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.jws.soap,org.xml.sax.ext;org.xml.sax.helpers;org.xml.sax,sun.misc,sun.misc.unsafe,javax.crypto,javax.crypto.spec,javax.management,javax.servlet;version=3.0,javax.servlet.http;version=3.0,org.joda.time;org.joda.time.format;version=2.3,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,org.slf4j;version=1.7.2] for [org.killbill.osgi.system.bundle.export.packages] on [org.killbill.billing.util.config.OSGIConfig#getSystemBundleExportPackages()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [30] for [org.killbill.billing.osgi.jdbc.maxActive] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMaxActive()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [org.killbill.billing.osgi.jdbc.connectionTimeout] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getConnectionTimeout()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill] for [org.killbill.billing.osgi.jdbc.password] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getPassword()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [jdbc:h2:file:killbill;MODE=MYSQL;DB_CLOSE_DELAY=-1;MVCC=true;DB_CLOSE_ON_EXIT=FALSE] for [org.killbill.billing.osgi.jdbc.url] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getJdbcUrl()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.billing.osgi.jdbc.minIdle] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMinIdle()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill] for [org.killbill.billing.osgi.jdbc.user] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getUsername()]
16:02:26.525 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1h] for [org.killbill.rbac.globalSessionTimeout] on [org.killbill.billing.util.config.RbacConfig#getGlobalSessionTimeout()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [classpath:shiro.ini] for [org.killbill.security.shiroResourcePath] on [org.killbill.billing.util.config.SecurityConfig#getShiroResourcePath()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [memberOf=uid={0}] for [org.killbill.security.ldap.groupSearchFilter] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPGroupSearchFilter()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [memberOf] for [org.killbill.security.ldap.groupNameId] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPGroupNameID()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [admin = *:*
finance = invoice:*, payment:*
support = entitlement:*, invoice:item_adjust] for [org.killbill.security.ldap.permissionsByGroup] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPPermissionsByGroup()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [ldap://127.0.0.1:389] for [org.killbill.security.ldap.url] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPUrl()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.systemUsername] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSystemUsername()]
16:02:26.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.systemPassword] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSystemPassword()]
16:02:26.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [simple] for [org.killbill.security.ldap.authenticationMechanism] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPAuthenticationMechanism()]
16:02:26.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.searchBase] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSearchBase()]
16:02:26.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.userDnTemplate] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPUserDnTemplate()]
16:02:26.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.security.ldap.disableSSLCheck] on [org.killbill.billing.util.config.SecurityConfig#disableShiroLDAPSSLCheck()]
16:02:27.291 [localhost-startStop-1] INFO com.mchange.v2.log.MLog - MLog clients using java 1.4+ standard logging.
16:02:27.311 [localhost-startStop-1] INFO com.mchange.v2.c3p0.C3P0Registry - Initializing c3p0-0.9.2 [built 09-February-2013 02:13:17 +0000; debug? true; trace: 10]
16:02:27.312 [localhost-startStop-1] WARN c.m.v.c.m.ActiveManagementCoordinator - A C3P0Registry mbean is already registered. This probably means that an application using c3p0 was undeployed, but not all PooledDataSources were closed prior to undeployment. This may lead to resource leaks over time. Please take care to close all PooledDataSources.
16:02:27.372 [localhost-startStop-1] INFO o.k.b.server.modules.DBIProvider - Using org.killbill.commons.jdbi.transaction.RestartTransactionRunner as a transaction handler class
16:02:27.662 [localhost-startStop-1] INFO o.k.b.p.p.DefaultPaymentProviderPluginRegistry - DefaultPaymentProviderPluginRegistry registering service __EXTERNAL_PAYMENT__
==> At this point the other stack trace in the localhost log file is dumped (see my first message). <==
avr. 28, 2014 4:02:28 PM org.apache.catalina.core.StandardContext startInternal
Grave: Error listenerStart
avr. 28, 2014 4:02:28 PM org.apache.catalina.core.StandardContext startInternal
Grave: Erreur de démarrage du contexte [/kb] suite aux erreurs précédentes
16:02:28.079 [localhost-startStop-1] INFO o.k.b.s.l.KillbillGuiceListener - IrsKillbillListener : contextDestroyed
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesJdbc
Grave: The web application [/kb] registered the JDBC driver [com.mysql.jdbc.Driver] but failed to unregister it when the web application was stopped. To prevent a memory leak, the JDBC Driver has been forcibly unregistered.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [com.google.inject.internal.util.$Finalizer] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [Abandoned connection cleanup thread] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [net.sf.ehcache.CacheManager@41ff5e0] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #1] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #2] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #3] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #4] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #5] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #6] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #7] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #8] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O boss #9] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [Timer-1] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader checkThreadLocalMapForLeaks
Grave: The web application [/kb] created a ThreadLocal with key of type [com.google.inject.internal.InjectorImpl$1] (value [com.google.inject.internal.InjectorImpl$1@108d92e2]) and a value of type [java.lang.Object[]] (value [[Ljava.lang.Object;@3ea63beb]) but failed to remove it when the web application was stopped. Threads are going to be renewed over time to try and avoid a probable memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.startup.HostConfig deployDirectory
Infos: Déploiement du répertoire /home/me/workspaces/ij/tomcat7/webapps/ROOT de l'application web
avr. 28, 2014 4:02:28 PM org.apache.coyote.AbstractProtocol start
Infos: Starting ProtocolHandler ["http-bio-8080"]
avr. 28, 2014 4:02:28 PM org.apache.coyote.AbstractProtocol start
Infos: Starting ProtocolHandler ["ajp-bio-8009"]
avr. 28, 2014 4:02:28 PM org.apache.catalina.startup.Catalina start
Infos: Server startup in 33906 ms
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader loadClass
Infos: Illegal access: this web application instance has been stopped already. Could not load net.sf.ehcache.util.ProductInfo. The eventual following stack trace is caused by an error thrown for debugging purposes as well as to attempt to terminate the thread which caused the illegal access, and has no functional impact.
java.lang.IllegalStateException
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1600)
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1559)
at net.sf.ehcache.util.UpdateChecker.buildParamsString(UpdateChecker.java:133)
at net.sf.ehcache.util.UpdateChecker.buildUpdateCheckUrl(UpdateChecker.java:123)
at net.sf.ehcache.util.UpdateChecker.doCheck(UpdateChecker.java:68)
at net.sf.ehcache.util.UpdateChecker.checkForUpdate(UpdateChecker.java:60)
at net.sf.ehcache.util.UpdateChecker.run(UpdateChecker.java:51)
at java.util.TimerThread.mainLoop(Timer.java:555)
at java.util.TimerThread.run(Timer.java:505)
16:02:30.999 [net.sf.ehcache.CacheManager@49d999bd] INFO net.sf.ehcache.util.UpdateChecker - New update(s) found: 2.6.5 [http://www.terracotta.org/confluence/display/release/Release+Notes+Ehcache+Core+2.6]. Please check http://ehcache.org for the latest version.
Of course I should have shared all that, please find the whole startup sequence logs below. Note that the log I pasted in my previous message was from the localhost.log file.
My install is completely standard, i.e. I installed JDK 1.7 straight from Oracle's website with the Mac OS X installer and the Tomcat install comes from the link pasted in the user guide (https://s3.amazonaws.com/kb-binaries/apache-tomcat-7.0.42.tar.gz). Then I followed the instructions in the user guide and ended up with the following Tomcat settings:
In $TOMCAT/conf/Catalina/localhost/Root.xml:
<Context docBase="/home/me/workspaces/ij/kb.war"></Context>
At the end of $TOMCAT/conf/catalina.properties:
# Kill Bill properties
org.killbill.dao.url=jdbc:mysql://127.0.0.1:3306/billing
org.killbill.dao.user=killbill
org.killbill.dao.password=killbill
ANTLR_USE_DIRECT_CLASS_LOADING=true
And here is the full output for catalina.out:
avr. 28, 2014 4:01:53 PM org.apache.catalina.core.AprLifecycleListener init
Infos: The APR based Apache Tomcat Native library which allows optimal performance in production environments was not found on the java.library.path: /home/me/Library/Java/Extensions:/Library/Java/Extensions:/Network/Library/Java/Extensions:/System/Library/Java/Extensions:/usr/lib/java:.
avr. 28, 2014 4:01:54 PM org.apache.coyote.AbstractProtocol init
Infos: Initializing ProtocolHandler ["http-bio-8080"]
avr. 28, 2014 4:01:54 PM org.apache.coyote.AbstractProtocol init
Infos: Initializing ProtocolHandler ["ajp-bio-8009"]
avr. 28, 2014 4:01:54 PM org.apache.catalina.startup.Catalina load
Infos: Initialization processed in 476 ms
avr. 28, 2014 4:01:54 PM org.apache.catalina.core.StandardService startInternal
Infos: Démarrage du service Catalina
avr. 28, 2014 4:01:54 PM org.apache.catalina.core.StandardEngine startInternal
Infos: Starting Servlet Engine: Apache Tomcat/7.0.42
avr. 28, 2014 4:01:54 PM org.apache.catalina.startup.HostConfig deployDescriptor
Infos: Déploiement du descripteur de configuration /home/me/workspaces/ij/tomcat7/conf/Catalina/localhost/Root.xml
16:02:19.027 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [true] for [org.killbill.server.multitenant] on [org.killbill.billing.server.config.KillbillServerConfig#isMultiTenancyEnabled()]
16:02:19.031 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.server.test.mode] on [org.killbill.billing.server.config.KillbillServerConfig#isTestModeEnabled()]
16:02:19.474 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [30] for [org.killbill.dao.maxActive] on [org.killbill.billing.server.config.DaoConfig#getMaxActive()]
16:02:19.474 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [org.killbill.dao.connectionTimeout] on [org.killbill.billing.server.config.DaoConfig#getConnectionTimeout()]
16:02:19.477 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [killbill] for [org.killbill.dao.password] on [org.killbill.billing.server.config.DaoConfig#getPassword()]
16:02:19.478 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [C3P0] for [org.killbill.dao.poolingType] on [org.killbill.billing.server.config.DaoConfig#getConnectionPoolingType()]
16:02:19.479 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [jdbc:mysql://127.0.0.1:3306/billing] for [org.killbill.dao.url] on [org.killbill.billing.server.config.DaoConfig#getJdbcUrl()]
16:02:19.480 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.dao.minIdle] on [org.killbill.billing.server.config.DaoConfig#getMinIdle()]
16:02:19.480 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [60m] for [org.killbill.dao.idleMaxAge] on [org.killbill.billing.server.config.DaoConfig#getIdleMaxAge()]
16:02:19.480 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [0m] for [org.killbill.dao.maxConnectionAge] on [org.killbill.billing.server.config.DaoConfig#getMaxConnectionAge()]
16:02:19.480 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.dao.idleConnectionTestPeriod] on [org.killbill.billing.server.config.DaoConfig#getIdleConnectionTestPeriod()]
16:02:19.481 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org.killbill.commons.jdbi.transaction.RestartTransactionRunner] for [org.killbill.dao.transactionHandler] on [org.killbill.billing.server.config.DaoConfig#getTransactionHandlerClass()]
16:02:19.481 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [WARN] for [org.killbill.dao.logLevel] on [org.killbill.billing.server.config.DaoConfig#getLogLevel()]
16:02:19.481 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [killbill] for [org.killbill.dao.user] on [org.killbill.billing.server.config.DaoConfig#getUsername()]
16:02:19.500 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.user] on [org.killbill.billing.util.email.EmailConfig#getSmtpUserName()]
16:02:19.500 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.password] on [org.killbill.billing.util.email.EmailConfig#getSmtpPassword()]
16:02:19.501 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [sup...@example.com] for [org.killbill.mail.from] on [org.killbill.billing.util.email.EmailConfig#getDefaultFrom()]
16:02:19.501 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [Your invoice] for [org.killbill.mail.invoiceEmailSubject] on [org.killbill.billing.util.email.EmailConfig#getInvoiceEmailSubject()]
16:02:19.501 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.port] on [org.killbill.billing.util.email.EmailConfig#getSmtpPort()]
16:02:19.502 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.mail.smtp.auth] on [org.killbill.billing.util.email.EmailConfig#useSmtpAuth()]
16:02:19.502 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.host] on [org.killbill.billing.util.email.EmailConfig#getSmtpServerName()]
16:02:19.502 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.mail.useSSL] on [org.killbill.billing.util.email.EmailConfig#useSSL()]
16:02:19.509 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [ehcache.xml] for [org.killbill.cache.config.location] on [org.killbill.billing.util.config.CacheConfig#getCacheConfigLocation()]
16:02:19.524 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [SpyCarBasic.xml] for [org.killbill.catalog.uri] on [org.killbill.billing.util.config.CatalogConfig#getCatalogURI()]
16:02:19.535 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:19.535 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:19.535 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:19.536 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:19.536 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:19.536 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:19.537 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:19.537 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:19.537 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:19.537 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events] for [org.killbill.persistent.bus.${instanceName}.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:19.538 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events_history] for [org.killbill.persistent.bus.${instanceName}.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:19.550 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.sticky] on [org.killbill.notificationq.api.NotificationQueueConfig#isSticky()]
16:02:19.551 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.notificationq.${instanceName}.max.failure.retry] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxFailureRetries()]
16:02:19.551 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [7] for [org.killbill.notificationq.${instanceName}.claimed] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxEntriesClaimed()]
16:02:19.551 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.notificationq.${instanceName}.claim.time] on [org.killbill.notificationq.api.NotificationQueueConfig#getClaimedTime()]
16:02:19.551 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.notificationq.${instanceName}.sleep] on [org.killbill.notificationq.api.NotificationQueueConfig#getSleepTimeMs()]
16:02:19.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.notification.off] on [org.killbill.notificationq.api.NotificationQueueConfig#isProcessingOff()]
16:02:19.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.notificationq.${instanceName}.notification.nbThreads] on [org.killbill.notificationq.api.NotificationQueueConfig#getNbThreads()]
16:02:19.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.useInflightQ] on [org.killbill.notificationq.api.NotificationQueueConfig#isUsingInflightQueue()]
16:02:19.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [0] for [org.killbill.notificationq.${instanceName}.queue.capacity] on [org.killbill.notificationq.api.NotificationQueueConfig#getQueueCapacity()]
16:02:19.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [notifications] for [org.killbill.notificationq.${instanceName}.tableName] on [org.killbill.notificationq.api.NotificationQueueConfig#getTableName()]
16:02:19.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [notifications_history] for [org.killbill.notificationq.${instanceName}.historyTableName] on [org.killbill.notificationq.api.NotificationQueueConfig#getHistoryTableName()]
16:02:19.577 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [36] for [org.killbill.invoice.maxNumberOfMonthsInFuture] on [org.killbill.billing.util.config.InvoiceConfig#getNumberOfMonthsInFuture()]
16:02:19.577 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.invoice.emailNotificationsEnabled] on [org.killbill.billing.util.config.InvoiceConfig#isEmailNotificationsEnabled()]
16:02:19.584 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org.killbill.billing.invoice.template.formatters.DefaultInvoiceFormatterFactory] for [org.killbill.template.invoiceFormatterFactoryClass] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceFormatterFactoryClass()]
16:02:19.585 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/template/translation/CatalogTranslation] for [org.killbill.catalog.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getCatalogBundlePath()]
16:02:19.586 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [en_US] for [org.killbill.default.locale] on [org.killbill.billing.util.template.translation.TranslatorConfig#getDefaultLocale()]
16:02:19.586 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/template/translation/InvoiceTranslation] for [org.killbill.template.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceTemplateBundlePath()]
16:02:19.586 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/email/templates/HtmlInvoiceTemplate.mustache] for [org.killbill.template.name] on [org.killbill.billing.util.template.translation.TranslatorConfig#getTemplateName()]
16:02:19.586 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - 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()]
16:02:19.622 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10] for [org.killbill.payment.plugin.threads.nb] on [org.killbill.billing.util.config.PaymentConfig#getPaymentPluginThreadNb()]
16:02:19.622 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [__external_payment__] for [org.killbill.payment.provider.default] on [org.killbill.billing.util.config.PaymentConfig#getDefaultPaymentProvider()]
16:02:19.623 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8,8,8] for [org.killbill.payment.retry.days] on [org.killbill.billing.util.config.PaymentConfig#getPaymentRetryDays()]
16:02:19.623 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [300] for [org.killbill.payment.failure.retry.start.sec] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryStart()]
16:02:19.623 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [2] for [org.killbill.payment.failure.retry.multiplier] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryMultiplier()]
16:02:19.623 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8] for [org.killbill.payment.failure.retry.max.attempts] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryMaxAttempts()]
16:02:19.624 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [90s] for [org.killbill.payment.plugin.timeout] on [org.killbill.billing.util.config.PaymentConfig#getPaymentPluginTimeout()]
16:02:19.624 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.payment.off] on [org.killbill.billing.util.config.PaymentConfig#isPaymentOff()]
16:02:19.642 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:19.642 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:19.642 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:19.642 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:19.643 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:19.643 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:19.643 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:19.643 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:19.643 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:19.644 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events] for [org.killbill.persistent.bus.${instanceName}.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:19.644 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events_history] for [org.killbill.persistent.bus.${instanceName}.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:19.644 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:19.644 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:19.644 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:19.645 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:19.645 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:19.645 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:19.645 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:19.645 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:19.646 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:19.646 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [bus_ext_events] for [org.killbill.persistent.bus.external.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:19.646 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [bus_ext_events_history] for [org.killbill.persistent.bus.external.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:19.653 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [NoOverdueConfig.xml] for [org.killbill.overdue.uri] on [org.killbill.billing.overdue.OverdueProperties#getConfigURI()]
16:02:19.660 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill-currency-plugin] for [org.killbill.currency.provider.default] on [org.killbill.billing.util.config.CurrencyConfig#getDefaultCurrencyProvider()]
16:02:19.674 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill.properties] for [org.killbill.osgi.bundle.property.name] on [org.killbill.billing.util.config.OSGIConfig#getOSGIKillbillPropertyName()]
16:02:19.674 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/var/tmp/felix] for [org.killbill.osgi.root.dir] on [org.killbill.billing.util.config.OSGIConfig#getOSGIBundleRootDir()]
16:02:19.674 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [osgi-cache] for [org.killbill.osgi.bundle.cache.name] on [org.killbill.billing.util.config.OSGIConfig#getOSGIBundleCacheName()]
16:02:19.674 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/var/tmp/bundles] for [org.killbill.osgi.bundle.install.dir] on [org.killbill.billing.util.config.OSGIConfig#getRootInstallationDir()]
16:02:19.675 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - 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.invoice.api,org.killbill.billing.entitlement.api,org.killbill.billing,org.killbill.billing.notification.api,org.killbill.billing.notification.plugin.api,org.killbill.billing.osgi.api,org.killbill.billing.osgi.api.config,org.killbill.billing.overdue,org.killbill.billing.payment.api,org.killbill.billing.payment.plugin.api,org.killbill.billing.tenant.api,org.killbill.billing.usage.api,org.killbill.billing.util.api,org.killbill.billing.util.audit,org.killbill.billing.util.callcontext,org.killbill.billing.util.customfield,org.killbill.billing.notification.plugin,org.killbill.billing.currency.plugin.api,org.killbill.billing.currency.api,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,sun.misc,sun.misc.unsafe,javax.crypto,javax.crypto.spec,javax.management,javax.servlet;version=3.0,javax.servlet.http;version=3.0,org.joda.time;org.joda.time.format;version=2.3,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,org.slf4j;version=1.7.2] for [org.killbill.osgi.system.bundle.export.packages] on [org.killbill.billing.util.config.OSGIConfig#getSystemBundleExportPackages()]
16:02:19.679 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [30] for [org.killbill.billing.osgi.jdbc.maxActive] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMaxActive()]
16:02:19.679 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [org.killbill.billing.osgi.jdbc.connectionTimeout] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getConnectionTimeout()]
16:02:19.679 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill] for [org.killbill.billing.osgi.jdbc.password] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getPassword()]
16:02:19.680 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [jdbc:h2:file:killbill;MODE=MYSQL;DB_CLOSE_DELAY=-1;MVCC=true;DB_CLOSE_ON_EXIT=FALSE] for [org.killbill.billing.osgi.jdbc.url] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getJdbcUrl()]
16:02:19.680 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.billing.osgi.jdbc.minIdle] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMinIdle()]
16:02:19.680 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill] for [org.killbill.billing.osgi.jdbc.user] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getUsername()]
16:02:19.799 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1h] for [org.killbill.rbac.globalSessionTimeout] on [org.killbill.billing.util.config.RbacConfig#getGlobalSessionTimeout()]
16:02:19.829 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [classpath:shiro.ini] for [org.killbill.security.shiroResourcePath] on [org.killbill.billing.util.config.SecurityConfig#getShiroResourcePath()]
16:02:19.829 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [memberOf=uid={0}] for [org.killbill.security.ldap.groupSearchFilter] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPGroupSearchFilter()]
16:02:19.829 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [memberOf] for [org.killbill.security.ldap.groupNameId] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPGroupNameID()]
16:02:19.829 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [admin = *:*
finance = invoice:*, payment:*
support = entitlement:*, invoice:item_adjust] for [org.killbill.security.ldap.permissionsByGroup] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPPermissionsByGroup()]
16:02:19.829 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [ldap://127.0.0.1:389] for [org.killbill.security.ldap.url] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPUrl()]
16:02:19.830 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.systemUsername] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSystemUsername()]
16:02:19.830 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.systemPassword] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSystemPassword()]
16:02:19.830 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [simple] for [org.killbill.security.ldap.authenticationMechanism] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPAuthenticationMechanism()]
16:02:19.830 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.searchBase] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSearchBase()]
16:02:19.830 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.userDnTemplate] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPUserDnTemplate()]
16:02:19.831 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.security.ldap.disableSSLCheck] on [org.killbill.billing.util.config.SecurityConfig#disableShiroLDAPSSLCheck()]
16:02:20.851 [localhost-startStop-1] INFO com.mchange.v2.log.MLog - MLog clients using java 1.4+ standard logging.
16:02:20.878 [localhost-startStop-1] INFO com.mchange.v2.c3p0.C3P0Registry - Initializing c3p0-0.9.2 [built 09-February-2013 02:13:17 +0000; debug? true; trace: 10]
16:02:20.957 [localhost-startStop-1] INFO o.k.b.server.modules.DBIProvider - Using org.killbill.commons.jdbi.transaction.RestartTransactionRunner as a transaction handler class
16:02:21.351 [localhost-startStop-1] INFO o.k.b.p.p.DefaultPaymentProviderPluginRegistry - DefaultPaymentProviderPluginRegistry registering service __EXTERNAL_PAYMENT__
16:02:21.823 [localhost-startStop-1] INFO o.k.b.s.l.KillbillGuiceListener - KillbillLifecycleListener : contextInitialized
16:02:21.858 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage LOAD_CATALOG
16:02:21.860 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler loadCatalog for service catalog-service
16:02:21.861 [localhost-startStop-1] INFO o.k.b.util.config.catalog.XMLLoader - Initializing an object of class org.killbill.billing.catalog.StandaloneCatalog from xml file at: file:/home/me/workspaces/ij/tomcat7/work/Catalina/localhost/Root/WEB-INF/classes/SpyCarBasic.xml
16:02:22.198 [localhost-startStop-1] INFO o.k.b.util.config.catalog.XMLLoader - Errors: 0 for file:/home/me/workspaces/ij/tomcat7/work/Catalina/localhost/Root/WEB-INF/classes/SpyCarBasic.xml
16:02:22.198 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler loadConfig for service overdue-service
16:02:22.198 [localhost-startStop-1] INFO o.k.b.util.config.catalog.XMLLoader - Initializing an object of class org.killbill.billing.overdue.config.OverdueConfig from xml file at: NoOverdueConfig.xml
16:02:22.237 [localhost-startStop-1] INFO o.k.b.util.config.catalog.XMLLoader - Errors: 0 for NoOverdueConfig.xml
16:02:22.238 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage INIT_BUS
16:02:22.238 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler startBus for service bus-service
16:02:22.238 [localhost-startStop-1] INFO org.killbill.queue.DBBackedQueue - DBBackedQueue-bus-bus_events: Initialized with isQueueOpenForWrite = false, isQueueOpenForRead = false
16:02:22.238 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - Bus: Starting with 3 threads
16:02:22.240 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [28] starting
16:02:22.240 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [30] starting
16:02:22.240 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [29] starting
16:02:22.241 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - Bus: Done waiting for all threads to be started, got 3/3
16:02:22.241 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler startBus for service beatrix-service
16:02:22.241 [localhost-startStop-1] INFO org.killbill.queue.DBBackedQueue - DBBackedQueue-bus-bus_ext_events: Initialized with isQueueOpenForWrite = false, isQueueOpenForRead = false
16:02:22.241 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - Bus: Starting with 3 threads
16:02:22.242 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [31] starting
16:02:22.242 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [32] starting
16:02:22.243 [bus-th] INFO o.k.queue.DefaultQueueLifecycle - Bus: Thread bus-th [33] starting
16:02:22.243 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - Bus: Done waiting for all threads to be started, got 3/3
16:02:22.244 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage INIT_PLUGIN
16:02:22.244 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service osgi-service
16:02:22.250 [localhost-startStop-1] INFO o.k.billing.osgi.DefaultOSGIService - Deleted recursively /var/tmp/felix/osgi-cache/bundle0
16:02:22.250 [localhost-startStop-1] INFO o.k.billing.osgi.DefaultOSGIService - Deleted recursively /var/tmp/felix/osgi-cache
16:02:22.286 [bus-th] INFO c.m.v.c.i.AbstractPoolBackedDataSource - Initializing c3p0 pool... com.mchange.v2.c3p0.ComboPooledDataSource [ acquireIncrement -> 3, acquireRetryAttempts -> 30, acquireRetryDelay -> 1000, autoCommitOnClose -> false, automaticTestTable -> null, breakAfterAcquireFailure -> false, checkoutTimeout -> 10000, connectionCustomizerClassName -> null, connectionTesterClassName -> com.mchange.v2.c3p0.impl.DefaultConnectionTester, dataSourceName -> 1hge15w911asj7ly15d2osm|70bf46e1, debugUnreturnedConnectionStackTraces -> false, description -> null, driverClass -> null, factoryClassLocation -> null, forceIgnoreUnresolvedTransactions -> false, identityToken -> 1hge15w911asj7ly15d2osm|70bf46e1, idleConnectionTestPeriod -> 300, initialPoolSize -> 3, jdbcUrl -> jdbc:mysql://127.0.0.1:3306/billing, maxAdministrativeTaskTime -> 0, maxConnectionAge -> 0, maxIdleTime -> 3600, maxIdleTimeExcessConnections -> 0, maxPoolSize -> 30, maxStatements -> 0, maxStatementsPerConnection -> 0, minPoolSize -> 1, numHelperThreads -> 3, preferredTestQuery -> null, properties -> {user=******, password=******}, propertyCycle -> 0, statementCacheNumDeferredCloseThreads -> 0, testConnectionOnCheckin -> false, testConnectionOnCheckout -> false, unreturnedConnectionTimeout -> 0, userOverrides -> {}, usesTraditionalReflectiveProxies -> false ]
16:02:22.464 [localhost-startStop-1] WARN o.killbill.billing.osgi.FileInstall - Unable to find the JRuby bundle at /var/tmp/bundles/platform/jruby.jar, ruby plugins won't be started!
16:02:22.464 [localhost-startStop-1] WARN org.slf4j.Logger - Configuration root dir /var/tmp/bundles/platform/ is not a valid directory
16:02:22.465 [localhost-startStop-1] WARN o.k.b.osgi.pluginconf.PluginFinder - Configuration root dir /var/tmp/bundles/plugins/ruby is not a valid directory
16:02:22.465 [localhost-startStop-1] WARN o.k.b.osgi.pluginconf.PluginFinder - Configuration root dir /var/tmp/bundles/plugins/java is not a valid directory
16:02:22.465 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage INIT_SERVICE
16:02:22.465 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service subscription-service
16:02:22.466 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service entitlement-service
16:02:22.467 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler registerForNotifications for service beatrix-service
16:02:22.467 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service security-service
16:02:22.470 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler registerForNotifications for service server-service
16:02:22.471 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service payment-service
16:02:22.472 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service invoice-service
16:02:22.474 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service overdue-service
16:02:22.474 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage START_PLUGIN
16:02:22.474 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service osgi-service
16:02:22.475 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage START_SERVICE
16:02:22.476 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service subscription-service
16:02:22.476 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - NotificationQ: Starting with 1 threads
16:02:22.478 [Notification-queue-dispatch] INFO o.k.queue.DefaultQueueLifecycle - NotificationQ: Thread Notification-queue-dispatch [40] starting
16:02:22.479 [localhost-startStop-1] INFO o.k.queue.DefaultQueueLifecycle - NotificationQ: Done waiting for all threads to be started, got 1/1
16:02:22.479 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service entitlement-service
16:02:22.479 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service payment-service
16:02:22.479 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service invoice-service
16:02:22.479 [localhost-startStop-1] INFO o.k.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service overdue-service
16:02:22.555 [localhost-startStop-1] INFO c.s.j.a.core.PackagesResourceConfig - Scanning for root resource and provider classes in the packages:
org.killbill.billing.jaxrs.mappers
org.killbill.billing.jaxrs.resources
16:02:22.802 [localhost-startStop-1] INFO c.s.j.a.core.ScanningResourceConfig - Root resource classes found:
class org.killbill.billing.jaxrs.resources.InvoiceResource
class org.killbill.billing.jaxrs.resources.ExportResource
class org.killbill.billing.jaxrs.resources.UsageResource
class org.killbill.billing.jaxrs.resources.ChargebackResource
class org.killbill.billing.jaxrs.resources.PaymentResource
class org.killbill.billing.jaxrs.resources.SubscriptionResource
class org.killbill.billing.jaxrs.resources.CatalogResource
class org.killbill.billing.jaxrs.resources.BundleResource
class org.killbill.billing.jaxrs.resources.TagResource
class org.killbill.billing.jaxrs.resources.CreditResource
class org.killbill.billing.jaxrs.resources.PaymentMethodResource
class org.killbill.billing.jaxrs.resources.TenantResource
class org.killbill.billing.jaxrs.resources.TagDefinitionResource
class org.killbill.billing.jaxrs.resources.CustomFieldResource
class org.killbill.billing.jaxrs.resources.SecurityResource
class org.killbill.billing.jaxrs.resources.RefundResource
class org.killbill.billing.jaxrs.resources.AccountResource
class org.killbill.billing.jaxrs.resources.PluginResource
class org.killbill.billing.jaxrs.resources.TestResource
16:02:22.813 [localhost-startStop-1] INFO c.s.j.a.core.ScanningResourceConfig - Provider classes found:
class org.killbill.billing.jaxrs.mappers.PaymentApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.EntityPersistenceExceptionMapper
class org.killbill.billing.jaxrs.mappers.CurrencyValueNullMapper
class org.killbill.billing.jaxrs.mappers.EmailApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.OverdueErrorMapper
class org.killbill.billing.jaxrs.mappers.CatalogApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.BlockingApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.SubscriptionRepairExceptionMapper
class org.killbill.billing.jaxrs.mappers.SubscriptionApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.EntitlementApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.RuntimeExceptionMapper
class org.killbill.billing.jaxrs.mappers.InvoiceApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.ShiroExceptionMapper
class org.killbill.billing.jaxrs.mappers.SubscriptionBillingApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.OverdueApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.IllegalArgumentExceptionMapper
class org.killbill.billing.jaxrs.mappers.BillingExceptionBaseMapper
class org.killbill.billing.jaxrs.mappers.IllegalPlanChangeMapper
class org.killbill.billing.jaxrs.mappers.TagDefinitionApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.TagApiExceptionMapper
class org.killbill.billing.jaxrs.mappers.AccountApiExceptionMapper
16:02:23.120 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.fasterxml.jackson.jaxrs.json.JacksonJsonProvider as a provider class
16:02:23.121 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.AccountResource as a root resource class
16:02:23.121 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.BundleResource as a root resource class
16:02:23.121 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.SubscriptionResource as a root resource class
16:02:23.121 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.InvoiceResource as a root resource class
16:02:23.121 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.CustomFieldResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.TagResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.TagDefinitionResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.CatalogResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.PaymentMethodResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.PaymentResource as a root resource class
16:02:23.122 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.PluginResource as a root resource class
16:02:23.123 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.RefundResource as a root resource class
16:02:23.123 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.TenantResource as a root resource class
16:02:23.123 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering org.killbill.billing.jaxrs.resources.ExportResource as a root resource class
16:02:23.127 [localhost-startStop-1] INFO c.s.j.s.i.a.WebApplicationImpl - Initiating Jersey application, version 'Jersey: 1.18.1 02/19/2014 03:28 AM'
16:02:23.290 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.fasterxml.jackson.jaxrs.json.JacksonJsonProvider to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.822 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.AccountResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.836 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.BundleResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.840 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.CatalogResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.846 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.ChargebackResource to GuiceInstantiatedComponentProvider
16:02:23.856 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.CreditResource to GuiceInstantiatedComponentProvider
16:02:23.859 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.CustomFieldResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.870 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.ExportResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.892 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.InvoiceResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.897 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.PaymentMethodResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.912 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.PaymentResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.917 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.PluginResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.922 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.RefundResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.927 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.SecurityResource to GuiceInstantiatedComponentProvider
16:02:23.941 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.SubscriptionResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.944 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.TagDefinitionResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.946 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.TagResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.950 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.TenantResource to GuiceManagedComponentProvider with the scope "Singleton"
16:02:23.960 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.TestResource to GuiceInstantiatedComponentProvider
16:02:23.965 [localhost-startStop-1] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding org.killbill.billing.jaxrs.resources.UsageResource to GuiceInstantiatedComponentProvider
16:02:23.987 [localhost-startStop-1] INFO o.k.b.s.filters.KillbillGuiceFilter - Kill Bill server has started
16:02:23.988 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [https://raw.github.com/killbill/killbill/master/server/src/main/resources/update-checker/killbill-server-update-list.properties] for [org.killbill.server.updateCheck.url] on [org.killbill.billing.server.config.UpdateCheckConfig#updateCheckURL()]
16:02:23.988 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.server.updateCheck.connectTimeout] on [org.killbill.billing.server.config.UpdateCheckConfig#updateCheckConnectionTimeout()]
16:02:23.988 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.server.updateCheck.skip] on [org.killbill.billing.server.config.UpdateCheckConfig#shouldSkipUpdateCheck()]
16:02:23.991 [localhost-startStop-1] INFO o.k.b.s.updatechecker.UpdateChecker - For Kill Bill Commercial Support, visit http://thebillingproject.com or send an email to sup...@thebillingproject.com
avr. 28, 2014 4:02:24 PM org.apache.catalina.startup.HostConfig deployDirectory
Infos: Déploiement du répertoire /home/me/workspaces/ij/tomcat7/webapps/kb de l'application web
16:02:25.746 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [true] for [org.killbill.server.multitenant] on [org.killbill.billing.server.config.KillbillServerConfig#isMultiTenancyEnabled()]
16:02:25.754 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.server.test.mode] on [org.killbill.billing.server.config.KillbillServerConfig#isTestModeEnabled()]
16:02:26.170 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [30] for [org.killbill.dao.maxActive] on [org.killbill.billing.server.config.DaoConfig#getMaxActive()]
16:02:26.170 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [org.killbill.dao.connectionTimeout] on [org.killbill.billing.server.config.DaoConfig#getConnectionTimeout()]
16:02:26.171 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [killbill] for [org.killbill.dao.password] on [org.killbill.billing.server.config.DaoConfig#getPassword()]
16:02:26.172 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [C3P0] for [org.killbill.dao.poolingType] on [org.killbill.billing.server.config.DaoConfig#getConnectionPoolingType()]
16:02:26.174 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [jdbc:mysql://127.0.0.1:3306/billing] for [org.killbill.dao.url] on [org.killbill.billing.server.config.DaoConfig#getJdbcUrl()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.dao.minIdle] on [org.killbill.billing.server.config.DaoConfig#getMinIdle()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [60m] for [org.killbill.dao.idleMaxAge] on [org.killbill.billing.server.config.DaoConfig#getIdleMaxAge()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [0m] for [org.killbill.dao.maxConnectionAge] on [org.killbill.billing.server.config.DaoConfig#getMaxConnectionAge()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.dao.idleConnectionTestPeriod] on [org.killbill.billing.server.config.DaoConfig#getIdleConnectionTestPeriod()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org.killbill.commons.jdbi.transaction.RestartTransactionRunner] for [org.killbill.dao.transactionHandler] on [org.killbill.billing.server.config.DaoConfig#getTransactionHandlerClass()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [WARN] for [org.killbill.dao.logLevel] on [org.killbill.billing.server.config.DaoConfig#getLogLevel()]
16:02:26.175 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [killbill] for [org.killbill.dao.user] on [org.killbill.billing.server.config.DaoConfig#getUsername()]
16:02:26.211 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.user] on [org.killbill.billing.util.email.EmailConfig#getSmtpUserName()]
16:02:26.211 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.password] on [org.killbill.billing.util.email.EmailConfig#getSmtpPassword()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [sup...@example.com] for [org.killbill.mail.from] on [org.killbill.billing.util.email.EmailConfig#getDefaultFrom()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [Your invoice] for [org.killbill.mail.invoiceEmailSubject] on [org.killbill.billing.util.email.EmailConfig#getInvoiceEmailSubject()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.port] on [org.killbill.billing.util.email.EmailConfig#getSmtpPort()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.mail.smtp.auth] on [org.killbill.billing.util.email.EmailConfig#useSmtpAuth()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.mail.smtp.host] on [org.killbill.billing.util.email.EmailConfig#getSmtpServerName()]
16:02:26.212 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.mail.useSSL] on [org.killbill.billing.util.email.EmailConfig#useSSL()]
16:02:26.219 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [ehcache.xml] for [org.killbill.cache.config.location] on [org.killbill.billing.util.config.CacheConfig#getCacheConfigLocation()]
16:02:26.233 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [SpyCarBasic.xml] for [org.killbill.catalog.uri] on [org.killbill.billing.util.config.CatalogConfig#getCatalogURI()]
16:02:26.246 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:26.247 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:26.248 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events] for [org.killbill.persistent.bus.${instanceName}.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:26.248 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events_history] for [org.killbill.persistent.bus.${instanceName}.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.sticky] on [org.killbill.notificationq.api.NotificationQueueConfig#isSticky()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.notificationq.${instanceName}.max.failure.retry] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxFailureRetries()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [7] for [org.killbill.notificationq.${instanceName}.claimed] on [org.killbill.notificationq.api.NotificationQueueConfig#getMaxEntriesClaimed()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.notificationq.${instanceName}.claim.time] on [org.killbill.notificationq.api.NotificationQueueConfig#getClaimedTime()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.notificationq.${instanceName}.sleep] on [org.killbill.notificationq.api.NotificationQueueConfig#getSleepTimeMs()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.notification.off] on [org.killbill.notificationq.api.NotificationQueueConfig#isProcessingOff()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.notificationq.${instanceName}.notification.nbThreads] on [org.killbill.notificationq.api.NotificationQueueConfig#getNbThreads()]
16:02:26.265 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.notificationq.${instanceName}.useInflightQ] on [org.killbill.notificationq.api.NotificationQueueConfig#isUsingInflightQueue()]
16:02:26.266 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [0] for [org.killbill.notificationq.${instanceName}.queue.capacity] on [org.killbill.notificationq.api.NotificationQueueConfig#getQueueCapacity()]
16:02:26.266 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [notifications] for [org.killbill.notificationq.${instanceName}.tableName] on [org.killbill.notificationq.api.NotificationQueueConfig#getTableName()]
16:02:26.266 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [notifications_history] for [org.killbill.notificationq.${instanceName}.historyTableName] on [org.killbill.notificationq.api.NotificationQueueConfig#getHistoryTableName()]
16:02:26.281 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [36] for [org.killbill.invoice.maxNumberOfMonthsInFuture] on [org.killbill.billing.util.config.InvoiceConfig#getNumberOfMonthsInFuture()]
16:02:26.281 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.invoice.emailNotificationsEnabled] on [org.killbill.billing.util.config.InvoiceConfig#isEmailNotificationsEnabled()]
16:02:26.289 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org.killbill.billing.invoice.template.formatters.DefaultInvoiceFormatterFactory] for [org.killbill.template.invoiceFormatterFactoryClass] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceFormatterFactoryClass()]
16:02:26.290 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/template/translation/CatalogTranslation] for [org.killbill.catalog.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getCatalogBundlePath()]
16:02:26.291 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [en_US] for [org.killbill.default.locale] on [org.killbill.billing.util.template.translation.TranslatorConfig#getDefaultLocale()]
16:02:26.291 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/template/translation/InvoiceTranslation] for [org.killbill.template.bundlePath] on [org.killbill.billing.util.template.translation.TranslatorConfig#getInvoiceTemplateBundlePath()]
16:02:26.291 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [org/killbill/billing/util/email/templates/HtmlInvoiceTemplate.mustache] for [org.killbill.template.name] on [org.killbill.billing.util.template.translation.TranslatorConfig#getTemplateName()]
16:02:26.291 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - 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()]
16:02:26.330 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10] for [org.killbill.payment.plugin.threads.nb] on [org.killbill.billing.util.config.PaymentConfig#getPaymentPluginThreadNb()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [__external_payment__] for [org.killbill.payment.provider.default] on [org.killbill.billing.util.config.PaymentConfig#getDefaultPaymentProvider()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8,8,8] for [org.killbill.payment.retry.days] on [org.killbill.billing.util.config.PaymentConfig#getPaymentRetryDays()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [300] for [org.killbill.payment.failure.retry.start.sec] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryStart()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [2] for [org.killbill.payment.failure.retry.multiplier] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryMultiplier()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8] for [org.killbill.payment.failure.retry.max.attempts] on [org.killbill.billing.util.config.PaymentConfig#getPluginFailureRetryMaxAttempts()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [90s] for [org.killbill.payment.plugin.timeout] on [org.killbill.billing.util.config.PaymentConfig#getPaymentPluginTimeout()]
16:02:26.331 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.payment.off] on [org.killbill.billing.util.config.PaymentConfig#isPaymentOff()]
16:02:26.354 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:26.354 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:26.354 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:26.354 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events] for [org.killbill.persistent.bus.${instanceName}.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:26.355 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [bus_events_history] for [org.killbill.persistent.bus.${instanceName}.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:26.356 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.sticky] on [org.killbill.bus.api.PersistentBusConfig#isSticky()]
16:02:26.356 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.max.failure.retry] on [org.killbill.bus.api.PersistentBusConfig#getMaxFailureRetries()]
16:02:26.356 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [org.killbill.persistent.bus.${instanceName}.claimed] on [org.killbill.bus.api.PersistentBusConfig#getMaxEntriesClaimed()]
16:02:26.356 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [org.killbill.persistent.bus.${instanceName}.claim.time] on [org.killbill.bus.api.PersistentBusConfig#getClaimedTime()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.sleep] on [org.killbill.bus.api.PersistentBusConfig#getSleepTimeMs()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.off] on [org.killbill.bus.api.PersistentBusConfig#isProcessingOff()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [org.killbill.persistent.bus.${instanceName}.nbThreads] on [org.killbill.bus.api.PersistentBusConfig#getNbThreads()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.persistent.bus.${instanceName}.useInflightQ] on [org.killbill.bus.api.PersistentBusConfig#isUsingInflightQueue()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [org.killbill.persistent.bus.${instanceName}.queue.capacity] on [org.killbill.bus.api.PersistentBusConfig#getQueueCapacity()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [bus_ext_events] for [org.killbill.persistent.bus.external.tableName] on [org.killbill.bus.api.PersistentBusConfig#getTableName()]
16:02:26.357 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning value [bus_ext_events_history] for [org.killbill.persistent.bus.external.historyTableName] on [org.killbill.bus.api.PersistentBusConfig#getHistoryTableName()]
16:02:26.364 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [NoOverdueConfig.xml] for [org.killbill.overdue.uri] on [org.killbill.billing.overdue.OverdueProperties#getConfigURI()]
16:02:26.372 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill-currency-plugin] for [org.killbill.currency.provider.default] on [org.killbill.billing.util.config.CurrencyConfig#getDefaultCurrencyProvider()]
16:02:26.388 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill.properties] for [org.killbill.osgi.bundle.property.name] on [org.killbill.billing.util.config.OSGIConfig#getOSGIKillbillPropertyName()]
16:02:26.388 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/var/tmp/felix] for [org.killbill.osgi.root.dir] on [org.killbill.billing.util.config.OSGIConfig#getOSGIBundleRootDir()]
16:02:26.388 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [osgi-cache] for [org.killbill.osgi.bundle.cache.name] on [org.killbill.billing.util.config.OSGIConfig#getOSGIBundleCacheName()]
16:02:26.388 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/var/tmp/bundles] for [org.killbill.osgi.bundle.install.dir] on [org.killbill.billing.util.config.OSGIConfig#getRootInstallationDir()]
16:02:26.388 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - 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.invoice.api,org.killbill.billing.entitlement.api,org.killbill.billing,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.payment.api,org.killbill.billing.payment.plugin.api,org.killbill.billing.tenant.api,org.killbill.billing.usage.api,org.killbill.billing.util.api,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.currency.api,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.jws.soap,org.xml.sax.ext;org.xml.sax.helpers;org.xml.sax,sun.misc,sun.misc.unsafe,javax.crypto,javax.crypto.spec,javax.management,javax.servlet;version=3.0,javax.servlet.http;version=3.0,org.joda.time;org.joda.time.format;version=2.3,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,org.slf4j;version=1.7.2] for [org.killbill.osgi.system.bundle.export.packages] on [org.killbill.billing.util.config.OSGIConfig#getSystemBundleExportPackages()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [30] for [org.killbill.billing.osgi.jdbc.maxActive] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMaxActive()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [org.killbill.billing.osgi.jdbc.connectionTimeout] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getConnectionTimeout()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill] for [org.killbill.billing.osgi.jdbc.password] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getPassword()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [jdbc:h2:file:killbill;MODE=MYSQL;DB_CLOSE_DELAY=-1;MVCC=true;DB_CLOSE_ON_EXIT=FALSE] for [org.killbill.billing.osgi.jdbc.url] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getJdbcUrl()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [org.killbill.billing.osgi.jdbc.minIdle] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getMinIdle()]
16:02:26.394 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill] for [org.killbill.billing.osgi.jdbc.user] on [org.killbill.billing.osgi.glue.OSGIDataSourceConfig#getUsername()]
16:02:26.525 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1h] for [org.killbill.rbac.globalSessionTimeout] on [org.killbill.billing.util.config.RbacConfig#getGlobalSessionTimeout()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [classpath:shiro.ini] for [org.killbill.security.shiroResourcePath] on [org.killbill.billing.util.config.SecurityConfig#getShiroResourcePath()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [memberOf=uid={0}] for [org.killbill.security.ldap.groupSearchFilter] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPGroupSearchFilter()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [memberOf] for [org.killbill.security.ldap.groupNameId] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPGroupNameID()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [admin = *:*
finance = invoice:*, payment:*
support = entitlement:*, invoice:item_adjust] for [org.killbill.security.ldap.permissionsByGroup] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPPermissionsByGroup()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [ldap://127.0.0.1:389] for [org.killbill.security.ldap.url] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPUrl()]
16:02:26.552 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.systemUsername] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSystemUsername()]
16:02:26.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.systemPassword] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSystemPassword()]
16:02:26.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [simple] for [org.killbill.security.ldap.authenticationMechanism] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPAuthenticationMechanism()]
16:02:26.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.searchBase] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPSearchBase()]
16:02:26.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [org.killbill.security.ldap.userDnTemplate] on [org.killbill.billing.util.config.SecurityConfig#getShiroLDAPUserDnTemplate()]
16:02:26.553 [localhost-startStop-1] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [org.killbill.security.ldap.disableSSLCheck] on [org.killbill.billing.util.config.SecurityConfig#disableShiroLDAPSSLCheck()]
16:02:27.291 [localhost-startStop-1] INFO com.mchange.v2.log.MLog - MLog clients using java 1.4+ standard logging.
16:02:27.311 [localhost-startStop-1] INFO com.mchange.v2.c3p0.C3P0Registry - Initializing c3p0-0.9.2 [built 09-February-2013 02:13:17 +0000; debug? true; trace: 10]
16:02:27.312 [localhost-startStop-1] WARN c.m.v.c.m.ActiveManagementCoordinator - A C3P0Registry mbean is already registered. This probably means that an application using c3p0 was undeployed, but not all PooledDataSources were closed prior to undeployment. This may lead to resource leaks over time. Please take care to close all PooledDataSources.
16:02:27.372 [localhost-startStop-1] INFO o.k.b.server.modules.DBIProvider - Using org.killbill.commons.jdbi.transaction.RestartTransactionRunner as a transaction handler class
16:02:27.662 [localhost-startStop-1] INFO o.k.b.p.p.DefaultPaymentProviderPluginRegistry - DefaultPaymentProviderPluginRegistry registering service __EXTERNAL_PAYMENT__
==> At this point the other stack trace in the localhost log file is dumped (see my first message). <==
avr. 28, 2014 4:02:28 PM org.apache.catalina.core.StandardContext startInternal
Grave: Error listenerStart
avr. 28, 2014 4:02:28 PM org.apache.catalina.core.StandardContext startInternal
Grave: Erreur de démarrage du contexte [/kb] suite aux erreurs précédentes
16:02:28.079 [localhost-startStop-1] INFO o.k.b.s.l.KillbillGuiceListener - IrsKillbillListener : contextDestroyed
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesJdbc
Grave: The web application [/kb] registered the JDBC driver [com.mysql.jdbc.Driver] but failed to unregister it when the web application was stopped. To prevent a memory leak, the JDBC Driver has been forcibly unregistered.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [com.google.inject.internal.util.$Finalizer] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [Abandoned connection cleanup thread] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [net.sf.ehcache.CacheManager@41ff5e0] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #1] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #2] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #3] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #4] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #5] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #6] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #7] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O worker #8] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [New I/O boss #9] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader clearReferencesThreads
Grave: The web application [/kb] appears to have started a thread named [Timer-1] but has failed to stop it. This is very likely to create a memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader checkThreadLocalMapForLeaks
Grave: The web application [/kb] created a ThreadLocal with key of type [com.google.inject.internal.InjectorImpl$1] (value [com.google.inject.internal.InjectorImpl$1@108d92e2]) and a value of type [java.lang.Object[]] (value [[Ljava.lang.Object;@3ea63beb]) but failed to remove it when the web application was stopped. Threads are going to be renewed over time to try and avoid a probable memory leak.
avr. 28, 2014 4:02:28 PM org.apache.catalina.startup.HostConfig deployDirectory
Infos: Déploiement du répertoire /home/me/workspaces/ij/tomcat7/webapps/ROOT de l'application web
avr. 28, 2014 4:02:28 PM org.apache.coyote.AbstractProtocol start
Infos: Starting ProtocolHandler ["http-bio-8080"]
avr. 28, 2014 4:02:28 PM org.apache.coyote.AbstractProtocol start
Infos: Starting ProtocolHandler ["ajp-bio-8009"]
avr. 28, 2014 4:02:28 PM org.apache.catalina.startup.Catalina start
Infos: Server startup in 33906 ms
avr. 28, 2014 4:02:28 PM org.apache.catalina.loader.WebappClassLoader loadClass
Infos: Illegal access: this web application instance has been stopped already. Could not load net.sf.ehcache.util.ProductInfo. The eventual following stack trace is caused by an error thrown for debugging purposes as well as to attempt to terminate the thread which caused the illegal access, and has no functional impact.
java.lang.IllegalStateException
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1600)
at org.apache.catalina.loader.WebappClassLoader.loadClass(WebappClassLoader.java:1559)
at net.sf.ehcache.util.UpdateChecker.buildParamsString(UpdateChecker.java:133)
at net.sf.ehcache.util.UpdateChecker.buildUpdateCheckUrl(UpdateChecker.java:123)
at net.sf.ehcache.util.UpdateChecker.doCheck(UpdateChecker.java:68)
at net.sf.ehcache.util.UpdateChecker.checkForUpdate(UpdateChecker.java:60)
at net.sf.ehcache.util.UpdateChecker.run(UpdateChecker.java:51)
at java.util.TimerThread.mainLoop(Timer.java:555)
at java.util.TimerThread.run(Timer.java:505)
16:02:30.999 [net.sf.ehcache.CacheManager@49d999bd] INFO net.sf.ehcache.util.UpdateChecker - New update(s) found: 2.6.5 [http://www.terracotta.org/confluence/display/release/Release+Notes+Ehcache+Core+2.6]. Please check http://ehcache.org for the latest version.
Pierre-Alexandre Meyer
Apr 28, 2014, 10:32:01 AM4/28/14
to Valentin Crettaz, killbill...@googlegroups.com, valentin...@consulthys.com
On Mon, Apr 28, 2014 at 10:14 AM, Valentin Crettaz <valentin...@gmail.com> wrote:
16:02:23.987 [localhost-startStop-1] INFO o.k.b.s.filters.KillbillGuiceFilter - Kill Bill server has started
This looks good, at this point the startup sequence should be pretty much done.
avr. 28, 2014 4:02:24 PM org.apache.catalina.startup.HostConfig deployDirectory
Infos: Déploiement du répertoire /home/me/workspaces/ij/tomcat7/webapps/kb de l'application web
Do you have multiple webapps in /home/me/workspaces/ij/tomcat7/webapps? You should have a single one, ROOT (which is killbill-server-0.10.2-jar-with-dependencies.war renamed) or kb.war (which is mapped as ROOT with the XML config).
Pierre
Valentin Crettaz
Apr 28, 2014, 10:57:15 AM4/28/14
to killbill...@googlegroups.com, Valentin Crettaz, valentin...@consulthys.com
Brilliant!
In my webapps folder I had removed all webapps (manager, docs, examples, etc) except the ROOT one. Then I guess the kb one was created in $TOMCAT/webapps because there was already one named ROOT. Now I've removed the $TOMCAT/webapps/ROOT exploded folder, too, and cleared the $TOMCAT/work folder and it's working ok.
Thank you very much for your great help! Much appreciated.
Pierre-Alexandre Meyer
Apr 28, 2014, 11:02:41 AM4/28/14
to Valentin Crettaz, killbill...@googlegroups.com, Valentin Crettaz
On Mon, Apr 28, 2014 at 10:57 AM, Valentin Crettaz <valentin...@gmail.com> wrote:
In my webapps folder I had removed all webapps (manager, docs, examples, etc) except the ROOT one. Then I guess the kb one was created in $TOMCAT/webapps because there was already one named ROOT. Now I've removed the $TOMCAT/webapps/ROOT exploded folder, too, and cleared the $TOMCAT/work folder and it's working ok.
Thank you very much for your great help! Much appreciated.
No worries, happy billing! ;-)
Pierre
Reply all
Reply to author
Forward
0 new messages