public void NDLCDeepTest()
{
LogManager.Configuration = XmlLoggingConfiguration.CreateFromXmlString(@"
<nlog>
<targets><target name='debug' type='Debug' layout='${ndlc:topframes=1} ${message}' /></targets>
<rules>
<logger name='*' minlevel='Debug' writeTo='debug' />
</rules>
</nlog>");
NestedDiagnosticsLogicalContext.Clear();
for (int i = 1; i <= 100; ++i)
{
NestedDiagnosticsLogicalContext.Push(i);
}
LogManager.GetLogger("A").Debug("0");
AssertDebugLastMessage("debug", "100 0");
NestedDiagnosticsLogicalContext.PopObject();
LogManager.GetLogger("A").Debug("1");
AssertDebugLastMessage("debug", "99 1");
NestedDiagnosticsLogicalContext.Clear();
LogManager.GetLogger("A").Debug("2");
AssertDebugLastMessage("debug", " 2");
}
public void NDLCTop1TestTest()
{
LogManager.Configuration = XmlLoggingConfiguration.CreateFromXmlString(@"
<nlog>
<targets><target name='debug' type='Debug' layout='${ndlc:topframes=1} ${message}' /></targets>
<rules>
<logger name='*' minlevel='Debug' writeTo='debug' />
</rules>
</nlog>");
NestedDiagnosticsLogicalContext.Clear();
LogManager.GetLogger("A").Debug("0");
AssertDebugLastMessage("debug", " 0");
using (NestedDiagnosticsLogicalContext.Push("ala"))
{
LogManager.GetLogger("A").Debug("a");
AssertDebugLastMessage("debug", "ala a");
using (NestedDiagnosticsLogicalContext.Push("ma"))
{
LogManager.GetLogger("A").Debug("b");
AssertDebugLastMessage("debug", "ma b");
using (NestedDiagnosticsLogicalContext.Push("kota"))
{
LogManager.GetLogger("A").Debug("c");
AssertDebugLastMessage("debug", "kota c");
NestedDiagnosticsLogicalContext.Push("kopytko");
LogManager.GetLogger("A").Debug("d");
AssertDebugLastMessage("debug", "kopytko d");
Assert.Equal("kopytko", NestedDiagnosticsLogicalContext.PopObject()); // manual pop
LogManager.GetLogger("A").Debug("c");
AssertDebugLastMessage("debug", "kota c");
}
LogManager.GetLogger("A").Debug("b");
AssertDebugLastMessage("debug", "ma b");
}
LogManager.GetLogger("A").Debug("a");
AssertDebugLastMessage("debug", "ala a");
}
LogManager.GetLogger("A").Debug("0");
AssertDebugLastMessage("debug", " 0");
Assert.Null(NestedDiagnosticsLogicalContext.Pop()); //inconsistent with NDC - should be string.empty, but for backwardsscomp. Fix in NLog 5
NestedDiagnosticsLogicalContext.Push("zzz");
NestedDiagnosticsLogicalContext.Push("yyy");
Assert.Equal("yyy", NestedDiagnosticsLogicalContext.Pop());
NestedDiagnosticsLogicalContext.Clear();
Assert.Null(NestedDiagnosticsLogicalContext.Pop()); //inconsistent with NDC - should be string.empty, but for backwardsscomp. Fix in NLog 5
}
public void NDLCTop1TestTest()
{
LogManager.Configuration = CreateConfigurationFromString(@"
<nlog>
<targets><target name='debug' type='Debug' layout='${ndlc:topframes=1} ${message}' /></targets>
<rules>
<logger name='*' minlevel='Debug' writeTo='debug' />
</rules>
</nlog>");
NestedDiagnosticsLogicalContext.Clear();
LogManager.GetLogger("A").Debug("0");
AssertDebugLastMessage("debug", " 0");
using (NestedDiagnosticsLogicalContext.Push("ala"))
{
LogManager.GetLogger("A").Debug("a");
AssertDebugLastMessage("debug", "ala a");
using (NestedDiagnosticsLogicalContext.Push("ma"))
{
LogManager.GetLogger("A").Debug("b");
AssertDebugLastMessage("debug", "ma b");
using (NestedDiagnosticsLogicalContext.Push("kota"))
{
LogManager.GetLogger("A").Debug("c");
AssertDebugLastMessage("debug", "kota c");
NestedDiagnosticsLogicalContext.Push("kopytko");
LogManager.GetLogger("A").Debug("d");
AssertDebugLastMessage("debug", "kopytko d");
Assert.Equal("kopytko", NestedDiagnosticsLogicalContext.PopObject()); // manual pop
LogManager.GetLogger("A").Debug("c");
AssertDebugLastMessage("debug", "kota c");
}
LogManager.GetLogger("A").Debug("b");
AssertDebugLastMessage("debug", "ma b");
}
LogManager.GetLogger("A").Debug("a");
AssertDebugLastMessage("debug", "ala a");
}
LogManager.GetLogger("A").Debug("0");
AssertDebugLastMessage("debug", " 0");
Assert.Equal(string.Empty, NestedDiagnosticsLogicalContext.Pop());
NestedDiagnosticsLogicalContext.Push("zzz");
NestedDiagnosticsLogicalContext.Push("yyy");
Assert.Equal("yyy", NestedDiagnosticsLogicalContext.Pop());
NestedDiagnosticsLogicalContext.Clear();
Assert.Equal(string.Empty, NestedDiagnosticsLogicalContext.Pop());
}
public void LegacyNdlcPopShouldNotAffectProperties1()
{
// Arrange
ScopeContext.Clear();
var expectedValue = "World";
var success = false;
object propertyValue;
// Act
using (ScopeContext.PushProperty("Hello", expectedValue))
{
NestedDiagnosticsLogicalContext.PopObject(); // Should not pop anything (skip legacy mode)
success = ScopeContext.TryGetProperty("Hello", out propertyValue);
}
// Assert
Assert.True(success);
Assert.Equal(expectedValue, propertyValue);
}
public void LegacyNdlcPopShouldNotAffectProperties3()
{
// Arrange
ScopeContext.Clear();
var expectedValue1 = "World";
var expectedValue2 = System.Guid.NewGuid();
var expectedNestedState1 = "First Push";
var expectedNestedState2 = System.Guid.NewGuid();
var success1 = false;
var success2 = false;
object propertyValue1;
object propertyValue2;
object nestedState1;
object nestedState2;
// Act
using (ScopeContext.PushProperty("Hello", expectedValue1))
{
ScopeContext.PushNestedState(expectedNestedState1);
ScopeContext.PushNestedState(expectedNestedState2);
using (ScopeContext.PushProperty("RequestId", expectedValue2))
{
nestedState2 = NestedDiagnosticsLogicalContext.PopObject(); // Evil pop where it should leave properties alone (Legacy mode)
nestedState1 = NestedDiagnosticsLogicalContext.PopObject(); // Evil pop where it should leave properties alone (Legacy mode)
success1 = ScopeContext.TryGetProperty("Hello", out propertyValue1);
success2 = ScopeContext.TryGetProperty("RequestId", out propertyValue2);
}
}
// Assert
Assert.True(success1);
Assert.True(success2);
Assert.Equal(expectedValue1, propertyValue1);
Assert.Equal(expectedValue2, propertyValue2);
Assert.Equal(expectedNestedState1, nestedState1);
Assert.Equal(expectedNestedState2, nestedState2);
}
public void LegacyNdlcPopShouldNotAffectProperties2()
{
// Arrange
ScopeContext.Clear();
var expectedValue = "World";
var expectedNestedState = "First Push";
var success = false;
object propertyValue;
object nestedState;
// Act
using (ScopeContext.PushProperty("Hello", expectedValue))
{
ScopeContext.PushNestedState(expectedNestedState);
nestedState = NestedDiagnosticsLogicalContext.PopObject(); // Should only pop active scope (skip legacy mode)
success = ScopeContext.TryGetProperty("Hello", out propertyValue);
}
// Assert
Assert.True(success);
Assert.Equal(expectedValue, propertyValue);
Assert.Equal(expectedNestedState, nestedState);
}