You are viewing a plain text version of this content. The canonical link for it is here.
Posted to users@camel.apache.org by Nestor Urquiza <ne...@gmail.com> on 2012/04/30 04:21:27 UTC
Logging from route not working
Hello guys,
I have setup a simple route:
package com.krfs.orchestration.camel.route;
import org.apache.camel.LoggingLevel;
import org.apache.camel.builder.RouteBuilder;
import org.slf4j.Logger;
import org.slf4j.LoggerFactory;
public class SampleRouteBuilder extends RouteBuilder {
Logger log =
LoggerFactory.getLogger(SampleRouteBuilder.class.getName());
@Override
public void configure() {
log.debug("Configuring dummy route");
from("direct:start").log(LoggingLevel.DEBUG, "Processing ${id}");
}
}
Then I get the DEBUG message straight from the code ("Configuring dummy
route") however I do not get the DEBUG message from within the Camel route
("Processing ${id}")
Any ideas why?
2012-04-29 22:15:27,801 DEBUG
[com.krfs.orchestration.camel.route.SampleRouteBuilder] - Configuring
dummy route
2012-04-29 22:15:27,845 DEBUG [org.apache.camel.spring.SpringCamelContext] -
onApplicationEvent:
org.springframework.context.event.ContextRefreshedEvent[source=Root
WebApplicationContext: startup date [Sun Apr 29 22:15:00 EDT 2012]; root of
context hierarchy]
2012-04-29 22:15:27,846 INFO [org.apache.camel.spring.SpringCamelContext] -
Apache Camel 2.9.2 (CamelContext: camel-1) is starting
2012-04-29 22:15:27,847 INFO
[org.apache.camel.management.ManagementStrategyFactory] - JMX enabled.
Using ManagedManagementStrategy.
2012-04-29 22:15:27,863 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Starting JMX agent
on server: com.sun.jmx.mbeanserver.JmxMBeanServer@6f878144
2012-04-29 22:15:27,869 INFO
[org.apache.camel.management.DefaultManagementLifecycleStrategy] -
StatisticsLevel at All so enabling load performance statistics
2012-04-29 22:15:27,873 DEBUG
[org.apache.camel.impl.DefaultExecutorServiceManager] - Created new
ScheduledThreadPool for source:
org.apache.camel.management.DefaultManagementLifecycleStrategy@4304c9a6 with
name: ManagementLoadTask. ->
java.util.concurrent.ScheduledThreadPoolExecutor@6f52d3a9
2012-04-29 22:15:27,874 DEBUG
[org.apache.camel.support.TimerListenerManager] - Started scheduled
TimerListener task to run with interval 1000 ms
2012-04-29 22:15:27,925 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=context,name="camel-1"
2012-04-29 22:15:27,925 DEBUG
[org.apache.camel.support.TimerListenerManager] - Added TimerListener:
org.apache.camel.management.mbean.ManagedCamelContext@6115d451
2012-04-29 22:15:27,954 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=DefaultTypeConverter(0x68200cae)
2012-04-29 22:15:28,001 INFO
[org.apache.camel.impl.converter.AnnotationTypeConverterLoader] - Found 3
packages with 15 @Converter classes to load
2012-04-29 22:15:28,474 INFO
[org.apache.camel.impl.converter.DefaultTypeConverter] - Loaded 170 core
type converters (total 170 type converters)
2012-04-29 22:15:28,474 DEBUG
[org.apache.camel.impl.converter.DefaultTypeConverter] - Loading
additional type converters ...
2012-04-29 22:15:28,475 DEBUG
[org.apache.camel.impl.converter.AnnotationTypeConverterLoader] - Loading
file META-INF/services/org/apache/camel/TypeConverter to retrieve list of
packages, from url:
jar:file:/Users/nestor/Downloads/apache-tomcat-7.0.22/krfs-app/ROOT/WEB-INF/lib/camel-core-2.9.2.jar!/META-INF/services/org/apache/camel/TypeConverter
2012-04-29 22:15:28,477 DEBUG
[org.apache.camel.impl.converter.AnnotationTypeConverterLoader] - No
additional package names found in classpath for annotated type converters.
2012-04-29 22:15:28,478 DEBUG
[org.apache.camel.impl.converter.DefaultTypeConverter] - Loading
additional type converters done
2012-04-29 22:15:28,479 INFO
[org.apache.camel.impl.converter.DefaultTypeConverter] - Loaded additional
0 type converters (total 170 type converters) in 0.004 seconds
2012-04-29 22:15:28,483 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=EndpointRegistry(0x9134b1a)
2012-04-29 22:15:28,485 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=DefaultExecutorServiceManager(0x431d8faa)
2012-04-29 22:15:28,486 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=SharedProducerServicePool(0x2014030)
2012-04-29 22:15:28,486 DEBUG
[org.apache.camel.impl.SharedProducerServicePool] - Starting service pool:
org.apache.camel.impl.SharedProducerServicePool@2014030
2012-04-29 22:15:28,487 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=DefaultInflightRepository(0x73c659d3)
2012-04-29 22:15:28,488 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=DefaultShutdownStrategy(0x1000c9c8)
2012-04-29 22:15:28,489 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=DefaultPackageScanClassResolver(0x78731200)
2012-04-29 22:15:28,672 DEBUG
[org.apache.camel.impl.DefaultComponentResolver] - Found component: direct
in registry: null
2012-04-29 22:15:28,673 DEBUG
[org.apache.camel.impl.DefaultComponentResolver] - Found component: direct
via type: org.apache.camel.component.direct.DirectComponent via:
META-INF/services/org/apache/camel/component/direct
2012-04-29 22:15:28,681 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=components,name="direct"
2012-04-29 22:15:28,682 DEBUG [org.apache.camel.impl.DefaultComponent] -
Creating endpoint uri=[direct://start], path=[start], parameters=[{}]
2012-04-29 22:15:28,690 DEBUG [org.apache.camel.spring.SpringCamelContext] -
direct://start converted to endpoint: Endpoint[direct://start] by component:
org.apache.camel.component.direct.DirectComponent@122f8e3e
2012-04-29 22:15:28,691 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=endpoints,name="direct://start"
2012-04-29 22:15:28,736 DEBUG
[org.apache.camel.processor.interceptor.DefaultChannel] - Initialize
channel for target: 'Log[Processing ${id}]'
2012-04-29 22:15:28,750 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=tracer,name=Tracer(0x74730024)
2012-04-29 22:15:28,765 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=errorhandlers,name="DefaultErrorHandlerBuilder(ref:CamelDefaultErrorHandlerBuilder)"
2012-04-29 22:15:28,774 DEBUG [org.apache.camel.spring.SpringCamelContext] -
Warming up route id: route1 having autoStartup=true
2012-04-29 22:15:28,774 DEBUG [org.apache.camel.impl.RouteService] -
Starting services on route: route1
2012-04-29 22:15:28,777 DEBUG [org.apache.camel.impl.RouteService] -
Starting child service on route: route1 ->
Instrumentation:route[DelegateAsync[UnitOfWork(Channel[Log(route1)[Processing
${id}]])]]
2012-04-29 22:15:28,780 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=threadpools,name="DefaultErrorHandler(0x5a0768e0)"
2012-04-29 22:15:28,780 DEBUG
[org.apache.camel.impl.DefaultExecutorServiceManager] - Created new
ScheduledThreadPool for source:
DefaultErrorHandler[TraceInterceptor[Log[Processing ${id}]]] with name:
ErrorHandlerRedeliveryTask. ->
java.util.concurrent.ScheduledThreadPoolExecutor@1c76784d
2012-04-29 22:15:28,780 DEBUG
[org.apache.camel.processor.DefaultErrorHandler] - Redelivery enabled:
false on error handler: DefaultErrorHandler[TraceInterceptor[Log[Processing
${id}]]]
2012-04-29 22:15:28,780 DEBUG [org.apache.camel.impl.RouteService] -
Starting child service on route: route1 ->
DelegateAsync[UnitOfWork(RouteContextProcessor[Channel[Log(route1)[Processing
${id}]]])]
2012-04-29 22:15:28,780 DEBUG [org.apache.camel.impl.RouteService] -
Starting child service on route: route1 ->
UnitOfWork(RouteContextProcessor[Channel[Log(route1)[Processing ${id}]]])
2012-04-29 22:15:28,781 DEBUG [org.apache.camel.impl.RouteService] -
Starting child service on route: route1 -> Channel[Log(route1)[Processing
${id}]]
2012-04-29 22:15:28,789 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=routes,name="route1"
2012-04-29 22:15:28,789 DEBUG
[org.apache.camel.support.TimerListenerManager] - Added TimerListener:
org.apache.camel.management.mbean.ManagedSuspendableRoute@139adc2c
2012-04-29 22:15:28,790 DEBUG [org.apache.camel.spring.SpringCamelContext] -
Route: route1 >>> EventDrivenConsumerRoute[Endpoint[direct://start] ->
Instrumentation:route[DelegateAsync[UnitOfWork(RouteContextProcessor[Channel[Log(route1)[Processing
${id}]]])]]]
2012-04-29 22:15:28,790 DEBUG [org.apache.camel.spring.SpringCamelContext] -
Starting consumer (order: 1000) on route: route1
2012-04-29 22:15:28,793 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=consumers,name=DirectConsumer(0x26e24671)
2012-04-29 22:15:28,793 INFO [org.apache.camel.spring.SpringCamelContext] -
Route: route1 started and consuming from: Endpoint[direct://start]
2012-04-29 22:15:28,793 DEBUG [org.apache.camel.impl.DefaultComponent] -
Creating endpoint uri=[spring-event://default], path=[default],
parameters=[{}]
2012-04-29 22:15:28,794 DEBUG [org.apache.camel.spring.SpringCamelContext] -
spring-event://default converted to endpoint:
Endpoint[spring-event://default] by component:
org.apache.camel.component.event.EventComponent@4d5ec0c6
2012-04-29 22:15:28,795 DEBUG
[org.apache.camel.management.DefaultManagementAgent] - Registered MBean
with objectname:
org.apache.camel:context=nestor-krfs.local/camel-1,type=endpoints,name="spring-event://default"
2012-04-29 22:15:28,796 INFO [org.apache.camel.spring.SpringCamelContext] -
Total 1 routes, of which 1 is started.
2012-04-29 22:15:28,796 INFO [org.apache.camel.spring.SpringCamelContext] -
Apache Camel 2.9.2 (CamelContext: camel-1) started in 0.949 seconds
2012-04-29 22:15:28,802 INFO
[com.krfs.utils.web.ApplicationServletContextListener] - Servlet Context
initialized
2012-04-29 22:15:37,061 DEBUG [org.apache.camel.spring.SpringCamelContext] -
onApplicationEvent:
org.springframework.context.event.ContextRefreshedEvent[source=WebApplicationContext
for namespace 'krfs-servlet': startup date [Sun Apr 29 22:15:28 EDT 2012];
parent: Root WebApplicationContext]
Thanks in advance,
-Nestor
--
View this message in context: http://camel.465427.n5.nabble.com/Logging-from-route-not-working-tp5674964p5674964.html
Sent from the Camel - Users mailing list archive at Nabble.com.
Re: Logging from route not working
Posted by Nestor Urquiza <ne...@gmail.com>.
Thanks Christian. That is of course a good point.
To test this works right away from the container I run the below and I got
the messages as expected:
from("quartz://group1/timer1?job.name=job1&stateful=true&trigger.repeatInterval=5000&trigger.repeatCount=0")
.log(LoggingLevel.INFO, LOG_NAME, "Triggered group1/timer1 ${id}");
Thanks to you all guys for helping me on clarifying how to use the log DSL.
Best regards,
-Nestor
--
View this message in context: http://camel.465427.n5.nabble.com/Logging-from-route-not-working-tp5674964p5676078.html
Sent from the Camel - Users mailing list archive at Nabble.com.
Re: Logging from route not working
Posted by Christian Müller <ch...@gmail.com>.
Did you send a message to your direct endpoint?
Best,
Christian
On Mon, Apr 30, 2012 at 12:54 PM, Nestor Urquiza
<ne...@gmail.com>wrote:
> I have changed the code by:
> private static final String LOG_NAME = SampleRouteBuilder.class.getName();
> private static final Logger log = LoggerFactory.getLogger(LOG_NAME);
> ...
> log.debug("Configuring dummy route");
> from("direct:start").log(LoggingLevel.DEBUG, LOG_NAME, "Processing ${id}");
>
> I still do not get the camel log message. Any ideas?
>
> --
> View this message in context:
> http://camel.465427.n5.nabble.com/Logging-from-route-not-working-tp5674964p5675622.html
> Sent from the Camel - Users mailing list archive at Nabble.com.
>
Re: Logging from route not working
Posted by Nestor Urquiza <ne...@gmail.com>.
I have changed the code by:
private static final String LOG_NAME = SampleRouteBuilder.class.getName();
private static final Logger log = LoggerFactory.getLogger(LOG_NAME);
...
log.debug("Configuring dummy route");
from("direct:start").log(LoggingLevel.DEBUG, LOG_NAME, "Processing ${id}");
I still do not get the camel log message. Any ideas?
--
View this message in context: http://camel.465427.n5.nabble.com/Logging-from-route-not-working-tp5674964p5675622.html
Sent from the Camel - Users mailing list archive at Nabble.com.
Re: Logging from route not working
Posted by Łukasz Dywicki <lu...@code-house.org>.
Use .log(priority, category, message). In your case .log(priority, message) goes to category named as route id. If you have no id set on route it will be generated.
Regards,
Lukasz
Wiadomość napisana przez Claus Ibsen w dniu 30 kwi 2012, o godz. 08:18:
> Its the name such as you define with this code
>
> Logger log =
> LoggerFactory.getLogger(SampleRouteBuilder.class.getName());
>
> Where the name of the logger is this
> SampleRouteBuilder.class.getName()
>
> So if you want to use the same name, then you need to use the above
> name in the Camel log in the DSL.
>
>
>
> On Mon, Apr 30, 2012 at 7:18 AM, Nestor Urquiza
> <ne...@gmail.com> wrote:
>> I am not sure I understand what logName refers to: The final log stream, the
>> appender, the category?
>>
>> Here is my log4j.properties relevant section:
>>
>> log4j.rootLogger=WARN, logfile
>> log4j.appender.logfile=org.apache.log4j.RollingFileAppender
>> log4j.appender.logfile.layout=org.apache.log4j.PatternLayout
>> log4j.appender.logfile.layout.ConversionPattern=%d %p [%c] -
>> %X{remoteAddress} %X{sessionId} %m%n
>> log4j.appender.logfile.File=${catalina.home}/logs/nestorurquiza-app.log
>> log4j.appender.logfile.MaxFileSize=200MB
>> log4j.appender.logfile.MaxBackupIndex=3
>> log4j.logger.com.nestorurquiza.orchestration.camel.route=DEBUG
>>
>> As per your suggestion I used:
>> from("direct:start").log(LoggingLevel.DEBUG, "logfile", "Processing ${id}");
>> and
>> from("direct:start").log(LoggingLevel.DEBUG,
>> "com.nestorurquiza.orchestration.camel.route", "Processing ${id}");
>>
>> --
>> View this message in context: http://camel.465427.n5.nabble.com/Logging-from-route-not-working-tp5674964p5675092.html
>> Sent from the Camel - Users mailing list archive at Nabble.com.
>
>
>
> --
> Claus Ibsen
> -----------------
> CamelOne 2012 Conference, May 15-16, 2012: http://camelone.com
> FuseSource
> Email: cibsen@fusesource.com
> Web: http://fusesource.com
> Twitter: davsclaus, fusenews
> Blog: http://davsclaus.blogspot.com/
> Author of Camel in Action: http://www.manning.com/ibsen/
Re: Logging from route not working
Posted by Claus Ibsen <cl...@gmail.com>.
Its the name such as you define with this code
Logger log =
LoggerFactory.getLogger(SampleRouteBuilder.class.getName());
Where the name of the logger is this
SampleRouteBuilder.class.getName()
So if you want to use the same name, then you need to use the above
name in the Camel log in the DSL.
On Mon, Apr 30, 2012 at 7:18 AM, Nestor Urquiza
<ne...@gmail.com> wrote:
> I am not sure I understand what logName refers to: The final log stream, the
> appender, the category?
>
> Here is my log4j.properties relevant section:
>
> log4j.rootLogger=WARN, logfile
> log4j.appender.logfile=org.apache.log4j.RollingFileAppender
> log4j.appender.logfile.layout=org.apache.log4j.PatternLayout
> log4j.appender.logfile.layout.ConversionPattern=%d %p [%c] -
> %X{remoteAddress} %X{sessionId} %m%n
> log4j.appender.logfile.File=${catalina.home}/logs/nestorurquiza-app.log
> log4j.appender.logfile.MaxFileSize=200MB
> log4j.appender.logfile.MaxBackupIndex=3
> log4j.logger.com.nestorurquiza.orchestration.camel.route=DEBUG
>
> As per your suggestion I used:
> from("direct:start").log(LoggingLevel.DEBUG, "logfile", "Processing ${id}");
> and
> from("direct:start").log(LoggingLevel.DEBUG,
> "com.nestorurquiza.orchestration.camel.route", "Processing ${id}");
>
> --
> View this message in context: http://camel.465427.n5.nabble.com/Logging-from-route-not-working-tp5674964p5675092.html
> Sent from the Camel - Users mailing list archive at Nabble.com.
--
Claus Ibsen
-----------------
CamelOne 2012 Conference, May 15-16, 2012: http://camelone.com
FuseSource
Email: cibsen@fusesource.com
Web: http://fusesource.com
Twitter: davsclaus, fusenews
Blog: http://davsclaus.blogspot.com/
Author of Camel in Action: http://www.manning.com/ibsen/
Re: Logging from route not working
Posted by Nestor Urquiza <ne...@gmail.com>.
I am not sure I understand what logName refers to: The final log stream, the
appender, the category?
Here is my log4j.properties relevant section:
log4j.rootLogger=WARN, logfile
log4j.appender.logfile=org.apache.log4j.RollingFileAppender
log4j.appender.logfile.layout=org.apache.log4j.PatternLayout
log4j.appender.logfile.layout.ConversionPattern=%d %p [%c] -
%X{remoteAddress} %X{sessionId} %m%n
log4j.appender.logfile.File=${catalina.home}/logs/nestorurquiza-app.log
log4j.appender.logfile.MaxFileSize=200MB
log4j.appender.logfile.MaxBackupIndex=3
log4j.logger.com.nestorurquiza.orchestration.camel.route=DEBUG
As per your suggestion I used:
from("direct:start").log(LoggingLevel.DEBUG, "logfile", "Processing ${id}");
and
from("direct:start").log(LoggingLevel.DEBUG,
"com.nestorurquiza.orchestration.camel.route", "Processing ${id}");
--
View this message in context: http://camel.465427.n5.nabble.com/Logging-from-route-not-working-tp5674964p5675092.html
Sent from the Camel - Users mailing list archive at Nabble.com.
Re: Logging from route not working
Posted by Claus Ibsen <cl...@gmail.com>.
On Mon, Apr 30, 2012 at 6:45 AM, Nestor Urquiza
<ne...@gmail.com> wrote:
> Hi Claus,
>
> Thanks for the fast response. Is there a way to ensure they both use the
> same container logger?
>
In the route the log will by default use the route id as the logger
name. You have to specify your custom logger name if you want
something else.
> Thanks,
> -Nestor
>
> --
> View this message in context: http://camel.465427.n5.nabble.com/Logging-from-route-not-working-tp5674964p5675066.html
> Sent from the Camel - Users mailing list archive at Nabble.com.
--
Claus Ibsen
-----------------
CamelOne 2012 Conference, May 15-16, 2012: http://camelone.com
FuseSource
Email: cibsen@fusesource.com
Web: http://fusesource.com
Twitter: davsclaus, fusenews
Blog: http://davsclaus.blogspot.com/
Author of Camel in Action: http://www.manning.com/ibsen/
Re: Logging from route not working
Posted by Nestor Urquiza <ne...@gmail.com>.
Hi Claus,
Thanks for the fast response. Is there a way to ensure they both use the
same container logger?
Thanks,
-Nestor
--
View this message in context: http://camel.465427.n5.nabble.com/Logging-from-route-not-working-tp5674964p5675066.html
Sent from the Camel - Users mailing list archive at Nabble.com.
Re: Logging from route not working
Posted by Claus Ibsen <cl...@gmail.com>.
Hi
Its 2 different logs
The 1st is a regular logger. eg like a Logger instance
The 2nd is part of the Camel route, and thus logs Camel messages.
On Mon, Apr 30, 2012 at 4:21 AM, Nestor Urquiza
<ne...@gmail.com> wrote:
> Hello guys,
>
> I have setup a simple route:
>
> package com.krfs.orchestration.camel.route;
>
> import org.apache.camel.LoggingLevel;
> import org.apache.camel.builder.RouteBuilder;
> import org.slf4j.Logger;
> import org.slf4j.LoggerFactory;
>
> public class SampleRouteBuilder extends RouteBuilder {
> Logger log =
> LoggerFactory.getLogger(SampleRouteBuilder.class.getName());
>
> @Override
> public void configure() {
> log.debug("Configuring dummy route");
> from("direct:start").log(LoggingLevel.DEBUG, "Processing ${id}");
>
> }
> }
>
> Then I get the DEBUG message straight from the code ("Configuring dummy
> route") however I do not get the DEBUG message from within the Camel route
> ("Processing ${id}")
>
> Any ideas why?
>
> 2012-04-29 22:15:27,801 DEBUG
> [com.krfs.orchestration.camel.route.SampleRouteBuilder] - Configuring
> dummy route
> 2012-04-29 22:15:27,845 DEBUG [org.apache.camel.spring.SpringCamelContext] -
> onApplicationEvent:
> org.springframework.context.event.ContextRefreshedEvent[source=Root
> WebApplicationContext: startup date [Sun Apr 29 22:15:00 EDT 2012]; root of
> context hierarchy]
> 2012-04-29 22:15:27,846 INFO [org.apache.camel.spring.SpringCamelContext] -
> Apache Camel 2.9.2 (CamelContext: camel-1) is starting
> 2012-04-29 22:15:27,847 INFO
> [org.apache.camel.management.ManagementStrategyFactory] - JMX enabled.
> Using ManagedManagementStrategy.
> 2012-04-29 22:15:27,863 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Starting JMX agent
> on server: com.sun.jmx.mbeanserver.JmxMBeanServer@6f878144
> 2012-04-29 22:15:27,869 INFO
> [org.apache.camel.management.DefaultManagementLifecycleStrategy] -
> StatisticsLevel at All so enabling load performance statistics
> 2012-04-29 22:15:27,873 DEBUG
> [org.apache.camel.impl.DefaultExecutorServiceManager] - Created new
> ScheduledThreadPool for source:
> org.apache.camel.management.DefaultManagementLifecycleStrategy@4304c9a6 with
> name: ManagementLoadTask. ->
> java.util.concurrent.ScheduledThreadPoolExecutor@6f52d3a9
> 2012-04-29 22:15:27,874 DEBUG
> [org.apache.camel.support.TimerListenerManager] - Started scheduled
> TimerListener task to run with interval 1000 ms
> 2012-04-29 22:15:27,925 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=context,name="camel-1"
> 2012-04-29 22:15:27,925 DEBUG
> [org.apache.camel.support.TimerListenerManager] - Added TimerListener:
> org.apache.camel.management.mbean.ManagedCamelContext@6115d451
> 2012-04-29 22:15:27,954 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=DefaultTypeConverter(0x68200cae)
> 2012-04-29 22:15:28,001 INFO
> [org.apache.camel.impl.converter.AnnotationTypeConverterLoader] - Found 3
> packages with 15 @Converter classes to load
> 2012-04-29 22:15:28,474 INFO
> [org.apache.camel.impl.converter.DefaultTypeConverter] - Loaded 170 core
> type converters (total 170 type converters)
> 2012-04-29 22:15:28,474 DEBUG
> [org.apache.camel.impl.converter.DefaultTypeConverter] - Loading
> additional type converters ...
> 2012-04-29 22:15:28,475 DEBUG
> [org.apache.camel.impl.converter.AnnotationTypeConverterLoader] - Loading
> file META-INF/services/org/apache/camel/TypeConverter to retrieve list of
> packages, from url:
> jar:file:/Users/nestor/Downloads/apache-tomcat-7.0.22/krfs-app/ROOT/WEB-INF/lib/camel-core-2.9.2.jar!/META-INF/services/org/apache/camel/TypeConverter
> 2012-04-29 22:15:28,477 DEBUG
> [org.apache.camel.impl.converter.AnnotationTypeConverterLoader] - No
> additional package names found in classpath for annotated type converters.
> 2012-04-29 22:15:28,478 DEBUG
> [org.apache.camel.impl.converter.DefaultTypeConverter] - Loading
> additional type converters done
> 2012-04-29 22:15:28,479 INFO
> [org.apache.camel.impl.converter.DefaultTypeConverter] - Loaded additional
> 0 type converters (total 170 type converters) in 0.004 seconds
> 2012-04-29 22:15:28,483 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=EndpointRegistry(0x9134b1a)
> 2012-04-29 22:15:28,485 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=DefaultExecutorServiceManager(0x431d8faa)
> 2012-04-29 22:15:28,486 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=SharedProducerServicePool(0x2014030)
> 2012-04-29 22:15:28,486 DEBUG
> [org.apache.camel.impl.SharedProducerServicePool] - Starting service pool:
> org.apache.camel.impl.SharedProducerServicePool@2014030
> 2012-04-29 22:15:28,487 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=DefaultInflightRepository(0x73c659d3)
> 2012-04-29 22:15:28,488 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=DefaultShutdownStrategy(0x1000c9c8)
> 2012-04-29 22:15:28,489 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=services,name=DefaultPackageScanClassResolver(0x78731200)
> 2012-04-29 22:15:28,672 DEBUG
> [org.apache.camel.impl.DefaultComponentResolver] - Found component: direct
> in registry: null
> 2012-04-29 22:15:28,673 DEBUG
> [org.apache.camel.impl.DefaultComponentResolver] - Found component: direct
> via type: org.apache.camel.component.direct.DirectComponent via:
> META-INF/services/org/apache/camel/component/direct
> 2012-04-29 22:15:28,681 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=components,name="direct"
> 2012-04-29 22:15:28,682 DEBUG [org.apache.camel.impl.DefaultComponent] -
> Creating endpoint uri=[direct://start], path=[start], parameters=[{}]
> 2012-04-29 22:15:28,690 DEBUG [org.apache.camel.spring.SpringCamelContext] -
> direct://start converted to endpoint: Endpoint[direct://start] by component:
> org.apache.camel.component.direct.DirectComponent@122f8e3e
> 2012-04-29 22:15:28,691 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=endpoints,name="direct://start"
> 2012-04-29 22:15:28,736 DEBUG
> [org.apache.camel.processor.interceptor.DefaultChannel] - Initialize
> channel for target: 'Log[Processing ${id}]'
> 2012-04-29 22:15:28,750 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=tracer,name=Tracer(0x74730024)
> 2012-04-29 22:15:28,765 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=errorhandlers,name="DefaultErrorHandlerBuilder(ref:CamelDefaultErrorHandlerBuilder)"
> 2012-04-29 22:15:28,774 DEBUG [org.apache.camel.spring.SpringCamelContext] -
> Warming up route id: route1 having autoStartup=true
> 2012-04-29 22:15:28,774 DEBUG [org.apache.camel.impl.RouteService] -
> Starting services on route: route1
> 2012-04-29 22:15:28,777 DEBUG [org.apache.camel.impl.RouteService] -
> Starting child service on route: route1 ->
> Instrumentation:route[DelegateAsync[UnitOfWork(Channel[Log(route1)[Processing
> ${id}]])]]
> 2012-04-29 22:15:28,780 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=threadpools,name="DefaultErrorHandler(0x5a0768e0)"
> 2012-04-29 22:15:28,780 DEBUG
> [org.apache.camel.impl.DefaultExecutorServiceManager] - Created new
> ScheduledThreadPool for source:
> DefaultErrorHandler[TraceInterceptor[Log[Processing ${id}]]] with name:
> ErrorHandlerRedeliveryTask. ->
> java.util.concurrent.ScheduledThreadPoolExecutor@1c76784d
> 2012-04-29 22:15:28,780 DEBUG
> [org.apache.camel.processor.DefaultErrorHandler] - Redelivery enabled:
> false on error handler: DefaultErrorHandler[TraceInterceptor[Log[Processing
> ${id}]]]
> 2012-04-29 22:15:28,780 DEBUG [org.apache.camel.impl.RouteService] -
> Starting child service on route: route1 ->
> DelegateAsync[UnitOfWork(RouteContextProcessor[Channel[Log(route1)[Processing
> ${id}]]])]
> 2012-04-29 22:15:28,780 DEBUG [org.apache.camel.impl.RouteService] -
> Starting child service on route: route1 ->
> UnitOfWork(RouteContextProcessor[Channel[Log(route1)[Processing ${id}]]])
> 2012-04-29 22:15:28,781 DEBUG [org.apache.camel.impl.RouteService] -
> Starting child service on route: route1 -> Channel[Log(route1)[Processing
> ${id}]]
> 2012-04-29 22:15:28,789 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=routes,name="route1"
> 2012-04-29 22:15:28,789 DEBUG
> [org.apache.camel.support.TimerListenerManager] - Added TimerListener:
> org.apache.camel.management.mbean.ManagedSuspendableRoute@139adc2c
> 2012-04-29 22:15:28,790 DEBUG [org.apache.camel.spring.SpringCamelContext] -
> Route: route1 >>> EventDrivenConsumerRoute[Endpoint[direct://start] ->
> Instrumentation:route[DelegateAsync[UnitOfWork(RouteContextProcessor[Channel[Log(route1)[Processing
> ${id}]]])]]]
> 2012-04-29 22:15:28,790 DEBUG [org.apache.camel.spring.SpringCamelContext] -
> Starting consumer (order: 1000) on route: route1
> 2012-04-29 22:15:28,793 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=consumers,name=DirectConsumer(0x26e24671)
> 2012-04-29 22:15:28,793 INFO [org.apache.camel.spring.SpringCamelContext] -
> Route: route1 started and consuming from: Endpoint[direct://start]
> 2012-04-29 22:15:28,793 DEBUG [org.apache.camel.impl.DefaultComponent] -
> Creating endpoint uri=[spring-event://default], path=[default],
> parameters=[{}]
> 2012-04-29 22:15:28,794 DEBUG [org.apache.camel.spring.SpringCamelContext] -
> spring-event://default converted to endpoint:
> Endpoint[spring-event://default] by component:
> org.apache.camel.component.event.EventComponent@4d5ec0c6
> 2012-04-29 22:15:28,795 DEBUG
> [org.apache.camel.management.DefaultManagementAgent] - Registered MBean
> with objectname:
> org.apache.camel:context=nestor-krfs.local/camel-1,type=endpoints,name="spring-event://default"
> 2012-04-29 22:15:28,796 INFO [org.apache.camel.spring.SpringCamelContext] -
> Total 1 routes, of which 1 is started.
> 2012-04-29 22:15:28,796 INFO [org.apache.camel.spring.SpringCamelContext] -
> Apache Camel 2.9.2 (CamelContext: camel-1) started in 0.949 seconds
> 2012-04-29 22:15:28,802 INFO
> [com.krfs.utils.web.ApplicationServletContextListener] - Servlet Context
> initialized
> 2012-04-29 22:15:37,061 DEBUG [org.apache.camel.spring.SpringCamelContext] -
> onApplicationEvent:
> org.springframework.context.event.ContextRefreshedEvent[source=WebApplicationContext
> for namespace 'krfs-servlet': startup date [Sun Apr 29 22:15:28 EDT 2012];
> parent: Root WebApplicationContext]
>
> Thanks in advance,
> -Nestor
>
> --
> View this message in context: http://camel.465427.n5.nabble.com/Logging-from-route-not-working-tp5674964p5674964.html
> Sent from the Camel - Users mailing list archive at Nabble.com.
--
Claus Ibsen
-----------------
CamelOne 2012 Conference, May 15-16, 2012: http://camelone.com
FuseSource
Email: cibsen@fusesource.com
Web: http://fusesource.com
Twitter: davsclaus, fusenews
Blog: http://davsclaus.blogspot.com/
Author of Camel in Action: http://www.manning.com/ibsen/