Log4net is a fail-stop logging system. Fail stop means that it stops logging on an internal exception and by design does not interact with the program flow. Knowing this explains you troubleshooting log4net isn’t so easy. If logging fails, your program does not notice. You see a lot of questions about: why is my log4net logging not working? This article explains the basic troubleshooting and most common solutions.
In most cases the first step is to enable internal debugging for log4net.
Enable internal debugging
There are 2 way of enabling internal debugging in log4net:
- Specify the log4net.Internal.Debug option in the application’s config file
- Enable log4net’s internal debug programmatically
Enable internal debugging is in most cases the best option to troubleshoot log4net.
Specify the log4net.Internal.Debug option in the application’s config file
This is the preferred method to enable internal debugging, add the log4net.Internal.Debug key to the app.config file of you application.
<?xml version="1.0" encoding="utf-8" ?> <configuration> <appSettings> <add key="log4net.Internal.Debug" value="true"/> </appSettings> </configuration>
Debug logging will start immediately when the application starts.
Enable log4net’s internal debug programmatically
A second way is to do this programmatically. Set the log4net.Util.LogLog.InternalDebugging property to true:
log4net.Util.LogLog.InternalDebugging = true;
Internal debug log output
Internal debugging messages are written to the console and to the System.Diagnostics.Trace. When you have to console output you can redirect the System.Console.Out. Or you can redirect the trace message to a file:
<configuration> ... <system.diagnostics> <trace autoflush="true"> <listeners> <add name="textWriterTraceListener" type="System.Diagnostics.TextWriterTraceListener" initializeData="C:\tmp\log4net.txt" /> </listeners> </trace> </system.diagnostics> ... </configuration>
Some of the log4net appenders are buffered appenders. These appenders will only log when a certain amount of messages are logged. Some samples are the SmtpAppender, RemotingAppender or the AdoNetAppender. These appenders have a setting BufferSize:
<appender name="AdoNetAppender" type="log4net.Appender.AdoNetAppender"> <bufferSize value="100" /> ... </appender>
This means that the logger will log when there are 100 messages in the buffer. When you want to test the appender you can set the bufferSize to 1.
<bufferSize value="100" />
If you what the buffer to be flushed on an error, you can use an evaluator:
<evaluator type="log4net.Core.LevelEvaluator"> <threshold value="ERROR" /> </evaluator>
If the condition of the evaluator is met, the buffer will be flushed.
Configure() not called, or called multiple times
If you do not see any logging, you can check if Configure() is called in your application. The easiest way is to add it as an attribute to your assembly:
[assembly: log4net.Config.XmlConfigurator(Watch = true)]
Then you do not have to add log4net.Config.XmlConfigurator.Configure() anywhere in your configuration. Or you can add log4net.Config.XmlConfigurator.Configure() in one of your startup methods. Make sure you only call the configuration once.
File appender does not write
If you have a file appender, make sure you are writing to a location where the user is allowed to create and update the files. If not the logging will fail. You can check this when you have internal debugging enabled.
In all cases you have trouble with logging, start with enabling the internal debugging. This will tell you in most cases why log4net stopped logging and gives you probably a hint on how to fix it.
4 thoughts on “Log4Net troubleshooting, debug your configuration”
Log4Net trace information are being correctly logged in the file, but it doesn’t show the date/time for each line/entry. Do you know how could I configure Log4Net tracing with date and time of each event writeen in the log file?
You can add it in the appender. Add a formatter for the logmessages that includes the datatime.
Thanks for the answer. I had already solved it by this afternoon. I won’t be able to test your suggestion, but in case someone else may be trying to solve this same problem, I was able to print the date/time in the Log4Net trace messages by folloing this tutorial in CodeProject website: https://www.codeproject.com/Articles/2680/Writing-custom-NET-trace-listeners
By the way, I think it would be helpful if you let “Notify me of new posts via email.” option checked by default below the “Leave a Reply” box here in your blog, so that your visitors don’t miss your answers to their comments. I had a blog too some years ago, but unfortunately I could’t keep it updated and had to shut it down. Keep up the good work!