Attachment 837257 Details for Bug 1031660 – IOException: Unsupported protocol version 60 in ER6 still appears

IOException: Unsupported protocol version 60 in ER6 still appears

RestRollUpsIOExProtocol60_JDGER6.txt (text/plain), 18.81 KB, created by Tomas Sykora on 2013-12-16 15:09:19 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: Tomas Sykora

Created: 2013-12-16 15:09:19 UTC

Size: 18.81 KB

patch

obsolete

>-------------------------------------------------------
> T E S T S
>-------------------------------------------------------
>Concurrency config is parallel='none', perCoreThreadCount=true, threadCount=2, useUnlimitedThreads=false
>15:57:25,442 INFO  [TestsuiteListener] (main) Running org.infinispan.server.test.configs.ExampleConfigsTest#testRestRollingUpgrades
>15:57:25,477 INFO  [ClientContainerController] (main) Manual starting of a server instance
>15:57:25,514 INFO  [ManagedDeployableContainer] (main) Starting container with: [/usr/java/default/bin/java, -Djava.net.preferIPv4Stack=true, -Xmx512m, -XX:MaxPermSize=128m, -Djboss.node.name=node1, -Djboss.socket.binding.port-offset=100, -ea, -Djboss.home.dir=/home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node2, -Dorg.jboss.boot.log.file=/home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node2/standalone/log/boot.log, -Dlogging.configuration=file:/home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node2/standalone/configuration/logging.properties, -Djboss.bundles.dir=/home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node2/bundles, -jar, /home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node2/jboss-modules.jar, -mp, /home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node2/modules, -jaxpmodule, javax.xml.jaxp-provider, org.jboss.as.standalone, -server-config, examples/standalone-compatibility-mode.xml]
>15:57:25,559 INFO  [xnio] (main) XNIO Version 3.0.7.GA-redhat-1
>15:57:25,568 INFO  [nio] (main) XNIO NIO Implementation Version 3.0.7.GA-redhat-1
>15:57:25,583 INFO  [remoting] (main) JBoss Remoting version 3.2.16.GA-redhat-1
>15:57:32,428 INFO  [RemoteCacheManager] (main) ISPN004021: Infinispan version: 6.0.0.Final-redhat-3
>15:57:32,479 INFO  [ClientContainerController] (main) Manual starting of a server instance
>15:57:32,481 INFO  [ManagedDeployableContainer] (main) Starting container with: [/usr/java/default/bin/java, -Djava.net.preferIPv4Stack=true, -Xmx512m, -XX:MaxPermSize=128m, -Djboss.node.name=node0, -ea, -Djboss.home.dir=/home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node1, -Dorg.jboss.boot.log.file=/home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node1/standalone/log/boot.log, -Dlogging.configuration=file:/home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node1/standalone/configuration/logging.properties, -Djboss.bundles.dir=/home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node1/bundles, -jar, /home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node1/jboss-modules.jar, -mp, /home/tsykora/programs/eclipseWorkspace/ISPN-RHgit/infinispan/server/integration/testsuite/target/server/node1/modules, -jaxpmodule, javax.xml.jaxp-provider, org.jboss.as.standalone, -server-config, examples/standalone-rest-rolling-upgrade.xml]
>15:57:38,698 INFO  [RemoteCacheManager] (main) ISPN004021: Infinispan version: 6.0.0.Final-redhat-3
>15:57:39,250 INFO  [ClientContainerController] (main) Manual stopping of a server instance
>15:57:39,847 INFO  [ClientContainerController] (main) Manual stopping of a server instance
>Running org.infinispan.server.test.configs.ExampleConfigsTest
>15:57:25,962 INFO  [org.jboss.modules] (main) JBoss Modules version 1.2.2.Final-redhat-1
>15:57:26,112 INFO  [org.jboss.msc] (main) JBoss MSC version 1.0.4.GA-redhat-1
>15:57:26,172 INFO  [org.jboss.as] (MSC service thread 1-5) JBAS015899: JBoss Data Grid 6.2.0 (AS 7.2.1.Final-redhat-10) starting
>15:57:26,874 INFO  [org.xnio] (MSC service thread 1-8) XNIO Version 3.0.7.GA-redhat-1
>15:57:26,878 INFO  [org.jboss.as.server] (Controller Boot Thread) JBAS015888: Creating http management service using socket-binding (management-http)
>15:57:26,881 INFO  [org.xnio.nio] (MSC service thread 1-8) XNIO NIO Implementation Version 3.0.7.GA-redhat-1
>15:57:26,888 INFO  [org.jboss.remoting] (MSC service thread 1-8) JBoss Remoting version 3.2.16.GA-redhat-1
>15:57:26,919 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 17) JBAS010280: Activating Infinispan subsystem.
>15:57:26,935 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 21) JBAS011800: Activating Naming Subsystem
>15:57:26,945 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 23) JBAS013171: Activating Security Subsystem
>15:57:26,951 INFO  [org.jboss.as.security] (MSC service thread 1-7) JBAS013170: Current PicketBox version=4.0.17.SP2-redhat-2
>15:57:26,955 INFO  [org.jboss.as.jsf] (ServerService Thread Pool -- 27) JBAS012605: Activated the following JSF Implementations: [main, 1.2]
>15:57:26,980 INFO  [org.jboss.as.connector.logging] (MSC service thread 1-7) JBAS010408: Starting JCA Subsystem (IronJacamar 1.0.19.Final-redhat-2)
>15:57:26,998 INFO  [org.jboss.as.naming] (MSC service thread 1-1) JBAS011802: Starting Naming Service
>15:57:27,370 INFO  [org.apache.coyote.ajp] (MSC service thread 1-8) JBWEB003046: Starting Coyote AJP/1.3 on ajp-/127.0.0.1:8109
>15:57:27,370 INFO  [org.apache.coyote.http11] (MSC service thread 1-6) JBWEB003001: Coyote HTTP/1.1 initializing on : http-/127.0.0.1:8180
>15:57:27,386 INFO  [org.apache.coyote.http11] (MSC service thread 1-6) JBWEB003000: Coyote HTTP/1.1 starting on: http-/127.0.0.1:8180
>15:57:27,729 INFO  [org.jboss.as.remoting] (MSC service thread 1-6) JBAS017100: Listening on 127.0.0.1:10099
>15:57:27,730 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-7) JDGS010000: REST starting
>15:57:27,730 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-3) JDGS010000: HotRodServer starting
>15:57:27,731 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-3) JDGS010001: HotRodServer listening on 127.0.0.1:11322
>15:57:27,732 INFO  [org.jboss.as.remoting] (MSC service thread 1-5) JBAS017100: Listening on 127.0.0.1:4547
>15:57:27,939 INFO  [org.infinispan.factories.GlobalComponentRegistry] (MSC service thread 1-1) ISPN000128: Infinispan version: Infinispan 'Infinium' 6.0.1-SNAPSHOT
>15:57:27,939 INFO  [org.infinispan.factories.GlobalComponentRegistry] (MSC service thread 1-2) ISPN000128: Infinispan version: Infinispan 'Infinium' 6.0.1-SNAPSHOT
>15:57:28,015 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-7) JDGS010002: REST mapped to /rest
>15:57:28,309 INFO  [org.infinispan.jmx.CacheJmxRegistration] (MSC service thread 1-1) ISPN000031: MBeans were successfully registered to the platform MBean server.
>15:57:28,309 INFO  [org.infinispan.jmx.CacheJmxRegistration] (MSC service thread 1-8) ISPN000031: MBeans were successfully registered to the platform MBean server.
>15:57:28,312 INFO  [org.infinispan.jmx.CacheJmxRegistration] (MSC service thread 1-2) ISPN000031: MBeans were successfully registered to the platform MBean server.
>15:57:28,312 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-1) JBAS010281: Started default cache from local container
>15:57:28,478 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-8) JBAS010281: Started other cache from security container
>15:57:28,480 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-2) JBAS010281: Started jboss-web-policy cache from security container
>15:57:28,483 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-7) JDGS010000: MemcachedServer starting
>15:57:28,483 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-7) JDGS010001: MemcachedServer listening on 127.0.0.1:11311
>15:57:28,801 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015961: Http management interface listening on http://127.0.0.1:10090/management
>15:57:28,801 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015951: Admin console listening on http://127.0.0.1:10090
>15:57:28,802 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015874: JBoss Data Grid 6.2.0 (AS 7.2.1.Final-redhat-10) started in 3214ms - Started 90 of 126 services (36 services are passive or on-demand)
>15:57:32,845 INFO  [org.jboss.modules] (main) JBoss Modules version 1.2.2.Final-redhat-1
>15:57:33,045 INFO  [org.jboss.msc] (main) JBoss MSC version 1.0.4.GA-redhat-1
>15:57:33,128 INFO  [org.jboss.as] (MSC service thread 1-6) JBAS015899: JBoss Data Grid 6.2.0 (AS 7.2.1.Final-redhat-10) starting
>15:57:33,830 INFO  [org.xnio] (MSC service thread 1-4) XNIO Version 3.0.7.GA-redhat-1
>15:57:33,833 INFO  [org.jboss.as.server] (Controller Boot Thread) JBAS015888: Creating http management service using socket-binding (management-http)
>15:57:33,836 INFO  [org.xnio.nio] (MSC service thread 1-4) XNIO NIO Implementation Version 3.0.7.GA-redhat-1
>15:57:33,920 INFO  [org.jboss.remoting] (MSC service thread 1-4) JBoss Remoting version 3.2.16.GA-redhat-1
>15:57:33,946 INFO  [org.jboss.as.clustering.infinispan] (ServerService Thread Pool -- 17) JBAS010280: Activating Infinispan subsystem.
>15:57:33,965 INFO  [org.jboss.as.security] (ServerService Thread Pool -- 23) JBAS013171: Activating Security Subsystem
>15:57:33,968 INFO  [org.jboss.as.security] (MSC service thread 1-5) JBAS013170: Current PicketBox version=4.0.17.SP2-redhat-2
>15:57:33,973 INFO  [org.jboss.as.naming] (ServerService Thread Pool -- 21) JBAS011800: Activating Naming Subsystem
>15:57:33,996 INFO  [org.jboss.as.naming] (MSC service thread 1-8) JBAS011802: Starting Naming Service
>15:57:34,015 INFO  [org.jboss.as.connector.logging] (MSC service thread 1-7) JBAS010408: Starting JCA Subsystem (IronJacamar 1.0.19.Final-redhat-2)
>15:57:34,015 INFO  [org.jboss.as.jsf] (ServerService Thread Pool -- 27) JBAS012605: Activated the following JSF Implementations: [main, 1.2]
>15:57:34,201 INFO  [org.apache.coyote.http11] (MSC service thread 1-1) JBWEB003001: Coyote HTTP/1.1 initializing on : http-/127.0.0.1:8080
>15:57:34,236 INFO  [org.apache.coyote.ajp] (MSC service thread 1-5) JBWEB003046: Starting Coyote AJP/1.3 on ajp-/127.0.0.1:8009
>15:57:34,257 INFO  [org.apache.coyote.http11] (MSC service thread 1-1) JBWEB003000: Coyote HTTP/1.1 starting on: http-/127.0.0.1:8080
>15:57:34,519 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-4) JDGS010000: HotRodServer starting
>15:57:34,520 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-6) JDGS010000: REST starting
>15:57:34,520 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-4) JDGS010001: HotRodServer listening on 127.0.0.1:11222
>15:57:34,594 INFO  [org.jboss.as.remoting] (MSC service thread 1-7) JBAS017100: Listening on 127.0.0.1:4447
>15:57:34,595 INFO  [org.jboss.as.remoting] (MSC service thread 1-5) JBAS017100: Listening on 127.0.0.1:9999
>15:57:34,764 INFO  [org.infinispan.factories.GlobalComponentRegistry] (MSC service thread 1-1) ISPN000128: Infinispan version: Infinispan 'Infinium' 6.0.1-SNAPSHOT
>15:57:34,764 INFO  [org.infinispan.factories.GlobalComponentRegistry] (MSC service thread 1-2) ISPN000128: Infinispan version: Infinispan 'Infinium' 6.0.1-SNAPSHOT
>15:57:34,800 INFO  [org.infinispan.server.endpoint] (MSC service thread 1-6) JDGS010002: REST mapped to /rest
>15:57:35,056 INFO  [org.infinispan.jmx.CacheJmxRegistration] (MSC service thread 1-2) ISPN000031: MBeans were successfully registered to the platform MBean server.
>15:57:35,056 INFO  [org.infinispan.jmx.CacheJmxRegistration] (MSC service thread 1-3) ISPN000031: MBeans were successfully registered to the platform MBean server.
>15:57:35,060 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-3) JBAS010281: Started jboss-web-policy cache from security container
>15:57:35,060 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-2) JBAS010281: Started other cache from security container
>15:57:35,206 INFO  [org.infinispan.jmx.CacheJmxRegistration] (MSC service thread 1-1) ISPN000031: MBeans were successfully registered to the platform MBean server.
>15:57:35,206 INFO  [org.jboss.as.clustering.infinispan] (MSC service thread 1-1) JBAS010281: Started default cache from local container
>15:57:35,607 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015961: Http management interface listening on http://127.0.0.1:9990/management
>15:57:35,607 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015951: Admin console listening on http://127.0.0.1:9990
>15:57:35,608 INFO  [org.jboss.as] (Controller Boot Thread) JBAS015874: JBoss Data Grid 6.2.0 (AS 7.2.1.Final-redhat-10) started in 3073ms - Started 89 of 125 services (36 services are passive or on-demand)
>15:57:39,209 ERROR [org.infinispan.interceptors.InvocationContextInterceptor] (pool-5-thread-1) ISPN000136: Execution error: org.infinispan.persistence.spi.PersistenceException: ISPN022003: HTTP error
>	at org.infinispan.persistence.rest.RestStore.load(RestStore.java:228)
>	at org.infinispan.persistence.manager.PersistenceManagerImpl.loadFromAllStores(PersistenceManagerImpl.java:430) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.CacheLoaderInterceptor.loadIfNeeded(CacheLoaderInterceptor.java:263) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.CacheLoaderInterceptor.loadIfNeededAndUpdateStats(CacheLoaderInterceptor.java:335) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.CacheLoaderInterceptor.visitGetKeyValueCommand(CacheLoaderInterceptor.java:105) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commands.read.GetKeyValueCommand.acceptVisitor(GetKeyValueCommand.java:40) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.EntryWrappingInterceptor.visitGetKeyValueCommand(EntryWrappingInterceptor.java:116) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commands.read.GetKeyValueCommand.acceptVisitor(GetKeyValueCommand.java:40) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.locking.NonTransactionalLockingInterceptor.visitGetKeyValueCommand(NonTransactionalLockingInterceptor.java:32) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commands.read.GetKeyValueCommand.acceptVisitor(GetKeyValueCommand.java:40) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.base.CommandInterceptor.handleDefault(CommandInterceptor.java:112) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commands.AbstractVisitor.visitGetKeyValueCommand(AbstractVisitor.java:74) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commands.read.GetKeyValueCommand.acceptVisitor(GetKeyValueCommand.java:40) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.CacheMgmtInterceptor.visitGetKeyValueCommand(CacheMgmtInterceptor.java:92) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commands.read.GetKeyValueCommand.acceptVisitor(GetKeyValueCommand.java:40) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.compat.BaseTypeConverterInterceptor.visitGetKeyValueCommand(BaseTypeConverterInterceptor.java:75) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commands.read.GetKeyValueCommand.acceptVisitor(GetKeyValueCommand.java:40) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.base.CommandInterceptor.invokeNextInterceptor(CommandInterceptor.java:98) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.InvocationContextInterceptor.handleAll(InvocationContextInterceptor.java:110) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.InvocationContextInterceptor.handleDefault(InvocationContextInterceptor.java:73) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commands.AbstractVisitor.visitGetKeyValueCommand(AbstractVisitor.java:74) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commands.read.GetKeyValueCommand.acceptVisitor(GetKeyValueCommand.java:40) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.interceptors.InterceptorChain.invoke(InterceptorChain.java:333) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.CacheImpl.get(CacheImpl.java:377) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.CacheImpl.get(CacheImpl.java:369) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.persistence.rest.upgrade.RestTargetMigrator$1.run(RestTargetMigrator.java:55)	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:471) [rt.jar:1.7.0_02]
>	at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:334) [rt.jar:1.7.0_02]
>	at java.util.concurrent.FutureTask.run(FutureTask.java:166) [rt.jar:1.7.0_02]
>	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110) [rt.jar:1.7.0_02]
>	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603) [rt.jar:1.7.0_02]
>	at java.lang.Thread.run(Thread.java:722) [rt.jar:1.7.0_02]
>Caused by: java.io.IOException: Unsupported protocol version 60
>	at org.jboss.marshalling.river.RiverUnmarshaller.start(RiverUnmarshaller.java:1243) [jboss-marshalling-river-1.3.18.GA-redhat-1.jar:1.3.18.GA-redhat-1]
>	at org.infinispan.commons.marshall.jboss.AbstractJBossMarshaller.startObjectInput(AbstractJBossMarshaller.java:130) [infinispan-commons.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.marshall.core.VersionAwareMarshaller.startObjectInput(VersionAwareMarshaller.java:142) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.marshall.core.VersionAwareMarshaller.objectFromByteBuffer(VersionAwareMarshaller.java:98) [infinispan-core.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commons.marshall.AbstractMarshaller.objectFromByteBuffer(AbstractMarshaller.java:82) [infinispan-commons.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.commons.marshall.AbstractDelegatingMarshaller.objectFromByteBuffer(AbstractDelegatingMarshaller.java:75) [infinispan-commons.jar:6.0.0.Final-redhat-3]
>	at org.infinispan.persistence.rest.RestStore.unmarshall(RestStore.java:149)
>	at org.infinispan.persistence.rest.RestStore.load(RestStore.java:221)
>	... 36 more
>15:57:39,219 INFO  [org.infinispan.upgrade.RollingUpgradeManager] (pool-1-thread-1) ISPN000216: 51 entries migrated to cache default in 144 milliseconds
>Tests run: 1, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 15.055 sec
>
>Results :
>
>Tests run: 1, Failures: 0, Errors: 0, Skipped: 0
>

Actions: View

Attachments on bug 1031660: 837257