2 Replies Latest reply on Feb 11, 2013 3:49 PM by rdcrng

    Jboss 7.1.1 fails to start upon JDK update.

    rdcrng

      I'm posting this here since searching the web has lead me to a similar issue (https://community.jboss.org/thread/195016) from around a year ago - trying the solution outlined there has not yielded any results. However, my problem appeared upon a JDK update. Here are the symptoms:

       

       

      Initial environment:

      [radu@home bin]$ uname -srvmpio

      Linux 3.7.3-101.fc17.x86_64 #1 SMP Fri Jan 18 17:40:57 UTC 2013 x86_64 x86_64 x86_64 GNU/Linux

       

      [radu@home bin]$ java -version

      java version "1.7.0_b147-icedtea"

      OpenJDK Runtime Environment (fedora-2.1.fc17.6-x86_64)

      OpenJDK 64-Bit Server VM (build 22.0-b10, mixed mode)

       

      Jboss starts:

      [radu@home bin]$ pwd

      /home/radu/jboss-as-7.1.1.Final/bin

      [radu@home bin]$ ./standalone.sh

      =========================================================================

       

       

        JBoss Bootstrap Environment

       

       

        JBOSS_HOME: /home/radu/jboss-as-7.1.1.Final

       

       

        JAVA: java

       

       

        JAVA_OPTS:  -server -XX:+UseCompressedOops -XX:+TieredCompilation -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

       

       

      =========================================================================

       

       

      11:16:49,187 INFO  [org.jboss.modules] JBoss Modules version 1.1.1.GA

      11:16:49,506 INFO  [org.jboss.msc] JBoss MSC version 1.0.2.GA

      11:16:49,570 INFO  [org.jboss.as] JBAS015899: JBoss AS 7.1.1.Final "Brontes" starting

      11:16:50,845 INFO  [org.xnio] XNIO Version 3.0.3.GA

      11:16:50,865 INFO  [org.jboss.as.server] JBAS015888: Creating http management service using socket-binding (management-http)

      11:16:50,916 INFO  [org.xnio.nio] XNIO NIO Implementation Version 3.0.3.GA

      11:16:50,934 INFO  [org.jboss.remoting] JBoss Remoting version 3.2.3.GA

      11:16:50,990 INFO  [org.jboss.as.logging] JBAS011502: Removing bootstrap log handlers

      11:16:51,004 INFO  [org.jboss.as.configadmin] (ServerService Thread Pool -- 26) JBAS016200: Activating ConfigAdmin Subsystem

      11:16:51,041 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 31) JBAS010280: Activating Infinispan subsystem.

      11:16:51,115 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 44) JBAS013101: Activating Security Subsystem

      11:16:51,130 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 38) JBAS011800: Activating Naming Subsystem

      11:16:51,131 INFO  [org.jboss.as.osgi] (ServerService Thread Pool -- 39) JBAS011940: Activating OSGi Subsystem

      11:16:51,162 INFO  [org.jboss.as.security] (MSC service thread 1-1) JBAS013100: Current PicketBox version=4.0.7.Final

      11:16:51,179 INFO  [org.jboss.as.webservices] (ServerService Thread Pool -- 48) JBAS015537: Activating WebServices Extension

      11:16:51,330 INFO  [org.jboss.as.connector] (MSC service thread 1-2) JBAS010408: Starting JCA Subsystem (JBoss IronJacamar 1.0.9.Final)

      11:16:51,456 INFO  [org.jboss.as.naming] (MSC service thread 1-2) JBAS011802: Starting Naming Service

      11:16:51,460 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 27) JBAS010403: Deploying JDBC-compliant driver class org.h2.Driver (version 1.3)

      11:16:51,653 INFO  [org.jboss.as.mail.extension] (MSC service thread 1-2) JBAS015400: Bound mail session [java:jboss/mail/Default]

      11:16:51,710 INFO  [org.jboss.ws.common.management.AbstractServerConfig] (MSC service thread 1-1) JBoss Web Services - Stack CXF Server 4.0.2.GA

      11:16:51,987 INFO  [org.apache.coyote.http11.Http11Protocol] (MSC service thread 1-2) Starting Coyote HTTP/1.1 on http--127.0.0.1-8080

      11:16:52,584 INFO  [org.jboss.as.remoting] (MSC service thread 1-2) JBAS017100: Listening on /127.0.0.1:9999

      11:16:52,605 INFO  [org.jboss.as.server.deployment.scanner] (MSC service thread 1-2) JBAS015012: Started FileSystemDeploymentService for directory /home/radu/jboss-as-7.1.1.Final/standalone/deployments

      11:16:52,608 INFO  [org.jboss.as.remoting] (MSC service thread 1-2) JBAS017100: Listening on /127.0.0.1:4447

      11:16:52,771 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-2) JBAS010400: Bound data source [java:jboss/datasources/ExampleDS]

      11:16:52,800 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015951: Admin console listening on http://127.0.0.1:9990

      11:16:52,802 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015874: JBoss AS 7.1.1.Final "Brontes" started in 3964ms - Started 133 of 208 services (74 services are passive or on-demand)

      ^C11:16:59,558 INFO  [org.jboss.as.osgi] (MSC service thread 1-2) JBAS011942: Stopping OSGi Framework

      11:16:59,587 INFO  [org.jboss.as.logging] JBAS011503: Restored bootstrap log handlers

      11:16:59,604 INFO  [com.arjuna.ats.jbossatx] ARJUNA032018: Destroying TransactionManagerService

      11:16:59,608 INFO  [com.arjuna.ats.jbossatx] ARJUNA032014: Stopping transaction recovery manager

      11:16:59,616 INFO  [org.jboss.as] JBAS015950: JBoss AS 7.1.1.Final "Brontes" stopped in 48ms

       

      Update the JDK:

      [radu@home bin]$ sudo yum update

      [sudo] password for radu:

      Loaded plugins: langpacks, presto, refresh-packagekit

      Resolving Dependencies

      --> Running transaction check

      ---> Package java-1.7.0-openjdk.x86_64 1:1.7.0.3-2.1.fc17.6 will be updated

      ---> Package java-1.7.0-openjdk.x86_64 1:1.7.0.9-2.3.5.fc17 will be an update

      --> Finished Dependency Resolution

       

       

      Dependencies Resolved

       

       

      ===========================================================================================================================================================================================================

      Package                                               Arch                                      Version                                                  Repository                                  Size

      ===========================================================================================================================================================================================================

      Updating:

      java-1.7.0-openjdk                                    x86_64                                    1:1.7.0.9-2.3.5.fc17                                     updates                                     25 M

       

       

      Transaction Summary

      ===========================================================================================================================================================================================================

      Upgrade  1 Package

       

       

      Total download size: 25 M

      Is this ok [y/N]: y

      Downloading Packages:

      Setting up and reading Presto delta metadata

      Processing delta metadata

      Download delta size: 3.5 M

      java-1.7.0-openjdk-1.7.0.3-2.1.fc17.6_1.7.0.9-2.3.5.fc17.x86_64.drpm                                                                                                                | 3.5 MB     00:03

      Finishing rebuild of rpms, from deltarpms

      <locally rebuilding deltarpms>                                                                                                                                                      |  25 MB     00:17

      Presto reduced the update size by 87% (from 25 M to 3.5 M).

      Running Transaction Check

      Running Transaction Test

      Transaction Test Succeeded

      Running Transaction

        Updating   : 1:java-1.7.0-openjdk-1.7.0.9-2.3.5.fc17.x86_64                                                                                                                                          1/2

        Cleanup    : 1:java-1.7.0-openjdk-1.7.0.3-2.1.fc17.6.x86_64                                                                                                                                          2/2

        Verifying  : 1:java-1.7.0-openjdk-1.7.0.9-2.3.5.fc17.x86_64                                                                                                                                          1/2

        Verifying  : 1:java-1.7.0-openjdk-1.7.0.3-2.1.fc17.6.x86_64                                                                                                                                          2/2

       

       

      Updated:

        java-1.7.0-openjdk.x86_64 1:1.7.0.9-2.3.5.fc17

       

       

      Complete!

       

      Logger Error:

      [radu@home bin]$ ./standalone.sh

      =========================================================================

       

       

        JBoss Bootstrap Environment

       

       

        JBOSS_HOME: /home/radu/jboss-as-7.1.1.Final

       

       

        JAVA: java

       

       

        JAVA_OPTS:  -server -XX:+UseCompressedOops -XX:+TieredCompilation -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

       

       

      =========================================================================

       

       

      Exception in thread "main" java.lang.ExceptionInInitializerError

              at org.jboss.as.server.Main.main(Main.java:73)

              at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)

              at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)

              at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)

              at java.lang.reflect.Method.invoke(Method.java:601)

              at org.jboss.modules.Module.run(Module.java:260)

              at org.jboss.modules.Main.main(Main.java:291)

      Caused by: java.lang.IllegalStateException: The LogManager was not properly installed (you must set the "java.util.logging.manager" system property to "org.jboss.logmanager.LogManager")

              at org.jboss.logmanager.Logger.getLogger(Logger.java:60)

              at org.jboss.logmanager.log4j.BridgeRepositorySelector.<clinit>(BridgeRepositorySelector.java:42)

              ... 7 more

       

      Downgrade the JDK:

      [radu@home bin]$ sudo yum downgrade java-1.7.0-openjdk

      Loaded plugins: langpacks, presto, refresh-packagekit

      Resolving Dependencies

      --> Running transaction check

      ---> Package java-1.7.0-openjdk.x86_64 1:1.7.0.3-2.1.fc17.6 will be a downgrade

      ---> Package java-1.7.0-openjdk.x86_64 1:1.7.0.9-2.3.5.fc17 will be erased

      --> Finished Dependency Resolution

       

       

      Dependencies Resolved

       

       

      ===========================================================================================================================================================================================================

      Package                                               Arch                                      Version                                                   Repository                                 Size

      ===========================================================================================================================================================================================================

      Downgrading:

      java-1.7.0-openjdk                                    x86_64                                    1:1.7.0.3-2.1.fc17.6                                      fedora                                     25 M

       

       

      Transaction Summary

      ===========================================================================================================================================================================================================

      Downgrade  1 Package

       

       

      Total download size: 25 M

      Is this ok [y/N]: y

      Downloading Packages:

      java-1.7.0-openjdk-1.7.0.3-2.1.fc17.6.x86_64.rpm                                                                                                                                    |  25 MB     00:20

      Running Transaction Check

      Running Transaction Test

      Transaction Test Succeeded

      Running Transaction

        Installing : 1:java-1.7.0-openjdk-1.7.0.3-2.1.fc17.6.x86_64                                                                                                                                          1/2

        Cleanup    : 1:java-1.7.0-openjdk-1.7.0.9-2.3.5.fc17.x86_64                                                                                                                                          2/2

        Verifying  : 1:java-1.7.0-openjdk-1.7.0.3-2.1.fc17.6.x86_64                                                                                                                                          1/2

        Verifying  : 1:java-1.7.0-openjdk-1.7.0.9-2.3.5.fc17.x86_64                                                                                                                                          2/2

       

       

      Removed:

        java-1.7.0-openjdk.x86_64 1:1.7.0.9-2.3.5.fc17

       

       

      Installed:

        java-1.7.0-openjdk.x86_64 1:1.7.0.3-2.1.fc17.6

       

       

      Complete!

       

      Now JBoss starts:

      [radu@home bin]$ ./standalone.sh

      =========================================================================

       

       

        JBoss Bootstrap Environment

       

       

        JBOSS_HOME: /home/radu/jboss-as-7.1.1.Final

       

       

        JAVA: java

       

       

        JAVA_OPTS:  -server -XX:+UseCompressedOops -XX:+TieredCompilation -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

       

       

      =========================================================================

       

       

      11:18:55,194 INFO  [org.jboss.modules] JBoss Modules version 1.1.1.GA

      11:18:55,534 INFO  [org.jboss.msc] JBoss MSC version 1.0.2.GA

      11:18:55,599 INFO  [org.jboss.as] JBAS015899: JBoss AS 7.1.1.Final "Brontes" starting

      11:18:57,099 INFO  [org.xnio] XNIO Version 3.0.3.GA

      11:18:57,118 INFO  [org.jboss.as.server] JBAS015888: Creating http management service using socket-binding (management-http)

      11:18:57,181 INFO  [org.xnio.nio] XNIO NIO Implementation Version 3.0.3.GA

      11:18:57,198 INFO  [org.jboss.remoting] JBoss Remoting version 3.2.3.GA

      11:18:57,258 INFO  [org.jboss.as.logging] JBAS011502: Removing bootstrap log handlers

      11:18:57,274 INFO  [org.jboss.as.configadmin] (ServerService Thread Pool -- 26) JBAS016200: Activating ConfigAdmin Subsystem

      11:18:57,311 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 31) JBAS010280: Activating Infinispan subsystem.

      11:18:57,371 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 44) JBAS013101: Activating Security Subsystem

      11:18:57,394 INFO  [org.jboss.as.osgi] (ServerService Thread Pool -- 39) JBAS011940: Activating OSGi Subsystem

      11:18:57,397 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 38) JBAS011800: Activating Naming Subsystem

      11:18:57,444 INFO  [org.jboss.as.webservices] (ServerService Thread Pool -- 48) JBAS015537: Activating WebServices Extension

      11:18:57,475 INFO  [org.jboss.as.security] (MSC service thread 1-1) JBAS013100: Current PicketBox version=4.0.7.Final

      11:18:57,524 INFO  [org.jboss.as.connector] (MSC service thread 1-2) JBAS010408: Starting JCA Subsystem (JBoss IronJacamar 1.0.9.Final)

      11:18:57,612 INFO  [org.jboss.as.naming] (MSC service thread 1-2) JBAS011802: Starting Naming Service

      11:18:57,788 INFO  [org.jboss.as.connector.subsystems.datasources] (ServerService Thread Pool -- 27) JBAS010403: Deploying JDBC-compliant driver class org.h2.Driver (version 1.3)

      11:18:57,942 INFO  [org.jboss.as.mail.extension] (MSC service thread 1-2) JBAS015400: Bound mail session [java:jboss/mail/Default]

      11:18:58,125 INFO  [org.jboss.ws.common.management.AbstractServerConfig] (MSC service thread 1-1) JBoss Web Services - Stack CXF Server 4.0.2.GA

      11:18:58,570 INFO  [org.apache.coyote.http11.Http11Protocol] (MSC service thread 1-1) Starting Coyote HTTP/1.1 on http--127.0.0.1-8080

      11:18:59,026 INFO  [org.jboss.as.remoting] (MSC service thread 1-2) JBAS017100: Listening on /127.0.0.1:9999

      11:18:59,053 INFO  [org.jboss.as.server.deployment.scanner] (MSC service thread 1-2) JBAS015012: Started FileSystemDeploymentService for directory /home/radu/jboss-as-7.1.1.Final/standalone/deployments

      11:18:59,056 INFO  [org.jboss.as.remoting] (MSC service thread 1-2) JBAS017100: Listening on /127.0.0.1:4447

      11:18:59,264 INFO  [org.jboss.as.connector.subsystems.datasources] (MSC service thread 1-2) JBAS010400: Bound data source [java:jboss/datasources/ExampleDS]

      11:18:59,307 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015951: Admin console listening on http://127.0.0.1:9990

      11:18:59,308 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015874: JBoss AS 7.1.1.Final "Brontes" started in 4496ms - Started 133 of 208 services (74 services are passive or on-demand)

      ^C11:19:03,074 INFO  [org.jboss.as.osgi] (MSC service thread 1-2) JBAS011942: Stopping OSGi Framework

      11:19:03,117 INFO  [org.jboss.as.logging] JBAS011503: Restored bootstrap log handlers

      11:19:03,129 INFO  [com.arjuna.ats.jbossatx] ARJUNA032018: Destroying TransactionManagerService

      11:19:03,131 INFO  [com.arjuna.ats.jbossatx] ARJUNA032014: Stopping transaction recovery manager

      11:19:03,145 INFO  [org.jboss.as] JBAS015950: JBoss AS 7.1.1.Final "Brontes" stopped in 49ms

       

      Is this a Jboss AS issue or a JDK issue? Any ideas on how I should go about determining that? 

        • 1. Re: Jboss 7.1.1 fails to start upon JDK update.
          dgolovin

          Cannot replicate that for latest JVM with Brand New JBoss AS 7.1.1.Final. Could you check if it works/doesn't work for you with freshly unpacked JBoss AS?

          • 2. Re: Jboss 7.1.1 fails to start upon JDK update.
            rdcrng

            I thought that had been the first thing I did, but as a sanity check I had just tried it again and I cannot reproduce it anymore either. I guess this means that it wasn't a fresh download the first time around, which would have been something from about 3-4 months ago. Anyhow, my appologies for the wrongful alarm and thank you for investigating.