[JBoss JIRA] (WFLY-6011) Remote branch of a transaction gets rolled back incorrectly.
by David Lloyd (JIRA)
[ https://issues.jboss.org/browse/WFLY-6011?page=com.atlassian.jira.plugin.... ]
David Lloyd commented on WFLY-6011:
-----------------------------------
There does not seem to be a reproducer on the original issue, but maybe that's the next necessary step.
> Remote branch of a transaction gets rolled back incorrectly.
> -------------------------------------------------------------
>
> Key: WFLY-6011
> URL: https://issues.jboss.org/browse/WFLY-6011
> Project: WildFly
> Issue Type: Bug
> Components: EJB
> Reporter: Jason Greene
> Assignee: David Lloyd
>
> The use case is as follow:
> Client makes a call to a bean on server-1
> bean (server-1) inserts a row into table-1
> bean (server-1) calls to a bean on server-2
> bean (server-2) inserts a row into table-2
> bean (server-2) goes to sleep for 3 minutes
> periodic recovery (server-1) flags the remote branchof the transaction (on server-2) as in doubt and rolls it back.
> (server-1 log)
> {noformat}
> 11:53:37,991 TRACE [com.arjuna.ats.arjuna] (Periodic Recovery) RecoveryXids _whenFirstSeen toRecover no RecoveryOnlyEJBXAResource{receiverContext=EJBReceiverContext{clientContext=org.jboss.ejb.client.EJBClientContext@322f7790, receiver=Remoting connection EJB receiver [connection=Remoting connection <2c1ab3f6>,channel=jboss.ejb,nodename=server2]}, transactionOriginNodeIdentifier='server1'} 1452599607985 === 1452599617991
> 11:53:37,991 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) Have 1 Xids to recover on this pass.
> 11:53:37,992 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) No record found for < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name >
> 11:53:37,992 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) XAResourceOrphanFilter com.arjuna.ats.internal.jta.recovery.arjunacore.JTATransactionLogXAResourceOrphanFilter voted ABSTAIN
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) node name of < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name > is server1
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) XAResourceOrphanFilter com.arjuna.ats.internal.jta.recovery.arjunacore.JTANodeNameXAResourceOrphanFilter voted ROLLBACK
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) subordinate node name of < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name > is server2
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) Checking whether Xid < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name > exists in ObjectStore.
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) Looking for 0:ffffc0a80164:-fa2e9db:5694e833:2c and /StateManager/BasicAction/TwoPhaseCoordinator/AtomicAction/SubordinateAtomicAction/JCA
> 11:53:37,993 INFO [com.arjuna.ats.jta] (Periodic Recovery) ARJUNA016013: Rolling back < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name >
> {noformat}
> (server-2 log)
> {noformat}
> 11:53:37,997 TRACE [com.arjuna.ats.jta] (EJB default - 5) TransactionImple.getStatus: javax.transaction.Status.STATUS_ACTIVE
> 11:53:37,998 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::phase2Abort() for action-id 0:ffffc0a80164:-41fcd6d0:5694e85a:34
> 11:53:37,998 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::doAbort (XAResourceRecord < resource:XAResourceWrapperImpl@3de8e444[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@6440856e pad=false overrideRmValue=false productName=PostgreSQL productVersion=9.4.1 jndiName=java:jboss/datasources/testJBossDS], txid:< formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-41fcd6d0:5694e85a:3e, subordinatenodename=server2, eis_name=java:jboss/datasources/testJBossDS >, heuristic: TwoPhaseOutcome.FINISH_OK, product: PostgreSQL/9.4.1, jndiName: java:jboss/datasources/testJBossDS com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord@32ff4c6d >)
> 11:53:37,998 TRACE [com.arjuna.ats.jta] (EJB default - 5) XAResourceRecord.topLevelAbort for XAResourceRecord < resource:XAResourceWrapperImpl@3de8e444[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@6440856e pad=false overrideRmValue=false productName=PostgreSQL productVersion=9.4.1 jndiName=java:jboss/datasources/testJBossDS], txid:< formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-41fcd6d0:5694e85a:3e, subordinatenodename=server2, eis_name=java:jboss/datasources/testJBossDS >, heuristic: TwoPhaseOutcome.FINISH_OK, product: PostgreSQL/9.4.1, jndiName: java:jboss/datasources/testJBossDS com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord@32ff4c6d >, record id=0:ffffc0a80164:-41fcd6d0:5694e85a:3f
> 11:53:37,998 TRACE [org.jboss.as.connector.subsystems.datasources.AbstractDataSourceService$MyXaMCF] (EJB default - 5) Unlock: HeldByCurrentThread: Yes, Locked: Yes, HoldCount: 1, QueueLength: 0
> 11:53:37,998 TRACE [org.jboss.as.connector.subsystems.datasources.AbstractDataSourceService$MyXaMCF] (EJB default - 5) Owner: Thread[EJB default - 5,5,EJB default]
> 11:53:37,999 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::doAbort() result for action-id (0:ffffc0a80164:-41fcd6d0:5694e85a:34) on record id: (0:ffffc0a80164:-41fcd6d0:5694e85a:3f) is (TwoPhaseOutcome.FINISH_OK) node id: (server2)
> 11:53:37,999 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::updateState() for action-id 0:ffffc0a80164:-41fcd6d0:5694e85a:34
> 11:53:37,999 TRACE [com.arjuna.ats.jta] (EJB default - 5) SynchronizationImple.afterCompletion
> {noformat}
> bean (server-2) wake up
> bean (server-1) updates the row in table-1
> at this point the parent transaction gets committed without an error
> {noformat}
> 11:55:31,104 TRACE [com.arjuna.ats.arjuna] (EJB default - 3) BasicAction::removeChildThread () action 0:ffffc0a80164:-fa2e9db:5694e833:2c removing TSThread:1
> 11:55:31,104 TRACE [com.arjuna.ats.arjuna] (EJB default - 3) BasicAction::removeChildThread () action 0:ffffc0a80164:-fa2e9db:5694e833:2c removing TSThread:1 result = true
> 11:55:31,104 TRACE [com.arjuna.ats.arjuna] (EJB default - 3) TransactionReaper::remove ( BasicAction: 0:ffffc0a80164:-fa2e9db:5694e833:2c status: ActionStatus.COMMITTED )
> {noformat}
> client call ends
> When I look at the table in the database I see a row in table-1 but no row in table-2. I would expect to see both tables empty.
> When I switch to JTS and run the same use case it all works as expected.
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
10 years, 3 months
- 1
- 0
[JBoss JIRA] (WFLY-6011) Remote branch of a transaction gets rolled back incorrectly.
by Tom Jenkinson (JIRA)
[ https://issues.jboss.org/browse/WFLY-6011?page=com.atlassian.jira.plugin.... ]
Tom Jenkinson commented on WFLY-6011:
-------------------------------------
What I can't work out is why the remote transaction having rolled back isn't becoming an issue for the upstream server during its commit process. I think that the upstream server either hasn't had the remote side enlisted in the transaction or for some reason the enlisted JBR proxy has executed the rollback (EJB default - 5) but not reported an error to server 1 which is then able to commit just fine.
> Remote branch of a transaction gets rolled back incorrectly.
> -------------------------------------------------------------
>
> Key: WFLY-6011
> URL: https://issues.jboss.org/browse/WFLY-6011
> Project: WildFly
> Issue Type: Bug
> Components: EJB
> Reporter: Jason Greene
> Assignee: David Lloyd
>
> The use case is as follow:
> Client makes a call to a bean on server-1
> bean (server-1) inserts a row into table-1
> bean (server-1) calls to a bean on server-2
> bean (server-2) inserts a row into table-2
> bean (server-2) goes to sleep for 3 minutes
> periodic recovery (server-1) flags the remote branchof the transaction (on server-2) as in doubt and rolls it back.
> (server-1 log)
> {noformat}
> 11:53:37,991 TRACE [com.arjuna.ats.arjuna] (Periodic Recovery) RecoveryXids _whenFirstSeen toRecover no RecoveryOnlyEJBXAResource{receiverContext=EJBReceiverContext{clientContext=org.jboss.ejb.client.EJBClientContext@322f7790, receiver=Remoting connection EJB receiver [connection=Remoting connection <2c1ab3f6>,channel=jboss.ejb,nodename=server2]}, transactionOriginNodeIdentifier='server1'} 1452599607985 === 1452599617991
> 11:53:37,991 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) Have 1 Xids to recover on this pass.
> 11:53:37,992 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) No record found for < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name >
> 11:53:37,992 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) XAResourceOrphanFilter com.arjuna.ats.internal.jta.recovery.arjunacore.JTATransactionLogXAResourceOrphanFilter voted ABSTAIN
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) node name of < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name > is server1
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) XAResourceOrphanFilter com.arjuna.ats.internal.jta.recovery.arjunacore.JTANodeNameXAResourceOrphanFilter voted ROLLBACK
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) subordinate node name of < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name > is server2
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) Checking whether Xid < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name > exists in ObjectStore.
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) Looking for 0:ffffc0a80164:-fa2e9db:5694e833:2c and /StateManager/BasicAction/TwoPhaseCoordinator/AtomicAction/SubordinateAtomicAction/JCA
> 11:53:37,993 INFO [com.arjuna.ats.jta] (Periodic Recovery) ARJUNA016013: Rolling back < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name >
> {noformat}
> (server-2 log)
> {noformat}
> 11:53:37,997 TRACE [com.arjuna.ats.jta] (EJB default - 5) TransactionImple.getStatus: javax.transaction.Status.STATUS_ACTIVE
> 11:53:37,998 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::phase2Abort() for action-id 0:ffffc0a80164:-41fcd6d0:5694e85a:34
> 11:53:37,998 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::doAbort (XAResourceRecord < resource:XAResourceWrapperImpl@3de8e444[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@6440856e pad=false overrideRmValue=false productName=PostgreSQL productVersion=9.4.1 jndiName=java:jboss/datasources/testJBossDS], txid:< formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-41fcd6d0:5694e85a:3e, subordinatenodename=server2, eis_name=java:jboss/datasources/testJBossDS >, heuristic: TwoPhaseOutcome.FINISH_OK, product: PostgreSQL/9.4.1, jndiName: java:jboss/datasources/testJBossDS com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord@32ff4c6d >)
> 11:53:37,998 TRACE [com.arjuna.ats.jta] (EJB default - 5) XAResourceRecord.topLevelAbort for XAResourceRecord < resource:XAResourceWrapperImpl@3de8e444[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@6440856e pad=false overrideRmValue=false productName=PostgreSQL productVersion=9.4.1 jndiName=java:jboss/datasources/testJBossDS], txid:< formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-41fcd6d0:5694e85a:3e, subordinatenodename=server2, eis_name=java:jboss/datasources/testJBossDS >, heuristic: TwoPhaseOutcome.FINISH_OK, product: PostgreSQL/9.4.1, jndiName: java:jboss/datasources/testJBossDS com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord@32ff4c6d >, record id=0:ffffc0a80164:-41fcd6d0:5694e85a:3f
> 11:53:37,998 TRACE [org.jboss.as.connector.subsystems.datasources.AbstractDataSourceService$MyXaMCF] (EJB default - 5) Unlock: HeldByCurrentThread: Yes, Locked: Yes, HoldCount: 1, QueueLength: 0
> 11:53:37,998 TRACE [org.jboss.as.connector.subsystems.datasources.AbstractDataSourceService$MyXaMCF] (EJB default - 5) Owner: Thread[EJB default - 5,5,EJB default]
> 11:53:37,999 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::doAbort() result for action-id (0:ffffc0a80164:-41fcd6d0:5694e85a:34) on record id: (0:ffffc0a80164:-41fcd6d0:5694e85a:3f) is (TwoPhaseOutcome.FINISH_OK) node id: (server2)
> 11:53:37,999 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::updateState() for action-id 0:ffffc0a80164:-41fcd6d0:5694e85a:34
> 11:53:37,999 TRACE [com.arjuna.ats.jta] (EJB default - 5) SynchronizationImple.afterCompletion
> {noformat}
> bean (server-2) wake up
> bean (server-1) updates the row in table-1
> at this point the parent transaction gets committed without an error
> {noformat}
> 11:55:31,104 TRACE [com.arjuna.ats.arjuna] (EJB default - 3) BasicAction::removeChildThread () action 0:ffffc0a80164:-fa2e9db:5694e833:2c removing TSThread:1
> 11:55:31,104 TRACE [com.arjuna.ats.arjuna] (EJB default - 3) BasicAction::removeChildThread () action 0:ffffc0a80164:-fa2e9db:5694e833:2c removing TSThread:1 result = true
> 11:55:31,104 TRACE [com.arjuna.ats.arjuna] (EJB default - 3) TransactionReaper::remove ( BasicAction: 0:ffffc0a80164:-fa2e9db:5694e833:2c status: ActionStatus.COMMITTED )
> {noformat}
> client call ends
> When I look at the table in the database I see a row in table-1 but no row in table-2. I would expect to see both tables empty.
> When I switch to JTS and run the same use case it all works as expected.
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
10 years, 3 months
- 1
- 0
[JBoss JIRA] (WFCORE-1306) SlaveReconnectTestCase fails intermittently with IBM JDK
by Marek Kopecký (JIRA)
[ https://issues.jboss.org/browse/WFCORE-1306?page=com.atlassian.jira.plugi... ]
Marek Kopecký moved JBEAP-2842 to WFCORE-1306:
----------------------------------------------
Project: WildFly Core (was: JBoss Enterprise Application Platform)
Key: WFCORE-1306 (was: JBEAP-2842)
Workflow: GIT Pull Request workflow (was: CDW v1)
Component/s: Test Suite
(was: Test Suite)
Target Release: (was: 7.0.0.GA)
Affects Version/s: 2.0.6.Final
(was: 7.0.0.ER4)
> SlaveReconnectTestCase fails intermittently with IBM JDK
> --------------------------------------------------------
>
> Key: WFCORE-1306
> URL: https://issues.jboss.org/browse/WFCORE-1306
> Project: WildFly Core
> Issue Type: Bug
> Components: Test Suite
> Affects Versions: 2.0.6.Final
> Reporter: Marek Kopecký
> Assignee: Kabir Khan
>
> *Description of problem:*
> SlaveReconnectTestCase from wildfly-core fails intermittently with IBM JDK:
> * org.jboss.as.test.integration.domain.slavereconnect.SlaveReconnectTestCase#test01_OrderedExtensionsAndDeployments
> * org.jboss.as.test.integration.domain.slavereconnect.SlaveReconnectTestCase#test02_DeploymentOverlays
> *How reproducible:*
> * 10% if you run single test from TS on IBM JDK
> * always if you run all tests from testsuite on IBM JDK
> *Steps to Reproduce:*
> # mvn install -Dmaven.repo.local=$MAVEN_REPO_LOCAL -fae -Dnode0=$MYTESTIP_1 -Dmcast=$MCAST_ADDR -DfailIfNoTests=false -Dts.domain -Dtest=SlaveReconnectTestCase
> *test01_OrderedExtensionsAndDeployments results:*
> {noformat}
> Stacktrace:
> org.jboss.as.test.integration.management.util.MgmtOperationException: Management operation failed.
> at org.jboss.as.test.integration.domain.management.util.DomainTestUtils.executeForResult(DomainTestUtils.java:160)
> at org.jboss.as.test.integration.domain.slavereconnect.DeploymentScenario.undeploy(DeploymentScenario.java:261)
> at org.jboss.as.test.integration.domain.slavereconnect.DeploymentScenario.tearDownDomain(DeploymentScenario.java:123)
> at org.jboss.as.test.integration.domain.slavereconnect.SlaveReconnectTestCase.testReconnect(SlaveReconnectTestCase.java:156)
> at org.jboss.as.test.integration.domain.slavereconnect.SlaveReconnectTestCase.test01_OrderedExtensionsAndDeployments(SlaveReconnectTestCase.java:93)
> Standard Output
> INFO [org.xnio] XNIO version 3.3.4.Final-redhat-1
> INFO [org.xnio.nio] XNIO NIO Implementation Version 3.3.4.Final-redhat-1
> INFO [org.jboss.remoting] JBoss Remoting version 4.0.18.Final-redhat-1
> &#27;[0m06:48:48,668 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.0.Final-redhat-1
> &#27;[0m&#27;[0m06:48:49,375 INFO [org.jboss.as.process.Host Controller.status] (main) WFLYPC0018: Starting process 'Host Controller'
> &#27;[0m[Host Controller] &#27;[0m06:48:54,053 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.0.Final-redhat-1&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:48:54,686 INFO [org.jboss.msc] (main) JBoss MSC version 1.2.6.Final-redhat-1&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:48:54,927 INFO [org.jboss.as] (MSC service thread 1-6) WFLYSRV0049: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" starting&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:48:57,111 INFO [org.jboss.as.host.controller] (Controller Boot Thread) WFLYHC0003: Creating http management service using network interface (management) port (9990) securePort (-1)&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:48:57,126 INFO [org.xnio] (MSC service thread 1-4) XNIO version 3.3.4.Final-redhat-1&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:48:57,158 INFO [org.xnio.nio] (MSC service thread 1-4) XNIO NIO Implementation Version 3.3.4.Final-redhat-1&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:48:57,354 INFO [org.jboss.remoting] (MSC service thread 1-4) JBoss Remoting version 4.0.18.Final-redhat-1&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:48:57,471 INFO [org.jboss.as.remoting] (MSC service thread 1-1) WFLYRMT0001: Listening on 10.16.95.146:9999&#27;[0m
> [Host Controller] &#27;[0m&#27;[33m06:48:57,558 WARN [org.jboss.as.domain.http.api.undertow] (MSC service thread 1-3) WFLYDMHTTP0003: Unable to load console module for slot main, disabling console&#27;[0m
> [Host Controller] &#27;[33m&#27;[0m&#27;[0m06:49:00,017 INFO [org.jboss.as.host.controller] (Controller Boot Thread) WFLYHC0023: Starting server main-one&#27;[0m
> &#27;[0m06:49:00,168 INFO [org.jboss.as.process.Server:main-one.status] (ProcessController-threads - 3) WFLYPC0018: Starting process 'Server:main-one'
> &#27;[0m[Server:main-one] 06:49:06,140 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.0.Final-redhat-1
> [Server:main-one] 06:49:07,555 INFO [org.jboss.msc] (main) JBoss MSC version 1.2.6.Final-redhat-1
> [Server:main-one] 06:49:08,037 INFO [org.jboss.as] (MSC service thread 1-7) WFLYSRV0049: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" starting
> [Server:main-one] 06:49:08,358 INFO [org.xnio] (MSC service thread 1-8) XNIO version 3.3.4.Final-redhat-1
> [Server:main-one] 06:49:08,398 INFO [org.xnio.nio] (MSC service thread 1-8) XNIO NIO Implementation Version 3.3.4.Final-redhat-1
> [Server:main-one] 06:49:08,492 INFO [org.jboss.remoting] (MSC service thread 1-8) JBoss Remoting version 4.0.18.Final-redhat-1
> [Host Controller] &#27;[0m&#27;[0m06:49:11,745 INFO [org.jboss.as.host.controller] (Remoting "master:MANAGEMENT" task-3) WFLYHC0021: Server [Server:main-one] connected using connection [Channel ID 32521e75 (inbound) of Remoting connection 2868ecda to /10.16.95.146:54380]&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:11,876 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0060: Http management interface listening on http://10.16.95.146:9990/management&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:11,878 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0051: Admin console listening on http://10.16.95.146:9990&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:11,880 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" (Host Controller) started in 21516ms - Started 49 of 49 services (11 services are lazy, passive or on-demand)&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:11,895 INFO [org.jboss.as.host.controller] (server-registration-threads - 1) WFLYHC0020: Registering server main-one&#27;[0m
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] ServerIdentity{name=main-one, host=master, server-group=main-server-group} status is starting
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] ServerIdentity{name=main-one, host=master, server-group=main-server-group} status is starting
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] ServerIdentity{name=main-one, host=master, server-group=main-server-group} status is starting
> [Server:main-one] 06:49:13,162 INFO [org.wildfly.extension.io] (ServerService Thread Pool -- 11) WFLYIO001: Worker 'default' has auto-configured to 8 core threads with 64 task threads based on your 4 available processors
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] ServerIdentity{name=main-one, host=master, server-group=main-server-group} status is starting
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] ServerIdentity{name=main-one, host=master, server-group=main-server-group} status is starting
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] ServerIdentity{name=main-one, host=master, server-group=main-server-group} status is starting
> [Server:main-one] 06:49:14,145 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" started in 13171ms - Started 49 of 65 services (22 services are lazy, passive or on-demand)
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] All servers started in 28034 ms
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] HostController started in 28294 ms
> &#27;[0m06:49:19,902 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.0.Final-redhat-1
> &#27;[0m&#27;[0m06:49:21,161 INFO [org.jboss.as.process.Host Controller.status] (main) WFLYPC0018: Starting process 'Host Controller'
> &#27;[0m[Host Controller] &#27;[0m06:49:25,502 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.0.Final-redhat-1&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:25,956 INFO [org.jboss.msc] (main) JBoss MSC version 1.2.6.Final-redhat-1&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:26,154 INFO [org.jboss.as] (MSC service thread 1-5) WFLYSRV0049: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" starting&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:28,070 INFO [org.xnio] (MSC service thread 1-6) XNIO version 3.3.4.Final-redhat-1&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:28,078 INFO [org.jboss.as.host.controller] (Controller Boot Thread) WFLYHC0003: Creating http management service using network interface (management) port (19990) securePort (-1)&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:28,128 INFO [org.xnio.nio] (MSC service thread 1-6) XNIO NIO Implementation Version 3.3.4.Final-redhat-1&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:28,292 INFO [org.jboss.remoting] (MSC service thread 1-6) JBoss Remoting version 4.0.18.Final-redhat-1&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:28,418 INFO [org.jboss.as.remoting] (MSC service thread 1-1) WFLYRMT0001: Listening on 10.16.95.146:19999&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:32,479 INFO [org.jboss.as.domain.controller] (Host Controller Service Threads - 12) WFLYHC0019: Registered remote slave host "slave", WildFly 2.0.6.Final-redhat-SNAPSHOT "Kenny"&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:32,485 INFO [org.jboss.as.host.controller] (Controller Boot Thread) WFLYHC0148: Connected to master host controller at remote://10.16.95.146:9999&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:32,645 INFO [org.jboss.as.host.controller] (Controller Boot Thread) WFLYHC0023: Starting server main-three&#27;[0m
> &#27;[0m06:49:32,769 INFO [org.jboss.as.process.Server:main-three.status] (ProcessController-threads - 3) WFLYPC0018: Starting process 'Server:main-three'
> &#27;[0m[Server:main-three] 06:49:39,023 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.0.Final-redhat-1
> [Server:main-three] 06:49:40,512 INFO [org.jboss.msc] (main) JBoss MSC version 1.2.6.Final-redhat-1
> [Server:main-three] 06:49:41,031 INFO [org.jboss.as] (MSC service thread 1-7) WFLYSRV0049: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" starting
> [Server:main-three] 06:49:41,410 INFO [org.xnio] (MSC service thread 1-1) XNIO version 3.3.4.Final-redhat-1
> [Server:main-three] 06:49:41,460 INFO [org.xnio.nio] (MSC service thread 1-1) XNIO NIO Implementation Version 3.3.4.Final-redhat-1
> [Server:main-three] 06:49:41,618 INFO [org.jboss.remoting] (MSC service thread 1-1) JBoss Remoting version 4.0.18.Final-redhat-1
> [Host Controller] &#27;[0m&#27;[0m06:49:44,879 INFO [org.jboss.as.host.controller] (Remoting "slave:MANAGEMENT" task-6) WFLYHC0021: Server [Server:main-three] connected using connection [Channel ID 67c682e1 (inbound) of Remoting connection a80dd256 to /10.16.95.146:45011]&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:44,942 INFO [org.jboss.as.host.controller] (Controller Boot Thread) WFLYHC0023: Starting server other-two&#27;[0m
> &#27;[0m06:49:45,011 INFO [org.jboss.as.process.Server:other-two.status] (ProcessController-threads - 3) WFLYPC0018: Starting process 'Server:other-two'
> &#27;[0m[Host Controller] &#27;[0m&#27;[0m06:49:45,011 INFO [org.jboss.as.host.controller] (server-registration-threads - 1) WFLYHC0020: Registering server main-three&#27;[0m
> [Server:main-three] 06:49:46,080 INFO [org.wildfly.extension.io] (ServerService Thread Pool -- 8) WFLYIO001: Worker 'default' has auto-configured to 8 core threads with 64 task threads based on your 4 available processors
> [Server:main-three] 06:49:47,688 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" started in 14325ms - Started 50 of 66 services (23 services are lazy, passive or on-demand)
> [Server:other-two] 06:49:52,242 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.0.Final-redhat-1
> [Server:other-two] 06:49:53,954 INFO [org.jboss.msc] (main) JBoss MSC version 1.2.6.Final-redhat-1
> [Server:other-two] 06:49:54,394 INFO [org.jboss.as] (MSC service thread 1-7) WFLYSRV0049: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" starting
> [Server:other-two] 06:49:54,872 INFO [org.xnio] (MSC service thread 1-1) XNIO version 3.3.4.Final-redhat-1
> [Server:other-two] 06:49:54,909 INFO [org.xnio.nio] (MSC service thread 1-1) XNIO NIO Implementation Version 3.3.4.Final-redhat-1
> [Server:other-two] 06:49:55,016 INFO [org.jboss.remoting] (MSC service thread 1-1) JBoss Remoting version 4.0.18.Final-redhat-1
> [Host Controller] &#27;[0m&#27;[0m06:49:57,542 INFO [org.jboss.as.host.controller] (Remoting "slave:MANAGEMENT" task-12) WFLYHC0021: Server [Server:other-two] connected using connection [Channel ID 4265a37a (inbound) of Remoting connection f85d1a6d to /10.16.95.146:60116]&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:57,626 INFO [org.jboss.as.host.controller] (server-registration-threads - 1) WFLYHC0020: Registering server other-two&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:57,634 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0060: Http management interface listening on http://10.16.95.146:19990/management&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:57,645 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0054: Admin console is not enabled&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:49:57,646 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" (Host Controller) started in 35462ms - Started 48 of 49 services (13 services are lazy, passive or on-demand)&#27;[0m
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] ServerIdentity{name=other-two, host=slave, server-group=other-server-group} status is starting
> [Server:other-two] 06:49:58,512 INFO [org.wildfly.extension.io] (ServerService Thread Pool -- 8) WFLYIO001: Worker 'default' has auto-configured to 8 core threads with 64 task threads based on your 4 available processors
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] ServerIdentity{name=other-two, host=slave, server-group=other-server-group} status is starting
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] ServerIdentity{name=other-two, host=slave, server-group=other-server-group} status is starting
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] ServerIdentity{name=other-two, host=slave, server-group=other-server-group} status is starting
> [Server:other-two] 06:49:59,648 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" started in 13735ms - Started 50 of 66 services (23 services are lazy, passive or on-demand)
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] All servers started in 44891 ms
> INFO [org.jboss.as.test.integration.domain.management.util.DomainLifecycleUtil] HostController started in 45148 ms
> [Host Controller] &#27;[0m&#27;[0m06:50:03,186 INFO [org.jboss.as.host.controller] (management-handler-thread - 1) WFLYHC0023: Starting server server-unaffected&#27;[0m
> [Host Controller] &#27;[0m&#27;[33m06:50:03,189 WARN [org.jboss.as.host.controller] (management-handler-thread - 1) WFLYHC0011: Ignoring <permgen> for jvm 'SUN' type jvm: null&#27;[0m
> &#27;[0m06:50:03,314 INFO [org.jboss.as.process.Server:server-unaffected.status] (ProcessController-threads - 3) WFLYPC0018: Starting process 'Server:server-unaffected'
> &#27;[0m[Host Controller] &#27;[33m&#27;[0m&#27;[33m06:50:03,377 WARN [org.jboss.as.host.controller] (ProcessControllerConnection-thread - 2) WFLYHC0011: Ignoring <permgen> for jvm 'SUN' type jvm: null&#27;[0m
> [Server:server-unaffected] 06:50:09,434 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.0.Final-redhat-1
> [Server:server-unaffected] 06:50:10,574 INFO [org.jboss.msc] (main) JBoss MSC version 1.2.6.Final-redhat-1
> [Server:server-unaffected] 06:50:11,215 INFO [org.jboss.as] (MSC service thread 1-7) WFLYSRV0049: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" starting
> [Server:server-unaffected] 06:50:11,575 INFO [org.xnio] (MSC service thread 1-1) XNIO version 3.3.4.Final-redhat-1
> [Server:server-unaffected] 06:50:11,624 INFO [org.xnio.nio] (MSC service thread 1-1) XNIO NIO Implementation Version 3.3.4.Final-redhat-1
> [Server:server-unaffected] 06:50:11,738 INFO [org.jboss.remoting] (MSC service thread 1-1) JBoss Remoting version 4.0.18.Final-redhat-1
> [Host Controller] &#27;[33m&#27;[0m&#27;[0m06:50:15,128 INFO [org.jboss.as.host.controller] (Remoting "slave:MANAGEMENT" task-3) WFLYHC0021: Server [Server:server-unaffected] connected using connection [Channel ID 7b99b49d (inbound) of Remoting connection 24f20b4a to /10.16.95.146:54148]&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:15,224 INFO [org.jboss.as.host.controller] (server-registration-threads - 1) WFLYHC0020: Registering server server-unaffected&#27;[0m
> [Server:server-unaffected] 06:50:17,179 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" started in 12876ms - Started 41 of 57 services (21 services are lazy, passive or on-demand)
> [Host Controller] &#27;[0m&#27;[0m06:50:19,297 INFO [org.jboss.as.host.controller] (management-handler-thread - 3) WFLYHC0023: Starting server server-affected&#27;[0m
> [Host Controller] &#27;[0m&#27;[33m06:50:19,306 WARN [org.jboss.as.host.controller] (management-handler-thread - 3) WFLYHC0011: Ignoring <permgen> for jvm 'SUN' type jvm: null&#27;[0m
> &#27;[0m06:50:19,409 INFO [org.jboss.as.process.Server:server-affected.status] (ProcessController-threads - 3) WFLYPC0018: Starting process 'Server:server-affected'
> &#27;[0m[Host Controller] &#27;[33m&#27;[0m&#27;[33m06:50:19,466 WARN [org.jboss.as.host.controller] (ProcessControllerConnection-thread - 2) WFLYHC0011: Ignoring <permgen> for jvm 'SUN' type jvm: null&#27;[0m
> [Server:server-affected] 06:50:24,637 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.0.Final-redhat-1
> [Server:server-affected] 06:50:25,812 INFO [org.jboss.msc] (main) JBoss MSC version 1.2.6.Final-redhat-1
> [Server:server-affected] 06:50:26,126 INFO [org.jboss.as] (MSC service thread 1-7) WFLYSRV0049: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" starting
> [Server:server-affected] 06:50:26,338 INFO [org.xnio] (MSC service thread 1-5) XNIO version 3.3.4.Final-redhat-1
> [Server:server-affected] 06:50:26,366 INFO [org.xnio.nio] (MSC service thread 1-5) XNIO NIO Implementation Version 3.3.4.Final-redhat-1
> [Server:server-affected] 06:50:26,450 INFO [org.jboss.remoting] (MSC service thread 1-5) JBoss Remoting version 4.0.18.Final-redhat-1
> [Host Controller] &#27;[33m&#27;[0m&#27;[0m06:50:28,660 INFO [org.jboss.as.host.controller] (Remoting "slave:MANAGEMENT" task-4) WFLYHC0021: Server [Server:server-affected] connected using connection [Channel ID 0b33ef0a (inbound) of Remoting connection 41562de1 to /10.16.95.146:37200]&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:28,858 INFO [org.jboss.as.host.controller] (server-registration-threads - 1) WFLYHC0020: Registering server server-affected&#27;[0m
> [Server:server-affected] 06:50:30,584 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" started in 10442ms - Started 41 of 57 services (21 services are lazy, passive or on-demand)
> [Host Controller] &#27;[0m&#27;[0m06:50:32,698 INFO [org.jboss.as.repository] (management-handler-thread - 6) WFLYDR0001: Content added at location /mnt/hudson_workspace/workspace/eap-7x-as-testsuite-test-core-rhel-basic-reconnect/19de6045/testsuite/domain/target/domains/SlaveReconnectTestCase/master/data/content/09/d3f8807790439e696b8317b611b3dcd3b73357/content&#27;[0m
> [Server:server-affected] 06:50:33,005 INFO [org.jboss.as.server.deployment] (MSC service thread 1-2) WFLYSRV0027: Starting deployment of "reconnect-slave-depone.jar" (runtime-name: "reconnect-slave-depone.jar")
> [Server:server-affected] 06:50:33,167 INFO [stdout] (MSC service thread 1-5) ===> class org.jboss.as.test.integration.domain.slavereconnect.deployment.ServiceActivatorDeploymentOne setting property test.deployment.prop.one=one
> [Server:server-affected] 06:50:33,236 INFO [org.jboss.as.server] (ServerService Thread Pool -- 4) WFLYSRV0010: Deployed "reconnect-slave-depone.jar" (runtime-name : "reconnect-slave-depone.jar")
> [Host Controller] &#27;[0m&#27;[0m06:50:33,347 INFO [org.jboss.as.repository] (management-handler-thread - 2) WFLYDR0001: Content added at location /mnt/hudson_workspace/workspace/eap-7x-as-testsuite-test-core-rhel-basic-reconnect/19de6045/testsuite/domain/target/domains/SlaveReconnectTestCase/master/data/content/6b/bc9ff93840d04e654599ba2bfd2d8ca6dc8300/content&#27;[0m
> [Server:server-affected] 06:50:33,585 INFO [org.jboss.as.server.deployment] (MSC service thread 1-4) WFLYSRV0027: Starting deployment of "reconnect-slave-deptwo.jar" (runtime-name: "reconnect-slave-deptwo.jar")
> [Server:server-affected] 06:50:33,634 INFO [stdout] (MSC service thread 1-1) ===> class org.jboss.as.test.integration.domain.slavereconnect.deployment.ServiceActivatorDeploymentTwo setting property test.deployment.prop.two=two
> [Server:server-affected] 06:50:33,741 INFO [org.jboss.as.server] (ServerService Thread Pool -- 4) WFLYSRV0010: Deployed "reconnect-slave-deptwo.jar" (runtime-name : "reconnect-slave-deptwo.jar")
> [Host Controller] &#27;[0m&#27;[0m06:50:34,161 INFO [org.jboss.as.host.controller] (Host Controller Service Threads - 23) WFLYHC0024: Stopping server main-one&#27;[0m
> &#27;[0m06:50:34,174 INFO [org.jboss.as.process.Server:main-one.status] (ProcessController-threads - 4) WFLYPC0019: Stopping process 'Server:main-one'
> &#27;[0m[Server:main-one] 06:50:34,180 INFO [org.jboss.as.server] (Thread-9) WFLYSRV0220: Server shutdown has been requested.
> [Host Controller] &#27;[0m&#27;[0m06:50:34,298 INFO [org.jboss.as.host.controller] (Remoting "master:MANAGEMENT" task-11) WFLYHC0027: Unregistering server main-one&#27;[0m
> [Server:main-one] 06:50:34,359 INFO [org.jboss.as] (MSC service thread 1-4) WFLYSRV0050: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" stopped in 129ms
> &#27;[0m06:50:34,398 INFO [org.jboss.as.process.Server:main-one.status] (reaper for Server:main-one) WFLYPC0011: Process 'Server:main-one' finished with an exit status of 0
> &#27;[0m[Host Controller] &#27;[0m&#27;[0m06:50:34,402 INFO [org.jboss.as.host.controller] (ProcessControllerConnection-thread - 2) WFLYHC0027: Unregistering server main-one&#27;[0m
> [Host Controller] &#27;[0m&#27;[33m06:50:34,455 WARN [org.jboss.as.domain.controller] (MSC service thread 1-3) WFLYHC0030: Connection to remote host "slave" closed unexpectedly&#27;[0m
> [Host Controller] &#27;[0m&#27;[33m06:50:34,521 WARN [org.jboss.as.host.controller] (Remoting "slave:MANAGEMENT" task-8) WFLYHC0015: Connection to remote host-controller closed. Trying to reconnect.&#27;[0m
> [Host Controller] &#27;[33m&#27;[0m&#27;[0m06:50:34,545 INFO [org.jboss.as.host.controller] (Host Controller Service Threads - 14) WFLYHC0150: Trying to reconnect to master host controller.&#27;[0m
> [Host Controller] &#27;[33m&#27;[0m&#27;[0m06:50:34,566 INFO [org.jboss.as] (MSC service thread 1-5) WFLYSRV0050: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" stopped in 422ms&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:34,573 INFO [org.jboss.as] (MSC service thread 1-5) WFLYSRV0049: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" starting&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:34,914 INFO [org.jboss.as.host.controller] (Controller Boot Thread) WFLYHC0003: Creating http management service using network interface (management) port (9990) securePort (-1)&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:35,021 INFO [org.jboss.as.remoting] (MSC service thread 1-4) WFLYRMT0001: Listening on 10.16.95.146:9999&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:35,558 INFO [org.jboss.as.host.controller] (Host Controller Service Threads - 14) WFLYHC0150: Trying to reconnect to master host controller.&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:36,112 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0060: Http management interface listening on http://10.16.95.146:9990/management&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:36,114 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0054: Admin console is not enabled&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:36,115 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" (Host Controller) started in 1539ms - Started 49 of 49 services (11 services are lazy, passive or on-demand)&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:36,558 INFO [org.jboss.as.repository] (management-handler-thread - 3) WFLYDR0002: Content removed from location /mnt/hudson_workspace/workspace/eap-7x-as-testsuite-test-core-rhel-basic-reconnect/19de6045/testsuite/domain/target/domains/SlaveReconnectTestCase/master/data/content/09/d3f8807790439e696b8317b611b3dcd3b73357/content&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:36,650 INFO [org.jboss.as.repository] (management-handler-thread - 4) WFLYDR0001: Content added at location /mnt/hudson_workspace/workspace/eap-7x-as-testsuite-test-core-rhel-basic-reconnect/19de6045/testsuite/domain/target/domains/SlaveReconnectTestCase/master/data/content/ab/7255f2406ac895cc3e9c8edadc609af88bf636/content&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:36,932 INFO [org.jboss.as.repository] (management-handler-thread - 1) WFLYDR0002: Content removed from location /mnt/hudson_workspace/workspace/eap-7x-as-testsuite-test-core-rhel-basic-reconnect/19de6045/testsuite/domain/target/domains/SlaveReconnectTestCase/master/data/content/6b/bc9ff93840d04e654599ba2bfd2d8ca6dc8300/content&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:36,996 INFO [org.jboss.as.repository] (management-handler-thread - 2) WFLYDR0001: Content added at location /mnt/hudson_workspace/workspace/eap-7x-as-testsuite-test-core-rhel-basic-reconnect/19de6045/testsuite/domain/target/domains/SlaveReconnectTestCase/master/data/content/a2/f1854f72e5888fed7ab9b24794f221f37ac757/content&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:37,135 INFO [org.jboss.as.repository] (management-handler-thread - 3) WFLYDR0001: Content added at location /mnt/hudson_workspace/workspace/eap-7x-as-testsuite-test-core-rhel-basic-reconnect/19de6045/testsuite/domain/target/domains/SlaveReconnectTestCase/master/data/content/c4/0aaecf59ae8bb17142bf35da9865286082c9e5/content&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:37,298 INFO [org.jboss.as] (MSC service thread 1-8) WFLYSRV0050: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" stopped in 55ms&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:37,307 INFO [org.jboss.as] (MSC service thread 1-3) WFLYSRV0049: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" starting&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:37,622 INFO [org.jboss.as.host.controller] (Controller Boot Thread) WFLYHC0003: Creating http management service using network interface (management) port (9990) securePort (-1)&#27;[0m
> [Host Controller] &#27;[0m&#27;[33m06:50:37,692 WARN [org.jboss.as.domain.http.api.undertow] (MSC service thread 1-1) WFLYDMHTTP0003: Unable to load console module for slot main, disabling console&#27;[0m
> [Host Controller] &#27;[33m&#27;[0m&#27;[0m06:50:37,705 INFO [org.jboss.as.remoting] (MSC service thread 1-3) WFLYRMT0001: Listening on 10.16.95.146:9999&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:38,503 INFO [org.jboss.as.host.controller] (Controller Boot Thread) WFLYHC0023: Starting server main-one&#27;[0m
> &#27;[0m06:50:38,563 INFO [org.jboss.as.process.Server:main-one.status] (ProcessController-threads - 4) WFLYPC0018: Starting process 'Server:main-one'
> &#27;[0m[Host Controller] &#27;[0m&#27;[0m06:50:39,654 INFO [org.jboss.as.host.controller] (Host Controller Service Threads - 14) WFLYHC0150: Trying to reconnect to master host controller.&#27;[0m
> [Host Controller] &#27;[0m&#27;[31m06:50:39,751 ERROR [org.jboss.as.controller.management-operation] (Host Controller Service Threads - 15) WFLYCTL0013: Operation ("resolve-subsystems") failed - address: ([]): java.lang.IllegalArgumentException: WFLYCTL0218: A node is already registered at '/profile=*/subsystem=ordered-children'&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.registry.ConcreteResourceRegistration.registerSubModel(ConcreteResourceRegistration.java:215)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.extension.ExtensionRegistry$SubsystemRegistrationImpl.registerSubsystemModel(ExtensionRegistry.java:702)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.test.integration.domain.extension.OrderedChildResourceExtension.initialize(OrderedChildResourceExtension.java:83)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.domain.controller.operations.ApplyExtensionsHandler.initializeExtension(ApplyExtensionsHandler.java:221)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.domain.controller.operations.ApplyExtensionsHandler.execute(ApplyExtensionsHandler.java:137)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.AbstractOperationContext.executeStep(AbstractOperationContext.java:890)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.AbstractOperationContext.processStages(AbstractOperationContext.java:659)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.AbstractOperationContext.executeOperation(AbstractOperationContext.java:370)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.OperationContextImpl.executeOperation(OperationContextImpl.java:1344)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.ModelControllerImpl.internalExecute(ModelControllerImpl.java:392)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.AbstractControllerService.internalExecute(AbstractControllerService.java:418)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.DomainModelControllerService.access$1100(DomainModelControllerService.java:176)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.DomainModelControllerService$InternalExecutor.installSlaveExtensions(DomainModelControllerService.java:1237)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.RemoteDomainConnectionService.resolveSubsystems(RemoteDomainConnectionService.java:544)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.RemoteDomainConnectionService.access$1000(RemoteDomainConnectionService.java:131)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.RemoteDomainConnectionService$2.resolveSubsystemVersions(RemoteDomainConnectionService.java:508)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.RemoteDomainConnection.resolveSubsystemVersions(RemoteDomainConnection.java:297)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.RemoteDomainConnection$HostControllerConnectRequest$1.execute(RemoteDomainConnection.java:389)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.protocol.mgmt.AbstractMessageHandler$ManagementRequestContextImpl$1.doExecute(AbstractMessageHandler.java:363)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.protocol.mgmt.AbstractMessageHandler$AsyncTaskRunner.run(AbstractMessageHandler.java:472)&#27;[0m
> [Host Controller] &#27;[31m at java.util.concurr[Host Controller] &#27;[0m&#27;[0m06:50:39,772 INFO [org.jboss.as.protocol] (Remoting "master:MANAGEMENT" I/O-1) WFLYPRT0057: cancelled task by interrupting thread Thread[Host Controller Service Threads - 42,5,Host Controller Service Threads]&#27;[0m
> [Host Controller] &#27;[0m&#27;[31m06:50:39,774 ERROR [org.jboss.as.controller.management-operation] (Host Controller Service Threads - 42) WFLYCTL0013: Operation ("read-master-domain-model") failed - address: ([]): java.lang.IllegalStateException: java.lang.InterruptedException&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.mgmt.HostControllerRegistrationHandler$RegistrationContext.executeBlocking(HostControllerRegistrationHandler.java:617)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.mgmt.HostControllerRegistrationHandler$RegistrationContext.processSubsystems(HostControllerRegistrationHandler.java:456)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.mgmt.HostControllerRegistrationHandler$RegistrationContext.access$900(HostControllerRegistrationHandler.java:334)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.mgmt.HostControllerRegistrationHandler$HostRegistrationStepHandler.execute(HostControllerRegistrationHandler.java:327)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.AbstractOperationContext.executeStep(AbstractOperationContext.java:890)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.AbstractOperationContext.processStages(AbstractOperationContext.java:659)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.AbstractOperationContext.executeOperation(AbstractOperationContext.java:370)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.OperationContextImpl.executeOperation(OperationContextImpl.java:1344)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.ModelControllerImpl.internalExecute(ModelControllerImpl.java:392)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.controller.AbstractControllerService.internalExecute(AbstractControllerService.java:408)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.DomainModelControllerService.access$900(DomainModelControllerService.java:176)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.DomainModelControllerService$InternalExecutor.execute(DomainModelControllerService.java:1230)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.mgmt.HostControllerRegistrationHandler$RegistrationContext.processRegistration(HostControllerRegistrationHandler.java:424)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.mgmt.HostControllerRegistrationHandler$RegistrationContext.access$400(HostControllerRegistrationHandler.java:334)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.mgmt.HostControllerRegistrationHandler$InitiateRegistrationHandler$1.execute(HostControllerRegistrationHandler.java:230)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.protocol.mgmt.AbstractMessageHandler$ManagementRequestContextImpl$1.doExecute(AbstractMessageHandler.java:363)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.protocol.mgmt.AbstractMessageHandler$AsyncTaskRunner.run(AbstractMessageHandler.java:472)&#27;[0m
> [Host Controller] &#27;[31m at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1153)&#27;[0m
> [Host Controller] &#27;[31m at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)&#27;[0m
> [Host Controller] &#27;[31m at java.lang.Thread.run(Thread.java:785)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.threads.JBossThread.run(JBossThread.java:320)&#27;[0m
> [Host Controller] &#27;[31mCaused by: java.lang.InterruptedException&#27;[0m
> [Host Controller] &#27;[31m at java.lang.Object.wait(Native Method)&#27;[0m
> [Host Controller] &#27;[31m at java.lang.Object.wait(Object.java:172)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.threads.AsyncFutureTask.await(AsyncFutureTask.java:192)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.threads.AsyncFutureTask.get(AsyncFutureTask.java:266)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.as.host.controller.mgmt.HostControllerRegistrationHandler$RegistrationContext.executeBlocking(HostControllerRegistrationHandler.java:614)&#27;[0m
> [Host Controller] &#27;[31m ... 20 more&#27;[0m
> [Host Controller] &#27;[31m&#27;[0m
> ent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1153)&#27;[0m
> [Host Controller] &#27;[31m at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:628)&#27;[0m
> [Host Controller] &#27;[31m at java.lang.Thread.run(Thread.java:785)&#27;[0m
> [Host Controller] &#27;[31m at org.jboss.threads.JBossThread.run(JBossThread.java:320)&#27;[0m
> [Host Controller] &#27;[31m&#27;[0m
> [Server:main-one] 06:50:43,912 INFO [org.jboss.modules] (main) JBoss Modules version 1.5.0.Final-redhat-1
> [Server:main-one] 06:50:44,982 INFO [org.jboss.msc] (main) JBoss MSC version 1.2.6.Final-redhat-1
> [Server:main-one] 06:50:45,418 INFO [org.jboss.as] (MSC service thread 1-7) WFLYSRV0049: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" starting
> [Server:main-one] 06:50:45,668 INFO [org.xnio] (MSC service thread 1-2) XNIO version 3.3.4.Final-redhat-1
> [Server:main-one] 06:50:45,729 INFO [org.xnio.nio] (MSC service thread 1-2) XNIO NIO Implementation Version 3.3.4.Final-redhat-1
> [Server:main-one] 06:50:45,880 INFO [org.jboss.remoting] (MSC service thread 1-2) JBoss Remoting version 4.0.18.Final-redhat-1
> [Host Controller] &#27;[31m&#27;[0m&#27;[0m06:50:48,783 INFO [org.jboss.as.host.controller] (Host Controller Service Threads - 14) WFLYHC0150: Trying to reconnect to master host controller.&#27;[0m
> [Host Controller] &#27;[31m&#27;[0m&#27;[0m06:50:49,461 INFO [org.jboss.as.host.controller] (Remoting "master:MANAGEMENT" task-16) WFLYHC0021: Server [Server:main-one] connected using connection [Channel ID 65fce631 (inbound) of Remoting connection 33bba145 to /10.16.95.146:43301]&#27;[0m
> [Host Controller] &#27;[0m&#27;[33m06:50:49,862 WARN [org.jboss.as.host.controller] (Host Controller Service Threads - 17) WFLYHC0011: Ignoring <permgen> for jvm 'SUN' type jvm: null&#27;[0m
> [Host Controller] &#27;[33m&#27;[0m&#27;[33m06:50:49,870 WARN [org.jboss.as.host.controller] (Host Controller Service Threads - 17) WFLYHC0011: Ignoring <permgen> for jvm 'SUN' type jvm: null&#27;[0m
> [Host Controller] &#27;[33m&#27;[0m&#27;[33m06:50:49,877 WARN [org.jboss.as.host.controller] (Host Controller Service Threads - 17) WFLYHC0011: Ignoring <permgen> for jvm 'SUN' type jvm: null&#27;[0m
> [Host Controller] &#27;[33m&#27;[0m&#27;[33m06:50:49,884 WARN [org.jboss.as.host.controller] (Host Controller Service Threads - 17) WFLYHC0011: Ignoring <permgen> for jvm 'SUN' type jvm: null&#27;[0m
> [Host Controller] &#27;[33m&#27;[0m&#27;[0m06:50:50,020 INFO [org.jboss.as.repository] (Host Controller Service Threads - 17) WFLYDR0002: Content removed from location /mnt/hudson_workspace/workspace/eap-7x-as-testsuite-test-core-rhel-basic-reconnect/19de6045/testsuite/domain/target/domains/SlaveReconnectTestCase/slave/data/content/6b/bc9ff93840d04e654599ba2bfd2d8ca6dc8300/content&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:50,030 INFO [org.jboss.as.host.controller] (Host Controller Service Threads - 14) WFLYHC0148: Connected to master host controller at remote://10.16.95.146:9999&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:50,027 INFO [org.jboss.as.domain.controller] (Host Controller Service Threads - 42) WFLYHC0019: Registered remote slave host "slave", WildFly 2.0.6.Final-redhat-SNAPSHOT "Kenny"&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:50,075 INFO [org.jboss.as.host.controller] (server-registration-threads - 1) WFLYHC0020: Registering server main-one&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:50,081 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0060: Http management interface listening on http://10.16.95.146:9990/management&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:50,091 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0051: Admin console listening on http://10.16.95.146:9990&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:50,093 INFO [org.jboss.as] (Controller Boot Thread) WFLYSRV0025: WildFly Core 2.0.6.Final-redhat-SNAPSHOT "Kenny" (Host Controller) started in 12771ms - Started 49 of 49 services (11 services are lazy, passive or on-demand)&#27;[0m
> [Server:main-one] 06:50:51,002 INFO [org.wildfly.extension.io] (ServerService Thread Pool -- 13) WFLYIO001: Worker 'default' has auto-configured to 8 core threads with 64 task threads based on your 4 available processors
> Failed operation:
> {
> "operation" => "read-resource",
> "address" => [
> ("host" => "master"),
> ("server" => "main-one"),
> ("subsystem" => "ordered-children")
> ],
> "recursive" => true
> }
> Response:
> {
> "outcome" => "failed",
> "result" => undefined,
> "failure-description" => "WFLYCTL0379: System boot is in process; execution of remote management operations is not currently available",
> "rolled-back" => true
> }
> [Host Controller] &#27;[0m&#27;[0m06:50:51,289 INFO [org.jboss.as.repository] (management-handler-thread - 3) WFLYDR0002: Content removed from location /mnt/hudson_workspace/workspace/eap-7x-as-testsuite-test-core-rhel-basic-reconnect/19de6045/testsuite/domain/target/domains/SlaveReconnectTestCase/master/data/content/c4/0aaecf59ae8bb17142bf35da9865286082c9e5/content&#27;[0m
> [Host Controller] &#27;[0m&#27;[0m06:50:51,317 INFO [org.jboss.as.repository] (Host Controller Service Threads - 14) WFLYDR0002: Content removed from location /mnt/hudson_workspace/workspace/eap-7x-as-testsuite-test-core-rhel-basic-reconnect/19de6045/testsuite/domain/target/domains/SlaveReconnectTestCase/slave/data/content/c4/0aaecf59ae8bb17142bf35da9865286082c9e5/content&#27;[0m
> Failed operation:
> {
> "operation" => "composite",
> "address" => [],
> "steps" => [
> {
> "operation" => "remove",
> "address" => [
> ("server-group" => "deployment-group-affected"),
> ("deployment" => "reconnect-slave-depfour.jar")
> ]
> },
> {
> "operation" => "remove",
> "address" => [("deployment" => "reconnect-slave-depfour.jar")]
> }
> ]
> }
> Response:
> {
> "outcome" => "failed",
> "result" => {
> "step-1" => {
> "outcome" => "failed",
> "rolled-back" => true
> },
> "step-2" => {
> "outcome" => "failed",
> "rolled-back" => true
> }
> },
> "failure-description" => {"WFLYDC0074: Operation failed or was rolled back on all servers. Server failures:" => {"server-group" => {"deployment-group-affected" => {"host" => {"slave" => {"server-affected" => {"WFLYCTL0062: Composite operation failed and was rolled back. Steps that failed:" => {"Operation step-1" => "WFLYCTL0216: Management resource '[(\"deployment\" => \"reconnect-slave-depfour.jar\")]' not found"}}}}}}}},
> "rolled-back" => true,
> "server-groups" => {"deployment-group-affected" => {"host" => {"slave" => {"server-affected" => {"response" => {
> "outcome" => "failed",
> "result" => {"step-1" => {
> "outcome" => "failed",
> "failure-description" => "WFLYCTL0216: Management resource '[(\"deployment\" => \"reconnect-slave-depfour.jar\")]' not found",
> "rolled-back" => true
> }},
> "failure-description" => {"WFLYCTL0062: Composite operation failed and was rolled back. Steps that failed:" => {"Operation step-1" => "WFLYCTL0216: Management resource '[(\"deployment\" => \"reconnect-slave-depfour.jar\")]' not found"}},
> "response-headers" => {"process-state" => "reload-required"},
> "rolled-back" => true
> }}}}}}
> }
> {noformat}
> *test02_DeploymentOverlays results:*
> {noformat}
> Stacktrace:
> org.jboss.as.test.integration.management.util.MgmtOperationException: Management operation failed.
> at org.jboss.as.test.integration.domain.management.util.DomainTestUtils.executeForResult(DomainTestUtils.java:160)
> at org.jboss.as.test.integration.domain.slavereconnect.SlaveReconnectTestCase.cloneProfile(SlaveReconnectTestCase.java:183)
> Standard Output:
> Failed operation:
> {
> "operation" => "clone",
> "address" => [("profile" => "minimal")],
> "to-profile" => "unaffacted"
> }
> Response:
> {
> "outcome" => "failed",
> "failure-description" => {"domain-failure-description" => "WFLYCTL0212: Duplicate resource [(\"profile\" => \"unaffacted\")]"},
> "rolled-back" => true
> }
> {noformat}
> *Expected results:*
> No errors
> *Additional info:*
> Jenkins reproducer job: https://jenkins.mw.lab.eng.bos.redhat.com/hudson/view/EAP7/view/EAP7-AS-T...
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
10 years, 3 months
- 1
- 0
[JBoss JIRA] (WFLY-6011) Remote branch of a transaction gets rolled back incorrectly.
by David Lloyd (JIRA)
[ https://issues.jboss.org/browse/WFLY-6011?page=com.atlassian.jira.plugin.... ]
David Lloyd commented on WFLY-6011:
-----------------------------------
The connection/disconnection of an upstream server currently should not have any bearing on whether the downstream XA transaction is committed. It should be able to reconnect and pick up where it left off.
This differs from remote UT handling, wherein if the connection is broken, the transaction is always rolled back.
> Remote branch of a transaction gets rolled back incorrectly.
> -------------------------------------------------------------
>
> Key: WFLY-6011
> URL: https://issues.jboss.org/browse/WFLY-6011
> Project: WildFly
> Issue Type: Bug
> Components: EJB
> Reporter: Jason Greene
> Assignee: David Lloyd
>
> The use case is as follow:
> Client makes a call to a bean on server-1
> bean (server-1) inserts a row into table-1
> bean (server-1) calls to a bean on server-2
> bean (server-2) inserts a row into table-2
> bean (server-2) goes to sleep for 3 minutes
> periodic recovery (server-1) flags the remote branchof the transaction (on server-2) as in doubt and rolls it back.
> (server-1 log)
> {noformat}
> 11:53:37,991 TRACE [com.arjuna.ats.arjuna] (Periodic Recovery) RecoveryXids _whenFirstSeen toRecover no RecoveryOnlyEJBXAResource{receiverContext=EJBReceiverContext{clientContext=org.jboss.ejb.client.EJBClientContext@322f7790, receiver=Remoting connection EJB receiver [connection=Remoting connection <2c1ab3f6>,channel=jboss.ejb,nodename=server2]}, transactionOriginNodeIdentifier='server1'} 1452599607985 === 1452599617991
> 11:53:37,991 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) Have 1 Xids to recover on this pass.
> 11:53:37,992 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) No record found for < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name >
> 11:53:37,992 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) XAResourceOrphanFilter com.arjuna.ats.internal.jta.recovery.arjunacore.JTATransactionLogXAResourceOrphanFilter voted ABSTAIN
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) node name of < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name > is server1
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) XAResourceOrphanFilter com.arjuna.ats.internal.jta.recovery.arjunacore.JTANodeNameXAResourceOrphanFilter voted ROLLBACK
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) subordinate node name of < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name > is server2
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) Checking whether Xid < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name > exists in ObjectStore.
> 11:53:37,993 DEBUG [com.arjuna.ats.jta] (Periodic Recovery) Looking for 0:ffffc0a80164:-fa2e9db:5694e833:2c and /StateManager/BasicAction/TwoPhaseCoordinator/AtomicAction/SubordinateAtomicAction/JCA
> 11:53:37,993 INFO [com.arjuna.ats.jta] (Periodic Recovery) ARJUNA016013: Rolling back < formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-fa2e9db:5694e833:39, subordinatenodename=server2, eis_name=unknown eis name >
> {noformat}
> (server-2 log)
> {noformat}
> 11:53:37,997 TRACE [com.arjuna.ats.jta] (EJB default - 5) TransactionImple.getStatus: javax.transaction.Status.STATUS_ACTIVE
> 11:53:37,998 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::phase2Abort() for action-id 0:ffffc0a80164:-41fcd6d0:5694e85a:34
> 11:53:37,998 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::doAbort (XAResourceRecord < resource:XAResourceWrapperImpl@3de8e444[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@6440856e pad=false overrideRmValue=false productName=PostgreSQL productVersion=9.4.1 jndiName=java:jboss/datasources/testJBossDS], txid:< formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-41fcd6d0:5694e85a:3e, subordinatenodename=server2, eis_name=java:jboss/datasources/testJBossDS >, heuristic: TwoPhaseOutcome.FINISH_OK, product: PostgreSQL/9.4.1, jndiName: java:jboss/datasources/testJBossDS com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord@32ff4c6d >)
> 11:53:37,998 TRACE [com.arjuna.ats.jta] (EJB default - 5) XAResourceRecord.topLevelAbort for XAResourceRecord < resource:XAResourceWrapperImpl@3de8e444[xaResource=org.jboss.jca.adapters.jdbc.xa.XAManagedConnection@6440856e pad=false overrideRmValue=false productName=PostgreSQL productVersion=9.4.1 jndiName=java:jboss/datasources/testJBossDS], txid:< formatId=131077, gtrid_length=35, bqual_length=43, tx_uid=0:ffffc0a80164:-fa2e9db:5694e833:2c, node_name=server1, branch_uid=0:ffffc0a80164:-41fcd6d0:5694e85a:3e, subordinatenodename=server2, eis_name=java:jboss/datasources/testJBossDS >, heuristic: TwoPhaseOutcome.FINISH_OK, product: PostgreSQL/9.4.1, jndiName: java:jboss/datasources/testJBossDS com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord@32ff4c6d >, record id=0:ffffc0a80164:-41fcd6d0:5694e85a:3f
> 11:53:37,998 TRACE [org.jboss.as.connector.subsystems.datasources.AbstractDataSourceService$MyXaMCF] (EJB default - 5) Unlock: HeldByCurrentThread: Yes, Locked: Yes, HoldCount: 1, QueueLength: 0
> 11:53:37,998 TRACE [org.jboss.as.connector.subsystems.datasources.AbstractDataSourceService$MyXaMCF] (EJB default - 5) Owner: Thread[EJB default - 5,5,EJB default]
> 11:53:37,999 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::doAbort() result for action-id (0:ffffc0a80164:-41fcd6d0:5694e85a:34) on record id: (0:ffffc0a80164:-41fcd6d0:5694e85a:3f) is (TwoPhaseOutcome.FINISH_OK) node id: (server2)
> 11:53:37,999 TRACE [com.arjuna.ats.arjuna] (EJB default - 5) BasicAction::updateState() for action-id 0:ffffc0a80164:-41fcd6d0:5694e85a:34
> 11:53:37,999 TRACE [com.arjuna.ats.jta] (EJB default - 5) SynchronizationImple.afterCompletion
> {noformat}
> bean (server-2) wake up
> bean (server-1) updates the row in table-1
> at this point the parent transaction gets committed without an error
> {noformat}
> 11:55:31,104 TRACE [com.arjuna.ats.arjuna] (EJB default - 3) BasicAction::removeChildThread () action 0:ffffc0a80164:-fa2e9db:5694e833:2c removing TSThread:1
> 11:55:31,104 TRACE [com.arjuna.ats.arjuna] (EJB default - 3) BasicAction::removeChildThread () action 0:ffffc0a80164:-fa2e9db:5694e833:2c removing TSThread:1 result = true
> 11:55:31,104 TRACE [com.arjuna.ats.arjuna] (EJB default - 3) TransactionReaper::remove ( BasicAction: 0:ffffc0a80164:-fa2e9db:5694e833:2c status: ActionStatus.COMMITTED )
> {noformat}
> client call ends
> When I look at the table in the database I see a row in table-1 but no row in table-2. I would expect to see both tables empty.
> When I switch to JTS and run the same use case it all works as expected.
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
10 years, 3 months
- 1
- 0
[JBoss JIRA] (WFLY-5170) WildFlySecurityManager throws exception by some tests with security manager
by Ondrej Kotek (JIRA)
[ https://issues.jboss.org/browse/WFLY-5170?page=com.atlassian.jira.plugin.... ]
Ondrej Kotek reopened WFLY-5170:
--------------------------------
{{org.jboss.as.test.integration.naming.remote.ejb.RemoteNamingEjbTestCase#testDeploymentBinding}} fails with
{noformat}
java.security.AccessControlException: WFSM000001: Permission check failed (permission "("org.jboss.as.naming.JndiPermission" "java:jboss/exported/some/entry" "bind")" in code source "(vfs:/content/test.jar <no signer certificates>)" of "null")
at org.wildfly.security.manager.WildFlySecurityManager.checkPermission(WildFlySecurityManager.java:273)
at org.wildfly.security.manager.WildFlySecurityManager.checkPermission(WildFlySecurityManager.java:175)
at org.jboss.as.naming.NamingContext.check(NamingContext.java:591)
at org.jboss.as.naming.NamingContext.bind(NamingContext.java:251)
at org.jboss.as.naming.InitialContext$DefaultInitialContext.bind(InitialContext.java:264)
at org.jboss.as.naming.NamingContext.bind(NamingContext.java:289)
at javax.naming.InitialContext.bind(InitialContext.java:425)
at javax.naming.InitialContext.bind(InitialContext.java:425)
at org.jboss.as.test.integration.naming.remote.ejb.Singleton.bind(Singleton.java:44)
{noformat}
Dependency on {{org.jboss.as.naming}} (private) module could help to grant JndiPermission.
> WildFlySecurityManager throws exception by some tests with security manager
> ---------------------------------------------------------------------------
>
> Key: WFLY-5170
> URL: https://issues.jboss.org/browse/WFLY-5170
> Project: WildFly
> Issue Type: Bug
> Components: Test Suite
> Reporter: Marek Kopecký
> Assignee: Ivo Studensky
> Fix For: 10.0.0.CR5
>
>
> *Description of problem:*
> WildFlySecurityManager throws ExceptionInInitializerError exception by some tests with security manager.
> *Affected tests found so far:*
> * org.jboss.as.test.integration.batch.deployment.JobControlTestCase#testStop
> * org.jboss.as.test.integration.ejb.mdb.ejb2x.MDB20MessageSelectorTestCase#retestMessageSelectors
> * org.jboss.as.test.integration.ejb.mdb.ejb2x.MDB20QueueTestCase#testEjb20MDB
> * org.jboss.as.test.integration.ejb.mdb.ejb2x.MDB20TopicTestCase#testEjb20TopicMDBs
> * org.jboss.as.test.integration.ejb.mdb.ejb2x.MDB21TestCase#testSimple21MDB
> * org.jboss.as.test.integration.ejb.pool.lifecycle.PooledEJBLifecycleTestCase#testMDB
> * org.jboss.as.test.xts.annotation.compensationScoped.CompensationScopedTestCase#shouldSeeDifferentValuesInDifferentTransactions
> * org.jboss.as.test.xts.wsat.client.ATTestCase#testWSATVoteReadOnly
> * org.jboss.as.test.xts.wsba.coordinatorcompletion.client.BACoordinatorCompletionTestCase#testWSBACoordinatorSimple
> *Steps to Reproduce for MDB20QueueTestCase:*
> # ./integration-tests.sh -fae -Dmaven.test.failure.ignore=true -Dnode0=$MYTESTIP_1 -Dnode1=$MYTESTIP_2 -DfailIfNoTests=false -Dsecurity.manager -Dts.basic -Dts.noSmoke -Dtest=MDB20QueueTestCase
> *Actual results:*
> {noformat}
> testEjb20MDB(org.jboss.as.test.integration.ejb.mdb.ejb2x.MDB20QueueTestCase) Time elapsed: 0.094 sec <<< ERROR!
> java.lang.ExceptionInInitializerError: null
> at org.wildfly.security.manager.WildFlySecurityManager.checkPermission(WildFlySecurityManager.java:273)
> at org.wildfly.security.manager.WildFlySecurityManager.checkPropertyAccess(WildFlySecurityManager.java:496)
> at java.lang.System.getProperty(System.java:717)
> at java.lang.Integer.getInteger(Integer.java:1101)
> at java.lang.Integer.getInteger(Integer.java:1057)
> at org.jboss.as.test.shared.TimeoutUtil.<clinit>(TimeoutUtil.java:39)
> at org.jboss.as.test.integration.ejb.mdb.ejb2x.MDB20QueueTestCase.testEjb20MDB(MDB20QueueTestCase.java:110)
> {noformat}
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
10 years, 3 months
- 1
- 0
[JBoss JIRA] (WFLY-6010) JSF initialization failure regression
by Scott Van Wart (JIRA)
[ https://issues.jboss.org/browse/WFLY-6010?page=com.atlassian.jira.plugin.... ]
Scott Van Wart updated WFLY-6010:
---------------------------------
Priority: Minor (was: Major)
I guess I'll set this to minor until I can get a reproducible EAR.
> JSF initialization failure regression
> -------------------------------------
>
> Key: WFLY-6010
> URL: https://issues.jboss.org/browse/WFLY-6010
> Project: WildFly
> Issue Type: Bug
> Components: JSF
> Affects Versions: 10.0.0.CR5
> Environment: Windows 10 64-bit
> Java HotSpot(TM) 64-Bit Server VM (build 25.51-b03, mixed mode)
> Reporter: Scott Van Wart
> Assignee: Farah Juma
> Priority: Minor
> Attachments: server.log
>
>
> I'm getting a JSF initialization error starting up Wildfly with a deployed EAR--I didn't experience this with 10.0.0CR4:
> (Moved the stack trace to an attachment for easier reading)
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
10 years, 3 months
- 1
- 0
[JBoss JIRA] (WFLY-6020) The upgrade to undertow-core 1.3.11 causes HTTP keep-alive requests to hang.
by Tomaz Cerar (JIRA)
[ https://issues.jboss.org/browse/WFLY-6020?page=com.atlassian.jira.plugin.... ]
Tomaz Cerar reassigned WFLY-6020:
---------------------------------
Assignee: Stuart Douglas (was: Jason Greene)
> The upgrade to undertow-core 1.3.11 causes HTTP keep-alive requests to hang.
> ----------------------------------------------------------------------------
>
> Key: WFLY-6020
> URL: https://issues.jboss.org/browse/WFLY-6020
> Project: WildFly
> Issue Type: Bug
> Components: Web (Undertow)
> Affects Versions: 10.0.0.CR5
> Reporter: Wouter van der Aa
> Assignee: Stuart Douglas
>
> I just created a Jira ticket on the undertow-core bugtracker, which I do think would be a big problem (at least for us), if it is not solved on the Final version of Wildfly.
> This ticket is about the hanging of Keep-Alive requests with the undertow-core version used in the CR5 release of Wildfly. See https://issues.jboss.org/browse/UNDERTOW-609 for more details.
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
10 years, 3 months
- 1
- 0
[JBoss JIRA] (WFLY-6020) The upgrade to undertow-core 1.3.11 causes HTTP keep-alive requests to hang.
by Tomaz Cerar (JIRA)
[ https://issues.jboss.org/browse/WFLY-6020?page=com.atlassian.jira.plugin.... ]
Tomaz Cerar updated WFLY-6020:
------------------------------
Component/s: Web (Undertow)
> The upgrade to undertow-core 1.3.11 causes HTTP keep-alive requests to hang.
> ----------------------------------------------------------------------------
>
> Key: WFLY-6020
> URL: https://issues.jboss.org/browse/WFLY-6020
> Project: WildFly
> Issue Type: Bug
> Components: Web (Undertow)
> Affects Versions: 10.0.0.CR5
> Reporter: Wouter van der Aa
> Assignee: Jason Greene
>
> I just created a Jira ticket on the undertow-core bugtracker, which I do think would be a big problem (at least for us), if it is not solved on the Final version of Wildfly.
> This ticket is about the hanging of Keep-Alive requests with the undertow-core version used in the CR5 release of Wildfly. See https://issues.jboss.org/browse/UNDERTOW-609 for more details.
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
10 years, 3 months
- 1
- 0
[JBoss JIRA] (WFLY-6020) The upgrade to undertow-core 1.3.11 causes HTTP keep-alive requests to hang.
by Tomaz Cerar (JIRA)
[ https://issues.jboss.org/browse/WFLY-6020?page=com.atlassian.jira.plugin.... ]
Tomaz Cerar updated WFLY-6020:
------------------------------
Affects Version/s: 10.0.0.CR5
> The upgrade to undertow-core 1.3.11 causes HTTP keep-alive requests to hang.
> ----------------------------------------------------------------------------
>
> Key: WFLY-6020
> URL: https://issues.jboss.org/browse/WFLY-6020
> Project: WildFly
> Issue Type: Bug
> Components: Web (Undertow)
> Affects Versions: 10.0.0.CR5
> Reporter: Wouter van der Aa
> Assignee: Jason Greene
>
> I just created a Jira ticket on the undertow-core bugtracker, which I do think would be a big problem (at least for us), if it is not solved on the Final version of Wildfly.
> This ticket is about the hanging of Keep-Alive requests with the undertow-core version used in the CR5 release of Wildfly. See https://issues.jboss.org/browse/UNDERTOW-609 for more details.
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
10 years, 3 months
- 1
- 0
[JBoss JIRA] (WFLY-5810) JNDIPermission is based in a private module
by Ondrej Kotek (JIRA)
[ https://issues.jboss.org/browse/WFLY-5810?page=com.atlassian.jira.plugin.... ]
Ondrej Kotek updated WFLY-5810:
-------------------------------
Priority: Critical (was: Major)
> JNDIPermission is based in a private module
> -------------------------------------------
>
> Key: WFLY-5810
> URL: https://issues.jboss.org/browse/WFLY-5810
> Project: WildFly
> Issue Type: Bug
> Components: Naming
> Affects Versions: 10.0.0.CR4
> Reporter: Ivo Studensky
> Assignee: David Lloyd
> Priority: Critical
>
> At the moment {{JndiPermission}} is based in {{org.jboss.as.naming}} module which is private. Because of this it effectively cannot be used by deployments.
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)
10 years, 3 months
- 1
- 0