Akka笔记之日志及测试

英文原文链接译文链接,原文作者:Arun Manivannan ,译者:有孚

在前两篇笔记中(第一篇第二篇),我们简单地介绍了一下Actor以及它的消息传递是如何工作的。在本篇中,我们将看下如何解决TeacherActor的日志打印及测试的问题。

简单回顾

前面我们的Actor是这样的:


class TeacherActor extends Actor {

  val quotes = List(
    "Moderation is for cowards",
    "Anything worth doing is worth overdoing",
    "The trouble is you think you have time",
    "You never gonna know if you never even try")

  def receive = {

    case QuoteRequest => {

      import util.Random

      //Get a random Quote from the list and construct a response
      val quoteResponse=QuoteResponse(quotes(Random.nextInt(quotes.size)))

      println (quoteResponse)

    }
  }
}

在Akka中使用slf4j来打印日志

你应该也看到了,在上面的代码中我们将QuoteResponse打印到了控制台上,你一定会觉得这种方式不太好。我们将使用slf4j接口来解决日志打印的问题。

1. 修改类以支持日志打印

Akka通过一个叫做ActorLogging的特质(trait)来实现的这一功能。我们将这个trait混入(mixin)到类里边:


class TeacherLogActor extends Actor with ActorLogging {

   val quotes = List(
    "Moderation is for cowards",
    "Anything worth doing is worth overdoing",
    "The trouble is you think you have time",
    "You never gonna know if you never even try")

  def receive = {

    case QuoteRequest => {

      import util.Random

      //get a random element (for now)
      val quoteResponse=QuoteResponse(quotes(Random.nextInt(quotes.size)))
      log.info(quoteResponse.toString())
    }
  }

  //We'll cover the purpose of this method in the Testing section
  def quoteList=quotes

}

说几句题外话:

当我们要打印一条消息的时候,ActorLogging中的日志方法会将日志信息发布到一个EventStream流中。没错,我的确说的是发布。那么EventStream到底是何方神圣?

EventStream和日志

EventStream就像是一个我们用来发布及接收消息的消息代理。它与常见的消息中间件的根本区别在于EventStream的订阅者只能是一个Actor。

打印消息日志的时候,所有的日志信息都会发布到EventStream里面。DefaultLogger默认是订阅了这些消息的,它只是简单地将消息打印到了标准输出上。


class DefaultLogger extends Actor with StdOutLogger { 
    override def receive: Receive = {
        ...
        case event: LogEvent ⇒ print(event)
    }
}

因此,这就是为什么我们在启动了StudentSimulatorApp之后,消息日志会打印到控制台上的原因。

也就是说,EventStream不光能用来记录日志。它是Actor在同一个虚拟机内的一个通用的发布-订阅机制。

再回头来说下如何配置slf4j:

2. 配置Akka以支持slf4j



akka{ 
    loggers = ["akka.event.slf4j.Slf4jLogger"]
    loglevel = "DEBUG"
    logging-filter = "akka.event.slf4j.Slf4jLoggingFilter"
}

我们把这类信息存储到classpath路径中的一个叫做application.conf的文件里。在我们sbt的目录结构中,它是放在了/main/resources目录下。

从配置信息中我们可以看出:

1. loggers属性指定的是订阅日志事件的Actor。Slf4jLogger要做的就是去消费日志消息,并委托给slf4j日志接口去处理。
2. logLevel属性配置的是日志打印的最小级别
3. loggeing-filter会将配置的logLevel和传进来的日志消息的级别进行比较,把低于logLevel的日志都给过滤掉,然后再发布到EventStream中。

但为什么前面这个例子我们没有用到application.conf呢?

这是因为Akka提供了一些默认值,因此在我们真正使用它之前不用去整一个配置文件。后面我们还会频繁使用到这个文件来定制各式各样的东西。在application.conf中除了日志参数,还有许多很棒的参数以供使用。这里是一个详细的说明

3. 配置logback.xml

现在我们来配置一个通过logback来打印日志的slf4j的logger。


<?xml version="1.0" encoding="UTF-8"?> 
<configuration> 
    <appender name="FILE"
        class="ch.qos.logback.core.rolling.RollingFileAppender">
        <encoder>
            <pattern>%d{HH:mm:ss.SSS} [%thread] %-5level %logger{36} - %msg%n</pattern>
        </encoder>

        <rollingPolicy class="ch.qos.logback.core.rolling.TimeBasedRollingPolicy">
            <fileNamePattern>logs\akka.%d{yyyy-MM-dd}.%i.log</fileNamePattern>
            <timeBasedFileNamingAndTriggeringPolicy class="ch.qos.logback.core.rolling.SizeAndTimeBasedFNATP">
                <maxFileSize>50MB</maxFileSize>
            </timeBasedFileNamingAndTriggeringPolicy>
        </rollingPolicy>
    </appender>

    <root level="DEBUG">
        <appender-ref ref="FILE" />
    </root>
</configuration> 

我把它跟application.conf一道放在了main/resources目录里。请确保main/resources已经在eclipse或者别的IDE的classpath路径中。同时还要在build.sbt中把logback和slf4j-api给包含进来。

当我们再次启动StudentSimulatorApp并发送消息到新的TeacherLogActor的时候,我们所配置的akkaxxxxx.log文件里的内容会是这样的。

image

测试Akka

请注意这绝对不是要覆盖到Akka测试中的所有细节。接下面的部分我们将根据各个用例所对应的主题尽量地测试更多的特性。这些用例旨在覆盖我们前面所写的各个Actor。

既然StudentSimulatorApp已经按需求实现好了,现在是时候给它测试一下了。

Akka提供了一套出色的测试工具来减轻测试时的痛苦,我们可以通过它实现许多不可思议的事情,比如可以查看Actor的内部实现。

讲得差不多了,我们来看下这些测试用例吧。

我们先给StudentSimulatorApp写一个测试用例。

image

先看下声明部分。


class TeacherPreTest extends TestKit(ActorSystem("UniversityMessageSystem")) 
  with WordSpecLike
  with MustMatchers
  with BeforeAndAfterAll {
 

从TestCase的定义中可以看出:

1. TestKit trait接收一个ActorSystem参数,这个是用来创建Actor的。在TestKit的内部实现中,它会对ActorSystem进行封装,并替换掉默认的分发器。
2. 我们使用WordSpec来编写测试用例,这是进行Scala测试的一种很有意思的方式。
3. MustMatcher提供了一些很便利的方法,能让测试用例看起来更像是自然语言。
4. 我们还将BeforeAndAfterAll混入了进来,以便在测试结束时能将ActorSystem关闭掉。trait提供的这个afterAll方法很像是JUnit中的tearDown。

1,2-将消息发送给Actor

1. 第一个测试用例只是把一条消息发送给了PrintActor。它并没有做断言:-(

2. 第二个用例将消息发送给日志Actor并使用ActorLogging里的log对象将消息发布给EventStream。它还是没有进行断言:-(


//1. Sends message to the Print Actor. Not even a testcase actually
  "A teacher" must {

    "print a quote when a QuoteRequest message is sent" in {

      val teacherRef = TestActorRef[TeacherActor]
      teacherRef ! QuoteRequest
    }
  }

  //2. Sends message to the Log Actor. Again, not a testcase per se
  "A teacher with ActorLogging" must {

    "log a quote when a QuoteRequest message is sent" in {

      val teacherRef = TestActorRef[TeacherLogActor]
      teacherRef ! QuoteRequest
    }
   

3 -对Actor的内部状态进行断言判断

第三个用例会使用TestActorRef里的underlyingActor方法并调用TeacherActor内部的quoteList方法。这个方法会返回一个名言的列表。我们会对这个列表的大小进行断言。

如果quoteList失败了,看一下前面提到的TeacherLogActor的代码,找一下这行


//From TeacherLogActor
//We'll cover the purpose of this method in the Testing section
  def quoteList=quotes
 
//3. Asserts the internal State of the Log Actor.
    "have a quote list of size 4" in {

      val teacherRef = TestActorRef[TeacherLogActor]
      teacherRef.underlyingActor.quoteList must have size (4)
      teacherRef.underlyingActor.quoteList must have size (4)
    }
   

4 – 日志消息的断言

我们在前面的EventStream和日志一节已经提到过了,所有的日志消息都会发送给EventStream,SLF4JLogger会订阅这些消息并使用自己的appender将日志写入到日志文件或者控制台中。不过在测试用例里直接从EventStream中订阅并对日志消息本身进行断言不是会更好一点么?看起来貌似是可行的。

要实现这点需要做两件事情:

1. 你需要给TestKit中添加一个额外的配置:


class TeacherTest extends TestKit(ActorSystem("UniversityMessageSystem", ConfigFactory.parseString("""akka.loggers = ["akka.testkit.TestEventListener"]"""))) 
  with WordSpecLike
  with MustMatchers
  with BeforeAndAfterAll {
 

2. 既然已经订阅到EventStream中了,现在我们可以在测试用例中对它进行断言了:


//4. Verifying log messages from eventStream
    "be verifiable via EventFilter in response to a QuoteRequest that is sent" in {

      val teacherRef = TestActorRef[TeacherLogActor]
      EventFilter.info(pattern = "QuoteResponse*", occurrences = 1) intercept {
        teacherRef ! QuoteRequest
      }
    }
   

EventFilter.info块只会拦截以QuoteResponse开头的一条日志消息(pattern=’QuoteResponse*)。(或者写成start=’QuoteResponse’也可以。如果没有日志消息发送给TeacherLogActor,这条测试用例就会失败)。

5 – 对带构造参数的Actor进行测试

请注意在测试用例中我们是通过TestActorRef[TeacherLogActor]而非syste.actorOf来创建Actor的。这么做是因为我们可以通过TeacherLogAcotr的underlyingActor方法来访问Actor的内部属性。而正常情况在运行时通过ActorRef是无法实现这点的。(不过这可不是在生产代码中使用TestActorRef的借口。你会被揍死的)

如果Actor是接受参数的话,那么我们可以这样来创建TestActorRef:


val teacherRef = TestActorRef(new TeacherLogParameterActor(quotes))

完整的测试用例是这样的:


//5. have a quote list of the same size as the input parameter
    " have a quote list of the same size as the input parameter" in {

      val quotes = List(
        "Moderation is for cowards",
        "Anything worth doing is worth overdoing",
        "The trouble is you think you have time",
        "You never gonna know if you never even try")

      val teacherRef = TestActorRef(new TeacherLogParameterActor(quotes))
      //val teacherRef = TestActorRef(Props(new TeacherLogParameterActor(quotes)))

      teacherRef.underlyingActor.quoteList must have size (4)
      EventFilter.info(pattern = "QuoteResponse*", occurrences = 1) intercept {
        teacherRef ! QuoteRequest
      }
    }
   

关闭ActorSystem

最后,到了afterAll方法


override def afterAll() { 
    super.afterAll()
    system.shutdown()
  }
 

代码

同样的,项目的完整代码可以从Github中进行下载。

本文最早发布于我的个人博客: Java译站

原创文章,转载请注明: 转载自并发编程网 – ifeve.com本文链接地址: Akka笔记之日志及测试



-之诸暇

花名有孚,支付宝工程师。

我的个人博客是http://it.deepinmind.com

欢迎关注我的新浪微博:Java译站

Latest posts by -之诸暇 (see all)

FavoriteLoading添加本文到我的收藏
  • Trackback are closed
  • Comments (1)
    • ant
    • 10/28. 2014 3:57pm

    HI,最近有了解AKKA。
    但有些疑问。
    akka的actor之间以mailbox方式对消息进行存储,转发,akka保证一个actor实例,只在一个线程上跑,也保证所收到的消息以串行的方式在这个actor实例上处理,这样就避免了所谓的actor实例内部状态的并发访问和修改。
    1、但我们知道,以java现有的并发库和集合库,是比较容易实现一个基于生产消费者模式,这种单一消费者实例在单线程中串行消费给它的信息的。不至于为此而引入庞大的akka吧?如果想更安全,更可靠些,一些高效的jms实现也有的。
    2、在java并发中,其实我们在解决问题时,之所以要使用多线程,主要还是因为很多情况下,单线程难以满足突发性的高并发请求的(只能利用一个cpu核),于是在线程和cpu核数量可以更多利用的情况下,将请求分发给多个线程来减轻单线程负载,同是有效利用了多核cpu和多线程的能力。
    同一个运行实例,只要是在多线程中跑,而这个运行实例又有自己的内部状态需要更新,则多线程之间一定会存在协调的(虽然会降低性能,但也是综合之后的选择),可是akka怎么样来实现这种功能呢?
    比如有一如下需求
    根据输入posid号,产生一个transNum交晚流水号,要求每一个posid上的交易流水号在每天必须是连续的,中间不得有间断,每天都从1开始递增。
    设计posTransNumActor,它内部维护一个map(posid,transNum)或数组(如果posid数量固定)
    每次请求,都会更新posid对应的trasNum
    问题如下:
    1、这个posTransNumActor只能有一个实例在运行吗?如果想提高它的负载能力,开三个posTransNumActor实例,分别在三个不同线程中专门运行。如何解决?

You must be logged in to post a comment.

return top