[
https://issues.jboss.org/browse/TEIID-4303?page=com.atlassian.jira.plugin...
]
Bram Gadeyne commented on TEIID-4303:
-------------------------------------
There are several:
1)
2016-06-28 08:51:58,811 DEBUG [org.teiid.SECURITY] (NIO1) Keep-alive ping received for
session: 3bZw8VxEr4t7
2016-06-28 08:52:31,721 WARN [com.arjuna.ats.arjuna] (Transaction Reaper) ARJUNA012117:
TransactionReaper::check timeout for TX 0:ffff7f000101:2f4a8c3a:576d4165:72fc in state
RUN
2016-06-28 08:52:31,722 WARN [com.arjuna.ats.arjuna] (Transaction Reaper Worker 2)
ARJUNA012095: Abort of action id 0:ffff7f000101:2f4a8c3a:576d4165:72fc invoked while
multiple threads active within it.
2016-06-28 08:52:31,722 WARN [com.arjuna.ats.arjuna] (Transaction Reaper Worker 2)
ARJUNA012108: CheckedAction::check - atomic action 0:ffff7f000101:2f4a8c3a:576d4165:72fc
aborting with 1 threads active!
2016-06-28 08:52:32,221 WARN [com.arjuna.ats.arjuna] (Transaction Reaper) ARJUNA012117:
TransactionReaper::check timeout for TX 0:ffff7f000101:2f4a8c3a:576d4165:72fc in state
CANCEL
2016-06-28 08:52:32,222 WARN [com.arjuna.ats.arjuna] (Transaction Reaper) ARJUNA012378:
ReaperElement appears to be wedged: sun.misc.Unsafe.park(Native Method)
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
java.util.concurrent.locks.AbstractQueuedSynchronizer.parkAndCheckInterrupt(AbstractQueuedSynchronizer.java:836)
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquireQueued(AbstractQueuedSynchronizer.java:870)
java.util.concurrent.locks.AbstractQueuedSynchronizer.acquire(AbstractQueuedSynchronizer.java:1199)
java.util.concurrent.locks.ReentrantLock$FairSync.lock(ReentrantLock.java:224)
java.util.concurrent.locks.ReentrantLock.lock(ReentrantLock.java:285)
org.jboss.jca.adapters.jdbc.BaseWrapperManagedConnection.lock(BaseWrapperManagedConnection.java:378)
org.jboss.jca.adapters.jdbc.xa.XAManagedConnection.end(XAManagedConnection.java:290)
org.jboss.jca.core.tx.jbossts.XAResourceWrapperImpl.end(XAResourceWrapperImpl.java:118)
com.arjuna.ats.internal.jta.resources.arjunacore.XAResourceRecord.topLevelAbort(XAResourceRecord.java:318)
com.arjuna.ats.arjuna.coordinator.BasicAction.doAbort(BasicAction.java:2993)
com.arjuna.ats.arjuna.coordinator.BasicAction.doAbort(BasicAction.java:2972)
com.arjuna.ats.arjuna.coordinator.BasicAction.Abort(BasicAction.java:1675)
com.arjuna.ats.arjuna.coordinator.TwoPhaseCoordinator.cancel(TwoPhaseCoordinator.java:127)
com.arjuna.ats.arjuna.AtomicAction.cancel(AtomicAction.java:215)
com.arjuna.ats.arjuna.coordinator.TransactionReaper.doCancellations(TransactionReaper.java:381)
com.arjuna.ats.internal.arjuna.coordinator.ReaperWorkerThread.run(ReaperWorkerThread.java:78)
2016-06-28 08:52:32,722 WARN [com.arjuna.ats.arjuna] (Transaction Reaper) ARJUNA012117:
TransactionReaper::check timeout for TX 0:ffff7f000101:2f4a8c3a:576d4165:72fc in state
CANCEL_INTERRUPTED
2016-06-28 08:52:32,722 WARN [com.arjuna.ats.arjuna] (Transaction Reaper) ARJUNA012120:
TransactionReaper::check worker Thread[Transaction Reaper Worker 2,5,main] not responding
to interrupt when cancelling TX 0:ffff7f000101:2f4a8c3a:576d4165:72fc -- worker marked as
zombie and TX scheduled for mark-as-rollback
2016-06-28 08:52:32,723 WARN [com.arjuna.ats.arjuna] (Transaction Reaper) ARJUNA012110:
TransactionReaper::check successfuly marked TX 0:ffff7f000101:2f4a8c3a:576d4165:72fc as
rollback only
2)
doCancellations worker while retrieving data
2016-06-28 08:54:35,563 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Processing MORE request
2016-06-28 08:54:35,563 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Getting results from connector
2016-06-28 08:54:35,564 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Obtained results from connector, current row count:
3072
2016-06-28 08:54:35,564 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Processing MORE request
2016-06-28 08:54:35,565 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Getting results from connector
2016-06-28 08:54:35,565 WARN [com.arjuna.ats.arjuna] (Transaction Reaper Worker 2)
ARJUNA012113: TransactionReaper::doCancellations worker Thread[Transaction Reaper Worker
2,5,main] missed interrupt when cancelling TX 0:ffff7f000101:2f4a8c3a:576d4165:72fc --
exiting as zombie (zombie count decremented to 0)
2016-06-28 08:54:35,570 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Obtained results from connector, current row count:
3328
2016-06-28 08:54:35,570 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Processing MORE request
2016-06-28 08:54:35,570 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Getting results from connector
2016-06-28 08:54:35,571 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Obtained results from connector, current row count:
3584
2016-06-28 08:54:35,571 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Processing MORE request
2016-06-28 08:54:35,571 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Getting results from connector
2016-06-28 08:54:35,572 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Obtained results from connector, current row count:
3840
Insert into temporary table fails
---------------------------------
Key: TEIID-4303
URL:
https://issues.jboss.org/browse/TEIID-4303
Project: Teiid
Issue Type: Bug
Affects Versions: 9.0
Reporter: Bram Gadeyne
Assignee: Steven Hawkins
Attachments: debugplan.txt
When executing a insert query in a temporary table the execution fails with the following
error:
2016-06-28 08:54:35,700 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Closed execution
2016-06-28 08:54:35,700 DEBUG [org.teiid.CONNECTOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 3bZw8VxEr4t7.26.4.30 Closed connection
2016-06-28 08:54:35,700 DEBUG [org.teiid.COMMAND_LOG] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 END SRC COMMAND: endTime=2016-06-28 08:54:35.7
requestID=3bZw8VxEr4t7.26 sourceCommandID=4 executionID=30
txID=TransactionImple < ac, BasicAction: 0:ffff7f000101:2f4a8c3a:576d4165:72fc status:
ActionStatus.ABORTED > modelName=iziswh translatorName=sybase
sessionID=3bZw8VxEr4t7 principal=veerle@teiid-security finalRowCount=21504
cpuTime(ns)=120503397
2016-06-28 08:54:35,701 INFO [org.teiid.COMMAND_LOG] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 ERROR USER COMMAND: endTime=2016-06-28 08:54:35.701
requestID=3bZw8VxEr4t7.26 txID=TransactionImple < ac, BasicAction:
0:ffff7f000101:2f4a8c3a:576d4165:72fc status: ActionStatus.ABORTED >
sessionID=3bZw8VxEr4t7 principal=veerle@teiid-security vdbName=vdb3 vdbVersion=14
finalRowCount=null
2016-06-28 08:54:35,701 WARN [org.teiid.PROCESSOR] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 TEIID30020 Processing exception for request 3bZw8VxEr4t7.26 'TEIID30223
javax.transaction.RollbackException: ARJUNA016083: Can't register synchronization
because the transaction is in aborted state'. Originally TeiidProcessingException
TransactionImple.java:396. Enable more detailed logging to see the entire stacktrace.
2016-06-28 08:54:35,701 WARN [com.arjuna.ats.arjuna] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 ARJUNA012077: Abort called on already aborted atomic action
0:ffff7f000101:2f4a8c3a:576d4165:72fc
2016-06-28 08:54:35,702 INFO [org.teiid.COMMAND_LOG] (Worker12_QueryProcessorQueue243)
3bZw8VxEr4t7 END USER COMMAND: endTime=2016-06-28 08:54:35.702
requestID=3bZw8VxEr4t7.26 txID=null sessionID=3bZw8VxEr4t7
principal=veerle@teiid-security vdbName=vdb3 vdbVersion=14 finalRowCount=0
--
This message was sent by Atlassian JIRA
(v6.4.11#64026)