Bug 777887 (SOA-415) - bpm_orchestration2 generates "org.jboss.soa.esb.services.jbpm.cmd.CallbackCommand] Token id" mismatch warnings - on single and multi-cpu systems
Summary: bpm_orchestration2 generates "org.jboss.soa.esb.services.jbpm.cmd.CallbackCom...
Keywords:
Status: CLOSED WORKSFORME
Alias: SOA-415
Product: JBoss Enterprise SOA Platform 4
Classification: JBoss
Component: Examples
Version: 4.2 CR3
Hardware: Unspecified
OS: Unspecified
medium
medium
Target Milestone: ---
: 4.2 CP01
Assignee: Kevin Conner
QA Contact:
URL: http://jira.jboss.org/jira/browse/SOA...
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2008-02-11 16:42 UTC by Len DiMaggio
Modified: 2008-09-26 06:04 UTC (History)
0 users

Fixed In Version:
Doc Type: Bug Fix
Doc Text:
Clone Of:
Environment:
/opt/RC3/soa-4.2.0.CR3.zip /opt/RC3/standalone-soa-4.2.0.CR3.zip
Last Closed: 2008-03-24 14:12:23 UTC
Type: Bug


Attachments (Terms of Use)
server.log (90.63 KB, text/x-log)
2008-02-11 16:42 UTC, Len DiMaggio
no flags Details
production_server.log.gz (11.99 KB, application/x-gzip)
2008-03-24 14:11 UTC, Len DiMaggio
no flags Details
standalone_server.log.gz (496.81 KB, application/x-gzip)
2008-03-24 14:11 UTC, Len DiMaggio
no flags Details


Links
System ID Private Priority Status Summary Last Updated
Red Hat Bugzilla 777882 0 high CLOSED bpm_orchestration2 generates "org.hibernate.StaleObjectStateException" errors on multi-cpu systems 2021-02-22 00:41:40 UTC
Red Hat Bugzilla 777889 0 medium CLOSED bpm_orchestration2 generates "[JDBCExceptionReporter] Concurrent update" errors on multi-cpu systems 2021-02-22 00:41:40 UTC
Red Hat Bugzilla 778386 0 medium CLOSED bpm_orchestration2 generates "[JDBCExceptionReporter] Concurrent update" errors on multi-cpu systems 2021-02-22 00:41:40 UTC
Red Hat Issue Tracker SOA-415 0 None None None Never

Internal Links: 777882 777889 778386

Description Len DiMaggio 2008-02-11 16:42:14 UTC
Date of First Response: 2008-02-13 13:20:48
project_key: SOA

Seeing this with the bpm_orchestration2 quickstart in CR3 - any database

2008-02-11 11:00:56,744 WARN  [org.jboss.soa.esb.services.jbpm.cmd.CallbackCommand] Token id 1 from process instance 1 is no longer on expected node, expected 9 but discovered 10

The system in question is:

[ldimaggi@ldimaggi bpm_orchestration2]$ uname -a
Linux ldimaggi.csb 2.6.18-53.1.6.el5 #1 SMP Wed Jan 16 03:56:43 EST 2008 i686 i686 i386 GNU/Linux
[ldimaggi@ldimaggi bpm_orchestration2]$ cat /proc/cpuinfo 
processor       : 0
vendor_id       : GenuineIntel
cpu family      : 6
model           : 13
model name      : Intel(R) Pentium(R) M processor 1.70GHz
stepping        : 6
cpu MHz         : 600.000
cache size      : 2048 KB
fdiv_bug        : no
hlt_bug         : no
f00f_bug        : no
coma_bug        : no
fpu             : yes
fpu_exception   : yes
cpuid level     : 2
wp              : yes
flags           : fpu vme de pse tsc msr mce cx8 mtrr pge mca cmov pat clflush dts acpi mmx fxsr sse sse2 ss tm pbe up est tm2
bogomips        : 1199.41

Comment 1 Len DiMaggio 2008-02-11 16:42:40 UTC
Server (enbedded/production) log

Comment 2 Len DiMaggio 2008-02-11 16:42:40 UTC
Attachment: Added: server.log


Comment 3 Aleksandar Kostadinov 2008-02-13 18:20:48 UTC
I tried this one 100 times with a local mysql instance to avoid network delays and it didn't occur. I tried on 2 CPU dual core AMD system.

I see on DEBUG level:
log/server.log:2008-02-13 11:23:34,701 DEBUG [org.jboss.soa.esb.services.jbpm.cmd.CallbackCommand] Expected nodeId=5, tokenId=414, processNodeVersion=0
log/server.log:2008-02-13 11:23:34,707 DEBUG [org.jboss.soa.esb.services.jbpm.cmd.CallbackCommand] ProcessNodeVersion=0
log/server.log:2008-02-13 11:23:34,861 DEBUG [org.jboss.soa.esb.services.jbpm.cmd.CommandExecutor] org.jboss.soa.esb.services.jbpm.cmd.CallbackCommand@1417a7
log/server.log:2008-02-13 11:23:34,861 DEBUG [org.jbpm.command.impl.CommandServiceImpl] executing org.jboss.soa.esb.services.jbpm.cmd.CallbackCommand@1417a7
log/server.log:2008-02-13 11:23:34,861 DEBUG [org.jboss.soa.esb.services.jbpm.cmd.CallbackCommand] Expected nodeId=9, tokenId=413, processNodeVersion=0
log/server.log:2008-02-13 11:23:34,867 DEBUG [org.jboss.soa.esb.services.jbpm.cmd.CallbackCommand] ProcessNodeVersion=0

But it seems expected. No messages on WARN level.

Comment 4 Aleksandar Kostadinov 2008-02-13 18:23:31 UTC
Link: Added: This issue is related to SOA-417


Comment 5 Aleksandar Kostadinov 2008-02-13 18:23:48 UTC
Link: Added: This issue is related to SOA-410


Comment 6 Aleksandar Kostadinov 2008-02-13 18:24:05 UTC
Link: Added: This issue is related to SOA-409


Comment 7 Aleksandar Kostadinov 2008-02-14 14:55:27 UTC
All tier1 databases tested to not produce any errors in 100 runs. So probably it's hsqldb that doesn't support transactions. Marking as passed in testify.

Comment 8 Kevin Conner 2008-03-18 14:04:48 UTC
Link: Removed: This issue is related to SOA-409 


Comment 9 Len DiMaggio 2008-03-24 14:11:07 UTC
This bug is not reproducible with the GA bits - on either the standlaone/default or embedded/production servers - even on the same physical machine where it was originally seen. 



Comment 10 Len DiMaggio 2008-03-24 14:11:07 UTC
Attachment: Added: production_server.log.gz
Attachment: Added: standalone_server.log.gz


Comment 11 Len DiMaggio 2008-03-24 14:12:23 UTC
This bug is not reproducible with the GA bits - on either the standlaone/default or embedded/production servers - even on the same physical machine where it was originally seen. 



Comment 12 Jarkko Lietolahti 2008-08-12 09:18:14 UTC
We can reproduce this on 4 different machines (using either mysql or hysqldb). 
Happens with 4.3.GA and 4.4.GA, SVN head from 9.8.2008.

12:15:01,919 WARN  [CallbackCommand] Token id 24 from process instance 14 is no longer on expected node, expected 124 but discovered 12

Happens almost (9 of 10) every time on first execution. 

Comment 13 nwallace 2008-09-26 06:04:30 UTC
Link: Added: This issue is related to SOA-869



Note You need to log in before you can comment on or make changes to this bug.