1 Reply Latest reply on Oct 6, 2005 8:13 PM by breski

    java.lang.ArrayIndexOutOfBoundsException

    breski

      I got the exception when deploying the entity example of jboss-EJB-3.0_RC2 tutorial.

      ---Background------------------------------------------------------------------------------------------------------------------------------------------------------------
      jboss-4.0.3RC1+jboss-EJB-3.0_RC2+Oracle10g

      I configuared my oracle10g datasource with typemapping of oracle9i.
      And I added three files--;jaws.xml,jbosscmp-jdbc.xml and persistence.xml which descripted informations about the oracle datasource, to the EJB3 archive above.

      By the way,this ejb3 archive without that three xml files could be successfully deployed to the jboss server with hypersonic datasource configured defaultly.But when I deployed that full ejb3 archive,I met the exception although the related data tables were successfully created in my oracle database during deployment.


      ---The Deployment log--------------------------------------------------------------------------------------------------------------------------------------------------
      2005-10-05 16:56:14,315 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment of package: file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:14,315 DEBUG [org.jboss.deployment.MainDeployer] Starting deployment (init step) of package at: file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:14,315 DEBUG [org.jboss.deployment.MainDeployer] Copying file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3 -> C:\Program Files\Java\jboss-4.0.3RC1\server\all\tmp\deploy\tmp57340server.entity.ejb3
      2005-10-05 16:56:14,315 DEBUG [org.jboss.deployment.MainDeployer] using deployer org.jboss.ejb3.EJB3Deployer@166bfd8
      2005-10-05 16:56:14,315 DEBUG [org.jboss.ejb3.EJB3Deployer] init, server.entity.ejb3
      2005-10-05 16:56:14,315 DEBUG [org.jboss.ejb3.EJB3Deployer] looking for nested deployments in : file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:14,315 DEBUG [org.jboss.deployment.DeploymentInfo] createLoaderRepository from config: LoaderRepositoryConfig(repositoryName: JMImplementation:service=LoaderRepository,name=Default, repositoryClassName: null, configParserClassName: null, repositoryConfig: null)
      2005-10-05 16:56:14,315 DEBUG [org.jboss.mx.loading.UnifiedClassLoader] New jmx UCL with url file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/tmp/deploy/tmp57340server.entity.ejb3
      2005-10-05 16:56:14,315 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository, repository=org.jboss.mx.loading.UnifiedLoaderRepository3@a17083, cl=org.jboss.mx.loading.UnifiedClassLoader3@19c123d{ url=file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/tmp/deploy/tmp57340server.entity.ejb3 ,addedOrder=0}
      2005-10-05 16:56:14,315 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] setRepository, repository=org.jboss.mx.loading.UnifiedLoaderRepository3@a17083, cl=org.jboss.mx.loading.UnifiedClassLoader3@19c123d{ url=file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/tmp/deploy/tmp57340server.entity.ejb3 ,addedOrder=0}
      2005-10-05 16:56:14,326 DEBUG [org.jboss.mx.loading.UnifiedLoaderRepository3] Adding org.jboss.mx.loading.UnifiedClassLoader3@19c123d{ url=file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/tmp/deploy/tmp57340server.entity.ejb3 ,addedOrder=0}
      2005-10-05 16:56:14,336 DEBUG [org.jboss.deployment.MainDeployer] found 0 subpackages of file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:14,336 DEBUG [org.jboss.deployment.MainDeployer] Watching new file: file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:14,336 DEBUG [org.jboss.deployment.MainDeployer] create step for deployment file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:14,336 DEBUG [org.jboss.ejb3.EJB3Deployer] create, server.entity.ejb3
      2005-10-05 16:56:14,346 DEBUG [org.jboss.ejb3.EJB3Deployer] Deploying: file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:14,346 DEBUG [org.jboss.system.ServiceController] Creating service jboss.j2ee:service=EJB3,module=server.entity.ejb3
      2005-10-05 16:56:14,346 DEBUG [org.jboss.ejb3.Ejb3Module] Creating jboss.j2ee:service=EJB3,module=server.entity.ejb3
      2005-10-05 16:56:14,346 INFO [org.jboss.ejb3.security.JaccHelper] Initialising JACC Context for deployment: server.entity.ejb3
      2005-10-05 16:56:14,376 INFO [org.jboss.ejb3.Ejb3AnnotationHandler] found EJB3: ejbName=org.jboss.tutorial.entity.bean.ShoppingCartBean, class=org.jboss.tutorial.entity.bean.ShoppingCartBean, type=STATEFUL
      2005-10-05 16:56:14,386 DEBUG [org.jboss.ejb3.Ejb3Deployment] Bound ejb3 container jboss.j2ee:service=EJB3,name=org.jboss.tutorial.entity.bean.ShoppingCartBean
      2005-10-05 16:56:14,396 DEBUG [org.jboss.system.ServiceController] Creating service jboss.j2ee:service=EJB3,name=org.jboss.tutorial.entity.bean.ShoppingCartBean
      2005-10-05 16:56:14,396 DEBUG [org.jboss.system.ServiceController] adding depends in ServiceController.register: []
      2005-10-05 16:56:14,396 DEBUG [org.jboss.ejb3.stateful.StatefulManager] Creating jboss.j2ee:service=EJB3,name=org.jboss.tutorial.entity.bean.ShoppingCartBean
      2005-10-05 16:56:14,436 DEBUG [org.jboss.mx.loading.RepositoryClassLoader] Added url: file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/tmp/aopdynclasses/ucl57341/?dynamic=true, to ucl: org.jboss.mx.loading.UnifiedClassLoader3@19c123d{ url=file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/tmp/deploy/tmp57340server.entity.ejb3 ,addedOrder=58}
      2005-10-05 16:56:14,496 INFO [org.jboss.ejb3.security.JaccHelper] org.jboss.tutorial.entity.bean.ShoppingCartBean has no @SecurityDomain - skipping JACC configuration
      2005-10-05 16:56:14,496 DEBUG [org.jboss.ejb3.stateful.StatefulManager] Created jboss.j2ee:service=EJB3,name=org.jboss.tutorial.entity.bean.ShoppingCartBean
      2005-10-05 16:56:14,496 DEBUG [org.jboss.system.ServiceController] Creating dependent components for: jboss.j2ee:service=EJB3,name=org.jboss.tutorial.entity.bean.ShoppingCartBean dependents are: []
      2005-10-05 16:56:14,516 INFO [org.jboss.ejb3.Ejb3Deployment] Found persistence.xml file in EJB3 jar
      2005-10-05 16:56:14,536 DEBUG [org.hibernate.ejb.Ejb3Configuration] Detect class: true; detect hbm: true
      2005-10-05 16:56:14,536 INFO [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.jboss.tutorial.entity.bean.LineItem
      2005-10-05 16:56:14,536 INFO [org.hibernate.ejb.Ejb3Configuration] found EJB3 Entity bean: org.jboss.tutorial.entity.bean.Order
      2005-10-05 16:56:14,546 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Execute first pass mapping processing
      2005-10-05 16:56:14,546 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process hbm files
      2005-10-05 16:56:14,546 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process annotated classes
      2005-10-05 16:56:14,546 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column TYPE unique false
      2005-10-05 16:56:14,546 DEBUG [org.hibernate.cfg.annotations.EntityBinder] Import with entity name=LineItem
      2005-10-05 16:56:14,546 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing org.jboss.tutorial.entity.bean.LineItem per property access
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of org.jboss.tutorial.entity.bean.LineItem.id
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column id unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] id is an id
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for id
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property id
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading id with null
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Bind @EmbeddedId on id
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of org.jboss.tutorial.entity.bean.LineItem.order
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column order_id unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column order unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property order
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading order with none
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of org.jboss.tutorial.entity.bean.LineItem.product
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column product unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property product with lazy=false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for product
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property product
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading product with null
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of org.jboss.tutorial.entity.bean.LineItem.quantity
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column quantity unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property quantity with lazy=false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for quantity
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property quantity
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading quantity with null
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of org.jboss.tutorial.entity.bean.LineItem.subtotal
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column subtotal unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property subtotal with lazy=false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for subtotal
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property subtotal
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading subtotal with null
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column TYPE unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.EntityBinder] Import with entity name=Order
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing org.jboss.tutorial.entity.bean.Order per property access
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of org.jboss.tutorial.entity.bean.Order.id
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column id unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] id is an id
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for id
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property id
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading id with null
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Bind @EmbeddedId on id
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of org.jboss.tutorial.entity.bean.Order.total
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column total unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] binding property total with lazy=false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.SimpleValueBinder] building SimpleValue for total
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property total
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading total with null
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationBinder] Processing annotations of org.jboss.tutorial.entity.bean.Order.lineItems
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column null unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column lineItems unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column null unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column null unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.Ejb3Column] Binding column null unique false
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.CollectionBinder] Collection role: org.jboss.tutorial.entity.bean.Order.lineItems
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Building property lineItems
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.annotations.PropertyBinder] Cascading lineItems with all
      2005-10-05 16:56:14,556 DEBUG [org.hibernate.cfg.AnnotationConfiguration] processing manytoone fk mappings
      2005-10-05 16:56:14,556 INFO [org.hibernate.cfg.Configuration] processing extends queue
      2005-10-05 16:56:14,556 INFO [org.hibernate.cfg.Configuration] processing collection mappings
      2005-10-05 16:56:14,566 DEBUG [org.hibernate.cfg.CollectionSecondPass] Second pass for collection: org.jboss.tutorial.entity.bean.Order.lineItems
      2005-10-05 16:56:14,566 DEBUG [org.hibernate.cfg.annotations.CollectionBinder] Binding a OneToMany: org.jboss.tutorial.entity.bean.Order.lineItems through a foreign key
      2005-10-05 16:56:14,566 INFO [org.hibernate.cfg.annotations.CollectionBinder] Mapping collection: org.jboss.tutorial.entity.bean.Order.lineItems -> LineItem
      2005-10-05 16:56:14,566 DEBUG [org.hibernate.cfg.annotations.TableBinder] Retrieving property org.jboss.tutorial.entity.bean.LineItem.order
      2005-10-05 16:56:14,566 DEBUG [org.hibernate.cfg.CollectionSecondPass] Mapped collection key: order_id, one-to-many: org.jboss.tutorial.entity.bean.LineItem
      2005-10-05 16:56:14,566 INFO [org.hibernate.cfg.Configuration] processing association property references
      2005-10-05 16:56:14,566 INFO [org.hibernate.cfg.Configuration] processing foreign key constraints
      2005-10-05 16:56:14,566 DEBUG [org.hibernate.cfg.Configuration] resolving reference to class: org.jboss.tutorial.entity.bean.Order
      2005-10-05 16:56:14,566 DEBUG [org.hibernate.cfg.Configuration] Preparing to build session factory with filters : {}
      2005-10-05 16:56:14,566 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Execute first pass mapping processing
      2005-10-05 16:56:14,566 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process hbm files
      2005-10-05 16:56:14,576 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process annotated classes
      2005-10-05 16:56:14,576 DEBUG [org.hibernate.cfg.AnnotationConfiguration] processing manytoone fk mappings
      2005-10-05 16:56:14,576 INFO [org.hibernate.cfg.Configuration] processing extends queue
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.Configuration] processing collection mappings
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.Configuration] processing association property references
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.Configuration] processing foreign key constraints
      2005-10-05 16:56:14,586 DEBUG [org.hibernate.cfg.Configuration] resolving reference to class: org.jboss.tutorial.entity.bean.Order
      2005-10-05 16:56:14,586 INFO [org.hibernate.connection.ConnectionProviderFactory] Initializing connection provider: org.hibernate.ejb.InjectedDataSourceConnectionProvider
      2005-10-05 16:56:14,586 INFO [org.hibernate.ejb.InjectedDataSourceConnectionProvider] Using provided datasource
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] RDBMS: Oracle, version: Oracle Database 10g Enterprise Edition Release 10.2.0.1.0 - Production
      With the Partitioning, OLAP and Data Mining options
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] JDBC driver: Oracle JDBC driver, version: 10.2.0.1.0
      2005-10-05 16:56:14,586 INFO [org.hibernate.dialect.Dialect] Using dialect: org.hibernate.dialect.Oracle9Dialect
      2005-10-05 16:56:14,586 INFO [org.hibernate.transaction.TransactionFactoryFactory] Using default transaction strategy (direct JDBC transactions)
      2005-10-05 16:56:14,586 INFO [org.hibernate.transaction.TransactionManagerLookupFactory] instantiating TransactionManagerLookup: org.hibernate.transaction.JBossTransactionManagerLookup
      2005-10-05 16:56:14,586 INFO [org.hibernate.transaction.TransactionManagerLookupFactory] instantiated TransactionManagerLookup
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Automatic flush during beforeCompletion(): disabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Automatic session close at end of transaction: disabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] JDBC batch size: 15
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] JDBC batch updates for versioned data: disabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Scrollable result sets: enabled
      2005-10-05 16:56:14,586 DEBUG [org.hibernate.cfg.SettingsFactory] Wrap result sets: disabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] JDBC3 getGeneratedKeys(): enabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Connection release mode: after_statement
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Default batch fetch size: 1
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Generate SQL with comments: disabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Order SQL updates by primary key: disabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Query translator: org.hibernate.hql.ast.ASTQueryTranslatorFactory
      2005-10-05 16:56:14,586 INFO [org.hibernate.hql.ast.ASTQueryTranslatorFactory] Using ASTQueryTranslatorFactory
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Query language substitutions: {}
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Second-level cache: enabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Query cache: disabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Cache provider: org.hibernate.cache.HashtableCacheProvider
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Optimize cache for minimal puts: disabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Structured second-level cache entries: disabled
      2005-10-05 16:56:14,586 DEBUG [org.hibernate.exception.SQLExceptionConverterFactory] Using dialect defined converter
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Statistics: disabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Deleted entity synthetic identifier rollback: enabled
      2005-10-05 16:56:14,586 INFO [org.hibernate.cfg.SettingsFactory] Default entity-mode: POJO
      2005-10-05 16:56:14,606 INFO [org.hibernate.impl.SessionFactoryImpl] building session factory
      2005-10-05 16:56:14,606 DEBUG [org.hibernate.impl.SessionFactoryImpl] Session factory constructed with filter configurations : {}
      2005-10-05 16:56:14,606 DEBUG [org.hibernate.impl.SessionFactoryImpl] instantiating session factory with properties: {java.vendor=Sun Microsystems Inc., catalina.base=C:\Program Files\Java\jboss-4.0.3RC1\server\all, sun.management.compiler=HotSpot Client Compiler, catalina.useNaming=false, hibernate.transaction.flush_before_completion=false, os.name=Windows XP, sun.boot.class.path=C:\Program Files\Java\jboss-4.0.3RC1\bin\\..\lib\endorsed\resolver.jar;C:\Program Files\Java\jboss-4.0.3RC1\bin\\..\lib\endorsed\xalan.jar;C:\Program Files\Java\jboss-4.0.3RC1\bin\\..\lib\endorsed\xercesImpl.jar;C:\Program Files\Java\jboss-4.0.3RC1\bin\\..\lib\endorsed\xml-apis.jar;C:\Program Files\Java\jdk1.5.0_04\jre\lib\rt.jar;C:\Program Files\Java\jdk1.5.0_04\jre\lib\i18n.jar;C:\Program Files\Java\jdk1.5.0_04\jre\lib\sunrsasign.jar;C:\Program Files\Java\jdk1.5.0_04\jre\lib\jsse.jar;C:\Program Files\Java\jdk1.5.0_04\jre\lib\jce.jar;C:\Program Files\Java\jdk1.5.0_04\jre\lib\charsets.jar;C:\Program Files\Java\jdk1.5.0_04\jre\classes, sun.desktop=windows, java.vm.specification.vendor=Sun Microsystems Inc., java.runtime.version=1.5.0_04-b05, hibernate.connection.autocommit=true, hibernate.cache.provider_class=org.hibernate.cache.HashtableCacheProvider, user.name=breski, shared.loader=${catalina.base}/shared/classes,${catalina.base}/shared/lib/*.jar, jboss.bind.address=0.0.0.0, tomcat.util.buf.StringCache.byte.enabled=true, hibernate.connection.release_mode=after_statement, jboss.home.dir=C:\Program Files\Java\jboss-4.0.3RC1, user.language=zh, java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, sun.boot.library.path=C:\Program Files\Java\jdk1.5.0_04\jre\bin, hibernate.jndi.java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, jboss.home.url=file:/C:/Program Files/Java/jboss-4.0.3RC1/, jacorb.config.log.verbosity=0, java.version=1.5.0_04, user.timezone=Asia/Shanghai, jboss.server.home.dir=C:\Program Files\Java\jboss-4.0.3RC1\server\all, sun.arch.data.model=32, java.endorsed.dirs=C:\Program Files\Java\jboss-4.0.3RC1\bin\\..\lib\endorsed, jboss.server.home.url=file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/, sun.cpu.isalist=, sun.jnu.encoding=GBK, file.encoding.pkg=sun.io, package.access=sun.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper.,sun.beans., file.separator=\, java.specification.name=Java Platform API Specification, hibernate.cglib.use_reflection_optimizer=true, java.class.version=49.0, jboss.server.config.url=file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/conf/, user.country=CN, java.home=C:\Program Files\Java\jdk1.5.0_04\jre, java.vm.info=mixed mode, jboss.lib.url=file:/C:/Program Files/Java/jboss-4.0.3RC1/lib/, os.version=5.1, hibernate.jndi.java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces, hibernate.jacc.ctx.id=server.entity.ejb3, org.omg.CORBA.ORBSingletonClass=org.jboss.system.ORBSingleton, path.separator=;, java.vm.version=1.5.0_04-b05, user.variant=, java.protocol.handler.pkgs=org.jboss.net.protocol, java.awt.printerjob=sun.awt.windows.WPrinterJob, sun.io.unicode.encoding=UnicodeLittle, awt.toolkit=sun.awt.windows.WToolkit, package.definition=sun.,java.,org.apache.catalina.,org.apache.coyote.,org.apache.tomcat.,org.apache.jasper., jboss.server.temp.dir=C:\Program Files\Java\jboss-4.0.3RC1\server\all\tmp, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces, user.home=C:\Documents and Settings\breski, java.rmi.server.RMIClassLoaderSpi=org.jboss.system.JBossRMIClassLoader, java.specification.vendor=Sun Microsystems Inc., hibernate.hbm2ddl.auto=create-drop, java.library.path=C:\Program Files\Java\jdk1.5.0_04\bin;.;C:\WINDOWS\System32;C:\WINDOWS;D:\oracle\product\10.2.0\db_1\bin;C:\WINDOWS\system32;C:\WINDOWS;C:\WINDOWS\System32\Wbem;C:\Program Files\Microsoft SQL Server\80\Tools\BINN, java.vendor.url=http://java.sun.com/, program.name=run.bat, java.vm.vendor=Sun Microsystems Inc., hibernate.dialect=org.hibernate.dialect.Oracle9Dialect, common.loader=${catalina.home}/common/classes,${catalina.home}/common/i18n/*.jar,${catalina.home}/common/endorsed/*.jar,${catalina.home}/common/lib/*.jar, java.runtime.name=Java(TM) 2 Runtime Environment, Standard Edition, java.class.path=C:\Program Files\Java\jdk1.5.0_04\lib\tools.jar;C:\Program Files\Java\jboss-4.0.3RC1\bin\\run.jar, hibernate.transaction.auto_close_session=false, jbossmx.loader.repository.class=org.jboss.mx.loading.UnifiedLoaderRepository3, java.vm.specification.name=Java Virtual Machine Specification, catalina.home=C:\Program Files\Java\jboss-4.0.3RC1\server\all, java.vm.specification.version=1.0, jboss.server.lib.url=file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/lib/, sun.os.patch.level=Service Pack 1, sun.cpu.endian=little, hibernate.connection.provider_class=org.hibernate.ejb.InjectedDataSourceConnectionProvider, java.io.tmpdir=C:\DOCUME~1\breski\LOCALS~1\Temp\, java.rmi.server.codebase=http://baby:8083/, java.vendor.url.bug=http://java.sun.com/cgi-bin/bugreport.cgi, server.loader=${catalina.home}/server/classes,${catalina.home}/server/lib/*.jar, jboss.server.data.dir=C:\Program Files\Java\jboss-4.0.3RC1\server\all\data, hibernate.query.factory_class=org.hibernate.hql.ast.ASTQueryTranslatorFactory, java.awt.graphicsenv=sun.awt.Win32GraphicsEnvironment, os.arch=x86, java.ext.dirs=C:\Program Files\Java\jdk1.5.0_04\jre\lib\ext, user.dir=C:\Program Files\Java\jboss-4.0.3RC1\bin, line.separator=
      , java.vm.name=Java HotSpot(TM) Client VM, jboss.server.base.dir=C:\Program Files\Java\jboss-4.0.3RC1\server, org.jboss.ORBSingletonDelegate=org.jacorb.orb.ORBSingleton, jboss.server.base.url=file:/C:/Program Files/Java/jboss-4.0.3RC1/server/, javax.management.builder.initial=org.jboss.mx.server.MBeanServerBuilderImpl, file.encoding=GBK, org.omg.CORBA.ORBClass=org.jacorb.orb.ORB, hibernate.use_identifier_rollback=true, catalina.ext.dirs=C:\Program Files\Java\jboss-4.0.3RC1\server\all\lib, hibernate.transaction.manager_lookup_class=org.hibernate.transaction.JBossTransactionManagerLookup, java.specification.version=1.5, jboss.server.name=all}
      2005-10-05 16:56:14,686 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Static SQL for entity: org.jboss.tutorial.entity.bean.LineItem
      2005-10-05 16:56:14,686 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Version select: select id from LineItem where id =?
      2005-10-05 16:56:14,686 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Snapshot select: select lineitem_.id, lineitem_.order_id as order5_43_, lineitem_.product as product43_, lineitem_.quantity as quantity43_, lineitem_.subtotal as subtotal43_ from LineItem lineitem_ where lineitem_.id=?
      2005-10-05 16:56:14,686 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Insert 0: insert into LineItem (order_id, product, quantity, subtotal, id) values (?, ?, ?, ?, ?)
      2005-10-05 16:56:14,686 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Update 0: update LineItem set order_id=?, product=?, quantity=?, subtotal=? where id=?
      2005-10-05 16:56:14,686 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Delete 0: delete from LineItem where id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Static SQL for entity: org.jboss.tutorial.entity.bean.Order
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Version select: select id from PURCHASE_ORDER where id =?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Snapshot select: select order_.id, order_.total as total44_ from PURCHASE_ORDER order_ where order_.id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Insert 0: insert into PURCHASE_ORDER (total, id) values (?, ?)
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Update 0: update PURCHASE_ORDER set total=? where id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.persister.entity.AbstractEntityPersister] Delete 0: delete from PURCHASE_ORDER where id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.persister.collection.AbstractCollectionPersister] Static SQL for collection: org.jboss.tutorial.entity.bean.Order.lineItems
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.persister.collection.AbstractCollectionPersister] Row insert: update LineItem set order_id=? where id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.persister.collection.AbstractCollectionPersister] Row delete: update LineItem set order_id=null where order_id=? and id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.persister.collection.AbstractCollectionPersister] One-shot delete: update LineItem set order_id=null where order_id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for entity org.jboss.tutorial.entity.bean.LineItem: select lineitem0_.id as id43_1_, lineitem0_.order_id as order5_43_1_, lineitem0_.product as product43_1_, lineitem0_.quantity as quantity43_1_, lineitem0_.subtotal as subtotal43_1_, order1_.id as id44_0_, order1_.total as total44_0_ from LineItem lineitem0_ left outer join PURCHASE_ORDER order1_ on lineitem0_.order_id=order1_.id where lineitem0_.id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for entity org.jboss.tutorial.entity.bean.LineItem: select lineitem0_.id as id43_1_, lineitem0_.order_id as order5_43_1_, lineitem0_.product as product43_1_, lineitem0_.quantity as quantity43_1_, lineitem0_.subtotal as subtotal43_1_, order1_.id as id44_0_, order1_.total as total44_0_ from LineItem lineitem0_ left outer join PURCHASE_ORDER order1_ on lineitem0_.order_id=order1_.id where lineitem0_.id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for entity org.jboss.tutorial.entity.bean.LineItem: select lineitem0_.id as id43_0_, lineitem0_.order_id as order5_43_0_, lineitem0_.product as product43_0_, lineitem0_.quantity as quantity43_0_, lineitem0_.subtotal as subtotal43_0_ from LineItem lineitem0_ where lineitem0_.id=? for update
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for entity org.jboss.tutorial.entity.bean.LineItem: select lineitem0_.id as id43_0_, lineitem0_.order_id as order5_43_0_, lineitem0_.product as product43_0_, lineitem0_.quantity as quantity43_0_, lineitem0_.subtotal as subtotal43_0_ from LineItem lineitem0_ where lineitem0_.id=? for update nowait
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for action ACTION_MERGE on entity org.jboss.tutorial.entity.bean.LineItem: select lineitem0_.id as id43_0_, lineitem0_.order_id as order5_43_0_, lineitem0_.product as product43_0_, lineitem0_.quantity as quantity43_0_, lineitem0_.subtotal as subtotal43_0_ from LineItem lineitem0_ where lineitem0_.id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for action ACTION_REFRESH on entity org.jboss.tutorial.entity.bean.LineItem: select lineitem0_.id as id43_0_, lineitem0_.order_id as order5_43_0_, lineitem0_.product as product43_0_, lineitem0_.quantity as quantity43_0_, lineitem0_.subtotal as subtotal43_0_ from LineItem lineitem0_ where lineitem0_.id=?
      2005-10-05 16:56:14,706 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for entity org.jboss.tutorial.entity.bean.Order: select order0_.id as id44_1_, order0_.total as total44_1_, lineitems1_.order_id as order5_3_, lineitems1_.id as id3_, lineitems1_.id as id43_0_, lineitems1_.order_id as order5_43_0_, lineitems1_.product as product43_0_, lineitems1_.quantity as quantity43_0_, lineitems1_.subtotal as subtotal43_0_ from PURCHASE_ORDER order0_ left outer join LineItem lineitems1_ on order0_.id=lineitems1_.order_id where order0_.id=?
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for entity org.jboss.tutorial.entity.bean.Order: select order0_.id as id44_1_, order0_.total as total44_1_, lineitems1_.order_id as order5_3_, lineitems1_.id as id3_, lineitems1_.id as id43_0_, lineitems1_.order_id as order5_43_0_, lineitems1_.product as product43_0_, lineitems1_.quantity as quantity43_0_, lineitems1_.subtotal as subtotal43_0_ from PURCHASE_ORDER order0_ left outer join LineItem lineitems1_ on order0_.id=lineitems1_.order_id where order0_.id=?
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for entity org.jboss.tutorial.entity.bean.Order: select order0_.id as id44_0_, order0_.total as total44_0_ from PURCHASE_ORDER order0_ where order0_.id=? for update
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for entity org.jboss.tutorial.entity.bean.Order: select order0_.id as id44_0_, order0_.total as total44_0_ from PURCHASE_ORDER order0_ where order0_.id=? for update nowait
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for action ACTION_MERGE on entity org.jboss.tutorial.entity.bean.Order: select order0_.id as id44_1_, order0_.total as total44_1_, lineitems1_.order_id as order5_3_, lineitems1_.id as id3_, lineitems1_.id as id43_0_, lineitems1_.order_id as order5_43_0_, lineitems1_.product as product43_0_, lineitems1_.quantity as quantity43_0_, lineitems1_.subtotal as subtotal43_0_ from PURCHASE_ORDER order0_ left outer join LineItem lineitems1_ on order0_.id=lineitems1_.order_id where order0_.id=?
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.loader.entity.EntityLoader] Static select for action ACTION_REFRESH on entity org.jboss.tutorial.entity.bean.Order: select order0_.id as id44_1_, order0_.total as total44_1_, lineitems1_.order_id as order5_3_, lineitems1_.id as id3_, lineitems1_.id as id43_0_, lineitems1_.order_id as order5_43_0_, lineitems1_.product as product43_0_, lineitems1_.quantity as quantity43_0_, lineitems1_.subtotal as subtotal43_0_ from PURCHASE_ORDER order0_ left outer join LineItem lineitems1_ on order0_.id=lineitems1_.order_id where order0_.id=?
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.loader.collection.OneToManyLoader] Static select for one-to-many org.jboss.tutorial.entity.bean.Order.lineItems: select lineitems0_.order_id as order5_1_, lineitems0_.id as id1_, lineitems0_.id as id43_0_, lineitems0_.order_id as order5_43_0_, lineitems0_.product as product43_0_, lineitems0_.quantity as quantity43_0_, lineitems0_.subtotal as subtotal43_0_ from LineItem lineitems0_ where lineitems0_.order_id=?
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.impl.SessionFactoryObjectFactory] registered: 402881b006bfd88a0106bffebe7c0008 (unnamed)
      2005-10-05 16:56:14,716 INFO [org.hibernate.impl.SessionFactoryObjectFactory] Not binding factory to JNDI, no JNDI name configured
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.impl.SessionFactoryImpl] instantiated session factory
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Execute first pass mapping processing
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process hbm files
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process annotated classes
      2005-10-05 16:56:14,716 DEBUG [org.hibernate.cfg.AnnotationConfiguration] processing manytoone fk mappings
      2005-10-05 16:56:14,716 INFO [org.hibernate.cfg.Configuration] processing extends queue
      2005-10-05 16:56:14,716 INFO [org.hibernate.cfg.Configuration] processing collection mappings
      2005-10-05 16:56:14,726 INFO [org.hibernate.cfg.Configuration] processing association property references
      2005-10-05 16:56:14,726 INFO [org.hibernate.cfg.Configuration] processing foreign key constraints
      2005-10-05 16:56:14,726 DEBUG [org.hibernate.cfg.Configuration] resolving reference to class: org.jboss.tutorial.entity.bean.Order
      2005-10-05 16:56:14,726 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Execute first pass mapping processing
      2005-10-05 16:56:14,726 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process hbm files
      2005-10-05 16:56:14,726 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process annotated classes
      2005-10-05 16:56:14,726 DEBUG [org.hibernate.cfg.AnnotationConfiguration] processing manytoone fk mappings
      2005-10-05 16:56:14,726 INFO [org.hibernate.cfg.Configuration] processing extends queue
      2005-10-05 16:56:14,726 INFO [org.hibernate.cfg.Configuration] processing collection mappings
      2005-10-05 16:56:14,726 INFO [org.hibernate.cfg.Configuration] processing association property references
      2005-10-05 16:56:14,726 INFO [org.hibernate.cfg.Configuration] processing foreign key constraints
      2005-10-05 16:56:14,726 DEBUG [org.hibernate.cfg.Configuration] resolving reference to class: org.jboss.tutorial.entity.bean.Order
      2005-10-05 16:56:14,726 INFO [org.hibernate.tool.hbm2ddl.SchemaExport] Running hbm2ddl schema export
      2005-10-05 16:56:14,726 DEBUG [org.hibernate.tool.hbm2ddl.SchemaExport] import file not found: /import.sql
      2005-10-05 16:56:14,726 INFO [org.hibernate.tool.hbm2ddl.SchemaExport] exporting generated schema to database
      2005-10-05 16:56:14,726 DEBUG [org.hibernate.tool.hbm2ddl.SchemaExport] drop table LineItem cascade constraints
      2005-10-05 16:56:17,450 DEBUG [org.hibernate.tool.hbm2ddl.SchemaExport] drop table PURCHASE_ORDER cascade constraints
      2005-10-05 16:56:17,670 DEBUG [org.hibernate.tool.hbm2ddl.SchemaExport] drop sequence hibernate_sequence
      2005-10-05 16:56:18,421 DEBUG [org.hibernate.tool.hbm2ddl.SchemaExport] create table LineItem (id number(10,0) not null, product varchar2(255 char), quantity number(10,0) not null, subtotal double precision not null, order_id number(10,0), primary key (id))
      2005-10-05 16:56:21,336 DEBUG [org.hibernate.tool.hbm2ddl.SchemaExport] create table PURCHASE_ORDER (id number(10,0) not null, total double precision not null, primary key (id))
      2005-10-05 16:56:21,816 DEBUG [org.hibernate.tool.hbm2ddl.SchemaExport] alter table LineItem add constraint FK4AAEE947F4C206B8 foreign key (order_id) references PURCHASE_ORDER
      2005-10-05 16:56:22,007 DEBUG [org.hibernate.tool.hbm2ddl.SchemaExport] create sequence hibernate_sequence
      2005-10-05 16:56:22,077 INFO [org.hibernate.tool.hbm2ddl.SchemaExport] schema export complete
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Execute first pass mapping processing
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process hbm files
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process annotated classes
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.cfg.AnnotationConfiguration] processing manytoone fk mappings
      2005-10-05 16:56:22,077 INFO [org.hibernate.cfg.Configuration] processing extends queue
      2005-10-05 16:56:22,077 INFO [org.hibernate.cfg.Configuration] processing collection mappings
      2005-10-05 16:56:22,077 INFO [org.hibernate.cfg.Configuration] processing association property references
      2005-10-05 16:56:22,077 INFO [org.hibernate.cfg.Configuration] processing foreign key constraints
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.cfg.Configuration] resolving reference to class: org.jboss.tutorial.entity.bean.Order
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Execute first pass mapping processing
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process hbm files
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.cfg.AnnotationConfiguration] Process annotated classes
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.cfg.AnnotationConfiguration] processing manytoone fk mappings
      2005-10-05 16:56:22,077 INFO [org.hibernate.cfg.Configuration] processing extends queue
      2005-10-05 16:56:22,077 INFO [org.hibernate.cfg.Configuration] processing collection mappings
      2005-10-05 16:56:22,077 INFO [org.hibernate.cfg.Configuration] processing association property references
      2005-10-05 16:56:22,077 INFO [org.hibernate.cfg.Configuration] processing foreign key constraints
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.cfg.Configuration] resolving reference to class: org.jboss.tutorial.entity.bean.Order
      2005-10-05 16:56:22,077 DEBUG [org.hibernate.impl.SessionFactoryImpl] obtaining JTA TransactionManager
      2005-10-05 16:56:22,077 INFO [org.hibernate.util.NamingHelper] JNDI InitialContext properties:{java.naming.factory.initial=org.jnp.interfaces.NamingContextFactory, java.naming.factory.url.pkgs=org.jboss.naming:org.jnp.interfaces}
      2005-10-05 16:56:22,087 INFO [org.hibernate.impl.SessionFactoryImpl] Checking 0 named queries
      2005-10-05 16:56:22,087 INFO [org.jboss.ejb3.Ejb3Deployment] Create EntityManager with JNDI name:
      2005-10-05 16:56:22,087 DEBUG [org.jboss.ejb3.Ejb3Module] Initialization failed jboss.j2ee:service=EJB3,module=server.entity.ejb3
      java.lang.ArrayIndexOutOfBoundsException: -1
      at java.util.Vector.elementAt(Vector.java:435)
      at javax.naming.NameImpl.get(NameImpl.java:534)
      at javax.naming.CompoundName.get(CompoundName.java:343)
      at org.jboss.ejb3.NonSerializableFactory.rebind(NonSerializableFactory.java:55)
      at org.jboss.ejb3.Ejb3Deployment.initializeManagedEntityManagerFactory(Ejb3Deployment.java:522)
      at org.jboss.ejb3.Ejb3Deployment.create(Ejb3Deployment.java:253)
      at org.jboss.ejb3.Ejb3JmxDeployment.create(Ejb3JmxDeployment.java:230)
      at org.jboss.ejb3.Ejb3Module.createService(Ejb3Module.java:34)
      at org.jboss.system.ServiceMBeanSupport.jbossInternalCreate(ServiceMBeanSupport.java:233)
      at org.jboss.system.ServiceMBeanSupport.jbossInternalLifecycle(ServiceMBeanSupport.java:215)
      at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      at java.lang.reflect.Method.invoke(Method.java:585)
      at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:141)
      at org.jboss.mx.server.Invocation.dispatch(Invocation.java:80)
      at org.jboss.mx.server.Invocation.invoke(Invocation.java:72)
      at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:245)
      at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:644)
      at org.jboss.system.ServiceController$ServiceProxy.invoke(ServiceController.java:950)
      at $Proxy0.create(Unknown Source)
      at org.jboss.system.ServiceController.create(ServiceController.java:342)
      at org.jboss.system.ServiceController.create(ServiceController.java:281)
      at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      at java.lang.reflect.Method.invoke(Method.java:585)
      at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:141)
      at org.jboss.mx.server.Invocation.dispatch(Invocation.java:80)
      at org.jboss.mx.server.Invocation.invoke(Invocation.java:72)
      at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:245)
      at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:644)
      at org.jboss.mx.util.MBeanProxyExt.invoke(MBeanProxyExt.java:176)
      at $Proxy17.create(Unknown Source)
      at org.jboss.ejb3.EJB3Deployer.create(EJB3Deployer.java:198)
      at org.jboss.deployment.MainDeployer.create(MainDeployer.java:919)
      at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:773)
      at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:737)
      at sun.reflect.GeneratedMethodAccessor16.invoke(Unknown Source)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      at java.lang.reflect.Method.invoke(Method.java:585)
      at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:141)
      at org.jboss.mx.server.Invocation.dispatch(Invocation.java:80)
      at org.jboss.mx.interceptor.AbstractInterceptor.invoke(AbstractInterceptor.java:118)
      at org.jboss.mx.server.Invocation.invoke(Invocation.java:74)
      at org.jboss.mx.interceptor.ModelMBeanOperationInterceptor.invoke(ModelMBeanOperationInterceptor.java:127)
      at org.jboss.mx.server.Invocation.invoke(Invocation.java:74)
      at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:245)
      at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:644)
      at org.jboss.mx.util.MBeanProxyExt.invoke(MBeanProxyExt.java:176)
      at $Proxy9.deploy(Unknown Source)
      at org.jboss.deployment.scanner.URLDeploymentScanner.deploy(URLDeploymentScanner.java:325)
      at org.jboss.deployment.scanner.URLDeploymentScanner.scan(URLDeploymentScanner.java:501)
      at org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread.doScan(AbstractDeploymentScanner.java:204)
      at org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread.loop(AbstractDeploymentScanner.java:215)
      at org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread.run(AbstractDeploymentScanner.java:194)
      2005-10-05 16:56:22,087 WARN [org.jboss.system.ServiceController] Problem creating service jboss.j2ee:service=EJB3,module=server.entity.ejb3
      java.lang.ArrayIndexOutOfBoundsException: -1
      at java.util.Vector.elementAt(Vector.java:435)
      at javax.naming.NameImpl.get(NameImpl.java:534)
      at javax.naming.CompoundName.get(CompoundName.java:343)
      at org.jboss.ejb3.NonSerializableFactory.rebind(NonSerializableFactory.java:55)
      at org.jboss.ejb3.Ejb3Deployment.initializeManagedEntityManagerFactory(Ejb3Deployment.java:522)
      at org.jboss.ejb3.Ejb3Deployment.create(Ejb3Deployment.java:253)
      at org.jboss.ejb3.Ejb3JmxDeployment.create(Ejb3JmxDeployment.java:230)
      at org.jboss.ejb3.Ejb3Module.createService(Ejb3Module.java:34)
      at org.jboss.system.ServiceMBeanSupport.jbossInternalCreate(ServiceMBeanSupport.java:233)
      at org.jboss.system.ServiceMBeanSupport.jbossInternalLifecycle(ServiceMBeanSupport.java:215)
      at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
      at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      at java.lang.reflect.Method.invoke(Method.java:585)
      at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:141)
      at org.jboss.mx.server.Invocation.dispatch(Invocation.java:80)
      at org.jboss.mx.server.Invocation.invoke(Invocation.java:72)
      at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:245)
      at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:644)
      at org.jboss.system.ServiceController$ServiceProxy.invoke(ServiceController.java:950)
      at $Proxy0.create(Unknown Source)
      at org.jboss.system.ServiceController.create(ServiceController.java:342)
      at org.jboss.system.ServiceController.create(ServiceController.java:281)
      at sun.reflect.GeneratedMethodAccessor4.invoke(Unknown Source)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      at java.lang.reflect.Method.invoke(Method.java:585)
      at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:141)
      at org.jboss.mx.server.Invocation.dispatch(Invocation.java:80)
      at org.jboss.mx.server.Invocation.invoke(Invocation.java:72)
      at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:245)
      at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:644)
      at org.jboss.mx.util.MBeanProxyExt.invoke(MBeanProxyExt.java:176)
      at $Proxy17.create(Unknown Source)
      at org.jboss.ejb3.EJB3Deployer.create(EJB3Deployer.java:198)
      at org.jboss.deployment.MainDeployer.create(MainDeployer.java:919)
      at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:773)
      at org.jboss.deployment.MainDeployer.deploy(MainDeployer.java:737)
      at sun.reflect.GeneratedMethodAccessor16.invoke(Unknown Source)
      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
      at java.lang.reflect.Method.invoke(Method.java:585)
      at org.jboss.mx.interceptor.ReflectedDispatcher.invoke(ReflectedDispatcher.java:141)
      at org.jboss.mx.server.Invocation.dispatch(Invocation.java:80)
      at org.jboss.mx.interceptor.AbstractInterceptor.invoke(AbstractInterceptor.java:118)
      at org.jboss.mx.server.Invocation.invoke(Invocation.java:74)
      at org.jboss.mx.interceptor.ModelMBeanOperationInterceptor.invoke(ModelMBeanOperationInterceptor.java:127)
      at org.jboss.mx.server.Invocation.invoke(Invocation.java:74)
      at org.jboss.mx.server.AbstractMBeanInvoker.invoke(AbstractMBeanInvoker.java:245)
      at org.jboss.mx.server.MBeanServerImpl.invoke(MBeanServerImpl.java:644)
      at org.jboss.mx.util.MBeanProxyExt.invoke(MBeanProxyExt.java:176)
      at $Proxy9.deploy(Unknown Source)
      at org.jboss.deployment.scanner.URLDeploymentScanner.deploy(URLDeploymentScanner.java:325)
      at org.jboss.deployment.scanner.URLDeploymentScanner.scan(URLDeploymentScanner.java:501)
      at org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread.doScan(AbstractDeploymentScanner.java:204)
      at org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread.loop(AbstractDeploymentScanner.java:215)
      at org.jboss.deployment.scanner.AbstractDeploymentScanner$ScannerThread.run(AbstractDeploymentScanner.java:194)
      2005-10-05 16:56:22,097 DEBUG [org.jboss.deployment.MainDeployer] Done with create step of deploying server.entity.ejb3
      2005-10-05 16:56:22,097 DEBUG [org.jboss.deployment.MainDeployer] Begin deployment start file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:22,097 DEBUG [org.jboss.ejb3.EJB3Deployer] start application, deploymentInfo: org.jboss.deployment.DeploymentInfo@5ea05c3 { url=file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3 }
      deployer: org.jboss.ejb3.EJB3Deployer@166bfd8
      status: Starting
      state: START_DEPLOYER
      watch: file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      altDD: null
      lastDeployed: 1128502574336
      lastModified: 1128502576000
      mbeans:
      jboss.j2ee:service=EJB3,name=org.jboss.tutorial.entity.bean.ShoppingCartBean state: Created
      , short name: server.entity.ejb3, parent short name: null
      2005-10-05 16:56:22,097 DEBUG [org.jboss.system.ServiceController] starting service jboss.j2ee:service=EJB3,module=server.entity.ejb3
      2005-10-05 16:56:22,097 DEBUG [org.jboss.system.ServiceController] Ignoring start request for service: jboss.j2ee:service=EJB3,module=server.entity.ejb3
      2005-10-05 16:56:22,097 INFO [org.jboss.ejb3.EJB3Deployer] Deployed: file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:22,097 DEBUG [org.jboss.deployment.MainDeployer] End deployment start on package: server.entity.ejb3
      2005-10-05 16:56:22,097 DEBUG [org.jboss.deployment.MainDeployer] Deployed package: file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:22,097 DEBUG [org.jboss.deployment.scanner.URLDeploymentScanner] Watch URL for: file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3 -> file:/C:/Program Files/Java/jboss-4.0.3RC1/server/all/deploy/server.entity.ejb3
      2005-10-05 16:56:22,097 ERROR [org.jboss.deployment.scanner.URLDeploymentScanner] Incomplete Deployment listing:

      --- MBeans waiting for other MBeans ---
      ObjectName: jboss.j2ee:service=EJB3,module=server.entity.ejb3
      State: FAILED
      Reason: java.lang.ArrayIndexOutOfBoundsException: -1

      --- MBEANS THAT ARE THE ROOT CAUSE OF THE PROBLEM ---
      ObjectName: jboss.j2ee:service=EJB3,module=server.entity.ejb3
      State: FAILED
      Reason: java.lang.ArrayIndexOutOfBoundsException: -1