Cfrgtkky

I use Nlog to log and i find that i have 5 entries in my log file for every call made to nLog. How can i fix it?
for eg.

2012-12-23 18:18:19.2465 NinjaTrader.Strategy.LODHOD.OnStartUp Debug   startup

2012-12-23 18:18:19.2465 NinjaTrader.Strategy.LODHOD.OnStartUp Debug   startup

2012-12-23 18:18:19.2465 NinjaTrader.Strategy.LODHOD.OnStartUp Debug   startup

2012-12-23 18:18:19.2465 NinjaTrader.Strategy.LODHOD.OnStartUp Debug   startup

2012-12-23 18:18:19.2465 NinjaTrader.Strategy.LODHOD.OnStartUp Debug   startup

2012-12-23 18:18:19.2465 NinjaTrader.Strategy.LODHOD.OnStartUp Debug   startup

My nLog config is as below

/****CLASS LEVEL VARIABLES***/

// Step 1. Create configuration object 

private static LoggingConfiguration config = new LoggingConfiguration();

private static FileTarget fileTarget = new FileTarget();

private static Logger logger = LogManager.GetCurrentClassLogger();

/*** END OF CLASS LEVEL VARIABLES ***/



/*************************NLOG CONFIG*****/



fileTarget.FileName = 

  "C:\temp\" + Instrument.FullName + "nLog." + DateTime.Now.Ticks + ".log";

fileTarget.Layout = 

  "${longdate} ${callsite} ${level} ${event-context:item=StrategyId}  ${message}";



config.AddTarget("file", fileTarget);



// Step 4. Define rules

LoggingRule rule2 = new LoggingRule("*", NLog.LogLevel.Trace, fileTarget);

config.LoggingRules.Add(rule2);



// Step 5. Activate the configuration

LogManager.Configuration = config;





logger.Debug("startup");





/*************************NLOG CONFIG*****/

you can see the starup printed 6 times and it is called only once in the program at the begining of the program in the Ninjatrader onStartup.

I also have the scoped Global Diagnistoc but i dont think that can cause this to happen

public class ScopedGlobalContext : IDisposable

{

  private string n;

  private string v;



  public ScopedGlobalContext(string name, string value)

  {

    n = name;

    v = value;

    NLog.GlobalDiagnosticsContext.Set(n, v);

  }



  public void Dispose()

  {

    NLog.GlobalDiagnosticsContext.Remove(n);

  }

}   

If you have multiple rules that targets for instance file, then you get multiple writes to it.

I had the same thing happen to me. Several searches lead to other people having the same issue, but no solution. I think this is a bug that happens if you're running multiple threads and/or if the logging is being called inside a Linq query. Remember, Linq does always execute immediately. Although this isn't an answer, it should help you find the source of the problem.

WhenRepeated-Filter

Matches when the calculated layout has already been logged. Useful if having an aggressive logger, and wants to throttle the output.

Introduced with NLog ver. 4.5

It looks to be the solution introduced by nlog to debounce/throttle log outputs.