Uploaded image for project: 'Mule'
  1. Mule
  2. MULE-5351

JDBC driver found but is not loaded

    Details

    • Type: Bug
    • Status: Closed
    • Priority: Major
    • Resolution: Won't Fix or Usage Issue
    • Affects Version/s: 3.1.0
    • Fix Version/s: None
    • Component/s: Core: Deployment
    • Labels:
      None
    • Severity:
      S2
    • Log Output:
      Hide
      INFO 2011-01-19 16:03:13,186 [WrapperListener_start_runner] org.mule.module.launcher.application.DefaultMuleApplication: Installing application: test
      INFO 2011-01-19 16:03:13,188 [WrapperListener_start_runner] org.mule.module.launcher.MuleApplicationClassLoader: [test] Library directory: /home/dzapata/mule-standalone-3.1.0/apps/test/lib
      INFO 2011-01-19 16:03:13,188 [WrapperListener_start_runner] org.mule.module.launcher.MuleApplicationClassLoader: [test] Loading the following jars:
      =============================
      file:/home/dzapata/mule-standalone-3.1.0/apps/test/lib/mysql-connector-java-5.1.14-bin.jar
      =============================

      INFO 2011-01-19 16:03:13,188 [WrapperListener_start_runner] org.mule.module.launcher.application.DefaultMuleApplication: Initializing application: test
      INFO 2011-01-19 16:03:13,209 [WrapperListener_start_runner] org.mule.config.spring.MuleApplicationContext: Refreshing org.mule.config.spring.MuleApplicationContext@7578a7d9: startup date [Wed Jan 19 16:03:13 PST 2011]; root of context hierarchy
      INFO 2011-01-19 16:03:14,460 [WrapperListener_start_runner] org.mule.module.ibeans.config.IBeanHolderConfigurationBuilder: Scanning for annotations using the following paths: {org/mule, }
      INFO 2011-01-19 16:03:16,740 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Initialising model: _muleSystemModel
      WARN 2011-01-19 16:03:16,807 [WrapperListener_start_runner] org.mule.transport.jdbc.JdbcConnector: transactionPerMessage property is set to false so setting createMultipleTransactedReceivers to false also to prevent creation of multiple JdbcMessageReceivers
      INFO 2011-01-19 16:03:16,808 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Initialising connector: jdbcConnector
      INFO 2011-01-19 16:03:16,863 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Initialising connector: output
      WARN 2011-01-19 16:03:16,872 [WrapperListener_start_runner] org.mule.transport.file.FileConnector: MULE-1773: cannot configure maxDispatchersActive when using outputAppend. New value not set
      INFO 2011-01-19 16:03:16,955 [WrapperListener_start_runner] org.mule.construct.FlowConstructLifecycleManager: Initialising flow: allDbRows
      WARN 2011-01-19 16:03:16,971 [WrapperListener_start_runner] org.mule.context.notification.Configuration: The notification listener subscription "ListenerSubscriptionPair [listener=ObjectToString{this=59d6e3d2, name='ObjectToString', ignoreBadInput=false, returnClass=SimpleDataType{type=java.lang.String, mimeType='text/plain'}, sourceTypes=[SimpleDataType{type=java.lang.Object, mimeType='*/*'}, SimpleDataType{type=[B, mimeType='*/*'}, SimpleDataType{type=java.io.InputStream, mimeType='*/*'}, SimpleDataType{type=org.mule.api.transport.OutputHandler, mimeType='*/*'}]}, subscription=NULL]" has already been registered
      INFO 2011-01-19 16:03:16,971 [WrapperListener_start_runner] org.mule.exception.DefaultServiceExceptionStrategy: Initialising exception listener: org.mule.exception.DefaultServiceExceptionStrategy@32487ae0
      INFO 2011-01-19 16:03:16,976 [WrapperListener_start_runner] org.mule.config.builders.AutoConfigurationBuilder: Configured Mule using "org.mule.config.spring.SpringXmlConfigurationBuilder" with configuration resource(s): "[ConfigResource{resourceName='/home/dzapata/mule-standalone-3.1.0/apps/test/mule-config.xml'}]"
      INFO 2011-01-19 16:03:16,976 [WrapperListener_start_runner] org.mule.config.builders.AutoConfigurationBuilder: Configured Mule using "org.mule.config.builders.AutoConfigurationBuilder" with configuration resource(s): "[ConfigResource{resourceName='/home/dzapata/mule-standalone-3.1.0/apps/test/mule-config.xml'}]"
      INFO 2011-01-19 16:03:16,976 [WrapperListener_start_runner] org.mule.module.launcher.application.DefaultMuleApplication: Monitoring for hot-deployment: /home/dzapata/mule-standalone-3.1.0/apps/test/mule-config.xml
      INFO 2011-01-19 16:03:16,976 [WrapperListener_start_runner] org.mule.module.launcher.application.DefaultMuleApplication: Starting application: test
      INFO 2011-01-19 16:03:16,982 [WrapperListener_start_runner] org.mule.module.management.agent.JmxAgent: Registry on rmi://localhost:1099/server already bound. Attempting to use that instead
      INFO 2011-01-19 16:03:16,984 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Starting connector: jdbcConnector
      INFO 2011-01-19 16:03:16,986 [WrapperListener_start_runner] org.mule.transport.jdbc.JdbcConnector: Connected: JdbcConnector
      {
        name=jdbcConnector
        lifecycle=initialise
        this=6d854b38
        numberOfConcurrentTransactedReceivers=4
        createMultipleTransactedReceivers=false
        connected=true
        supportedProtocols=[jdbc]
        serviceOverrides=<none>
      }

      INFO 2011-01-19 16:03:16,987 [WrapperListener_start_runner] org.mule.transport.jdbc.JdbcConnector: Starting: JdbcConnector
      {
        name=jdbcConnector
        lifecycle=initialise
        this=6d854b38
        numberOfConcurrentTransactedReceivers=4
        createMultipleTransactedReceivers=false
        connected=true
        supportedProtocols=[jdbc]
        serviceOverrides=<none>
      }

      INFO 2011-01-19 16:03:16,994 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Starting connector: output
      INFO 2011-01-19 16:03:16,994 [WrapperListener_start_runner] org.mule.transport.file.FileConnector: Connected: FileConnector
      {
        name=output
        lifecycle=initialise
        this=450f8ee4
        numberOfConcurrentTransactedReceivers=4
        createMultipleTransactedReceivers=true
        connected=true
        supportedProtocols=[file]
        serviceOverrides=<none>
      }

      INFO 2011-01-19 16:03:16,994 [WrapperListener_start_runner] org.mule.transport.file.FileConnector: Starting: FileConnector
      {
        name=output
        lifecycle=initialise
        this=450f8ee4
        numberOfConcurrentTransactedReceivers=4
        createMultipleTransactedReceivers=true
        connected=true
        supportedProtocols=[file]
        serviceOverrides=<none>
      }

      INFO 2011-01-19 16:03:16,995 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Starting model: _muleSystemModel
      INFO 2011-01-19 16:03:16,997 [WrapperListener_start_runner] org.mule.construct.FlowConstructLifecycleManager: Starting flow: allDbRows
      INFO 2011-01-19 16:03:17,002 [WrapperListener_start_runner] org.mule.transport.jdbc.JdbcConnector: Registering listener: allDbRows on endpointUri: jdbc://read
      INFO 2011-01-19 16:03:17,020 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Initialising: 'null'. Object is: JdbcMessageReceiver
      INFO 2011-01-19 16:03:17,024 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Starting: 'null'. Object is: JdbcMessageReceiver
      INFO 2011-01-19 16:03:17,029 [WrapperListener_start_runner] org.mule.util.queue.TransactionalQueueManager: Starting ResourceManager
      INFO 2011-01-19 16:03:17,030 [WrapperListener_start_runner] org.mule.util.queue.TransactionalQueueManager: Started ResourceManager
      INFO 2011-01-19 16:03:17,042 [WrapperListener_start_runner] org.mule.module.management.agent.JmxAgent: Attempting to register service with name: Mule.test:type=Endpoint,service="allDbRows",connector=jdbcConnector,name="endpoint.jdbc.read"
      INFO 2011-01-19 16:03:17,042 [WrapperListener_start_runner] org.mule.module.management.agent.JmxAgent: Registered Endpoint Service with name: Mule.test:type=Endpoint,service="allDbRows",connector=jdbcConnector,name="endpoint.jdbc.read"
      INFO 2011-01-19 16:03:17,045 [WrapperListener_start_runner] org.mule.module.management.agent.JmxAgent: Registered Connector Service with name Mule.test:type=Connector,name="jdbcConnector.1"
      INFO 2011-01-19 16:03:17,045 [WrapperListener_start_runner] org.mule.module.management.agent.JmxAgent: Registered Connector Service with name Mule.test:type=Connector,name="output.1"
      INFO 2011-01-19 16:03:17,045 [WrapperListener_start_runner] org.mule.module.launcher.application.DefaultMuleApplication: Reload interval: 3000
      INFO 2011-01-19 16:03:17,047 [WrapperListener_start_runner] org.mule.DefaultMuleContext:
      **********************************************************************
      * Application: test *
      * OS encoding: UTF-8, Mule encoding: UTF-8 *
      * *
      * Agents Running: *
      * JMX Agent *
      * Wrapper Manager: Mule PID #26763, Wrapper PID #26761 *
      **********************************************************************
      INFO 2011-01-19 16:03:17,052 [WrapperListener_start_runner] org.mule.module.launcher.DeploymentService: Application directory check interval: 5000
      INFO 2011-01-19 16:03:18,048 [[test].jdbcConnector.receiver.1] org.mule.exception.DefaultSystemExceptionStrategy: Exception caught is a ConnectException, attempting to reconnect...
      INFO 2011-01-19 16:03:18,053 [[test].jdbcConnector.receiver.1] org.mule.lifecycle.AbstractLifecycleManager: Stopping: 'null'. Object is: JdbcMessageReceiver
      INFO 2011-01-19 16:03:18,055 [[test].jdbcConnector.receiver.1] org.mule.transport.jdbc.JdbcConnector: Disconnected: JdbcConnector
      {
        name=jdbcConnector
        lifecycle=start
        this=6d854b38
        numberOfConcurrentTransactedReceivers=4
        createMultipleTransactedReceivers=false
        connected=false
        supportedProtocols=[jdbc]
        serviceOverrides=<none>
      }

      ERROR 2011-01-19 16:03:18,057 [[test].jdbcConnector.receiver.1] org.mule.exception.DefaultSystemExceptionStrategy:
      ********************************************************************************
      Message : Error trying to load driver: com.mysql.jdbc.Driver : com.mysql.jdbc.Driver (java.sql.SQLException)
      Code : MULE_ERROR--2
      --------------------------------------------------------------------------------
      Exception stack is:
      1. Error trying to load driver: com.mysql.jdbc.Driver : com.mysql.jdbc.Driver(SQL Code: 0, SQL State: + null) (java.sql.SQLException)
        org.enhydra.jdbc.standard.StandardDataSource:184 (null)
      2. Error trying to load driver: com.mysql.jdbc.Driver : com.mysql.jdbc.Driver (java.sql.SQLException) (org.mule.transport.ConnectException)
        org.mule.transport.jdbc.JdbcConnector:247 (http://www.mulesoft.org/docs/site/current3/apidocs/org/mule/transport/ConnectException.html)
      --------------------------------------------------------------------------------
      Root Exception stack trace:
      java.sql.SQLException: Error trying to load driver: com.mysql.jdbc.Driver : com.mysql.jdbc.Driver
      at org.enhydra.jdbc.standard.StandardDataSource.getConnection(StandardDataSource.java:184)
      at org.enhydra.jdbc.standard.StandardDataSource.getConnection(StandardDataSource.java:144)
      at org.mule.transport.jdbc.JdbcConnector.getConnection(JdbcConnector.java:243)
          + 3 more (set debug level logging or '-Dmule.verbose.exceptions=true' for everything)
      ********************************************************************************
      Show
      INFO 2011-01-19 16:03:13,186 [WrapperListener_start_runner] org.mule.module.launcher.application.DefaultMuleApplication: Installing application: test INFO 2011-01-19 16:03:13,188 [WrapperListener_start_runner] org.mule.module.launcher.MuleApplicationClassLoader: [test] Library directory: /home/dzapata/mule-standalone-3.1.0/apps/test/lib INFO 2011-01-19 16:03:13,188 [WrapperListener_start_runner] org.mule.module.launcher.MuleApplicationClassLoader: [test] Loading the following jars: ============================= file:/home/dzapata/mule-standalone-3.1.0/apps/test/lib/mysql-connector-java-5.1.14-bin.jar ============================= INFO 2011-01-19 16:03:13,188 [WrapperListener_start_runner] org.mule.module.launcher.application.DefaultMuleApplication: Initializing application: test INFO 2011-01-19 16:03:13,209 [WrapperListener_start_runner] org.mule.config.spring.MuleApplicationContext: Refreshing org.mule.config.spring.MuleApplicationContext@7578a7d9 : startup date [Wed Jan 19 16:03:13 PST 2011]; root of context hierarchy INFO 2011-01-19 16:03:14,460 [WrapperListener_start_runner] org.mule.module.ibeans.config.IBeanHolderConfigurationBuilder: Scanning for annotations using the following paths: {org/mule, } INFO 2011-01-19 16:03:16,740 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Initialising model: _muleSystemModel WARN 2011-01-19 16:03:16,807 [WrapperListener_start_runner] org.mule.transport.jdbc.JdbcConnector: transactionPerMessage property is set to false so setting createMultipleTransactedReceivers to false also to prevent creation of multiple JdbcMessageReceivers INFO 2011-01-19 16:03:16,808 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Initialising connector: jdbcConnector INFO 2011-01-19 16:03:16,863 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Initialising connector: output WARN 2011-01-19 16:03:16,872 [WrapperListener_start_runner] org.mule.transport.file.FileConnector: MULE-1773 : cannot configure maxDispatchersActive when using outputAppend. New value not set INFO 2011-01-19 16:03:16,955 [WrapperListener_start_runner] org.mule.construct.FlowConstructLifecycleManager: Initialising flow: allDbRows WARN 2011-01-19 16:03:16,971 [WrapperListener_start_runner] org.mule.context.notification.Configuration: The notification listener subscription "ListenerSubscriptionPair [listener=ObjectToString{this=59d6e3d2, name='ObjectToString', ignoreBadInput=false, returnClass=SimpleDataType{type=java.lang.String, mimeType='text/plain'}, sourceTypes=[SimpleDataType{type=java.lang.Object, mimeType='*/*'}, SimpleDataType{type=[B, mimeType='*/*'}, SimpleDataType{type=java.io.InputStream, mimeType='*/*'}, SimpleDataType{type=org.mule.api.transport.OutputHandler, mimeType='*/*'}]}, subscription=NULL]" has already been registered INFO 2011-01-19 16:03:16,971 [WrapperListener_start_runner] org.mule.exception.DefaultServiceExceptionStrategy: Initialising exception listener: org.mule.exception.DefaultServiceExceptionStrategy@32487ae0 INFO 2011-01-19 16:03:16,976 [WrapperListener_start_runner] org.mule.config.builders.AutoConfigurationBuilder: Configured Mule using "org.mule.config.spring.SpringXmlConfigurationBuilder" with configuration resource(s): "[ConfigResource{resourceName='/home/dzapata/mule-standalone-3.1.0/apps/test/mule-config.xml'}]" INFO 2011-01-19 16:03:16,976 [WrapperListener_start_runner] org.mule.config.builders.AutoConfigurationBuilder: Configured Mule using "org.mule.config.builders.AutoConfigurationBuilder" with configuration resource(s): "[ConfigResource{resourceName='/home/dzapata/mule-standalone-3.1.0/apps/test/mule-config.xml'}]" INFO 2011-01-19 16:03:16,976 [WrapperListener_start_runner] org.mule.module.launcher.application.DefaultMuleApplication: Monitoring for hot-deployment: /home/dzapata/mule-standalone-3.1.0/apps/test/mule-config.xml INFO 2011-01-19 16:03:16,976 [WrapperListener_start_runner] org.mule.module.launcher.application.DefaultMuleApplication: Starting application: test INFO 2011-01-19 16:03:16,982 [WrapperListener_start_runner] org.mule.module.management.agent.JmxAgent: Registry on rmi://localhost:1099/server already bound. Attempting to use that instead INFO 2011-01-19 16:03:16,984 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Starting connector: jdbcConnector INFO 2011-01-19 16:03:16,986 [WrapperListener_start_runner] org.mule.transport.jdbc.JdbcConnector: Connected: JdbcConnector {   name=jdbcConnector   lifecycle=initialise   this=6d854b38   numberOfConcurrentTransactedReceivers=4   createMultipleTransactedReceivers=false   connected=true   supportedProtocols=[jdbc]   serviceOverrides=<none> } INFO 2011-01-19 16:03:16,987 [WrapperListener_start_runner] org.mule.transport.jdbc.JdbcConnector: Starting: JdbcConnector {   name=jdbcConnector   lifecycle=initialise   this=6d854b38   numberOfConcurrentTransactedReceivers=4   createMultipleTransactedReceivers=false   connected=true   supportedProtocols=[jdbc]   serviceOverrides=<none> } INFO 2011-01-19 16:03:16,994 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Starting connector: output INFO 2011-01-19 16:03:16,994 [WrapperListener_start_runner] org.mule.transport.file.FileConnector: Connected: FileConnector {   name=output   lifecycle=initialise   this=450f8ee4   numberOfConcurrentTransactedReceivers=4   createMultipleTransactedReceivers=true   connected=true   supportedProtocols=[file]   serviceOverrides=<none> } INFO 2011-01-19 16:03:16,994 [WrapperListener_start_runner] org.mule.transport.file.FileConnector: Starting: FileConnector {   name=output   lifecycle=initialise   this=450f8ee4   numberOfConcurrentTransactedReceivers=4   createMultipleTransactedReceivers=true   connected=true   supportedProtocols=[file]   serviceOverrides=<none> } INFO 2011-01-19 16:03:16,995 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Starting model: _muleSystemModel INFO 2011-01-19 16:03:16,997 [WrapperListener_start_runner] org.mule.construct.FlowConstructLifecycleManager: Starting flow: allDbRows INFO 2011-01-19 16:03:17,002 [WrapperListener_start_runner] org.mule.transport.jdbc.JdbcConnector: Registering listener: allDbRows on endpointUri: jdbc://read INFO 2011-01-19 16:03:17,020 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Initialising: 'null'. Object is: JdbcMessageReceiver INFO 2011-01-19 16:03:17,024 [WrapperListener_start_runner] org.mule.lifecycle.AbstractLifecycleManager: Starting: 'null'. Object is: JdbcMessageReceiver INFO 2011-01-19 16:03:17,029 [WrapperListener_start_runner] org.mule.util.queue.TransactionalQueueManager: Starting ResourceManager INFO 2011-01-19 16:03:17,030 [WrapperListener_start_runner] org.mule.util.queue.TransactionalQueueManager: Started ResourceManager INFO 2011-01-19 16:03:17,042 [WrapperListener_start_runner] org.mule.module.management.agent.JmxAgent: Attempting to register service with name: Mule.test:type=Endpoint,service="allDbRows",connector=jdbcConnector,name="endpoint.jdbc.read" INFO 2011-01-19 16:03:17,042 [WrapperListener_start_runner] org.mule.module.management.agent.JmxAgent: Registered Endpoint Service with name: Mule.test:type=Endpoint,service="allDbRows",connector=jdbcConnector,name="endpoint.jdbc.read" INFO 2011-01-19 16:03:17,045 [WrapperListener_start_runner] org.mule.module.management.agent.JmxAgent: Registered Connector Service with name Mule.test:type=Connector,name="jdbcConnector.1" INFO 2011-01-19 16:03:17,045 [WrapperListener_start_runner] org.mule.module.management.agent.JmxAgent: Registered Connector Service with name Mule.test:type=Connector,name="output.1" INFO 2011-01-19 16:03:17,045 [WrapperListener_start_runner] org.mule.module.launcher.application.DefaultMuleApplication: Reload interval: 3000 INFO 2011-01-19 16:03:17,047 [WrapperListener_start_runner] org.mule.DefaultMuleContext: ********************************************************************** * Application: test * * OS encoding: UTF-8, Mule encoding: UTF-8 * * * * Agents Running: * * JMX Agent * * Wrapper Manager: Mule PID #26763, Wrapper PID #26761 * ********************************************************************** INFO 2011-01-19 16:03:17,052 [WrapperListener_start_runner] org.mule.module.launcher.DeploymentService: Application directory check interval: 5000 INFO 2011-01-19 16:03:18,048 [[test].jdbcConnector.receiver.1] org.mule.exception.DefaultSystemExceptionStrategy: Exception caught is a ConnectException, attempting to reconnect... INFO 2011-01-19 16:03:18,053 [[test].jdbcConnector.receiver.1] org.mule.lifecycle.AbstractLifecycleManager: Stopping: 'null'. Object is: JdbcMessageReceiver INFO 2011-01-19 16:03:18,055 [[test].jdbcConnector.receiver.1] org.mule.transport.jdbc.JdbcConnector: Disconnected: JdbcConnector {   name=jdbcConnector   lifecycle=start   this=6d854b38   numberOfConcurrentTransactedReceivers=4   createMultipleTransactedReceivers=false   connected=false   supportedProtocols=[jdbc]   serviceOverrides=<none> } ERROR 2011-01-19 16:03:18,057 [[test].jdbcConnector.receiver.1] org.mule.exception.DefaultSystemExceptionStrategy: ******************************************************************************** Message : Error trying to load driver: com.mysql.jdbc.Driver : com.mysql.jdbc.Driver (java.sql.SQLException) Code : MULE_ERROR--2 -------------------------------------------------------------------------------- Exception stack is: 1. Error trying to load driver: com.mysql.jdbc.Driver : com.mysql.jdbc.Driver(SQL Code: 0, SQL State: + null) (java.sql.SQLException)   org.enhydra.jdbc.standard.StandardDataSource:184 (null) 2. Error trying to load driver: com.mysql.jdbc.Driver : com.mysql.jdbc.Driver (java.sql.SQLException) (org.mule.transport.ConnectException)   org.mule.transport.jdbc.JdbcConnector:247 ( http://www.mulesoft.org/docs/site/current3/apidocs/org/mule/transport/ConnectException.html ) -------------------------------------------------------------------------------- Root Exception stack trace: java.sql.SQLException: Error trying to load driver: com.mysql.jdbc.Driver : com.mysql.jdbc.Driver at org.enhydra.jdbc.standard.StandardDataSource.getConnection(StandardDataSource.java:184) at org.enhydra.jdbc.standard.StandardDataSource.getConnection(StandardDataSource.java:144) at org.mule.transport.jdbc.JdbcConnector.getConnection(JdbcConnector.java:243)     + 3 more (set debug level logging or '-Dmule.verbose.exceptions=true' for everything) ********************************************************************************

      Description

      I created a Mule application using the JDBC transport and copied the JDBC client jar to the <MULE_HOME>/apps/app-name/lib directory. When I start Mule, it reports that it found the driver jar, but then later says it failed to load the driver. See the log output section. If I copy the jar to the <MULE_HOME>/lib/user directory instead, the application works fine.

        Attachments

          Activity

            People

            • Assignee:
              andrew Andrew Perepelytsya
              Reporter:
              dzapata Daniel Zapata
            • Votes:
              0 Vote for this issue
              Watchers:
              1 Start watching this issue

              Dates

              • Created:
                Updated:
                Resolved:

                PagerDuty

                Error rendering 'com.pagerduty.jira-server-plugin:PagerDuty'. Please contact your Jira administrators.