[ 
https://issues.apache.org/activemq/browse/AMQ-1063?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=59232#action_59232
 ] 

Hondong commented on AMQ-1063:
------------------------------

Hi,

here is the Log with this error in Debug Mode. 
I´ll Attach it to this issue, but I think this is the interesting part for you:

2010-05-06 19:20:49,275 [5fda:6db0:61938] DEBUG AbstractRegion                 
- Removing consumer: aa82a0e0-dc97-47ef-b34a-6d89a9826915:399:45359
2010-05-06 19:20:50,289 [5fda:6db0:61938] DEBUG AbstractRegion                 
- Adding consumer: aa82a0e0-dc97-47ef-b34a-6d89a9826915:399:45360
2010-05-06 19:20:50,382 [eckpoint Worker] DEBUG JournalPersistenceAdapter      
- Checkpoint started.
2010-05-06 19:20:50,398 [5fda:6db0:61938] DEBUG AbstractRegion                 
- Removing consumer: aa82a0e0-dc97-47ef-b34a-6d89a9826915:399:45360
2010-05-06 19:20:50,585 [eckpoint Worker] ERROR JournalPersistenceAdapter      
- Failed to checkpoint a message store: 
edu.emory.mathcs.backport.java.util.concurrent.ExecutionException: 
java.io.IOException: Already started.
edu.emory.mathcs.backport.java.util.concurrent.ExecutionException: 
java.io.IOException: Already started.
        at 
edu.emory.mathcs.backport.java.util.concurrent.FutureTask.getResult(FutureTask.java:299)
        at 
edu.emory.mathcs.backport.java.util.concurrent.FutureTask.get(FutureTask.java:118)
        at 
org.apache.activemq.store.journal.JournalPersistenceAdapter.doCheckpoint(JournalPersistenceAdapter.java:386)
        at 
org.apache.activemq.store.journal.JournalPersistenceAdapter$2.iterate(JournalPersistenceAdapter.java:129)
        at 
org.apache.activemq.thread.DedicatedTaskRunner.runTask(DedicatedTaskRunner.java:101)
        at 
org.apache.activemq.thread.DedicatedTaskRunner.access$000(DedicatedTaskRunner.java:25)
        at 
org.apache.activemq.thread.DedicatedTaskRunner$1.run(DedicatedTaskRunner.java:39)
Caused by: java.io.IOException: Already started.
        at 
org.apache.activemq.store.jdbc.TransactionContext.begin(TransactionContext.java:145)
        at 
org.apache.activemq.store.jdbc.JDBCPersistenceAdapter.beginTransaction(JDBCPersistenceAdapter.java:358)
        at 
org.apache.activemq.store.journal.JournalPersistenceAdapter.beginTransaction(JournalPersistenceAdapter.java:189)
        at 
org.apache.activemq.util.TransactionTemplate.run(TransactionTemplate.java:41)
        at 
org.apache.activemq.store.journal.JournalMessageStore.checkpoint(JournalMessageStore.java:247)
        at 
org.apache.activemq.store.journal.JournalMessageStore.checkpoint(JournalMessageStore.java:221)
        at 
org.apache.activemq.store.journal.JournalPersistenceAdapter$4.call(JournalPersistenceAdapter.java:356)
        at 
edu.emory.mathcs.backport.java.util.concurrent.FutureTask.run(FutureTask.java:176)
        at 
edu.emory.mathcs.backport.java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
        at 
edu.emory.mathcs.backport.java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
        at java.lang.Thread.run(Thread.java:619)
2010-05-06 19:20:50,585 [eckpoint Worker] DEBUG JournalPersistenceAdapter      
- Marking journal at: 190:18104176
2010-05-06 19:20:50,585 [eckpoint Worker] ERROR JournalPersistenceAdapter      
- Failed to mark the Journal: 
org.apache.activeio.journal.InvalidRecordLocationException: The location is 
less than the last mark.
org.apache.activeio.journal.InvalidRecordLocationException: The location is 
less than the last mark.
        at 
org.apache.activeio.journal.active.JournalImpl.setMark(JournalImpl.java:340)
        at 
org.apache.activemq.store.journal.JournalPersistenceAdapter.doCheckpoint(JournalPersistenceAdapter.java:403)
        at 
org.apache.activemq.store.journal.JournalPersistenceAdapter$2.iterate(JournalPersistenceAdapter.java:129)
        at 
org.apache.activemq.thread.DedicatedTaskRunner.runTask(DedicatedTaskRunner.java:101)
        at 
org.apache.activemq.thread.DedicatedTaskRunner.access$000(DedicatedTaskRunner.java:25)
        at 
org.apache.activemq.thread.DedicatedTaskRunner$1.run(DedicatedTaskRunner.java:39)
2010-05-06 19:20:50,585 [eckpoint Worker] DEBUG JDBCPersistenceAdapter         
- Cleaning up old messages.
2010-05-06 19:20:50,585 [eckpoint Worker] DEBUG DefaultJDBCAdapter             
- Executing SQL: DELETE FROM ACTIVEMQ_MSGS WHERE ( EXPIRATION<>0 AND 
EXPIRATION<?) OR ID <= ( SELECT min(ACTIVEMQ_ACKS.LAST_ACKED_ID) FROM 
ACTIVEMQ_ACKS WHERE ACTIVEMQ_ACKS.CONTAINER=ACTIVEMQ_MSGS.CONTAINER)
2010-05-06 19:20:50,585 [eckpoint Worker] DEBUG DefaultJDBCAdapter             
- Deleted 0 old message(s).
2010-05-06 19:20:50,585 [eckpoint Worker] DEBUG JDBCPersistenceAdapter         
- Cleanup done.
2010-05-06 19:20:50,585 [eckpoint Worker] DEBUG JournalPersistenceAdapter      
- Checkpoint done.

> Journaled JDBC checkpoint fails with java.io.IOException: Already started.
> --------------------------------------------------------------------------
>
>                 Key: AMQ-1063
>                 URL: https://issues.apache.org/activemq/browse/AMQ-1063
>             Project: ActiveMQ
>          Issue Type: Bug
>          Components: Broker
>    Affects Versions: 5.0.0
>         Environment: Windows XP Professional, JVM 1.5.0_09, MySQL 5.0.27
>            Reporter: [email protected]
>             Fix For: NEEDS_REVIEWED
>
>
> I am running trunk using JDBC against MySQL 5.0.27.  I am seeing the above 
> mentioned IOException.  Do not have specific instructions on how to reproduce 
> at the current time, but I was using durable subscriptions with the store 
> durable cursor if that helps.  (I'll post if I find out more information.)
>       <persistenceAdapter>
>    
>       <journaledJDBC journalLogFiles="5" dataDirectory="../activemq-data" 
> dataSource="#mysql-ds"/>
>     </persistenceAdapter>
>   <bean id="mysql-ds" class="org.apache.commons.dbcp.BasicDataSource" 
> destroy-method="close">
>     <property name="driverClassName" value="com.mysql.jdbc.Driver"/>
>     <property name="url" 
> value="jdbc:mysql://localhost/activemq?relaxAutoCommit=true"/>
>     <property name="username" value="*** OMITTED ***"/>
>     <property name="password" value="*** OMITTED *** "/>
>     <property name="poolPreparedStatements" value="true"/>
>   </bean>  
> Log trace:
> 2006-11-19 19:19:48,078 [/127.0.0.1:4898] DEBUG JournalPersistenceAdapter     
>  - Waking for checkpoint to complete.
> 2006-11-19 19:19:48,078 [eckpoint Worker] DEBUG JournalPersistenceAdapter     
>  - Checkpoint started.
> 2006-11-19 19:19:48,078 [eckpoint Worker] ERROR JournalPersistenceAdapter     
>  - Failed to checkpoint a message store: 
> java.util.concurrent.ExecutionException: java.io.IOException: Already started.
> java.util.concurrent.ExecutionException: java.io.IOException: Already started.
>       at java.util.concurrent.FutureTask$Sync.innerGet(FutureTask.java:205)
>       at java.util.concurrent.FutureTask.get(FutureTask.java:80)
>       at 
> org.apache.activemq.store.journal.JournalPersistenceAdapter.doCheckpoint(JournalPersistenceAdapter.java:386)
>       at 
> org.apache.activemq.store.journal.JournalPersistenceAdapter$2.iterate(JournalPersistenceAdapter.java:129)
>       at 
> org.apache.activemq.thread.DedicatedTaskRunner.runTask(DedicatedTaskRunner.java:88)
>       at 
> org.apache.activemq.thread.DedicatedTaskRunner.access$0(DedicatedTaskRunner.java:76)
>       at 
> org.apache.activemq.thread.DedicatedTaskRunner$1.run(DedicatedTaskRunner.java:39)
> Caused by: java.io.IOException: Already started.
>       at 
> org.apache.activemq.store.jdbc.TransactionContext.begin(TransactionContext.java:145)
>       at 
> org.apache.activemq.store.jdbc.JDBCPersistenceAdapter.beginTransaction(JDBCPersistenceAdapter.java:358)
>       at 
> org.apache.activemq.store.journal.JournalPersistenceAdapter.beginTransaction(JournalPersistenceAdapter.java:189)
>       at 
> org.apache.activemq.util.TransactionTemplate.run(TransactionTemplate.java:41)
>       at 
> org.apache.activemq.store.journal.JournalMessageStore.checkpoint(JournalMessageStore.java:247)
>       at 
> org.apache.activemq.store.journal.JournalTopicMessageStore.checkpoint(JournalTopicMessageStore.java:162)
>       at 
> org.apache.activemq.store.journal.JournalPersistenceAdapter$5.call(JournalPersistenceAdapter.java:373)
>       at java.util.concurrent.FutureTask$Sync.innerRun(FutureTask.java:269)
>       at java.util.concurrent.FutureTask.run(FutureTask.java:123)
>       at 
> java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:650)
>       at 
> java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:675)
>       at java.lang.Thread.run(Thread.java:595)
> 2006-11-19 19:19:48,109 [eckpoint Worker] DEBUG JournalPersistenceAdapter     
>  - Checkpoint done.

-- 
This message is automatically generated by JIRA.
-
You can reply to this email to add a comment to the issue online.

Reply via email to