Skip to content

Instantly share code, notes, and snippets.

@ghinch
Created June 7, 2012 04:25
Show Gist options
  • Save ghinch/2886541 to your computer and use it in GitHub Desktop.
Save ghinch/2886541 to your computer and use it in GitHub Desktop.
[INFO] Scanning for projects...
[INFO]
[INFO] ------------------------------------------------------------------------
[INFO] Building Notification 3.7-SNAPSHOT
[INFO] ------------------------------------------------------------------------
[INFO]
[INFO] --- buildnumber-maven-plugin:1.0-beta-3:create (default) @ notification ---
[INFO] Storing buildNumber: 20120606-2119_greg at timestamp: 1339042798936
[INFO]
[INFO] --- maven-antrun-plugin:1.4:run (build-info) @ notification ---
project.artifactId
[INFO] Executing tasks
[echo] Compiling build information to build.properties
[mkdir] Created dir: /Users/greg/Projects/emi/code/notification/target/classes
[propertyfile] Creating new property file: /Users/greg/Projects/emi/code/notification/target/classes/emi-build.properties
[INFO] Executed tasks
[INFO]
[INFO] --- maven-resources-plugin:2.4.3:resources (default-resources) @ notification ---
[INFO] Using 'utf-8' encoding to copy filtered resources.
[INFO] Copying 2 resources
[INFO]
[INFO] --- scala-maven-plugin:3.0.1:add-source (scala-compile-first) @ notification ---
[INFO] Add Source directory: /Users/greg/Projects/emi/code/notification/src/main/scala
[INFO] Add Test Source directory: /Users/greg/Projects/emi/code/notification/src/test/scala
[INFO]
[INFO] --- scala-maven-plugin:3.0.1:compile (scala-compile-first) @ notification ---
[INFO] Checking for multiple versions of scala
[INFO] includes = [**/*.scala,**/*.java,]
[INFO] excludes = []
[INFO] /Users/greg/Projects/emi/code/notification/src/main/java:-1: info: compiling
[INFO] /Users/greg/Projects/emi/code/notification/src/main/scala:-1: info: compiling
[INFO] Compiling 32 source files to /Users/greg/Projects/emi/code/notification/target/classes at 1339042804834
[WARNING] warning: there were 4 unchecked warnings; re-run with -unchecked for details
[WARNING] one warning found
[INFO] prepare-compile in 0 s
[INFO] compile in 39 s
[INFO]
[INFO] --- maven-compiler-plugin:2.3.2:compile (default-compile) @ notification ---
[INFO] Compiling 7 source files to /Users/greg/Projects/emi/code/notification/target/classes
[INFO]
[INFO] --- maven-resources-plugin:2.4.3:testResources (default-testResources) @ notification ---
[INFO] Using 'utf-8' encoding to copy filtered resources.
[INFO] Copying 1 resource
[INFO]
[INFO] --- scala-maven-plugin:3.0.1:testCompile (scala-test-compile) @ notification ---
[INFO] Checking for multiple versions of scala
[INFO] includes = [**/*.scala,**/*.java,]
[INFO] excludes = []
[INFO] /Users/greg/Projects/emi/code/notification/src/test/scala:-1: info: compiling
[INFO] Compiling 13 source files to /Users/greg/Projects/emi/code/notification/target/test-classes at 1339042846717
[INFO] prepare-compile in 0 s
[INFO] compile in 23 s
[INFO]
[INFO] --- maven-compiler-plugin:2.3.2:testCompile (default-testCompile) @ notification ---
[INFO] Nothing to compile - all classes are up to date
[INFO]
[INFO] --- maven-surefire-plugin:2.9:test (default-test) @ notification ---
[INFO] Surefire report directory: /Users/greg/Projects/emi/code/notification/target/surefire-reports
-------------------------------------------------------
T E S T S
-------------------------------------------------------
Running emi.emsrest.counters.svc.CookieValidatorTest
Tests run: 5, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.606 sec
Running emi.emsrest.counters.svc.CountersCrudTest
06/06 21:21:12 DEBUG[main] e.r.u.RedisTestUtils - Checking port 18091 for availability.
06/06 21:21:12 DEBUG[main] e.r.u.RedisTestUtils - Port 18091 is available.
06/06 21:21:12 INFO [main] e.e.c.s.f.EmbeddedWebAppContainer - Starting Redis, Akka, and Spray
06/06 21:21:12 DEBUG[main] e.r.u.RedisTestUtils - Checking port 14628 for availability.
06/06 21:21:12 DEBUG[main] e.r.u.RedisTestUtils - Port 14628 is available.
06/06 21:21:12 INFO [main] e.r.u.RedisTestUtils - Found open port 14628 to run Redis on.
06/06 21:21:12 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-1769419320981385402.conf.
06/06 21:21:12 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-3185133168906253064.rdb for Redis on-disk storage.
[Redis STDOUT] [45451] 06 Jun 21:21:12 * Server started, Redis version 2.4.13
[Redis STDOUT] [45451] 06 Jun 21:21:12 * The server is now ready to accept connections on port 14628
[Redis STDOUT] [45451] 06 Jun 21:21:12 - 0 clients connected (0 slaves), 922304 bytes in use
Starting Akka...
06/06 21:21:13 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:13 INFO [main] e.e.c.s.Janitor - Maximum heartbeat interval is 300 milliseconds.
06/06 21:21:13 INFO [main] e.n.TestBoot - Redis client configured for localhost:14628
[Redis STDOUT] [45451] 06 Jun 21:21:13 - Accepted 127.0.0.1:52869
06/06 21:21:13 WARN [main] c.s.SprayServerSettings$ - Akka.conf contains one or more unknown settings: 'spray.relaxed-header-parsing'
06/06 21:21:14 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
06/06 21:21:14 INFO [akka:event-driven:dispatcher:global-2] c.s.HttpService - HTTP Service started
06/06 21:21:14 INFO [main] c.s.c.HttpServer - Starting spray-can HTTP server on localhost/127.0.0.1:18091
Akka started successfully
06/06 21:21:14 DEBUG[main] e.e.c.s.f.EmbeddedWebAppContainer - Hitting http://localhost:18091/v2/ping
06/06 21:21:14 INFO [main] dispatch - localhost GET /v2/ping HTTP/1.1
06/06 21:21:14 INFO [akka:event-driven:dispatcher:global-7] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:14 INFO [akka:event-driven:dispatcher:global-3] c.s.SprayCanRootService - spray RootService started
06/06 21:21:14 INFO [main] dispatch - localhost POST /v2/admin/cookie_key HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-10] e.n.Boot$$anon$2 - EMSREST Cookie digest key has been set.
06/06 21:21:15 INFO [main] e.e.c.s.CountersCrudTest - ---------------->>>>> Running test testAddMultiple on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] o.a.h.testcycle - ---------------->>>>> Running test testAddMultiple on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/apple/alice/EDITING HTTP/1.1
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/banana/bob/EDITING HTTP/1.1
06/06 21:21:15 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-5] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 DEBUG[main] e.e.c.s.CountersCrudTest - ---------------..... Done test testAddMultiple on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/admin/counters/reset HTTP/1.1
06/06 21:21:15 DEBUG[akka:event-driven:dispatcher:global-1] e.e.c.s.Janitor - Clean-up queue has been reset.
06/06 21:21:15 INFO [main] e.e.c.s.CountersCrudTest - ---------------->>>>> Running test testConflict on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] o.a.h.testcycle - ---------------->>>>> Running test testConflict on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/apple/alice/EDITING HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-8] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/apple/adam/SUBMISSION_PROCESSING HTTP/1.1
06/06 21:21:15 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:15 DEBUG[main] e.e.c.s.CountersCrudTest - ---------------..... Done test testConflict on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/admin/counters/reset HTTP/1.1
06/06 21:21:15 DEBUG[akka:event-driven:dispatcher:global-2] e.e.c.s.Janitor - Clean-up queue has been reset.
06/06 21:21:15 INFO [main] e.e.c.s.CountersCrudTest - ---------------->>>>> Running test testConflictOverride on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] o.a.h.testcycle - ---------------->>>>> Running test testConflictOverride on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/apple/alice/EDITING HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-7] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost PUT /v2/counters/apple/adam/SUBMISSION_PROCESSING HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:15 DEBUG[main] e.e.c.s.CountersCrudTest - ---------------..... Done test testConflictOverride on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/admin/counters/reset HTTP/1.1
06/06 21:21:15 DEBUG[akka:event-driven:dispatcher:global-16] e.e.c.s.Janitor - Clean-up queue has been reset.
06/06 21:21:15 INFO [main] e.e.c.s.CountersCrudTest - ---------------->>>>> Running test testEmptySummary on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] o.a.h.testcycle - ---------------->>>>> Running test testEmptySummary on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:15 DEBUG[main] e.e.c.s.CountersCrudTest - ---------------..... Done test testEmptySummary on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/admin/counters/reset HTTP/1.1
06/06 21:21:15 DEBUG[akka:event-driven:dispatcher:global-5] e.e.c.s.Janitor - Clean-up queue has been reset.
06/06 21:21:15 INFO [main] e.e.c.s.CountersCrudTest - ---------------->>>>> Running test testRemoveOneOfMany on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] o.a.h.testcycle - ---------------->>>>> Running test testRemoveOneOfMany on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/apple/alice/EDITING HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-8] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost PUT /v2/counters/apple/adam/SUBMISSION_PROCESSING HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-13] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/banana/bob/EDITING HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-16] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost DELETE /v2/counters/apple/alice HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:15 DEBUG[main] e.e.c.s.CountersCrudTest - ---------------..... Done test testRemoveOneOfMany on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/admin/counters/reset HTTP/1.1
06/06 21:21:15 DEBUG[akka:event-driven:dispatcher:global-3] e.e.c.s.Janitor - Clean-up queue has been reset.
06/06 21:21:15 INFO [main] e.e.c.s.CountersCrudTest - ---------------->>>>> Running test testSimpleAdd on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] o.a.h.testcycle - ---------------->>>>> Running test testSimpleAdd on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/apple/alice/EDITING HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-11] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:15 DEBUG[main] e.e.c.s.CountersCrudTest - ---------------..... Done test testSimpleAdd on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/admin/counters/reset HTTP/1.1
06/06 21:21:15 DEBUG[akka:event-driven:dispatcher:global-16] e.e.c.s.Janitor - Clean-up queue has been reset.
06/06 21:21:15 INFO [main] e.e.c.s.CountersCrudTest - ---------------->>>>> Running test testSimpleRemove on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] o.a.h.testcycle - ---------------->>>>> Running test testSimpleRemove on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/apple/alice/EDITING HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-5] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:15 INFO [main] dispatch - localhost DELETE /v2/counters/apple/alice HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:15 DEBUG[main] e.e.c.s.CountersCrudTest - ---------------..... Done test testSimpleRemove on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/admin/counters/reset HTTP/1.1
06/06 21:21:15 DEBUG[akka:event-driven:dispatcher:global-12] e.e.c.s.Janitor - Clean-up queue has been reset.
06/06 21:21:15 INFO [main] e.e.c.s.f.EmbeddedWebAppContainer - Stopping Redis, Akka, and Spray
Shutting down Akka...
06/06 21:21:15 INFO [main] c.s.c.HttpServer - Stopped spray-can HTTP server on localhost/127.0.0.1:18091
06/06 21:21:15 INFO [main] c.s.HttpService - Stopped
06/06 21:21:15 INFO [main] c.s.SprayCanRootService - spray RootService stopped
Akka succesfully shut down
06/06 21:21:15 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
[Redis STDOUT] [45451] 06 Jun 21:21:15 # Received SIGTERM, scheduling shutdown...
06/06 21:21:15 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:15 INFO [main] e.e.c.s.f.EmbeddedWebAppContainer - Stopped Redis, Akka, and Spray
Tests run: 7, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 3.229 sec
Running emi.emsrest.counters.svc.CountersExpirationTest
06/06 21:21:15 DEBUG[main] e.r.u.RedisTestUtils - Checking port 18091 for availability.
06/06 21:21:15 DEBUG[main] e.r.u.RedisTestUtils - Port 18091 is available.
06/06 21:21:15 INFO [main] e.e.c.s.f.EmbeddedWebAppContainer - Starting Redis, Akka, and Spray
06/06 21:21:15 DEBUG[main] e.r.u.RedisTestUtils - Checking port 10816 for availability.
06/06 21:21:15 DEBUG[main] e.r.u.RedisTestUtils - Port 10816 is available.
06/06 21:21:15 INFO [main] e.r.u.RedisTestUtils - Found open port 10816 to run Redis on.
06/06 21:21:15 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-7222713209582505839.conf.
06/06 21:21:15 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-1146011611798649669.rdb for Redis on-disk storage.
Starting Akka...
[Redis STDOUT] [45452] 06 Jun 21:21:15 * Server started, Redis version 2.4.13
[Redis STDOUT] [45452] 06 Jun 21:21:15 * The server is now ready to accept connections on port 10816
[Redis STDOUT] [45452] 06 Jun 21:21:15 - 0 clients connected (0 slaves), 922304 bytes in use
06/06 21:21:15 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:15 INFO [main] e.e.c.s.Janitor - Maximum heartbeat interval is 300 milliseconds.
06/06 21:21:15 INFO [main] e.n.TestBoot - Redis client configured for localhost:10816
[Redis STDOUT] [45452] 06 Jun 21:21:15 - Accepted 127.0.0.1:52872
06/06 21:21:15 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-7] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-1] c.s.HttpService - HTTP Service started
06/06 21:21:15 INFO [main] c.s.c.HttpServer - Starting spray-can HTTP server on localhost/127.0.0.1:18091
Akka started successfully
06/06 21:21:15 DEBUG[main] e.e.c.s.f.EmbeddedWebAppContainer - Hitting http://localhost:18091/v2/ping
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-8] c.s.SprayCanRootService - spray RootService started
06/06 21:21:15 INFO [main] dispatch - localhost GET /v2/ping HTTP/1.1
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/admin/cookie_key HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-10] e.n.Boot$$anon$2 - EMSREST Cookie digest key has been set.
06/06 21:21:15 INFO [main] e.e.c.s.CountersExpirationTest - ---------------->>>>> Running test testExpirationRemovesConflict on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] o.a.h.testcycle - ---------------->>>>> Running test testExpirationRemovesConflict on Thread Thread[main,5,main] ----
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/apple/alice/EDITING HTTP/1.1
06/06 21:21:15 INFO [akka:event-driven:dispatcher:global-17] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:15 INFO [main] dispatch - localhost POST /v2/counters/apple/adam/SUBMISSION_PROCESSING HTTP/1.1
06/06 21:21:16 DEBUG[ForkJoinPool-2-worker-3] e.e.c.s.Janitor - Heartbeat expired for user alice on item apple
06/06 21:21:16 INFO [akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:16 INFO [main] dispatch - localhost POST /v2/counters/apple/adam/SUBMISSION_PROCESSING HTTP/1.1
06/06 21:21:16 INFO [akka:event-driven:dispatcher:global-7] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:16 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:16 DEBUG[main] e.e.c.s.CountersExpirationTest - ---------------..... Done test testExpirationRemovesConflict on Thread Thread[main,5,main] ----
06/06 21:21:16 INFO [main] dispatch - localhost POST /v2/admin/counters/reset HTTP/1.1
06/06 21:21:16 DEBUG[akka:event-driven:dispatcher:global-10] e.e.c.s.Janitor - Clean-up queue has been reset.
06/06 21:21:16 INFO [main] e.e.c.s.CountersExpirationTest - ---------------->>>>> Running test testHeartbeat on Thread Thread[main,5,main] ----
06/06 21:21:16 INFO [main] o.a.h.testcycle - ---------------->>>>> Running test testHeartbeat on Thread Thread[main,5,main] ----
06/06 21:21:16 INFO [main] dispatch - localhost POST /v2/counters/apple/alice/EDITING HTTP/1.1
06/06 21:21:16 INFO [akka:event-driven:dispatcher:global-12] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:16 INFO [main] dispatch - localhost PUT /v2/counters/apple/alex/EDITING HTTP/1.1
06/06 21:21:16 INFO [akka:event-driven:dispatcher:global-5] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:16 INFO [main] dispatch - localhost POST /v2/counters/banana/bob/EDITING HTTP/1.1
06/06 21:21:16 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:16 INFO [main] dispatch - localhost POST /v2/counters/apple/alex/EDITING HTTP/1.1
06/06 21:21:16 INFO [main] dispatch - localhost POST /v2/counters/banana/bob/EDITING HTTP/1.1
06/06 21:21:16 DEBUG[ForkJoinPool-2-worker-0] e.e.c.s.Janitor - Heartbeat expired for user alice on item apple
06/06 21:21:16 INFO [akka:event-driven:dispatcher:global-16] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:16 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:16 DEBUG[main] e.e.c.s.CountersExpirationTest - ---------------..... Done test testHeartbeat on Thread Thread[main,5,main] ----
06/06 21:21:16 INFO [main] dispatch - localhost POST /v2/admin/counters/reset HTTP/1.1
06/06 21:21:16 DEBUG[akka:event-driven:dispatcher:global-5] e.e.c.s.Janitor - Clean-up queue has been reset.
06/06 21:21:16 INFO [main] e.e.c.s.CountersExpirationTest - ---------------->>>>> Running test testSimpleExpiration on Thread Thread[main,5,main] ----
06/06 21:21:16 INFO [main] o.a.h.testcycle - ---------------->>>>> Running test testSimpleExpiration on Thread Thread[main,5,main] ----
06/06 21:21:16 INFO [main] dispatch - localhost POST /v2/counters/apple/alice/EDITING HTTP/1.1
06/06 21:21:16 INFO [akka:event-driven:dispatcher:global-11] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:17 DEBUG[ForkJoinPool-2-worker-2] e.e.c.s.Janitor - Heartbeat expired for user alice on item apple
06/06 21:21:17 INFO [akka:event-driven:dispatcher:global-14] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:17 INFO [main] dispatch - localhost GET /v2/admin/counters/summary HTTP/1.1
06/06 21:21:17 DEBUG[main] e.e.c.s.CountersExpirationTest - ---------------..... Done test testSimpleExpiration on Thread Thread[main,5,main] ----
06/06 21:21:17 INFO [main] dispatch - localhost POST /v2/admin/counters/reset HTTP/1.1
06/06 21:21:17 DEBUG[akka:event-driven:dispatcher:global-3] e.e.c.s.Janitor - Clean-up queue has been reset.
06/06 21:21:17 INFO [main] e.e.c.s.f.EmbeddedWebAppContainer - Stopping Redis, Akka, and Spray
Shutting down Akka...
06/06 21:21:17 INFO [main] c.s.c.HttpServer - Stopped spray-can HTTP server on localhost/127.0.0.1:18091
06/06 21:21:17 INFO [main] c.s.SprayCanRootService - spray RootService stopped
06/06 21:21:17 INFO [main] c.s.HttpService - Stopped
Akka succesfully shut down
06/06 21:21:17 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:17 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:17 INFO [main] e.e.c.s.f.EmbeddedWebAppContainer - Stopped Redis, Akka, and Spray
Tests run: 3, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 1.753 sec
Running emi.emsrest.counters.svc.PollingTest
06/06 21:21:17 DEBUG[main] e.r.u.RedisTestUtils - Checking port 18091 for availability.
06/06 21:21:17 DEBUG[main] e.r.u.RedisTestUtils - Port 18091 is available.
06/06 21:21:17 INFO [main] e.e.c.s.f.EmbeddedWebAppContainer - Starting Redis, Akka, and Spray
06/06 21:21:17 DEBUG[main] e.r.u.RedisTestUtils - Checking port 11406 for availability.
06/06 21:21:17 DEBUG[main] e.r.u.RedisTestUtils - Port 11406 is available.
06/06 21:21:17 INFO [main] e.r.u.RedisTestUtils - Found open port 11406 to run Redis on.
06/06 21:21:17 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-2910784300743448827.conf.
06/06 21:21:17 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-4441011768037790481.rdb for Redis on-disk storage.
Starting Akka...
06/06 21:21:17 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:17 INFO [main] e.e.c.s.Janitor - Maximum heartbeat interval is 300 milliseconds.
[Redis STDOUT] [45453] 06 Jun 21:21:17 * Server started, Redis version 2.4.13
[Redis STDOUT] [45453] 06 Jun 21:21:17 * The server is now ready to accept connections on port 11406
[Redis STDOUT] [45453] 06 Jun 21:21:17 - 0 clients connected (0 slaves), 922304 bytes in use
06/06 21:21:17 INFO [main] e.n.TestBoot - Redis client configured for localhost:11406
[Redis STDOUT] [45453] 06 Jun 21:21:17 - Accepted 127.0.0.1:52884
06/06 21:21:17 WARN [Finalizer] dispatch - Shutting down garbage-collected HttpExecutor--Call shutdown() explicitly to avoid resource leaks!
06/06 21:21:17 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
06/06 21:21:17 INFO [akka:event-driven:dispatcher:global-6] c.s.HttpService - HTTP Service started
06/06 21:21:17 INFO [main] c.s.c.HttpServer - Starting spray-can HTTP server on localhost/127.0.0.1:18091
06/06 21:21:17 INFO [akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:17 INFO [akka:event-driven:dispatcher:global-6] c.s.SprayCanRootService - spray RootService started
Akka started successfully
06/06 21:21:17 DEBUG[main] e.e.c.s.f.EmbeddedWebAppContainer - Hitting http://localhost:18091/v2/ping
06/06 21:21:17 INFO [main] dispatch - localhost GET /v2/ping HTTP/1.1
06/06 21:21:17 INFO [main] dispatch - localhost POST /v2/admin/cookie_key HTTP/1.1
06/06 21:21:17 INFO [akka:event-driven:dispatcher:global-10] e.n.Boot$$anon$2 - EMSREST Cookie digest key has been set.
06/06 21:21:17 INFO [main] e.e.c.s.f.EmbeddedWebAppContainer - Stopping Redis, Akka, and Spray
Shutting down Akka...
06/06 21:21:17 INFO [main] c.s.SprayCanRootService - spray RootService stopped
06/06 21:21:17 INFO [main] c.s.c.HttpServer - Stopped spray-can HTTP server on localhost/127.0.0.1:18091
06/06 21:21:17 INFO [main] c.s.HttpService - Stopped
Akka succesfully shut down
06/06 21:21:17 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:17 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:17 INFO [main] e.e.c.s.f.EmbeddedWebAppContainer - Stopped Redis, Akka, and Spray
Tests run: 0, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.33 sec
Running emi.notification.BroadcastTest
06/06 21:21:17 DEBUG[main] e.r.u.RedisTestUtils - Checking port 10523 for availability.
06/06 21:21:17 DEBUG[main] e.r.u.RedisTestUtils - Port 10523 is available.
06/06 21:21:17 INFO [main] e.r.u.RedisTestUtils - Found open port 10523 to run Redis on.
06/06 21:21:17 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-8245273878606565524.conf.
06/06 21:21:17 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-3173082680761432226.rdb for Redis on-disk storage.
[Redis STDOUT] [45454] 06 Jun 21:21:17 * Server started, Redis version 2.4.13
[Redis STDOUT] [45454] 06 Jun 21:21:17 * The server is now ready to accept connections on port 10523
[Redis STDOUT] [45454] 06 Jun 21:21:17 - 0 clients connected (0 slaves), 922304 bytes in use
Starting Akka...
06/06 21:21:17 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:17 INFO [main] e.n.TestBoot - Redis client configured for localhost:10523
[Redis STDOUT] [45454] 06 Jun 21:21:17 - Accepted 127.0.0.1:52892
06/06 21:21:17 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
[Redis STDOUT] [45454] 06 Jun 21:21:17 - Accepted 127.0.0.1:52895
06/06 21:21:17 DEBUG[akka:event-driven:dispatcher:global-2] e.n.c.Dispatcher - Register connection for annie (NEW session 3a3c8180-b058-11e1-bee6-c42c031ccf85) with 0 pending messages
06/06 21:21:17 DEBUG[akka:event-driven:dispatcher:global-2] e.n.c.Dispatcher - Register connection for bert (NEW session 3a4ab250-b058-11e1-bee6-c42c031ccf85) with 0 pending messages
06/06 21:21:17 INFO [akka:event-driven:dispatcher:global-2] e.n.c.Dispatcher - BROADCAST FixationEditState -> 2 listeners
06/06 21:21:17 DEBUG[akka:event-driven:dispatcher:global-12] e.n.c.LongPollingClientConnectionActor - DELIVER FixationEditState -> annie (session 3a3c8180-b058-11e1-bee6-c42c031ccf85)
06/06 21:21:17 DEBUG[akka:event-driven:dispatcher:global-16] e.n.c.LongPollingClientConnectionActor - DELIVER FixationEditState -> bert (session 3a4ab250-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
Akka succesfully shut down
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Checking port 12625 for availability.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Port 12625 is available.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Found open port 12625 to run Redis on.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-8391772625559158451.conf.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-6234396778548546644.rdb for Redis on-disk storage.
Starting Akka...
[Redis STDOUT] [45455] 06 Jun 21:21:18 * Server started, Redis version 2.4.13
[Redis STDOUT] [45455] 06 Jun 21:21:18 * The server is now ready to accept connections on port 12625
[Redis STDOUT] [45455] 06 Jun 21:21:18 - 0 clients connected (0 slaves), 922304 bytes in use
06/06 21:21:18 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:18 INFO [main] e.n.TestBoot - Redis client configured for localhost:12625
[Redis STDOUT] [45455] 06 Jun 21:21:18 - Accepted 127.0.0.1:52898
06/06 21:21:18 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
[Redis STDOUT] [45455] 06 Jun 21:21:18 - Accepted 127.0.0.1:52900
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-3] e.n.c.Dispatcher - Register connection for chaucer (NEW session 3a5bf060-b058-11e1-bee6-c42c031ccf85) with 0 pending messages
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-3] e.n.c.Dispatcher - Register connection for chaucer (NEW session 3a5c6590-b058-11e1-bee6-c42c031ccf85) with 0 pending messages
06/06 21:21:18 INFO [akka:event-driven:dispatcher:global-3] e.n.c.Dispatcher - BROADCAST FixationEditState -> 2 listeners
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-6] e.n.c.LongPollingClientConnectionActor - DELIVER FixationEditState -> chaucer (session 3a5bf060-b058-11e1-bee6-c42c031ccf85)
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-3] e.n.c.LongPollingClientConnectionActor - DELIVER FixationEditState -> chaucer (session 3a5c6590-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
Akka succesfully shut down
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Checking port 11065 for availability.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Port 11065 is available.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Found open port 11065 to run Redis on.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-9161317403752515643.conf.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-8622940345040788374.rdb for Redis on-disk storage.
Starting Akka...
[Redis STDOUT] [45456] 06 Jun 21:21:18 * Server started, Redis version 2.4.13
[Redis STDOUT] [45456] 06 Jun 21:21:18 * The server is now ready to accept connections on port 11065
[Redis STDOUT] [45456] 06 Jun 21:21:18 - 0 clients connected (0 slaves), 922304 bytes in use
06/06 21:21:18 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:18 INFO [main] e.n.TestBoot - Redis client configured for localhost:11065
[Redis STDOUT] [45456] 06 Jun 21:21:18 - Accepted 127.0.0.1:52905
06/06 21:21:18 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
[Redis STDOUT] [45456] 06 Jun 21:21:18 - Accepted 127.0.0.1:52906
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-11] e.n.c.Dispatcher - Register connection for derrick (NEW session 3a70b0e0-b058-11e1-bee6-c42c031ccf85) with 0 pending messages
06/06 21:21:18 INFO [akka:event-driven:dispatcher:global-11] e.n.c.Dispatcher - BROADCAST FixationEditState -> 1 listeners
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-10] e.n.c.LongPollingClientConnectionActor - DELIVER FixationEditState -> derrick (session 3a70b0e0-b058-11e1-bee6-c42c031ccf85)
06/06 21:21:18 INFO [akka:event-driven:dispatcher:global-15] e.n.c.Dispatcher - BROADCAST FixationEditState -> 1 listeners
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-15] e.n.c.LongPollingClientConnectionActor - DELIVER FixationEditState -> derrick (session 3a70b0e0-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
Akka succesfully shut down
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Checking port 13033 for availability.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Port 13033 is available.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Found open port 13033 to run Redis on.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-1802193421720680885.conf.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-7542245418299315963.rdb for Redis on-disk storage.
Starting Akka...
[Redis STDOUT] [45457] 06 Jun 21:21:18 * Server started, Redis version 2.4.13
[Redis STDOUT] [45457] 06 Jun 21:21:18 * The server is now ready to accept connections on port 13033
[Redis STDOUT] [45457] 06 Jun 21:21:18 - 0 clients connected (0 slaves), 922304 bytes in use
06/06 21:21:18 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:18 INFO [main] e.n.TestBoot - Redis client configured for localhost:13033
[Redis STDOUT] [45457] 06 Jun 21:21:18 - Accepted 127.0.0.1:52912
06/06 21:21:18 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
06/06 21:21:18 INFO [akka:event-driven:dispatcher:global-12] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:18 INFO [akka:event-driven:dispatcher:global-12] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
06/06 21:21:18 INFO [akka:event-driven:dispatcher:global-12] e.n.c.Dispatcher - BROADCAST FixationEditState -> 0 listeners
[Redis STDOUT] [45457] 06 Jun 21:21:18 - Accepted 127.0.0.1:52915
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-12] e.n.c.Dispatcher - Register connection for Esther (NEW session 3a85bf80-b058-11e1-bee6-c42c031ccf85) with 1 pending messages
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-12] e.n.c.LongPollingClientConnectionActor - DELIVER FixationEditState -> Esther (session 3a85bf80-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
Akka succesfully shut down
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
Tests run: 4, Failures: 0, Errors: 0, Skipped: 0, Time elapsed: 0.675 sec
Running emi.notification.MailboxTest
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Checking port 10098 for availability.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Port 10098 is available.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Found open port 10098 to run Redis on.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-3333605834900885097.conf.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-4333264219994829365.rdb for Redis on-disk storage.
Starting Akka...
06/06 21:21:18 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:18 INFO [main] e.n.TestBoot - Redis client configured for localhost:10098
[Redis STDOUT] [45458] 06 Jun 21:21:18 * Server started, Redis version 2.4.13
[Redis STDOUT] [45458] 06 Jun 21:21:18 * The server is now ready to accept connections on port 10098
[Redis STDOUT] [45458] 06 Jun 21:21:18 - Accepted 127.0.0.1:52948
[Redis STDOUT] [45458] 06 Jun 21:21:18 - 1 clients connected (0 slaves), 930832 bytes in use
06/06 21:21:18 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
[Redis STDOUT] [45458] 06 Jun 21:21:18 - Accepted 127.0.0.1:52951
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-5] e.n.c.Dispatcher - Register connection for alice (NEW session 3a9fd730-b058-11e1-bee6-c42c031ccf85) with 0 pending messages
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-11] e.n.c.LongPollingClientConnectionActor - DELIVER SharingNotification (1) -> alice (session 3a9fd730-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
06/06 21:21:18 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (1) -> alice (1 listeners)
Akka succesfully shut down
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Checking port 13242 for availability.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Port 13242 is available.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Found open port 13242 to run Redis on.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-8050939988147497887.conf.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-1023647839885216786.rdb for Redis on-disk storage.
Starting Akka...
[Redis STDOUT] [45460] 06 Jun 21:21:18 * Server started, Redis version 2.4.13
[Redis STDOUT] [45460] 06 Jun 21:21:18 * The server is now ready to accept connections on port 13242
[Redis STDOUT] [45460] 06 Jun 21:21:18 - 0 clients connected (0 slaves), 922304 bytes in use
06/06 21:21:18 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:18 INFO [main] e.n.TestBoot - Redis client configured for localhost:13242
[Redis STDOUT] [45460] 06 Jun 21:21:18 - Accepted 127.0.0.1:52977
06/06 21:21:18 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
[Redis STDOUT] [45460] 06 Jun 21:21:18 - Accepted 127.0.0.1:52978
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-10] e.n.c.Dispatcher - Register connection for arthur (NEW session 3ad47bc0-b058-11e1-bee6-c42c031ccf85) with 0 pending messages
06/06 21:21:18 INFO [akka:event-driven:dispatcher:global-10] e.n.c.Dispatcher - DISPATCH SharingNotification (1) -> arthur (1 listeners)
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-15] e.n.c.LongPollingClientConnectionActor - DELIVER SharingNotification (1) -> arthur (session 3ad47bc0-b058-11e1-bee6-c42c031ccf85)
06/06 21:21:18 INFO [akka:event-driven:dispatcher:global-2] e.n.c.Dispatcher - DISPATCH SharingNotification (2) -> arthur (1 listeners)
06/06 21:21:18 DEBUG[akka:event-driven:dispatcher:global-2] e.n.c.LongPollingClientConnectionActor - DELIVER SharingNotification (2) -> arthur (session 3ad47bc0-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
Akka succesfully shut down
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Checking port 13574 for availability.
06/06 21:21:18 DEBUG[main] e.r.u.RedisTestUtils - Port 13574 is available.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Found open port 13574 to run Redis on.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-4183046822906720117.conf.
06/06 21:21:18 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-8238603761785335373.rdb for Redis on-disk storage.
Starting Akka...
[Redis STDOUT] [45461] 06 Jun 21:21:18 * Server started, Redis version 2.4.13
[Redis STDOUT] [45461] 06 Jun 21:21:18 * The server is now ready to accept connections on port 13574
06/06 21:21:19 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
[Redis STDOUT] [45461] 06 Jun 21:21:18 - 0 clients connected (0 slaves), 922304 bytes in use
06/06 21:21:19 INFO [main] e.n.TestBoot - Redis client configured for localhost:13574
[Redis STDOUT] [45461] 06 Jun 21:21:19 - Accepted 127.0.0.1:52987
06/06 21:21:19 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
06/06 21:21:19 WARN [Finalizer] dispatch - Shutting down garbage-collected HttpExecutor--Call shutdown() explicitly to avoid resource leaks!
[Redis STDOUT] [45461] 06 Jun 21:21:19 - Accepted 127.0.0.1:52995
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - DISPATCH SharingNotification (1) -> bob (0 listeners)
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - Register connection for bob (NEW session 3af30040-b058-11e1-bee6-c42c031ccf85) with 1 pending messages
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-7] e.n.c.LongPollingClientConnectionActor - DELIVER SharingNotification (1) -> bob (session 3af30040-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
Akka succesfully shut down
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Checking port 14274 for availability.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Port 14274 is available.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Found open port 14274 to run Redis on.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-377239264194906859.conf.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-1370995465413232820.rdb for Redis on-disk storage.
Starting Akka...
[Redis STDOUT] [45462] 06 Jun 21:21:19 * Server started, Redis version 2.4.13
[Redis STDOUT] [45462] 06 Jun 21:21:19 * The server is now ready to accept connections on port 14274
[Redis STDOUT] [45462] 06 Jun 21:21:19 - 0 clients connected (0 slaves), 922304 bytes in use
06/06 21:21:19 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:19 INFO [main] e.n.TestBoot - Redis client configured for localhost:14274
[Redis STDOUT] [45462] 06 Jun 21:21:19 - Accepted 127.0.0.1:52999
06/06 21:21:19 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
[Redis STDOUT] [45462] 06 Jun 21:21:19 - Accepted 127.0.0.1:53002
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (1) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (2) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (3) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (4) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (5) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (6) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (7) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (8) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (9) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (10) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (11) -> charles (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-9] e.n.c.Dispatcher - DISPATCH SharingNotification (12) -> charles (0 listeners)
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-7] e.n.c.Dispatcher - Register connection for charles (NEW session 3b0528b0-b058-11e1-bee6-c42c031ccf85) with 12 pending messages
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-11] e.n.c.LongPollingClientConnectionActor - DELIVER SharingNotification (1), SharingNotification (2), SharingNotification (3), SharingNotification (4), SharingNotification (5), SharingNotification (6), SharingNotification (7), SharingNotification (8), SharingNotification (9), SharingNotification (10), SharingNotification (11), SharingNotification (12) -> charles (session 3b0528b0-b058-11e1-bee6-c42c031ccf85)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-13] e.n.c.Dispatcher - ACK (1) RELAY -> charles (1 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-13] e.n.c.Dispatcher - ACK (3) RELAY -> charles (1 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-13] e.n.c.Dispatcher - ACK (5) RELAY -> charles (1 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-13] e.n.c.Dispatcher - ACK (7) RELAY -> charles (1 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-13] e.n.c.Dispatcher - ACK (9) RELAY -> charles (1 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-13] e.n.c.Dispatcher - ACK (11) RELAY -> charles (1 listeners)
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-13] e.n.c.LongPollingClientConnectionActor - DELIVER MessageAckNotification, MessageAckNotification, MessageAckNotification, MessageAckNotification, MessageAckNotification, MessageAckNotification -> charles (session 3b0528b0-b058-11e1-bee6-c42c031ccf85)
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-5] e.n.c.Dispatcher - Register connection for charles (NEW session 3b1136a0-b058-11e1-bee6-c42c031ccf85) with 6 pending messages
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-5] e.n.c.LongPollingClientConnectionActor - DELIVER SharingNotification (2), SharingNotification (4), SharingNotification (6), SharingNotification (8), SharingNotification (10), SharingNotification (12) -> charles (session 3b1136a0-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
Akka succesfully shut down
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Checking port 14914 for availability.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Port 14914 is available.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Found open port 14914 to run Redis on.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-347054109790922840.conf.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-8280445124201613176.rdb for Redis on-disk storage.
Starting Akka...
[Redis STDOUT] [45463] 06 Jun 21:21:19 * Server started, Redis version 2.4.13
[Redis STDOUT] [45463] 06 Jun 21:21:19 * The server is now ready to accept connections on port 14914
06/06 21:21:19 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:19 INFO [main] e.n.TestBoot - Redis client configured for localhost:14914
[Redis STDOUT] [45463] 06 Jun 21:21:19 - Accepted 127.0.0.1:53022
[Redis STDOUT] [45463] 06 Jun 21:21:19 - 1 clients connected (0 slaves), 930832 bytes in use
06/06 21:21:19 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
[Redis STDOUT] [45463] 06 Jun 21:21:19 - Accepted 127.0.0.1:53023
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - DISPATCH SharingNotification (1) -> daedalus (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - DISPATCH SharingNotification (2) -> daedalus (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - ACK (1) RELAY -> daedalus (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - ACK (1) RELAY -> daedalus (0 listeners)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - ACK (1) RELAY -> daedalus (0 listeners)
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-6] e.n.c.Dispatcher - Register connection for daedalus (NEW session 3b295280-b058-11e1-bee6-c42c031ccf85) with 1 pending messages
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-11] e.n.c.LongPollingClientConnectionActor - DELIVER SharingNotification (2) -> daedalus (session 3b295280-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
Akka succesfully shut down
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Checking port 13045 for availability.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Port 13045 is available.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Found open port 13045 to run Redis on.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-5896727957604080319.conf.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-8710178209606164597.rdb for Redis on-disk storage.
Starting Akka...
[Redis STDOUT] [45464] 06 Jun 21:21:19 * Server started, Redis version 2.4.13
[Redis STDOUT] [45464] 06 Jun 21:21:19 * The server is now ready to accept connections on port 13045
[Redis STDOUT] [45464] 06 Jun 21:21:19 - 0 clients connected (0 slaves), 922304 bytes in use
06/06 21:21:19 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:19 INFO [main] e.n.TestBoot - Redis client configured for localhost:13045
[Redis STDOUT] [45464] 06 Jun 21:21:19 - Accepted 127.0.0.1:53036
06/06 21:21:19 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
[Redis STDOUT] [45464] 06 Jun 21:21:19 - Accepted 127.0.0.1:53037
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-17] e.n.c.Dispatcher - Register connection for anton (NEW session 3b3b05c0-b058-11e1-bee6-c42c031ccf85) with 0 pending messages
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-10] e.n.c.LongPollingClientConnectionActor - DELIVER MustReconnect -> anton (session 3b3b05c0-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-17] e.n.c.Dispatcher - DISPATCH MustReconnect -> anton (1 listeners)
Akka succesfully shut down
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Checking port 10896 for availability.
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Port 10896 is available.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Found open port 10896 to run Redis on.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-8977493836002355452.conf.
06/06 21:21:19 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-471596657937261679.rdb for Redis on-disk storage.
[Redis STDOUT] [45465] 06 Jun 21:21:19 * Server started, Redis version 2.4.13
[Redis STDOUT] [45465] 06 Jun 21:21:19 * The server is now ready to accept connections on port 10896
Starting Akka...[Redis STDOUT] [45465] 06 Jun 21:21:19 - 0 clients connected (0 slaves), 922304 bytes in use
06/06 21:21:19 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:19 INFO [main] e.n.TestBoot - Redis client configured for localhost:10896
[Redis STDOUT] [45465] 06 Jun 21:21:19 - Accepted 127.0.0.1:53051
06/06 21:21:19 INFO [main] e.n.c.Dispatcher - Dispatcher is starting.
Akka started successfully
[Redis STDOUT] [45465] 06 Jun 21:21:19 - Accepted 127.0.0.1:53052
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-14] e.n.c.Dispatcher - Register connection for brian (NEW session 3b4f7820-b058-11e1-bee6-c42c031ccf85) with 0 pending messages
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-12] e.n.c.Dispatcher - DISPATCH SharingNotification (1) -> brian (1 listeners)
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-12] e.n.c.LongPollingClientConnectionActor - DELIVER SharingNotification (1) -> brian (session 3b4f7820-b058-11e1-bee6-c42c031ccf85)
06/06 21:21:19 INFO [akka:event-driven:dispatcher:global-2] e.n.c.Dispatcher - ACK (1) RELAY -> brian (1 listeners)
06/06 21:21:19 DEBUG[akka:event-driven:dispatcher:global-2] e.n.c.LongPollingClientConnectionActor - DELIVER MessageAckNotification -> brian (session 3b4f7820-b058-11e1-bee6-c42c031ccf85)
Shutting down Akka...
Akka succesfully shut down
06/06 21:21:19 DEBUG[main] e.r.u.RedisTestUtils - Redis is running; shutting it down.
06/06 21:21:20 DEBUG[main] e.r.u.RedisTestUtils - Redis shutdown successfully.
06/06 21:21:20 DEBUG[main] e.r.u.RedisTestUtils - Checking port 14498 for availability.
06/06 21:21:20 DEBUG[main] e.r.u.RedisTestUtils - Port 14498 is available.
06/06 21:21:20 INFO [main] e.r.u.RedisTestUtils - Found open port 14498 to run Redis on.
06/06 21:21:20 INFO [main] e.r.u.RedisTestUtils - Staging modified configuration into temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-2728251999909492201.conf.
06/06 21:21:20 INFO [main] e.r.u.RedisTestUtils - Using temporary file /var/folders/66/xry5f21122z_7_9mrrlyzqjm0000gn/T/redis-6107547350337819393.rdb for Redis on-disk storage.
Starting Akka...
06/06 21:21:20 INFO [main] e.n.TestBoot - Booting TestBoot class with akka.config System Property set to '/Users/greg/Projects/emi/code/notification/target/test-classes/akka-test.conf'
06/06 21:21:20 INFO [main] e.n.TestBoot - Redis client configured for localhost:14498
Tests run: 8, Failures: 0, Errors: 1, Skipped: 0, Time elapsed: 2.368 sec <<< FAILURE!
[Redis STDOUT] [45466] 06 Jun 21:21:20 * Server started, Redis version 2.4.13
[Redis STDOUT] [45466] 06 Jun 21:21:20 * The server is now ready to accept connections on port 14498
Results :
Tests in error:
emi.notification.MailboxTest: Unable to connect
Tests run: 27, Failures: 0, Errors: 1, Skipped: 0
[INFO] ------------------------------------------------------------------------
[INFO] BUILD FAILURE
[INFO] ------------------------------------------------------------------------
[INFO] Total time: 1:25.616s
[INFO] Finished at: Wed Jun 06 21:21:21 PDT 2012
[INFO] Final Memory: 15M/81M
[INFO] ------------------------------------------------------------------------
[ERROR] Failed to execute goal org.apache.maven.plugins:maven-surefire-plugin:2.9:test (default-test) on project notification: There are test failures.
[ERROR]
[ERROR] Please refer to /Users/greg/Projects/emi/code/notification/target/surefire-reports for the individual test results.
[ERROR] -> [Help 1]
[ERROR]
[ERROR] To see the full stack trace of the errors, re-run Maven with the -e switch.
[ERROR] Re-run Maven using the -X switch to enable full debug logging.
[ERROR]
[ERROR] For more information about the errors and possible solutions, please read the following articles:
[ERROR] [Help 1] http://cwiki.apache.org/confluence/display/MAVEN/MojoFailureException
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment