La proprietà ThreadContext non scrive su AdoNetAppender

Question

Sto usando log4net 1.2.10.0. Ho esteso ILog e LogManager per includere un nuovo livello, "AUDIT". Voglio usare un AdoNetAppender per registrare il % message in un database. Ho bisogno di altre informazioni registrate e ho provato a usare log4net.ThreadContext.Properties .

Non ottengo alcun output quando provo a utilizzare una proprietà di contesto come valore per un parametro SQL.

<log4net>
  <level>
    <name value="AUDIT" />
    <value value="35000" />
  </level>
  <appender name="AdoNetAppender.Audit" type="log4net.Appender.AdoNetAppender">
    <filter type="log4net.Filter.LevelMatchFilter">
      <levelToMatch value="AUDIT" />
    </filter>
    <filter type="log4net.Filter.DenyAllFilter" />
    <connectionType value="System.Data.OracleClient.OracleConnection, System.Data.OracleClient, Version=1.0.3300.0, Culture=neutral, PublicKeyToken=b77a5c561934e089" />
    <connectionString value="data source=db1;User ID=user;Password=pass" />
    <commandText value="INSERT INTO table1 VALUES(:custom_prop, :message)" />
    <parameter>
      <parameterName value=":custom_prop" />
      <dbType value="String" />
      <layout type="log4net.Layout.PatternLayout">
        <conversionPattern value="%property{custom_prop}" />
      </layout>
    </parameter>
    <parameter>
      <parameterName value=":message" />
      <dbType value="String" />
      <layout type="log4net.Layout.PatternLayout">
        <conversionPattern value="%message" />
      </layout>
    </parameter>
  </appender>
  <root>
    <level value="ALL" />
    <appender-ref ref="AdoNetAppender.Audit" />
  </root>
</log4net>

Il codice di esecuzione è (presupponendo che log4net sia stato avviato e che sia stato creato un logger, 'log').

log4net.ThreadContext.Properties["custom_prop"] = "value";
log.Audit("a message");

L'appender funziona con il filtro AUDIT se codifico un valore invece di utilizzare un parametro SQL.

...
<commandText value="INSERT INTO table1 VALUES('value', :message)" />
...

L'appender funziona con la proprietà context se filtro su un livello integrato, come INFO.

...
<filter type="log4net.Filter.LevelMatchFilter">
  <levelToMatch value="INFO" />
</filter>
...

Un FileAppender funziona con il filtro AUDIT e la proprietà context!

<appender name="FileAppender" type="log4net.Appender.FileAppender" >
  <filter type="log4net.Filter.LevelMatchFilter">
    <levelToMatch value="AUDIT" />
    </filter>
  <filter type="log4net.Filter.DenyAllFilter" />
  <file value="test.log" />
  <layout type="log4net.Layout.PatternLayout" >
    <conversionPattern value="%-5level [%property{custom_prop}] - %message%newline" />
  </layout>
</appender>

Risultato in

AUDIT [value] - a message

L'uso di una proprietà di contesto globale funziona con il filtro AdoNetAppender e AUDIT. Ma ho bisogno della risoluzione del contesto del thread.

log4net.GlobalContext.Properties["custom_prop"] = "value";
log.Audit("a message");

Risultato in

table1
custom_prop message
=========== =======
value       a message

Quindi, non so se si tratta di un problema con AdoNetAppender o con le mie classi estese o la mia configurazione.

Answer 1

Il problema è stato causato dall'aborto precoce del thread in primo piano. Penso che log4net stesse eseguendo un'operazione asincrona. Mettere un sonno alla fine dell'app di test ha risolto il problema

...
log4net.ThreadContext.Properties["custom_prop"] = "value";
log.Audit("a message");
...
Thread.Sleep(1000);

o, se in un thread separato, unirti ad esso

Thread t = new Thread(new ThreadStart(delegate
{
    log4net.ThreadContext.Properties["custom_prop"] = "value";
    log.Audit("a message");        
}));
t.Start();
...
t.Join();

Durante il normale funzionamento, log4net dovrebbe avere abbastanza tempo tra l'ultima chiamata AUDIT e la fine dell'esecuzione.