search

killbill / killbill-hello-world-java-plugin

Hello World Kill Bill plugin in Java
https://killbill.io
Apache License 2.0
9 stars 23 forks source link

Error in starting the Hello World Plugin #1

Closed svsubramonian closed 11 years ago

svsubramonian commented 11 years ago

C:\Users\Chris>java -server -XX:+UseConcMarkSweepGC -Xms256m -Xmx512m -XX:MaxPermSize=512m -Dcom.ning.jetty.jdbi.user=root -Dcom.ning.jetty.jdbi.url=jdbc:mysql://127.0.0.1:3306/killbill -Dcom.ning.bil ling.analytics.dbi.url=jdbc:mysql://127.0.0.1:3306/killbill -Dcom.ning.billing.analytics.dbi.password=mysql -Dcom.ning.billing.analytics.dbi.user=root -Dcom.ning.jetty.jdbi.password=mysql -DANTLRUSE DIRECT_CLASSLOADING=true -jar C:\KillBill\killbill-server-0.3.2-jetty-console.war 2422 [Thread-5] INFO org.simplericity.jettyconsole.DefaultJettyManager - Added web application on path / from war C:\KillBill\killbill-server-0.3.2-jetty-console.war 2422 [Thread-5] INFO org.simplericity.jettyconsole.DefaultJettyManager - Starting web application on port 8080 2438 [Thread-5] INFO org.eclipse.jetty.server.Server - jetty-8.0.4.v20111024 2531 [Thread-5] INFO org.eclipse.jetty.webapp.WebInfConfiguration - Extract jar:file:/C:/KillBill/killbill-server-0.3.2-jetty-console.war!/ to C:\Users\Chris\AppData\Local\Temp\jetty-0.0.0.0-8080-kill bill-server-0.3.2-jetty-console.war--any-\webapp 15672 [Thread-5] INFO org.eclipse.jetty.webapp.StandardDescriptorProcessor - NO JSP Support for /, did not find org.apache.jasper.servlet.JspServlet SLF4J: Class path contains multiple SLF4J bindings. SLF4J: Found binding in [jar:file:/C:/Users/Chris/AppData/Local/Temp/jetty-0.0.0.0-8080-killbill-server-0.3.2-jetty-console.war-_-any-/webapp/WEB-INF/lib/logback-classic-1.0.1.jar!/org/slf4j/impl/Stat icLoggerBinder.class] SLF4J: Found binding in [jar:file:/C:/KillBill/killbill-server-0.3.2-jetty-console.war!/META-INF/jettyconsole/lib/slf4j-simple-1.6.4.jar/org/slf4j/impl/StaticLoggerBinder.class] SLF4J: See http://www.slf4j.org/codes.html#multiple_bindings for an explanation. SLF4J: Actual binding is of type [ch.qos.logback.classic.selector.DefaultContextSelector] 20859 [Thread-5] INFO org.eclipse.jetty.server.handler.ContextHandler - started o.e.j.w.WebAppContext{/,file:/C:/Users/Chris/AppData/Local/Temp/jetty-0.0.0.0-8080-killbill-server-0.3.2-jetty-console.w ar--any-/webapp/},C:\KillBill\killbill-server-0.3.2-jetty-console.war 20859 [Thread-5] INFO org.eclipse.jetty.server.handler.ContextHandler - started o.e.j.w.WebAppContext{/,file:/C:/Users/Chris/AppData/Local/Temp/jetty-0.0.0.0-8080-killbill-server-0.3.2-jetty-console.w ar--any-/webapp/},C:\KillBill\killbill-server-0.3.2-jetty-console.war 20875 [Thread-5] INFO / - Initializing Shiro environment 05:42:30.323 [Thread-5] INFO o.a.shiro.web.env.EnvironmentLoader - Starting Shiro environment initialization. 05:42:30.620 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [DEBUG] for [com.ning.jetty.jdbi.logLevel] on [com.ning.jetty.jdbi.config.DaoConfig#getLogLevel()] 05:42:30.620 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning value [mysql] for [com.ning.jetty.jdbi.password] on [com.ning.jetty.jdbi.config.DaoConfig#getPassword()] 05:42:30.620 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [com.ning.jetty.jdbi.idleConnectionTestPeriod] on [com.ning.jetty.jdbi.config.DaoConfig#getIdleConnect ionTestPeriod()] 05:42:30.651 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [com.ning.jetty.jdbi.connectionTimeout] on [com.ning.jetty.jdbi.config.DaoConfig#getConnectionTimeout ()] 05:42:30.651 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [60m] for [com.ning.jetty.jdbi.idleMaxAge] on [com.ning.jetty.jdbi.config.DaoConfig#getIdleMaxAge()] 05:42:30.651 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [0m] for [com.ning.jetty.jdbi.maxConnectionAge] on [com.ning.jetty.jdbi.config.DaoConfig#getMaxConnectionAge()]

05:42:30.666 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning value [root] for [com.ning.jetty.jdbi.user] on [com.ning.jetty.jdbi.config.DaoConfig#getUsername()] 05:42:30.666 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10] for [com.ning.jetty.jdbi.maxActive] on [com.ning.jetty.jdbi.config.DaoConfig#getMaxActive()] 05:42:30.666 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [com.ning.jetty.jdbi.minIdle] on [com.ning.jetty.jdbi.config.DaoConfig#getMinIdle()] 05:42:30.666 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning value [jdbc:mysql://127.0.0.1:3306/killbill] for [com.ning.jetty.jdbi.url] on [com.ning.jetty.jdbi.config.DaoConfig#getJdbcUr l()] 05:42:30.666 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [com.ning.jetty.jdbi.RestartTransactionRunner] for [com.ning.jetty.jdbi.transactionHandler] on [com.ning.jetty. jdbi.config.DaoConfig#getTransactionHandlerClass()] 05:42:31.620 [Thread-5] INFO o.a.shiro.realm.AuthorizingRealm - No cache or cacheManager properties have been set. Authorization cache cannot be obtained. 05:42:31.666 [Thread-5] INFO o.a.shiro.web.env.EnvironmentLoader - Shiro environment initialized in 1328 ms. 22234 [Thread-5] INFO org.eclipse.jetty.server.handler.ContextHandler - started o.e.j.w.WebAppContext{/,file:/C:/Users/Chris/AppData/Local/Temp/jetty-0.0.0.0-8080-killbill-server-0.3.2-jetty-console.w ar--any-/webapp/},C:\KillBill\killbill-server-0.3.2-jetty-console.war 22250 [Thread-5] INFO org.eclipse.jetty.server.handler.ContextHandler - started o.e.j.w.WebAppContext{/,file:/C:/Users/Chris/AppData/Local/Temp/jetty-0.0.0.0-8080-killbill-server-0.3.2-jetty-console.w ar--any-/webapp/},C:\KillBill\killbill-server-0.3.2-jetty-console.war 05:42:31.729 [Thread-5] INFO c.n.jetty.core.listeners.SetupServer - Returning injector from com.ning.jetty.base.modules.BaseServerModule 05:42:32.666 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [DEBUG] for [com.ning.jetty.jdbi.logLevel] on [com.ning.jetty.jdbi.config.DaoConfig#getLogLevel()] 05:42:32.682 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning value [mysql] for [com.ning.jetty.jdbi.password] on [com.ning.jetty.jdbi.config.DaoConfig#getPassword()] 05:42:32.682 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5m] for [com.ning.jetty.jdbi.idleConnectionTestPeriod] on [com.ning.jetty.jdbi.config.DaoConfig#getIdleConnect ionTestPeriod()] 05:42:32.682 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [com.ning.jetty.jdbi.connectionTimeout] on [com.ning.jetty.jdbi.config.DaoConfig#getConnectionTimeout ()] 05:42:32.682 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [60m] for [com.ning.jetty.jdbi.idleMaxAge] on [com.ning.jetty.jdbi.config.DaoConfig#getIdleMaxAge()] 05:42:32.682 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [0m] for [com.ning.jetty.jdbi.maxConnectionAge] on [com.ning.jetty.jdbi.config.DaoConfig#getMaxConnectionAge()]

05:42:32.682 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning value [root] for [com.ning.jetty.jdbi.user] on [com.ning.jetty.jdbi.config.DaoConfig#getUsername()] 05:42:32.682 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10] for [com.ning.jetty.jdbi.maxActive] on [com.ning.jetty.jdbi.config.DaoConfig#getMaxActive()] 05:42:32.698 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [com.ning.jetty.jdbi.minIdle] on [com.ning.jetty.jdbi.config.DaoConfig#getMinIdle()] 05:42:32.698 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning value [jdbc:mysql://127.0.0.1:3306/killbill] for [com.ning.jetty.jdbi.url] on [com.ning.jetty.jdbi.config.DaoConfig#getJdbcUr l()] 05:42:32.698 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [com.ning.jetty.jdbi.RestartTransactionRunner] for [com.ning.jetty.jdbi.transactionHandler] on [com.ning.jetty. jdbi.config.DaoConfig#getTransactionHandlerClass()] 05:42:32.698 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8080] for [com.ning.jetty.eventtracker.port] on [com.ning.jetty.eventtracker.config.TrackerConfig#getServerPor t()] 05:42:32.698 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [localhost] for [com.ning.jetty.eventtracker.host] on [com.ning.jetty.eventtracker.config.TrackerConfig#getServ erHost()] 05:42:32.760 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [killbill.mail.smtp.host] on [com.ning.billing.util.email.EmailConfig#getSmtpServerName()] 05:42:32.760 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [killbill.mail.smtp.user] on [com.ning.billing.util.email.EmailConfig#getSmtpUserName()] 05:42:32.760 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [killbill.mail.smtp.password] on [com.ning.billing.util.email.EmailConfig#getSmtpPassword()] 05:42:32.760 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [support@example.com] for [killbill.mail.from] on [com.ning.billing.util.email.EmailConfig#getDefaultFrom()] 05:42:32.776 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [Your invoice] for [killbill.mail.invoiceEmailSubject] on [com.ning.billing.util.email.EmailConfig#getInvoiceEm ailSubject()] 05:42:32.791 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [killbill.mail.useSSL] on [com.ning.billing.util.email.EmailConfig#useSSL()] 05:42:32.791 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [killbill.mail.smtp.auth] on [com.ning.billing.util.email.EmailConfig#useSmtpAuth()] 05:42:32.807 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning null default value for [killbill.mail.smtp.port] on [com.ning.billing.util.email.EmailConfig#getSmtpPort()] 05:42:32.823 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/ehcache.xml] for [killbill.cache.config.location] on [com.ning.billing.util.config.CacheConfig#getCacheConfig Location()] 05:42:32.854 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [SpyCarBasic.xml] for [killbill.catalog.uri] on [com.ning.billing.util.config.CatalogConfig#getCatalogURI()] 05:42:32.870 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [5] for [killbill.billing.util.persistent.bus.prefetch] on [com.ning.billing.util.bus.PersistentBusConfig#getPr efetchAmount()] 05:42:32.885 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [killbill.billing.util.persistent.bus.sleep] on [com.ning.billing.util.bus.PersistentBusConfig#getSl eepTimeMs()] 05:42:32.901 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [killbill.billing.util.persistent.bus.off] on [com.ning.billing.util.bus.PersistentBusConfig#isProc essingOff()] 05:42:32.916 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3] for [killbill.billing.util.persistent.bus.nbThreads] on [com.ning.billing.util.bus.PersistentBusConfig#getN bThreads()] 05:42:32.948 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [7] for [killbill.billing.util.notificationq.prefetch] on [com.ning.billing.util.notificationq.NotificationQueu eConfig#getPrefetchAmount()] 05:42:32.963 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [3000] for [killbill.billing.util.notificationq.sleep] on [com.ning.billing.util.notificationq.NotificationQueu eConfig#getSleepTimeMs()] 05:42:32.979 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [killbill.billing.util.notificationq.notification.off] on [com.ning.billing.util.notificationq.Noti ficationQueueConfig#isProcessingOff()] 05:42:32.995 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [killbill.billing.util.notificationq.notification.nbThreads] on [com.ning.billing.util.notificationq.No tificationQueueConfig#getNbThreads()] 05:42:33.026 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [killbill.invoice.emailNotificationsEnabled] on [com.ning.billing.util.config.InvoiceConfig#isEmail NotificationsEnabled()] 05:42:33.041 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [36] for [killbill.invoice.maxNumberOfMonthsInFuture] on [com.ning.billing.util.config.InvoiceConfig#getNumberO fMonthsInFuture()] 05:42:33.073 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [en_US] for [killbill.default.locale] on [com.ning.billing.util.template.translation.TranslatorConfig#getDefaul tLocale()] 05:42:33.088 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [com.ning.billing.invoice.template.formatters.DefaultInvoiceFormatterFactory] for [killbill.template.invoiceFor matterFactoryClass] on [com.ning.billing.util.template.translation.TranslatorConfig#getInvoiceFormatterFactoryClass()] 05:42:33.088 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [com/ning/billing/util/template/translation/InvoiceTranslation] for [killbill.template.bundlePath] on [com.ning .billing.util.template.translation.TranslatorConfig#getInvoiceTemplateBundlePath()] 05:42:33.120 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [com/ning/billing/util/email/templates/HtmlInvoiceTemplate.mustache] for [killbill.manualPayTemplate.name] on [ com.ning.billing.util.template.translation.TranslatorConfig#getManualPayTemplateName()] 05:42:33.135 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [com/ning/billing/util/template/translation/CatalogTranslation] for [killbill.catalog.bundlePath] on [com.ning. billing.util.template.translation.TranslatorConfig#getCatalogBundlePath()] 05:42:33.151 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [com/ning/billing/util/email/templates/HtmlInvoiceTemplate.mustache] for [killbill.template.name] on [com.ning. billing.util.template.translation.TranslatorConfig#getTemplateName()] 05:42:33.182 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [2] for [killbill.payment.failure.retry.multiplier] on [com.ning.billing.util.config.PaymentConfig#getPluginFai lureRetryMultiplier()] 05:42:33.198 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [false] for [killbill.payment.off] on [com.ning.billing.util.config.PaymentConfig#isPaymentOff()] 05:42:33.198 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10] for [killbill.payment.plugin.threads.nb] on [com.ning.billing.util.config.PaymentConfig#getPaymentPluginTh readNb()] 05:42:33.213 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [300] for [killbill.payment.failure.retry.start.sec] on [com.ning.billing.util.config.PaymentConfig#getPluginFa ilureRetryStart()] 05:42:33.229 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [external_payment] for [killbill.payment.provider.default] on [com.ning.billing.util.config.PaymentConfig#g etDefaultPaymentProvider()] 05:42:33.245 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [90s] for [killbill.payment.plugin.timeout] on [com.ning.billing.util.config.PaymentConfig#getPaymentPluginTime out()] 05:42:33.260 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8,8,8] for [killbill.payment.retry.days] on [com.ning.billing.util.config.PaymentConfig#getPaymentRetryDays()]

05:42:33.276 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [8] for [killbill.payment.failure.retry.max.attempts] on [com.ning.billing.util.config.PaymentConfig#getPluginF ailureRetryMaxAttempts()] 05:42:33.323 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [NoOverdueConfig.xml] for [killbill.overdue.uri] on [com.ning.billing.overdue.OverdueProperties#getConfigURI()]

05:42:33.354 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [killbill.properties] for [killbill.osgi.bundle.property.name] on [com.ning.billing.util.config.OSGIConfig#getO SGIKillbillPropertyName()] 05:42:33.370 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [osgi-cache] for [killbill.osgi.bundle.cache.name] on [com.ning.billing.util.config.OSGIConfig#getOSGIBundleCac heName()] 05:42:33.385 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/var/tmp/bundles] for [killbill.osgi.bundle.install.dir] on [com.ning.billing.util.config.OSGIConfig#getRootIn stallationDir()] 05:42:33.401 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [/var/tmp/felix] for [killbill.osgi.root.dir] on [com.ning.billing.util.config.OSGIConfig#getOSGIBundleRootDir( )] 05:42:33.416 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [com.ning.billing.account.api,com.ning.billing.analytics.api.sanity,com.ning.billing.analytics.api.user,com.nin g.billing.beatrix.bus.api,com.ning.billing.catalog.api,com.ning.billing.entitlement.api,com.ning.billing.entitlement.api.migration,com.ning.billing.entitlement.api.timeline,com.ning.billing.entitlemen t.api.transfer,com.ning.billing.entitlement.api.user,com.ning.billing.invoice.api,com.ning.billing.junction.api,com.ning.billing,com.ning.billing.notification.api,com.ning.billing.notification.plugin. api,com.ning.billing.osgi.api,com.ning.billing.osgi.api.config,com.ning.billing.overdue,com.ning.billing.payment.api,com.ning.billing.payment.plugin.api,com.ning.billing.tenant.api,com.ning.billing.us age.api,com.ning.billing.util.api,com.ning.billing.util.audit,com.ning.billing.util.callcontext,com.ning.billing.util.customfield,com.ning.billing.notification.plugin,com.ning.billing.util.email,com.n ing.billing.util.entity,com.ning.billing.util.tag,com.ning.billing.util.template,com.ning.billing.util.template.translation,javax.servlet;version=3.0,javax.servlet.http;version=3.0,org.joda.time;org.j oda.time.format;version=2.1,org.osgi.service.log;version=1.3,org.osgi.service.http,org.osgi.service.deploymentadmin;version=1.1.0,org.osgi.service.event;version=1.2.0,org.slf4j;version=1.7.2] for [kil lbill.osgi.system.bundle.export.packages] on [com.ning.billing.util.config.OSGIConfig#getSystemBundleExportPackages()] 05:42:33.463 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [root] for [com.ning.billing.osgi.jdbc.password] on [com.ning.billing.osgi.glue.OSGIDataSourceConfig#getPasswor d()] 05:42:33.479 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10s] for [com.ning.billing.osgi.jdbc.connectionTimeout] on [com.ning.billing.osgi.glue.OSGIDataSourceConfig#ge tConnectionTimeout()] 05:42:33.495 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [root] for [com.ning.billing.osgi.jdbc.user] on [com.ning.billing.osgi.glue.OSGIDataSourceConfig#getUsername()]

05:42:33.510 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [10] for [com.ning.billing.osgi.jdbc.maxActive] on [com.ning.billing.osgi.glue.OSGIDataSourceConfig#getMaxActiv e()] 05:42:33.526 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [1] for [com.ning.billing.osgi.jdbc.minIdle] on [com.ning.billing.osgi.glue.OSGIDataSourceConfig#getMinIdle()] 05:42:33.541 [Thread-5] INFO o.s.c.ConfigurationObjectFactory - Assigning default value [jdbc:mysql://127.0.0.1:3306/killbill] for [com.ning.billing.osgi.jdbc.url] on [com.ning.billing.osgi.glue.OSGI DataSourceConfig#getJdbcUrl()] 05:42:34.245 [Thread-5] INFO com.mchange.v2.log.MLog - MLog clients using java 1.4+ standard logging. 05:42:34.307 [Thread-5] INFO com.mchange.v2.c3p0.C3P0Registry - Initializing c3p0-0.9.2 [built 09-February-2013 02:13:17 +0000; debug? true; trace: 10] 05:42:34.385 [Thread-5] INFO c.n.b.server.modules.DBIProvider - Using com.ning.jetty.jdbi.RestartTransactionRunner as a transaction handler class 05:42:34.682 [Thread-5] INFO c.n.b.p.p.DefaultPaymentProviderPluginRegistry - DefaultPaymentProviderPluginRegistry registering service EXTERNAL_PAYMENT 05:42:37.791 [Thread-5] INFO c.n.b.s.l.KillbillGuiceListener - KillbillLifecycleListener : contextInitialized 05:42:37.854 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage LOADCATALOG 05:42:37.870 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler loadCatalog for service catalog-service 05:42:37.901 [Thread-5] INFO c.n.b.util.config.catalog.XMLLoader - Initializing an object of class com.ning.billing.catalog.StandaloneCatalog from xml file at: file:/C:/Users/Chris/AppData/Local/Temp /jetty-0.0.0.0-8080-killbill-server-0.3.2-jetty-console.war--any-/webapp/WEB-INF/classes/SpyCarBasic.xml 05:42:39.432 [Thread-5] INFO c.n.b.util.config.catalog.XMLLoader - Errors: 0 for file:/C:/Users/Chris/AppData/Local/Temp/jetty-0.0.0.0-8080-killbill-server-0.3.2-jetty-console.war-_-any-/webapp/WEB-I NF/classes/SpyCarBasic.xml 05:42:39.448 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler loadConfig for service overdue-service 05:42:39.463 [Thread-5] INFO c.n.b.util.config.catalog.XMLLoader - Initializing an object of class com.ning.billing.overdue.config.OverdueConfig from xml file at: NoOverdueConfig.xml 05:42:39.541 [Thread-5] INFO c.n.b.util.config.catalog.XMLLoader - Errors: 0 for NoOverdueConfig.xml 05:42:39.541 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage INIT_BUS 05:42:39.557 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler startBus for service bus-service 05:42:39.557 [Thread-5] INFO c.n.b.util.queue.PersistentQueueBase - Bus: Starting with 3 threads 05:42:39.573 [bus-th] INFO c.n.b.util.queue.PersistentQueueBase - Bus: Thread bus-th [29] starting 05:42:39.573 [bus-th] INFO c.n.b.util.queue.PersistentQueueBase - Bus: Thread bus-th [30] starting 05:42:39.573 [bus-th] INFO c.n.b.util.queue.PersistentQueueBase - Bus: Thread bus-th [31] starting 05:42:39.635 [Thread-5] INFO c.n.b.util.queue.PersistentQueueBase - Bus: Done waiting for all threads to be started, got 3/3 05:42:39.651 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler startBus for service beatrix-service 05:42:39.666 [Thread-5] INFO c.n.b.util.queue.PersistentQueueBase - Bus: Starting with 3 threads 05:42:39.682 [bus-th] INFO c.m.v.c.i.AbstractPoolBackedDataSource - Initializing c3p0 pool... com.mchange.v2.c3p0.ComboPooledDataSource [ acquireIncrement -> 3, acquireRetryAttempts -> 30, acquireRet ryDelay -> 1000, autoCommitOnClose -> false, automaticTestTable -> null, breakAfterAcquireFailure -> false, checkoutTimeout -> 10000, connectionCustomizerClassName -> null, connectionTesterClassName -

com.mchange.v2.c3p0.impl.DefaultConnectionTester, dataSourceName -> 1hge1d48v1wiqvgj5fq1j0|7a3a97, debugUnreturnedConnectionStackTraces -> false, description -> null, driverClass -> null, factoryCla ssLocation -> null, forceIgnoreUnresolvedTransactions -> false, identityToken -> 1hge1d48v1wiqvgj5fq1j0|7a3a97, idleConnectionTestPeriod -> 300, initialPoolSize -> 3, jdbcUrl -> jdbc:mysql://127.0.0.1 :3306/killbill, maxAdministrativeTaskTime -> 0, maxConnectionAge -> 0, maxIdleTime -> 3600, maxIdleTimeExcessConnections -> 0, maxPoolSize -> 10, maxStatements -> 0, maxStatementsPerConnection -> 0, m inPoolSize -> 1, numHelperThreads -> 3, preferredTestQuery -> null, properties -> {user=_, password=_}, propertyCycle -> 0, statementCacheNumDeferredCloseThreads -> 0, testConnectionOnChecki n -> false, testConnectionOnCheckout -> false, unreturnedConnectionTimeout -> 0, userOverrides -> {}, usesTraditionalReflectiveProxies -> false ] 05:42:39.729 [bus-th] INFO c.n.b.util.queue.PersistentQueueBase - Bus: Thread bus-th [36] starting 05:42:39.682 [bus-th] INFO c.n.b.util.queue.PersistentQueueBase - Bus: Thread bus-th [37] starting 05:42:39.682 [bus-th] INFO c.n.b.util.queue.PersistentQueueBase - Bus: Thread bus-th [38] starting 05:42:39.791 [Thread-5] INFO c.n.b.util.queue.PersistentQueueBase - Bus: Done waiting for all threads to be started, got 3/3 05:42:39.791 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage INIT_PLUGIN 05:42:39.823 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service osgi-service 05:42:39.838 [Thread-5] INFO c.n.billing.osgi.DefaultOSGIService - Deleted recursively C:\var\tmp\felix\osgi-cache\bundle0 05:42:39.870 [Thread-5] INFO c.n.billing.osgi.DefaultOSGIService - Deleted recursively C:\var\tmp\felix\osgi-cache\bundle1\version0.0 05:42:39.901 [Thread-5] INFO c.n.billing.osgi.DefaultOSGIService - Deleted recursively C:\var\tmp\felix\osgi-cache\bundle1 05:42:39.932 [Thread-5] INFO c.n.billing.osgi.DefaultOSGIService - Deleted recursively C:\var\tmp\felix\osgi-cache\bundle2\version0.0 05:42:39.948 [Thread-5] INFO c.n.billing.osgi.DefaultOSGIService - Deleted recursively C:\var\tmp\felix\osgi-cache\bundle2 05:42:39.963 [Thread-5] INFO c.n.billing.osgi.DefaultOSGIService - Deleted recursively C:\var\tmp\felix\osgi-cache\bundle3\version0.0 05:42:39.995 [Thread-5] INFO c.n.billing.osgi.DefaultOSGIService - Deleted recursively C:\var\tmp\felix\osgi-cache\bundle3 05:42:40.057 [Thread-5] INFO c.n.billing.osgi.DefaultOSGIService - Deleted recursively C:\var\tmp\felix\osgi-cache 05:42:40.604 [Thread-5] INFO com.ning.billing.osgi.FileInstall - Installing Java OSGI bundle from C:\var\tmp\bundles\platform\felix-consumer.jar 05:42:40.635 [Thread-5] INFO com.ning.billing.osgi.FileInstall - Installing Java OSGI bundle from C:\var\tmp\bundles\platform\felix-provider.jar 05:42:40.666 [Thread-5] INFO com.ning.billing.osgi.FileInstall - Installing Java OSGI bundle from C:\var\tmp\bundles\platform\killbill-osgi-bundles-hello-world-0.0.1-SNAPSHOT-jar-with-dependencies.ja r 05:42:40.932 [Thread-5] WARN c.n.b.osgi.pluginconf.PluginFinder - Configuration root dir /var/tmp/bundles/plugins/ruby is not a valid directory 05:42:40.948 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage INIT_SERVICE 05:42:40.963 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service entitlement-service 05:42:40.995 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler registerForNotifications for service server-service 05:42:41.010 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service invoice-service 05:42:41.041 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service overdue-service 05:42:41.073 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler initialize for service payment-service 05:42:41.088 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler registerForNotifications for service beatrix-service 05:42:41.120 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage START_PLUGIN 05:42:41.135 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service osgi-service 05:42:41.135 [Thread-5] INFO com.ning.billing.osgi.FileInstall - Starting bundle file:C:\var\tmp\bundles\platform\felix-consumer.jar 05:42:41.166 [Thread-5] WARN com.ning.billing.osgi.FileInstall - Unable to start bundle org.osgi.framework.BundleException: Activator start error in bundle OSGiDmHelloWorldConsumer [1]. at org.apache.felix.framework.Felix.activateBundle(Felix.java:2027) ~[org.apache.felix.framework-4.0.3.jar:na] at org.apache.felix.framework.Felix.startBundle(Felix.java:1895) ~[org.apache.felix.framework-4.0.3.jar:na] at org.apache.felix.framework.BundleImpl.start(BundleImpl.java:944) ~[org.apache.felix.framework-4.0.3.jar:na] at org.apache.felix.framework.BundleImpl.start(BundleImpl.java:931) ~[org.apache.felix.framework-4.0.3.jar:na] at com.ning.billing.osgi.FileInstall.startBundle(FileInstall.java:203) [killbill-osgi-0.3.2.jar:na] at com.ning.billing.osgi.FileInstall.startBundles(FileInstall.java:94) [killbill-osgi-0.3.2.jar:na] at com.ning.billing.osgi.DefaultOSGIService.start(DefaultOSGIService.java:95) ~[killbill-osgi-0.3.2.jar:na] at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.7.0_25] at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[na:1.7.0_25] at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[na:1.7.0_25] at java.lang.reflect.Method.invoke(Unknown Source) ~[na:1.7.0_25] at com.ning.billing.beatrix.lifecycle.DefaultLifecycle.doFireStage(DefaultLifecycle.java:134) ~[killbill-beatrix-0.3.2.jar:na] at com.ning.billing.beatrix.lifecycle.DefaultLifecycle.fireSequence(DefaultLifecycle.java:121) ~[killbill-beatrix-0.3.2.jar:na] at com.ning.billing.beatrix.lifecycle.DefaultLifecycle.fireStartupSequencePriorEventRegistration(DefaultLifecycle.java:74) ~[killbill-beatrix-0.3.2.jar:na] at com.ning.billing.server.listeners.KillbillGuiceListener.contextInitialized(KillbillGuiceListener.java:113) ~[classes/:na] at org.eclipse.jetty.server.handler.ContextHandler.callContextInitialized(ContextHandler.java:672) ~[na:na] at org.eclipse.jetty.servlet.ServletContextHandler.callContextInitialized(ServletContextHandler.java:403) ~[na:na] at org.eclipse.jetty.server.handler.ContextHandler.startContext(ContextHandler.java:664) ~[na:na] at org.eclipse.jetty.servlet.ServletContextHandler.startContext(ServletContextHandler.java:239) ~[na:na] at org.eclipse.jetty.webapp.WebAppContext.startContext(WebAppContext.java:1212) ~[na:na] at org.eclipse.jetty.server.handler.ContextHandler.doStart(ContextHandler.java:610) ~[na:na] at org.eclipse.jetty.webapp.WebAppContext.doStart(WebAppContext.java:453) ~[na:na] at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:59) ~[na:na] at org.eclipse.jetty.server.handler.HandlerCollection.doStart(HandlerCollection.java:224) ~[na:na] at org.eclipse.jetty.server.handler.ContextHandlerCollection.doStart(ContextHandlerCollection.java:167) ~[na:na] at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:59) ~[na:na] at org.eclipse.jetty.server.handler.HandlerCollection.doStart(HandlerCollection.java:224) ~[na:na] at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:59) ~[na:na] at org.eclipse.jetty.server.handler.HandlerWrapper.doStart(HandlerWrapper.java:89) ~[na:na] at org.eclipse.jetty.server.Server.doStart(Server.java:262) ~[na:na] at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:59) ~[na:na] at org.simplericity.jettyconsole.DefaultJettyManager.startServer(DefaultJettyManager.java:124) ~[jetty-console-core-1.47.jar/:na] at org.simplericity.jettyconsole.JettyConsole$5$1.run(JettyConsole.java:217) ~[jetty-console-core-1.47.jar/:na] Caused by: java.lang.NullPointerException: Specified service reference cannot be null. at org.apache.felix.framework.BundleContextImpl.getService(BundleContextImpl.java:458) ~[org.apache.felix.framework-4.0.3.jar:na] at com.netree.felix.consumer.HelloWorldActivator.start(HelloWorldActivator.java:23) ~[na:na] at org.apache.felix.framework.util.SecureAction.startActivator(SecureAction.java:645) ~[org.apache.felix.framework-4.0.3.jar:na] at org.apache.felix.framework.Felix.activateBundle(Felix.java:1977) ~[org.apache.felix.framework-4.0.3.jar:na] ... 32 common frames omitted 05:42:41.385 [Thread-5] INFO com.ning.billing.osgi.FileInstall - Starting bundle file:C:\var\tmp\bundles\platform\felix-provider.jar 05:42:41.401 [Thread-5] INFO com.ning.billing.osgi.FileInstall - Starting bundle file:C:\var\tmp\bundles\platform\killbill-osgi-bundles-hello-world-0.0.1-SNAPSHOT-jar-with-dependencies.jar 05:42:41.416 [Thread-5] INFO c.n.b.osgi.http.DefaultServletRouter - Registering OSGI servlet at /killbill-helloworld 05:42:41.432 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle firing stage STARTSERVICE 05:42:41.432 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service entitlement-service 05:42:41.448 [Thread-5] INFO c.n.b.util.queue.PersistentQueueBase - NotificationQ: Starting with 1 threads 05:42:41.448 [Notification-queue-dispatch] INFO c.n.b.util.queue.PersistentQueueBase - NotificationQ: Thread Notification-queue-dispatch [43] starting 05:42:41.479 [Thread-5] INFO c.n.b.util.queue.PersistentQueueBase - NotificationQ: Done waiting for all threads to be started, got 1/1 05:42:41.479 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service invoice-service 05:42:41.495 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service overdue-service 05:42:41.495 [Thread-5] INFO c.n.b.b.lifecycle.DefaultLifecycle - Killbill lifecycle calling handler start for service payment-service 32078 [Thread-5] INFO org.eclipse.jetty.server.handler.ContextHandler - started o.e.j.w.WebAppContext{/,file:/C:/Users/Chris/AppData/Local/Temp/jetty-0.0.0.0-8080-killbill-server-0.3.2-jetty-console.w ar--any-/webapp/},C:\KillBill\killbill-server-0.3.2-jetty-console.war 05:42:41.557 [Thread-5] INFO c.s.j.a.core.PackagesResourceConfig - Scanning for root resource and provider classes in the packages: com.ning.billing.jaxrs.mappers com.ning.billing.jaxrs.resources 05:42:41.604 [Thread-5] INFO c.s.j.a.core.ScanningResourceConfig - Root resource classes found: class com.ning.billing.jaxrs.resources.PluginResource class com.ning.billing.jaxrs.resources.ExportResource class com.ning.billing.jaxrs.resources.AccountResource class com.ning.billing.jaxrs.resources.PaymentResource class com.ning.billing.jaxrs.resources.BundleResource class com.ning.billing.jaxrs.resources.InvoiceResource class com.ning.billing.jaxrs.resources.RefundResource class com.ning.billing.jaxrs.resources.SubscriptionResource class com.ning.billing.jaxrs.resources.CatalogResource class com.ning.billing.jaxrs.resources.ChargebackResource class com.ning.billing.jaxrs.resources.TenantResource class com.ning.billing.jaxrs.resources.PaymentMethodResource class com.ning.billing.jaxrs.resources.TagResource class com.ning.billing.jaxrs.resources.OverdueResource class com.ning.billing.jaxrs.resources.CreditResource 05:42:41.682 [Thread-5] INFO c.s.j.a.core.ScanningResourceConfig - Provider classes found: class com.ning.billing.jaxrs.mappers.TagDefinitionApiExceptionMapper class com.ning.billing.jaxrs.mappers.RuntimeExceptionMapper class com.ning.billing.jaxrs.mappers.PaymentApiExceptionMapper class com.ning.billing.jaxrs.mappers.InvoiceApiExceptionMapper class com.ning.billing.jaxrs.mappers.EmailApiExceptionMapper class com.ning.billing.jaxrs.mappers.AccountApiExceptionMapper class com.ning.billing.jaxrs.mappers.IllegalPlanChangeMapper class com.ning.billing.jaxrs.mappers.TagApiExceptionMapper class com.ning.billing.jaxrs.mappers.EntitlementRepairExceptionMapper class com.ning.billing.jaxrs.mappers.OverdueErrorMapper class com.ning.billing.jaxrs.mappers.OverdueApiExceptionMapper class com.ning.billing.jaxrs.mappers.EntitlementBillingApiExceptionMapper class com.ning.billing.jaxrs.mappers.BlockingApiExceptionMapper class com.ning.billing.jaxrs.mappers.BillingExceptionBaseMapper class com.ning.billing.jaxrs.mappers.CurrencyValueNullMapper class com.ning.billing.jaxrs.mappers.IllegalArgumentExceptionMapper class com.ning.billing.jaxrs.mappers.EntitlementUserApiExceptionMapper class com.ning.billing.jaxrs.mappers.EntityPersistenceExceptionMapper class com.ning.billing.jaxrs.mappers.CatalogApiExceptionMapper 05:42:41.885 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.fasterxml.jackson.jaxrs.json.JacksonJsonProvider as a provider class 05:42:41.901 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.AccountResource as a root resource class 05:42:41.901 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.BundleResource as a root resource class 05:42:41.916 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.SubscriptionResource as a root resource class 05:42:41.916 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.InvoiceResource as a root resource class 05:42:41.932 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.TagResource as a root resource class 05:42:41.948 [net.sf.ehcache.CacheManager@7a8e25] 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. 05:42:41.948 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.CatalogResource as a root resource class 05:42:41.963 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.PaymentMethodResource as a root resource class 05:42:41.979 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.PaymentResource as a root resource class 05:42:41.979 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.PluginResource as a root resource class 05:42:41.995 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.RefundResource as a root resource class 05:42:41.995 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.TenantResource as a root resource class 05:42:42.010 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.ExportResource as a root resource class 05:42:42.026 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Registering com.ning.billing.jaxrs.resources.OverdueResource as a root resource class 05:42:42.026 [Thread-5] INFO c.s.j.s.i.a.WebApplicationImpl - Initiating Jersey application, version 'Jersey: 1.12 02/15/2012 04:51 PM' 05:42:42.166 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.fasterxml.jackson.jaxrs.json.JacksonJsonProvider to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.495 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.AccountResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.510 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.BundleResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.526 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.CatalogResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.541 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.ChargebackResource to GuiceInstantiatedComponentProvider 05:42:42.557 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.CreditResource to GuiceInstantiatedComponentProvider 05:42:42.573 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.ExportResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.604 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.InvoiceResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.604 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.OverdueResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.620 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.PaymentMethodResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.635 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.PaymentResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.651 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.PluginResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.666 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.RefundResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.682 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.SubscriptionResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.698 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.TagResource to GuiceManagedComponentProvider with the scope "Singleton" 05:42:42.713 [Thread-5] INFO c.s.j.g.s.c.GuiceComponentProviderFactory - Binding com.ning.billing.jaxrs.resources.TenantResource to GuiceManagedComponentProvider with the scope "Singleton" 33422 [Thread-5] INFO org.eclipse.jetty.server.AbstractConnector - Started DefaultJettyManager$2@0.0.0.0:8080 STARTING 05:42:44.698 [qtp16725029-50] INFO o.a.s.s.m.AbstractValidatingSessionManager - Enabling session validation scheduler...

pierre commented 11 years ago

The relevant errors are:

05:42:41.135 [Thread-5] INFO com.ning.billing.osgi.FileInstall - Starting bundle file:C:\var\tmp\bundles\platform\felix-consumer.jar
05:42:41.166 [Thread-5] WARN com.ning.billing.osgi.FileInstall - Unable to start bundle
org.osgi.framework.BundleException: Activator start error in bundle OSGiDmHelloWorldConsumer [1].
at org.apache.felix.framework.Felix.activateBundle(Felix.java:2027) ~[org.apache.felix.framework-4.0.3.jar:na]
at org.apache.felix.framework.Felix.startBundle(Felix.java:1895) ~[org.apache.felix.framework-4.0.3.jar:na]
at org.apache.felix.framework.BundleImpl.start(BundleImpl.java:944) ~[org.apache.felix.framework-4.0.3.jar:na]
at org.apache.felix.framework.BundleImpl.start(BundleImpl.java:931) ~[org.apache.felix.framework-4.0.3.jar:na]
at com.ning.billing.osgi.FileInstall.startBundle(FileInstall.java:203) [killbill-osgi-0.3.2.jar:na]
at com.ning.billing.osgi.FileInstall.startBundles(FileInstall.java:94) [killbill-osgi-0.3.2.jar:na]
at com.ning.billing.osgi.DefaultOSGIService.start(DefaultOSGIService.java:95) ~[killbill-osgi-0.3.2.jar:na]
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) ~[na:1.7.0_25]
at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source) ~[na:1.7.0_25]
at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source) ~[na:1.7.0_25]
at java.lang.reflect.Method.invoke(Unknown Source) ~[na:1.7.0_25]
at com.ning.billing.beatrix.lifecycle.DefaultLifecycle.doFireStage(DefaultLifecycle.java:134) ~[killbill-beatrix-0.3.2.jar:na]
at com.ning.billing.beatrix.lifecycle.DefaultLifecycle.fireSequence(DefaultLifecycle.java:121) ~[killbill-beatrix-0.3.2.jar:na]
at com.ning.billing.beatrix.lifecycle.DefaultLifecycle.fireStartupSequencePriorEventRegistration(DefaultLifecycle.java:74) ~[killbill-beatrix-0.3.2.jar:na]
at com.ning.billing.server.listeners.KillbillGuiceListener.contextInitialized(KillbillGuiceListener.java:113) ~[classes/:na]
at org.eclipse.jetty.server.handler.ContextHandler.callContextInitialized(ContextHandler.java:672) ~[na:na]
at org.eclipse.jetty.servlet.ServletContextHandler.callContextInitialized(ServletContextHandler.java:403) ~[na:na]
at org.eclipse.jetty.server.handler.ContextHandler.startContext(ContextHandler.java:664) ~[na:na]
at org.eclipse.jetty.servlet.ServletContextHandler.startContext(ServletContextHandler.java:239) ~[na:na]
at org.eclipse.jetty.webapp.WebAppContext.startContext(WebAppContext.java:1212) ~[na:na]
at org.eclipse.jetty.server.handler.ContextHandler.doStart(ContextHandler.java:610) ~[na:na]
at org.eclipse.jetty.webapp.WebAppContext.doStart(WebAppContext.java:453) ~[na:na]
at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:59) ~[na:na]
at org.eclipse.jetty.server.handler.HandlerCollection.doStart(HandlerCollection.java:224) ~[na:na]
at org.eclipse.jetty.server.handler.ContextHandlerCollection.doStart(ContextHandlerCollection.java:167) ~[na:na]
at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:59) ~[na:na]
at org.eclipse.jetty.server.handler.HandlerCollection.doStart(HandlerCollection.java:224) ~[na:na]
at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:59) ~[na:na]
at org.eclipse.jetty.server.handler.HandlerWrapper.doStart(HandlerWrapper.java:89) ~[na:na]
at org.eclipse.jetty.server.Server.doStart(Server.java:262) ~[na:na]
at org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:59) ~[na:na]
at org.simplericity.jettyconsole.DefaultJettyManager.startServer(DefaultJettyManager.java:124) ~[jetty-console-core-1.47.jar/:na]
at org.simplericity.jettyconsole.JettyConsole$5$1.run(JettyConsole.java:217) ~[jetty-console-core-1.47.jar/:na]
Caused by: java.lang.NullPointerException: Specified service reference cannot be null.
at org.apache.felix.framework.BundleContextImpl.getService(BundleContextImpl.java:458) ~[org.apache.felix.framework-4.0.3.jar:na]
at com.netree.felix.consumer.HelloWorldActivator.start(HelloWorldActivator.java:23) ~[na:na]
at org.apache.felix.framework.util.SecureAction.startActivator(SecureAction.java:645) ~[org.apache.felix.framework-4.0.3.jar:na]
at org.apache.felix.framework.Felix.activateBundle(Felix.java:1977) ~[org.apache.felix.framework-4.0.3.jar:na]
... 32 common frames omitted

It looks like the bundle C:\var\tmp\bundles\platform\felix-consumer.jar couldn't be started.

This should not impact Kill Bill (if a plugin cannot be started, Kill Bill will ignore it). As a matter of fact, the hello-world bundle was started correctly after it:

05:42:41.401 [Thread-5] INFO com.ning.billing.osgi.FileInstall - Starting bundle file:C:\var\tmp\bundles\platform\killbill-osgi-bundles-hello-world-0.0.1-SNAPSHOT-jar-with-dependencies.jar
05:42:41.416 [Thread-5] INFO c.n.b.osgi.http.DefaultServletRouter - Registering OSGI servlet at /killbill-helloworld

and the server seems to be running:

33422 [Thread-5] INFO org.eclipse.jetty.server.AbstractConnector - Started DefaultJettyManager$2@0.0.0.0:8080 STARTING

What is C:\var\tmp\bundles\platform\felix-consumer.jar? Can you try removing it?