Missing logs when running inside of Nunit

[sorran]

When using akka.net inside nunit, it seems to removes the console logger and we loose all debug information inside of the actor system for both running inside of intellij rider and using the cli dotnet test -l "console;verbosity=detailed".

I suspect there's some configuration we need to apply to reattach a logger some how but am lost what it could be?

Same if we use serilog loggers or the akka testkit we loose all logs.

As a CLI app the logging all works as expected so I suspect when akka is replacing the loggers we need to configure it to somehow attach to the test logger.

using Akka.Actor;
using Akka.Configuration;
using Akka.Event;
using NUnit.Framework;

namespace AkkaTest;

public class LogTest
{

    [Test]
    public async Task DebugLog()
    {
        Console.WriteLine("Hello world");
        Config config = @" akka {                
            stdout-loglevel = DEBUG

            loglevel = DEBUG

            actor {
              debug {
                receive = on # log any received message
                autoreceive= on # log automatically received messages, e.g. PoisonPill
                lifecycle = on # log actor lifecycle changes
                event-stream = on # log subscription changes for Akka.NET event stream
                unhandled = on # log unhandled messages sent to actors
              }
            }
          }";
        using var sys = ActorSystem.Create("mysystem", config);

        Console.WriteLine("sending");;
        var myActor = sys.ActorOf(Props.Create(() => new MyActor()));
        var response = await myActor.Ask("hello");

        Console.WriteLine($"Received {response}");
    }
    
    class MyActor : ReceiveActor, ILogReceive
    {
        private readonly ILoggingAdapter _log = Logging.GetLogger(Context);

        public MyActor()
        {
            Receive<string>(s =>
            {
                //LOGS MISSING?
                Console.WriteLine("console.writeline was here");
                _log.Info("log.info was here");
                Sender.Tell("ok", Self);
            });
        }
    }

}

<Project Sdk="Microsoft.NET.Sdk">

    <PropertyGroup>
        <TargetFramework>net6.0</TargetFramework>
        <ImplicitUsings>enable</ImplicitUsings>
        <Nullable>enable</Nullable>
    </PropertyGroup>

    
    <ItemGroup>
      <PackageReference Include="Akka" Version="1.5.8" />
      <PackageReference Include="nunit" Version="3.13.3" />
      <PackageReference Include="NUnit3TestAdapter" Version="4.5.0" />
      <PackageReference Include="Microsoft.NET.Test.Sdk" Version="17.7.0-preview.23280.1" />
    </ItemGroup>
    

</Project>

[Arkatufus]

You will need to set up the trace and debug capture inside NUnit: https://docs.nunit.org/articles/vs-test-adapter/Trace-and-Debug.html

[anpin]

for me this solution is not working, I can see logs from the TestKit such as [1] inside every test now, but nothing is logged from the actors spawning in the actual tests. I can set breakpoints inside actors and verify that the log method was invoked.
[1]

[DEBUG][07/05/2023 05:22:07.562Z][Thread 0015][EventStream] subscribing [akka://all-systems/] to channel Akka.Event.Debug
[DEBUG][07/05/2023 05:22:07.569Z][Thread 0015][EventStream] subscribing [akka://all-systems/] to channel Akka.Event.Info
[DEBUG][07/05/2023 05:22:07.569Z][Thread 0015][EventStream] subscribing [akka://all-systems/] to channel Akka.Event.Warning
[DEBUG][07/05/2023 05:22:07.569Z][Thread 0015][EventStream] subscribing [akka://all-systems/] to channel Akka.Event.Error
[DEBUG][07/05/2023 05:22:07.569Z][Thread 0015][EventStream] StandardOutLogger started
[DEBUG][07/05/2023 05:22:07.665Z][Thread 0015][EventStream] subscribing [akka://64d5f35a7af449c4987ed724f8ae52ed/system/UnhandledMessageForwarder#191812260] to channel Akka.Event.UnhandledMessage
[DEBUG][07/05/2023 05:22:07.665Z][Thread 0015][EventStream(64d5f35a7af449c4987ed724f8ae52ed)] StandardOutLogger being removed
[DEBUG][07/05/2023 05:22:07.665Z][Thread 0009][EventStream] subscribing [akka://64d5f35a7af449c4987ed724f8ae52ed/system/log1-DefaultLogger#1169379016] to channel Akka.Event.Debug
[DEBUG][07/05/2023 05:22:07.665Z][Thread 0015][EventStream] unsubscribing [akka://all-systems/] from all channels
[DEBUG][07/05/2023 05:22:07.665Z][Thread 0009][EventStream] subscribing [akka://64d5f35a7af449c4987ed724f8ae52ed/system/log1-DefaultLogger#1169379016] to channel Akka.Event.Info
[DEBUG][07/05/2023 05:22:07.665Z][Thread 0009][EventStream] subscribing [akka://64d5f35a7af449c4987ed724f8ae52ed/system/log1-DefaultLogger#1169379016] to channel Akka.Event.Warning
[DEBUG][07/05/2023 05:22:07.665Z][Thread 0009][EventStream] subscribing [akka://64d5f35a7af449c4987ed724f8ae52ed/system/log1-DefaultLogger#1169379016] to channel Akka.Event.Error
[DEBUG][07/05/2023 05:22:07.665Z][Thread 0009][EventStream(64d5f35a7af449c4987ed724f8ae52ed)] Logger log1-DefaultLogger [Akka.Event.DefaultLogger] started
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0016][EventStreamUnsubscriber] watching [akka://all-systems/] in order to unsubscribe from EventStream when it terminates
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0017][EventStream] subscribing [akka://all-systems/] to channel Akka.Event.Debug
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0016][EventStreamUnsubscriber] watching [akka://all-systems/] in order to unsubscribe from EventStream when it terminates
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0017][EventStream] subscribing [akka://all-systems/] to channel Akka.Event.Info
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0016][EventStreamUnsubscriber] watching [akka://all-systems/] in order to unsubscribe from EventStream when it terminates
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0017][EventStream] subscribing [akka://all-systems/] to channel Akka.Event.Warning
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0016][EventStreamUnsubscriber] watching [akka://all-systems/] in order to unsubscribe from EventStream when it terminates
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0017][EventStream] subscribing [akka://all-systems/] to channel Akka.Event.Error
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0017][EventStream] Shutting down: StandardOutLogger started
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0017][EventStream] unsubscribing [akka://64d5f35a7af449c4987ed724f8ae52ed/system/log1-DefaultLogger#1169379016] from all channels
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0016][EventStreamUnsubscriber] unwatching [akka://64d5f35a7af449c4987ed724f8ae52ed/system/log1-DefaultLogger#1169379016] since has no subscriptions
[DEBUG][07/05/2023 05:22:57.806Z][Thread 0017][EventStream] All default loggers stopped
[DEBUG][07/05/2023 05:22:57.807Z][Thread 0018][akka://64d5f35a7af449c4987ed724f8ae52ed/] received AutoReceiveMessage <Terminated>: [akka://64d5f35a7af449c4987ed724f8ae52ed/system] - ExistenceConfirmed=True