You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@activemq.apache.org by "Alex Chernyakhovsky (JIRA)" <ji...@apache.org> on 2014/12/23 09:12:15 UTC

[jira] [Commented] (AMQ-5249) "cursor got duplicate" error after upgrade

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

Alex Chernyakhovsky commented on AMQ-5249:
------------------------------------------

I am seeing:
2014-12-23 07:19:32,491 | WARN  | org.apache.activemq.broker.region.cursors.QueueStorePrefetch@4eed1516:xstomp.request,batchResetNeeded=false,size=1,cacheEnabled=false,maxBatchSize:1,hasSpace:false,pendingCachedIds.size:0,lastSyncCachedId:null,lastSyncCachedId-seq:null,lastAsyncCachedId:null,lastAsyncCachedId-seq:null,store=org.apache.activemq.store.memory.MemoryMessageStore@2f037fd5 - cursor got duplicate from store ID:ip-10-140-168-52-43583-1419289565347-1:1:4:1:46539 seq: 974372 | org.apache.activemq.broker.region.cursors.AbstractStoreCursor | ActiveMQ NIO Worker 11233
2014-12-23 07:19:32,492 | WARN  | org.apache.activemq.broker.region.cursors.QueueStorePrefetch@4eed1516:xstomp.request,batchResetNeeded=false,size=1,cacheEnabled=false,maxBatchSize:1,hasSpace:false,pendingCachedIds.size:0,lastSyncCachedId:null,lastSyncCachedId-seq:null,lastAsyncCachedId:null,lastAsyncCachedId-seq:null,store=org.apache.activemq.store.memory.MemoryMessageStore@2f037fd5 - cursor got duplicate from store ID:ip-10-45-179-71-55811-1419289516957-1:1:7:1:46574 seq: 974373 | org.apache.activemq.broker.region.cursors.AbstractStoreCursor | ActiveMQ NIO Worker 11233
2014-12-23 07:19:32,492 | WARN  | org.apache.activemq.broker.region.cursors.QueueStorePrefetch@4eed1516:xstomp.request,batchResetNeeded=false,size=1,cacheEnabled=false,maxBatchSize:1,hasSpace:false,pendingCachedIds.size:0,lastSyncCachedId:null,lastSyncCachedId-seq:null,lastAsyncCachedId:null,lastAsyncCachedId-seq:null,store=org.apache.activemq.store.memory.MemoryMessageStore@2f037fd5 - cursor got duplicate from store ID:ip-10-140-168-52-43583-1419289565347-1:1:9:1:46540 seq: 974374 | org.apache.activemq.broker.region.cursors.AbstractStoreCursor | ActiveMQ NIO Worker 11233
2014-12-23 07:19:32,493 | WARN  | duplicate message from store ID:ip-10-140-168-52-43583-1419289565347-1:1:7:1:46411, redirecting for dlq processing | org.apache.activemq.broker.region.Queue | ActiveMQ NIO Worker 11233
2014-12-23 07:19:32,495 | WARN  | duplicate message from store ID:ip-10-140-168-52-43583-1419289565347-1:1:7:1:46414, redirecting for dlq processing | org.apache.activemq.broker.region.Queue | ActiveMQ NIO Worker 11233
2014-12-23 07:19:32,496 | WARN  | duplicate message from store ID:ip-10-140-168-52-43583-1419289565347-1:1:4:1:46405, redirecting for dlq processing | org.apache.activemq.broker.region.Queue | ActiveMQ NIO Worker 11233
2014-12-23 07:19:32,497 | WARN  | duplicate message from store ID:ip-10-140-168-52-43583-1419289565347-1:1:9:1:46406, redirecting for dlq processing | org.apache.activemq.broker.region.Queue | ActiveMQ NIO Worker 11233

My confifuration is different though. I run 2 static brokers. 
I see these messages on both 5.10.0 and apache-activemq-5.11-20141222.222708-183. 5.9.0 works fine under exactly the same test hardware and configuration. It is highly reproducible.



> "cursor got duplicate" error after upgrade
> ------------------------------------------
>
>                 Key: AMQ-5249
>                 URL: https://issues.apache.org/jira/browse/AMQ-5249
>             Project: ActiveMQ
>          Issue Type: Bug
>    Affects Versions: 5.9.1, 5.10.0
>            Reporter: Rural Hunter
>
> I was using 5.9.0 and meet one problem so I tried to upgrade activemq. I tried both 5.9.1 and 5.10.0 and encouterred a same problem. I saw messages filled DLQ very quickly. I checked the clients both producer and consumer but there was no error. I checked activemq log and found the log is full of these warnings:
> 2014-06-27 23:22:09,337 | WARN  | org.apache.activemq.broker.region.cursors.QueueStorePrefetch@19117501:com.cyyun.webmon.spider.update,batchResetNeeded=false,storeHasMessages=true,size=211,cacheEnabled=true,maxBatchSize:200,hasSpace:true - cursor got duplicate: ID:211.com-52399-1400732399425-1:1:235992:1:1, 4 | org.apache.activemq.broker.region.cursors.AbstractStoreCursor | ActiveMQ Broker[localhost] Scheduler
> 2014-06-27 23:22:09,337 | WARN  | org.apache.activemq.broker.region.cursors.QueueStorePrefetch@19117501:com.xxxx.update,batchResetNeeded=false,storeHasMessages=true,size=211,cacheEnabled=true,maxBatchSize:200,hasSpace:true - cursor got duplicate: ID:nbzjjf22805-34129-1403880308671-1:1:28:1:1, 4 | org.apache.activemq.broker.region.cursors.AbstractStoreCursor | ActiveMQ Broker[localhost] Scheduler
> 2014-06-27 23:22:09,338 | WARN  | org.apache.activemq.broker.region.cursors.QueueStorePrefetch@19117501:com.xxxxx.update,batchResetNeeded=false,storeHasMessages=true,size=211,cacheEnabled=true,maxBatchSize:200,hasSpace:true - cursor got duplicate: ID:jxncxnj2-48598-1403856107346-1:1:6007:1:1, 4 | org.apache.activemq.broker.region.cursors.AbstractStoreCursor | ActiveMQ Broker[localhost] Scheduler
> 2014-06-27 23:22:09,338 | WARN  | org.apache.activemq.broker.region.cursors.QueueStorePrefetch@19117501:com.xxxx.update,batchResetNeeded=false,storeHasMessages=true,size=211,cacheEnabled=true,maxBatchSize:200,hasSpace:true - cursor got duplicate: ID:jxnc17-60227-1400730816361-1:1:149072:1:1, 4 | org.apache.activemq.broker.region.cursors.AbstractStoreCursor | ActiveMQ Broker[localhost] Scheduler
> 2014-06-27 23:22:09,339 | WARN  | org.apache.activemq.broker.region.cursors.QueueStorePrefetch@19117501:com.xxxx.update,batchResetNeeded=false,storeHasMessages=true,size=211,cacheEnabled=true,maxBatchSize:200,hasSpace:true - cursor got duplicate: ID:cyyun-46954-1403800808565-1:1:9765:1:1, 4 | org.apache.activemq.broker.region.cursors.AbstractStoreCursor | ActiveMQ Broker[localhost] Scheduler
> 2014-06-27 23:22:09,339 | WARN  | org.apache.activemq.broker.region.cursors.QueueStorePrefetch@19117501:com.xxxx.update,batchResetNeeded=false,storeHasMessages=true,size=211,cacheEnabled=true,maxBatchSize:200,hasSpace:true - cursor got duplicate: ID:ubuntu-55495-1403497638437-1:1:53086:1:1, 4 | org.apache.activemq.broker.region.cursors.AbstractStoreCursor | ActiveMQ Broker[localhost] Scheduler
> 2014-06-27 23:22:09,340 | WARN  | org.apache.activemq.broker.region.cursors.QueueStorePrefetch@19117501:com.xxxx.update,batchResetNeeded=false,storeHasMessages=true,size=211,cacheEnabled=true,maxBatchSize:200,hasSpace:true - cursor got duplicate: ID:cyyun-39030-1403880008363-1:1:70:1:1, 4 | org.apache.activemq.broker.region.cursors.AbstractStoreCursor | ActiveMQ Broker[localhost] Scheduler
> The problem mostly happens right after activemq starts and sometimes happened after activemq worked normally for a while.
> For now I have to roll back to 5.9.0 and the problem doesn't occure.



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)