Skip to content

Instantly share code, notes, and snippets.

@agios
Created November 24, 2012 20:51
Show Gist options
  • Save agios/4141360 to your computer and use it in GitHub Desktop.
Save agios/4141360 to your computer and use it in GitHub Desktop.
Torquebox log
[WARNING] navarino-knob.yml has not been deployed. Starting TorqueBox anyway.
Booting AS7 from configuration /home/agios/.rvm/gems/jruby-1.6.8@torquebox/gems/torquebox-server-2.1.2-java/jboss/standalone/configuration/standalone.xml
/bin/sh bin/standalone.sh -Djruby.home=/home/agios/.rvm/rubies/jruby-1.6.8 --server-config=standalone.xml
=========================================================================
JBoss Bootstrap Environment
JBOSS_HOME: /home/agios/.rvm/gems/jruby-1.6.8@torquebox/gems/torquebox-server-2.1.2-java/jboss
JAVA: java
JAVA_OPTS: -server -XX:+UseCompressedOops -Xms64m -Xmx512m -XX:MaxPermSize=256m -Djava.net.preferIPv4Stack=true -Dorg.jboss.resolver.warning=true -Dsun.rmi.dgc.client.gcInterval=3600000 -Dsun.rmi.dgc.server.gcInterval=3600000 -Djboss.modules.system.pkgs=org.jboss.byteman -Djava.awt.headless=true -Djboss.server.default.config=standalone.xml -Xss2048k -Djruby.compile.invokedynamic=false
=========================================================================
22:54:20,905 INFO [org.jboss.modules] JBoss Modules version 1.1.2.GA
22:54:21,213 INFO [org.jboss.msc] JBoss MSC version 1.0.2.GA
22:54:21,295 INFO [org.jboss.as] JBAS015899: JBoss AS 7.1.x.incremental.1 "Steropes" starting
22:54:21,993 INFO [org.torquebox.bootstrap] Bootstrapping TorqueBox with a JRuby home of /home/agios/.rvm/rubies/jruby-1.6.8
22:54:22,454 INFO [org.torquebox.core.as] Initializing TorqueBox Core Subsystem
22:54:22,469 INFO [org.torquebox.messaging.as] Initializing TorqueBox Messaging Subsystem
22:54:22,472 INFO [org.torquebox.stomp.as] Initializing TorqueBox STOMP Subsystem
22:54:22,487 INFO [org.torquebox.core.as] Welcome to TorqueBox AS - http://torquebox.org/
22:54:22,494 INFO [org.torquebox.core.as] version........... 2.1.2
22:54:22,497 INFO [org.torquebox.core.as] build............. 71
22:54:22,502 INFO [org.torquebox.core.as] revision.......... d3e1d6cb141377413123b044178e6bc605bce9bb +modifications
22:54:22,496 INFO [org.torquebox.services.as] Initializing TorqueBox Services Subsystem
22:54:22,503 INFO [org.torquebox.core.as] built with:
22:54:22,516 INFO [org.projectodd.polyglot.cache.as] Initializing Polyglot Cache Subsystem
22:54:22,516 INFO [org.torquebox.cdi.as] Initializing TorqueBox CDI Subsystem
22:54:22,519 INFO [org.torquebox.web.as] Initializing TorqueBox Web Subsystem
22:54:22,526 INFO [org.torquebox.core.as] HornetQ......... 2.2.18.Final (HQ_2_2_18_FINAL, 122)
22:54:22,527 INFO [org.torquebox.core.as] JBossAS......... 7.1.x.incremental.1
22:54:22,528 INFO [org.torquebox.core.as] Infinispan...... 5.1.5.FINAL
22:54:22,528 INFO [org.torquebox.core.as] Quartz.......... 1.8.5
22:54:22,528 INFO [org.projectodd.polyglot.hasingleton.as] Initializing HA-Singleton Subsystem
22:54:22,530 INFO [org.torquebox.security.as] Initializing TorqueBox Auth Subsystem
22:54:22,529 INFO [org.torquebox.core.as] JRuby........... 1.6.7.2
22:54:22,544 WARN [org.torquebox.core.as] WARNING: TorqueBox was built and tested with JRuby 1.6.7.2 and you are running JRuby 1.6.8. You may experience unexpected results. Side effects may include: itching, sleeplessness, and irritability.
22:54:22,544 INFO [org.torquebox.jobs.as] Initializing TorqueBox Jobs Subsystem
22:54:22,832 WARN [org.jboss.as.server] JBAS015883: No security realm defined for native management service; all access will be unrestricted.
22:54:22,838 INFO [org.xnio] XNIO Version 3.0.4.GA
22:54:22,842 INFO [org.jboss.as.server] JBAS015888: Creating http management service using socket-binding (management-http)
22:54:22,843 WARN [org.jboss.as.server] JBAS015884: No security realm defined for http management service; all access will be unrestricted.
22:54:22,846 INFO [org.xnio.nio] XNIO NIO Implementation Version 3.0.4.GA
22:54:22,857 INFO [org.jboss.remoting] JBoss Remoting version 3.2.8.GA
22:54:22,915 INFO [org.jboss.as.remoting] JBAS017100: Listening on 127.0.0.1:9999
22:54:22,920 INFO [org.jboss.as.logging] JBAS011502: Removing bootstrap log handlers
22:54:22,924 INFO [org.jboss.as.configadmin] (ServerService Thread Pool -- 42) JBAS016200: Activating ConfigAdmin Subsystem
22:54:22,962 INFO [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 47) JBAS010280: Activating Infinispan subsystem.
22:54:23,016 INFO [org.jboss.as.jacorb] (ServerService Thread Pool -- 48) JBAS016300: Activating JacORB Subsystem
22:54:23,066 INFO [org.jboss.as.connector.logging] (MSC service thread 1-1) JBAS010408: Starting JCA Subsystem (JBoss IronJacamar 1.0.11.Final)
22:54:23,078 INFO [org.jboss.as.naming] (ServerService Thread Pool -- 58) JBAS011800: Activating Naming Subsystem
22:54:23,114 INFO [org.jboss.as.osgi] (ServerService Thread Pool -- 59) JBAS011906: Activating OSGi Subsystem
22:54:23,125 INFO [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 43) JBAS010403: Deploying JDBC-compliant driver class org.h2.Driver (version 1.3)
22:54:23,160 INFO [org.jboss.as.naming] (MSC service thread 1-3) JBAS011802: Starting Naming Service
22:54:23,168 INFO [org.jboss.as.mail.extension] (MSC service thread 1-2) JBAS015400: Bound mail session [java:jboss/mail/Default]
22:54:23,188 INFO [org.jboss.jaxr] (MSC service thread 1-4) JBAS014000: Started JAXR subsystem, binding JAXR connection factory into JNDI as: java:jboss/jaxr/ConnectionFactory
22:54:23,231 INFO [org.jboss.as.security] (ServerService Thread Pool -- 64) JBAS013171: Activating Security Subsystem
22:54:23,383 INFO [org.jboss.as.security] (MSC service thread 1-4) JBAS013170: Current PicketBox version=4.0.9.Final
22:54:23,390 INFO [org.jboss.as.webservices] (ServerService Thread Pool -- 68) JBAS015537: Activating WebServices Extension
22:54:23,811 INFO [org.jboss.ws.common.management.AbstractServerConfig] (MSC service thread 1-3) JBoss Web Services - Stack CXF Server 4.0.2.GA
22:54:23,937 INFO [org.torquebox.core.runtime] (MSC service thread 1-1) Creating ruby runtime (ruby_version: RUBY1_8, compile_mode: JIT, context: global)
22:54:24,032 INFO [org.jboss.as.jacorb] (MSC service thread 1-2) JBAS016330: CORBA ORB Service started
22:54:24,202 INFO [org.apache.coyote.http11.Http11Protocol] (MSC service thread 1-2) Starting Coyote HTTP/1.1 on http-localhost/127.0.0.1:8080
22:54:24,773 INFO [org.hornetq.core.server.impl.HornetQServerImpl] (MSC service thread 1-2) live server is starting with configuration HornetQ Configuration (clustered=false,backup=false,sharedStore=true,journalDirectory=/home/agios/.rvm/gems/jruby-1.6.8@torquebox/gems/torquebox-server-2.1.2-java/jboss/standalone/data/messagingjournal,bindingsDirectory=/home/agios/.rvm/gems/jruby-1.6.8@torquebox/gems/torquebox-server-2.1.2-java/jboss/standalone/data/messagingbindings,largeMessagesDirectory=/home/agios/.rvm/gems/jruby-1.6.8@torquebox/gems/torquebox-server-2.1.2-java/jboss/standalone/data/messaginglargemessages,pagingDirectory=/home/agios/.rvm/gems/jruby-1.6.8@torquebox/gems/torquebox-server-2.1.2-java/jboss/standalone/data/messagingpaging)
22:54:24,776 INFO [org.hornetq.core.server.impl.HornetQServerImpl] (MSC service thread 1-2) Waiting to obtain live lock
22:54:24,912 INFO [org.hornetq.core.persistence.impl.journal.JournalStorageManager] (MSC service thread 1-2) Using AIO Journal
22:54:25,017 INFO [org.jboss.as.jacorb] (MSC service thread 1-3) JBAS016328: CORBA Naming Service started
22:54:25,269 INFO [org.hornetq.core.server.impl.AIOFileLockNodeManager] (MSC service thread 1-2) Waiting to obtain live lock
22:54:25,270 INFO [org.hornetq.core.server.impl.AIOFileLockNodeManager] (MSC service thread 1-2) Live Server Obtained live lock
22:54:25,403 INFO [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-4) JBAS010400: Bound data source [java:jboss/datasources/ExampleDS]
22:54:25,529 INFO [org.infinispan.factories.GlobalComponentRegistry] (CacheService lifecycle - 1) ISPN000128: Infinispan version: Infinispan 'Brahma' 5.1.5.FINAL
22:54:26,042 INFO [org.jboss.as.clustering.infinispan] (CacheService lifecycle - 1) JBAS010281: Started __recoveryInfoCacheName__ cache from polyglot container
22:54:26,109 INFO [org.infinispan.jmx.CacheJmxRegistration] (CacheService lifecycle - 1) ISPN000031: MBeans were successfully registered to the platform mbean server.
22:54:26,114 INFO [org.jboss.as.clustering.infinispan] (CacheService lifecycle - 1) JBAS010281: Started sessions cache from polyglot container
22:54:26,168 WARN [org.hornetq.core.journal.impl.JournalImpl] (MSC service thread 1-2) Temporary files were left unnatended after a crash on journal directory, deleting invalid files now
22:54:26,169 WARN [org.hornetq.core.journal.impl.JournalImpl] (MSC service thread 1-2) Deleting unnatended file hornetq-data-1.hq.tmp
22:54:26,171 WARNING [org.hornetq.core.server.impl.HornetQServerImpl] (MSC service thread 1-2) Critical IO Error, shutting down the server. code=6, message=Can't open file
22:54:26,172 SEVERE [org.hornetq.core.server.impl.HornetQServerImpl] (MSC service thread 1-2) Failure in initialisation: HornetQException[errorCode=205 message=Can't open file]
at org.hornetq.core.asyncio.impl.AsynchronousFileImpl.init(Native Method) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.asyncio.impl.AsynchronousFileImpl.open(AsynchronousFileImpl.java:217) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.journal.impl.AIOSequentialFile.open(AIOSequentialFile.java:194) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.journal.impl.JournalFilesRepository.createFile(JournalFilesRepository.java:581) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.journal.impl.JournalFilesRepository.ensureMinFiles(JournalFilesRepository.java:203) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.journal.impl.JournalImpl.load(JournalImpl.java:2165) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.journal.impl.JournalImpl.load(JournalImpl.java:1496) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.journal.impl.JournalImpl.load(JournalImpl.java:1480) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.persistence.impl.journal.JournalStorageManager.loadMessageJournal(JournalStorageManager.java:907) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.server.impl.HornetQServerImpl.loadJournals(HornetQServerImpl.java:1603) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.server.impl.HornetQServerImpl.initialisePart2(HornetQServerImpl.java:1445) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.server.impl.HornetQServerImpl.access$1200(HornetQServerImpl.java:138) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.server.impl.HornetQServerImpl$SharedStoreLiveActivation.run(HornetQServerImpl.java:1919) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.core.server.impl.HornetQServerImpl.start(HornetQServerImpl.java:366) [hornetq-core-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.hornetq.jms.server.impl.JMSServerManagerImpl.start(JMSServerManagerImpl.java:278) [hornetq-jms-2.2.18.Final.jar:2.2.18.Final (HQ_2_2_18_FINAL, 122)]
at org.jboss.as.messaging.jms.JMSService.start(JMSService.java:73) [jboss-as-messaging-7.1.x.incremental.1.jar:7.1.x.incremental.1]
at org.jboss.msc.service.ServiceControllerImpl$StartTask.startService(ServiceControllerImpl.java:1811) [jboss-msc-1.0.2.GA.jar:1.0.2.GA]
at org.jboss.msc.service.ServiceControllerImpl$StartTask.run(ServiceControllerImpl.java:1746) [jboss-msc-1.0.2.GA.jar:1.0.2.GA]
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110) [rt.jar:1.7.0_09]
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603) [rt.jar:1.7.0_09]
at java.lang.Thread.run(Thread.java:722) [rt.jar:1.7.0_09]
22:54:26,202 INFO [org.hornetq.core.server.impl.HornetQServerImpl] (MSC service thread 1-2) HornetQ Server version 2.2.18.Final (HQ_2_2_18_FINAL, 122) [f11557b4-3674-11e2-a6a2-51fb2a861494]) started
22:54:26,214 INFO [org.hornetq.jms.server.impl.JMSServerManagerImpl] (ServerService Thread Pool -- 80) Caching command for createConnectionFactory for RemoteConnectionFactory since the JMS Server is not active yet
22:54:26,226 INFO [org.hornetq.jms.server.impl.JMSServerManagerImpl] (ServerService Thread Pool -- 81) Caching command for createConnectionFactory for InVmConnectionFactory since the JMS Server is not active yet
22:54:26,396 INFO [org.jboss.as.deployment.connector] (MSC service thread 1-4) JBAS010406: Registered connection factory java:/JmsXA
22:54:26,439 WARN [org.hornetq.jms.server.recovery.RecoveryDiscovery] (MSC service thread 1-4) Couldn't start recovery discovery on XARecoveryConfig [transportConfiguration = [org-hornetq-core-remoting-impl-invm-InVMConnectorFactory?server-id=0], discoveryConfiguration = null, username=null, password=null], we will retry this on the next recovery scan
22:54:26,452 INFO [org.hornetq.ra.HornetQResourceAdapter] (MSC service thread 1-4) HornetQ resource adaptor started
22:54:26,463 INFO [org.jboss.as.connector.services.resourceadapters.ResourceAdapterActivatorService$ResourceAdapterActivator] (MSC service thread 1-4) IJ020002: Deployed: file://RaActivatorhornetq-ra
22:54:26,483 INFO [org.jboss.as.deployment.connector] (MSC service thread 1-2) JBAS010401: Bound JCA ConnectionFactory [java:/JmsXA]
22:54:28,268 INFO [org.jboss.as.server.deployment.scanner] (DeploymentScanner-threads - 1) JBAS015014: Re-attempting failed deployment test_sinatra-knob.yml
22:54:28,275 INFO [org.jboss.as.server.deployment.scanner] (MSC service thread 1-3) JBAS015012: Started FileSystemDeploymentService for directory /home/agios/.rvm/gems/jruby-1.6.8@torquebox/gems/torquebox-server-2.1.2-java/jboss/standalone/deployments
22:54:28,295 INFO [org.jboss.as.remoting] (MSC service thread 1-4) JBAS017100: Listening on 127.0.0.1:4447
22:54:28,461 INFO [org.torquebox.core.runtime] (MSC service thread 1-1) Created ruby runtime (ruby_version: RUBY1_8, compile_mode: JIT, context: global) in 4.5s
22:54:28,686 INFO [org.jboss.as.controller] (Controller Boot Thread) JBAS014774: Service status report
JBAS014775: New missing/unsatisfied dependencies:
service jboss.naming.context.java.ConnectionFactory (missing) dependents: [service torquebox.messaging.ruby-connection-factory.manager, service torquebox.messaging.ruby-xa-connection-factory.manager]
22:54:28,710 INFO [org.jboss.as.server.deployment] (MSC service thread 1-1) JBAS015876: Starting deployment of "test_sinatra-knob.yml"
22:54:29,321 INFO [org.jboss.as.osgi] (MSC service thread 1-1) JBAS011907: Register module: Module "deployment.test_sinatra-knob.yml:main" from Service Module Loader
22:54:29,366 INFO [org.hornetq.jms.server.impl.JMSServerManagerImpl] (pool-7-thread-1) Caching command for createQueue for /queues/torquebox/test_sinatra/tasks/torquebox_backgroundable since the JMS Server is not active yet
22:54:29,558 INFO [org.jboss.as] (MSC service thread 1-2) JBAS015961: Http management interface listening on http://127.0.0.1:9990/management
22:54:29,559 INFO [org.jboss.as] (MSC service thread 1-2) JBAS015951: Admin console listening on http://127.0.0.1:9990
22:54:29,559 ERROR [org.jboss.as] (MSC service thread 1-2) JBAS015875: JBoss AS 7.1.x.incremental.1 "Steropes" started (with errors) in 9032ms - Started 218 of 336 services (8 services failed or missing dependencies, 109 services are passive or on-demand)
22:54:29,669 INFO [org.jboss.as.osgi] (MSC service thread 1-3) JBAS011908: Unregister module: Module "deployment.test_sinatra-knob.yml:main" from Service Module Loader
22:54:29,672 INFO [org.jboss.as.server] (DeploymentScanner-threads - 2) JBAS015870: Deploy of deployment "test_sinatra-knob.yml" was rolled back with failure message {"JBAS014771: Services with missing/unavailable dependencies" => ["jboss.deployment.unit.\"test_sinatra-knob.yml\".torquebox.core.runtime.factory Missing[JBAS014861: <one or more transitive dependencies>]","jboss.deployment.unit.\"test_sinatra-knob.yml\".rack.application Missing[JBAS014861: <one or more transitive dependencies>]","jboss.deployment.unit.\"test_sinatra-knob.yml\".torquebox.core.runtime.pool.web Missing[JBAS014861: <one or more transitive dependencies>]","jboss.deployment.unit.\"test_sinatra-knob.yml\".jboss.security.jacc Missing[JBAS014861: <one or more transitive dependencies>]","jboss.web.deployment.default-host./ Missing[JBAS014861: <one or more transitive dependencies>]","jboss.deployment.unit.\"test_sinatra-knob.yml\".torquebox.core.runtime.pool.messaging Missing[JBAS014861: <one or more transitive dependencies>]","jboss.deployment.unit.\"test_sinatra-knob.yml\".torquebox.messaging.\"/queues/torquebox/test_sinatra/tasks/torquebox_backgroundable.TorqueBox::Messaging::BackgroundableProcessor\" Missing[jboss.naming.context.java.ConnectionFactory, jboss.naming.context.java.queues.torquebox.test_sinatra.tasks.torquebox_backgroundable]"]}
22:54:29,675 INFO [org.hornetq.jms.server.impl.JMSServerManagerImpl] (pool-7-thread-1) Caching command for removeQueueFromJNDI for /queues/torquebox/test_sinatra/tasks/torquebox_backgroundable since the JMS Server is not active yet
22:54:29,702 INFO [org.jboss.as.server.deployment] (MSC service thread 1-2) JBAS015877: Stopped deployment test_sinatra-knob.yml in 40ms
22:54:29,710 ERROR [org.jboss.as.server.deployment.scanner] (DeploymentScanner-threads - 1) {"JBAS014653: Composite operation failed and was rolled back. Steps that failed:" => {"Operation step-2" => {"JBAS014771: Services with missing/unavailable dependencies" => ["jboss.deployment.unit.\"test_sinatra-knob.yml\".torquebox.core.runtime.factory Missing[JBAS014861: <one or more transitive dependencies>]","jboss.deployment.unit.\"test_sinatra-knob.yml\".rack.application Missing[JBAS014861: <one or more transitive dependencies>]","jboss.deployment.unit.\"test_sinatra-knob.yml\".torquebox.core.runtime.pool.web Missing[JBAS014861: <one or more transitive dependencies>]","jboss.deployment.unit.\"test_sinatra-knob.yml\".jboss.security.jacc Missing[JBAS014861: <one or more transitive dependencies>]","jboss.web.deployment.default-host./ Missing[JBAS014861: <one or more transitive dependencies>]","jboss.deployment.unit.\"test_sinatra-knob.yml\".torquebox.core.runtime.pool.messaging Missing[JBAS014861: <one or more transitive dependencies>]","jboss.deployment.unit.\"test_sinatra-knob.yml\".torquebox.messaging.\"/queues/torquebox/test_sinatra/tasks/torquebox_backgroundable.TorqueBox::Messaging::BackgroundableProcessor\" Missing[jboss.naming.context.java.ConnectionFactory, jboss.naming.context.java.queues.torquebox.test_sinatra.tasks.torquebox_backgroundable]"]}}}
22:54:35,082 WARN [org.hornetq.jms.server.recovery.RecoveryDiscovery] (HornetQ Recovery Discovery Reinitialization) Couldn't start recovery discovery on XARecoveryConfig [transportConfiguration = [org-hornetq-core-remoting-impl-invm-InVMConnectorFactory?server-id=0], discoveryConfiguration = null, username=null, password=null], we will retry this on the next recovery scan
@alwinmark
Copy link

If you have the same problem and google send you here, please take a look at: https://gist.github.com/dcolebatch/2406315

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment