Unknown Exception !!! "Column not found" !!
eric138 Jan 27, 2002 11:12 PM[2002-01-28 12:04:26,490,OILServerILService,DEBUG] The OILClientIL Connection is set up
[2002-01-28 12:04:26,550,JMSServer,DEBUG] PING
[2002-01-28 12:04:26,550,OILClientIL,INFO] ConnectionReceiverOILClient is connecting to: 192.168.100.92:1891
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock aquire
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock released
[2002-01-28 12:04:26,710,MessageReference,DEBUG] clear lock aquire
[2002-01-28 12:04:26,710,MessageReference,DEBUG] clear lock relased
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock aquire
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock released
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock aquire
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock released
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock aquire
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock released
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock aquire
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock released
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock aquire
[2002-01-28 12:04:26,710,MessageReference,DEBUG] getMessage lock released
[2002-01-28 12:04:26,710,SpyConnectionConsumer,DEBUG] SpyConnectionConsumer:QUEUE.testQueue->addMessage(mes=org.jboss.mq.SpyObjectMessage@65ab39)
[2002-01-28 12:04:26,710,StdServerSessionPool,DEBUG] getting a server session
[2002-01-28 12:04:26,710,StdServerSessionPool,DEBUG] using server session: org.jboss.jms.asf.StdServerSession@7b21ea
[2002-01-28 12:04:26,710,SpyConnectionConsumer,DEBUG] SpyConnectionConsumer:QUEUE.testQueue Starting the ServerSession.
[2002-01-28 12:04:26,710,StdServerSession,DEBUG] starting invokes on server session
[2002-01-28 12:04:26,710,JMSServer,DEBUG] JMSServer->connectionClosing(dc=SpyDistributedConnection:ID15)
[2002-01-28 12:04:26,710,StdServerSession,DEBUG] running...
[2002-01-28 12:04:26,710,StdServerSession,INFO] running (pool, session, xaSession, useLocalTX): , org.jboss.mq.SpyTopicSession@2c7ac5, org.jboss.mq.SpyTopicSession@2c7ac5, false
[2002-01-28 12:04:26,710,TxCapsule,DEBUG] Reused instance for tx=XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,710,TxManager,DEBUG] began tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,710,TxCapsule,DEBUG] enlistResource(): Entered, tx=XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=] status=STATUS_ACTIVE
[2002-01-28 12:04:26,710,TxCapsule,DEBUG] startResource(XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=1]) entered: org.jboss.mq.SpyXAResource@76d2e3 flags=0
[2002-01-28 12:04:26,710,TxCapsule,DEBUG] startResource(XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=1]) leaving: org.jboss.mq.SpyXAResource@76d2e3 flags=0
[2002-01-28 12:04:26,710,StdServerSession,DEBUG] XAResource 'org.jboss.mq.SpyXAResource@76d2e3' enlisted.
[2002-01-28 12:04:26,710,JMSContainerInvoker,DEBUG] processing message: org.jboss.mq.SpyObjectMessage@65ab39
[2002-01-28 12:04:26,710,TxManager,DEBUG] suspended tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,710,TxManager,DEBUG] resumed tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,710,Default,INFO] In constructor()
[2002-01-28 12:04:26,820,Default,INFO] {startDate=Mon Jan 28 12:04:26 CST 2002, scheduleName=Hello, executeDate=Mon Jan 28 12:05:26 CST 2002, incrementTime=120000, endDate=Mon Jan 28 12:04:26 CST 2002}
[2002-01-28 12:04:26,820,TxManager,DEBUG] suspended tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,820,TxManager,DEBUG] resumed tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,820,DefaultDS,DEBUG] Pool DefaultDS [1/1/10] gave out pooled object: org.jboss.resource.adapter.jdbc.local.JDBCManagedConnection@7e9bf
[2002-01-28 12:04:26,820,TxCapsule,DEBUG] registerSynchronization(): Entered, tx=XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=] status=STATUS_ACTIVE
[2002-01-28 12:04:26,820,DefaultDS,DEBUG] Connection handle 'org.jboss.resource.adapter.jdbc.local.ConnectionInPool@24edc4' issued by connection manager 'org.jboss.resource.connectionmanager.jboss.MinervaSharedLocalCM@452200' from mcf 'org.jboss.resource.adapter.jdbc.local.JDBCManagedConnectionFactory@45466b'
[2002-01-28 12:04:26,820,CMP,DEBUG] Exists command executing: SELECT COUNT(*) FROM ScheduleEJB WHERE scheduleName=?
[2002-01-28 12:04:26,820,CMP,DEBUG] Set parameter: index=1, jdbcType=VARCHAR, value=Hello
[2002-01-28 12:04:26,820,DefaultDS,DEBUG] Pool DefaultDS [0/0/10] destroyed object org.jboss.resource.adapter.jdbc.local.JDBCManagedConnection@7e9bf.
[2002-01-28 12:04:26,820,CMP,DEBUG] java.sql.SQLException: Column not found: SCHEDULENAME in statement [SELECT COUNT(*) FROM ScheduleEJB WHERE scheduleName='Hello']
[2002-01-28 12:04:26,820,CMP,DEBUG] java.sql.SQLException: Column not found: SCHEDULENAME in statement [SELECT COUNT(*) FROM ScheduleEJB WHERE scheduleName='Hello']
[2002-01-28 12:04:26,820,TxManager,DEBUG] suspended tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,820,TxManager,DEBUG] resumed tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,820,TxManager,DEBUG] suspended tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,820,TxManager,DEBUG] resumed tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,880,CMP,DEBUG] Create, id is Hello
[2002-01-28 12:04:26,880,CMP,DEBUG] Exists command executing: SELECT COUNT(*) FROM ScheduleEJB WHERE scheduleName=?
[2002-01-28 12:04:26,880,CMP,DEBUG] Set parameter: index=1, jdbcType=VARCHAR, value=Hello
[2002-01-28 12:04:26,880,CMP,DEBUG] java.sql.SQLException: Column not found: SCHEDULENAME in statement [SELECT COUNT(*) FROM ScheduleEJB WHERE scheduleName='Hello']
[2002-01-28 12:04:26,880,CMP,DEBUG] java.sql.SQLException: Column not found: SCHEDULENAME in statement [SELECT COUNT(*) FROM ScheduleEJB WHERE scheduleName='Hello']
[2002-01-28 12:04:26,880,CMP,DEBUG] Create command executing: INSERT INTO ScheduleEJB (scheduleName, startDate, executeDate, incrementTime, endDate) VALUES (?, ?, ?, ?, ?)
[2002-01-28 12:04:26,880,CMP,DEBUG] Set parameter: index=1, jdbcType=VARCHAR, value=Hello
[2002-01-28 12:04:26,880,CMP,DEBUG] Set parameter: index=2, jdbcType=DATE, value=Mon Jan 28 12:04:26 CST 2002
[2002-01-28 12:04:26,880,CMP,DEBUG] Set parameter: index=3, jdbcType=DATE, value=Mon Jan 28 12:05:26 CST 2002
[2002-01-28 12:04:26,880,CMP,DEBUG] Set parameter: index=4, jdbcType=BIGINT, value=120000
[2002-01-28 12:04:26,880,CMP,DEBUG] Set parameter: index=5, jdbcType=DATE, value=Mon Jan 28 12:04:26 CST 2002
[2002-01-28 12:04:26,880,CMP,DEBUG] java.sql.SQLException: Column not found: SCHEDULENAME in statement [INSERT INTO ScheduleEJB (scheduleName, startDate, executeDate, incrementTime, endDate) VALUES ('Hello', '2002-01-28', '2002-01-28', 120000, '2002-01-28')]
[2002-01-28 12:04:26,880,CMP,DEBUG] java.sql.SQLException: Column not found: SCHEDULENAME in statement [INSERT INTO ScheduleEJB (scheduleName, startDate, executeDate, incrementTime, endDate) VALUES ('Hello', '2002-01-28', '2002-01-28', 120000, '2002-01-28')]
[2002-01-28 12:04:26,880,TxManager,DEBUG] suspended tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,880,TxManager,DEBUG] resumed tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,880,Default,ERROR] javax.ejb.CreateException: Could not create entity:java.sql.SQLException: Column not found: SCHEDULENAME in statement [INSERT INTO ScheduleEJB (scheduleName, startDate, executeDate, incrementTime, endDate) VALUES ('Hello', '2002-01-28', '2002-01-28', 120000, '2002-01-28')]
[2002-01-28 12:04:26,880,Default,ERROR] at org.jboss.ejb.plugins.cmp.jdbc.JDBCCreateEntityCommand.execute(JDBCCreateEntityCommand.java:94)
[2002-01-28 12:04:26,880,Default,ERROR] at org.jboss.ejb.plugins.cmp.CMPStoreManager.createEntity(CMPStoreManager.java:169)
[2002-01-28 12:04:26,880,Default,ERROR] at org.jboss.ejb.plugins.CMPPersistenceManager.createEntity(CMPPersistenceManager.java:253)
[2002-01-28 12:04:26,880,Default,ERROR] at org.jboss.ejb.EntityContainer.createLocalHome(EntityContainer.java:533)
[2002-01-28 12:04:26,880,Default,ERROR] at java.lang.reflect.Method.invoke(Native Method)
[2002-01-28 12:04:26,880,Default,ERROR] at org.jboss.ejb.EntityContainer$ContainerInterceptor.invokeHome(EntityContainer.java:926)
[2002-01-28 12:04:26,880,Default,ERROR] at org.jboss.ejb.plugins.AbstractInterceptor.invokeHome(AbstractInterceptor.java:74)
[2002-01-28 12:04:26,880,Default,ERROR] at org.jboss.ejb.plugins.AbstractInterceptor.invokeHome(AbstractInterceptor.java:74)
[2002-01-28 12:04:26,880,Default,ERROR] at org.jboss.ejb.plugins.EntitySynchronizationInterceptor.invokeHome(EntitySynchronizationInterceptor.java:234)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.EntityInstanceInterceptor.invokeHome(EntityInstanceInterceptor.java:151)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.EntityLockInterceptor.invokeHome(EntityLockInterceptor.java:104)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.AbstractTxInterceptor.invokeNext(AbstractTxInterceptor.java:100)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.TxInterceptorCMT.runWithTransactions(TxInterceptorCMT.java:156)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.TxInterceptorCMT.invokeHome(TxInterceptorCMT.java:56)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.SecurityInterceptor.invokeHome(SecurityInterceptor.java:106)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.LogInterceptor.invokeHome(LogInterceptor.java:109)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.EntityContainer.invokeHome(EntityContainer.java:441)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.local.BaseLocalContainerInvoker.invokeHome(BaseLocalContainerInvoker.java:255)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.local.BaseLocalContainerInvoker$HomeProxy.invoke(BaseLocalContainerInvoker.java:406)
[2002-01-28 12:04:26,930,Default,ERROR] at $Proxy23.create(Unknown Source)
[2002-01-28 12:04:26,930,Default,ERROR] at SchedulerMDB.onMessage(SchedulerMDB.java:70)
[2002-01-28 12:04:26,930,Default,ERROR] at java.lang.reflect.Method.invoke(Native Method)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.MessageDrivenContainer$ContainerInterceptor.invoke(MessageDrivenContainer.java:407)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.MessageDrivenInstanceInterceptor.invoke(MessageDrivenInstanceInterceptor.java:79)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.AbstractTxInterceptor.invokeNext(AbstractTxInterceptor.java:98)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.TxInterceptorCMT.runWithTransactions(TxInterceptorCMT.java:156)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.TxInterceptorCMT.invoke(TxInterceptorCMT.java:65)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.SecurityInterceptor.invoke(SecurityInterceptor.java:131)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.LogInterceptor.invoke(LogInterceptor.java:166)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.MessageDrivenContainer.invoke(MessageDrivenContainer.java:282)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.jms.JMSContainerInvoker.invoke(JMSContainerInvoker.java:564)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.ejb.plugins.jms.JMSContainerInvoker$MessageListenerImpl.onMessage(JMSContainerInvoker.java:909)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.mq.SpyMessageConsumer.sessionConsumerProcessMessage(SpyMessageConsumer.java:433)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.mq.SpyMessageConsumer.addMessage(SpyMessageConsumer.java:303)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.mq.SpySession.run(SpySession.java:216)
[2002-01-28 12:04:26,930,Default,ERROR] at org.jboss.jms.asf.StdServerSession.run(StdServerSession.java:209)
[2002-01-28 12:04:26,930,Default,ERROR] at EDU.oswego.cs.dl.util.concurrent.PooledExecutor$Worker.run(PooledExecutor.java:642)
[2002-01-28 12:04:26,930,Default,ERROR] at java.lang.Thread.run(Unknown Source)
[2002-01-28 12:04:26,930,TxManager,DEBUG] suspended tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,930,TxManager,DEBUG] resumed tx: TransactionImpl:XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,930,TxCapsule,DEBUG] Committing, tx=XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=], status=STATUS_ACTIVE
[2002-01-28 12:04:26,930,TxCapsule,DEBUG] Before completion done, tx=XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=], status=STATUS_ACTIVE
[2002-01-28 12:04:26,930,TxCapsule,DEBUG] endresources(0): state=1
[2002-01-28 12:04:26,930,TxCapsule,DEBUG] endResource(XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=1]) entered: org.jboss.mq.SpyXAResource@76d2e3 flag=67108864
[2002-01-28 12:04:26,930,TxCapsule,DEBUG] endResource(XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=1]) leaving: org.jboss.mq.SpyXAResource@76d2e3 flag=67108864
[2002-01-28 12:04:26,930,TxCapsule,DEBUG] One phase commit: One resource.
[2002-01-28 12:04:26,930,TxCapsule,DEBUG] Committing resources, resourceStates[0]=3
[2002-01-28 12:04:26,930,MessageReference,DEBUG] getMessage lock aquire
[2002-01-28 12:04:26,930,MessageReference,DEBUG] getMessage lock released
[2002-01-28 12:04:26,930,MessageReference,DEBUG] getMessage lock aquire
[2002-01-28 12:04:26,930,MessageReference,DEBUG] getMessage lock released
[2002-01-28 12:04:26,930,MessageReference,DEBUG] clear lock aquire
[2002-01-28 12:04:26,930,MessageReference,DEBUG] clear lock relased
[2002-01-28 12:04:26,930,TxCapsule,DEBUG] Committed OK, tx=XidImpl [FormatId=257, GlobalId=mis004//25, BranchQual=]
[2002-01-28 12:04:26,930,StdServerSessionPool,DEBUG] recycled server session: org.jboss.jms.asf.StdServerSession@7b21ea
[2002-01-28 12:04:26,930,StdServerSession,DEBUG] done
And my ejb-jar.xml as following :
<?xml version="1.0"?>
<!DOCTYPE ejb-jar PUBLIC
"-//Sun Microsystems, Inc.//DTD Enterprise JavaBeans 2.0//EN"
"http://java.sun.com/dtd/ejb-jar_2_0.dtd">
<ejb-jar>
<display-name>Real-time Scheduler</display-name>
<enterprise-beans>
Schedule EJB -- CMP
<ejb-name>ScheduleEJB</ejb-name>
<local-home>ScheduleLocalHome</local-home>
ScheduleLocal
<ejb-class>ScheduleEJB</ejb-class>
<persistence-type>Container</persistence-type>
<prim-key-class>java.lang.String</prim-key-class>
False
<abstract-schema-name>MySchedule</abstract-schema-name>
<cmp-version>2.x</cmp-version>
<cmp-field><field-name>scheduleName</field-name></cmp-field>
<cmp-field><field-name>executeDate</field-name></cmp-field>
<cmp-field><field-name>startDate</field-name></cmp-field>
<cmp-field><field-name>endDate</field-name></cmp-field>
<cmp-field><field-name>incrementTime</field-name></cmp-field>
<primkey-field>scheduleName</primkey-field>
</enterprise-beans>
<assembly-descriptor>
<container-transaction>
<ejb-name>ScheduleEJB</ejb-name>
<method-intf>Local</method-intf>
<method-name>*</method-name>
<trans-attribute>Required</trans-attribute>
</container-transaction>
</assembly-descriptor>
</ejb-jar>