Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

Sign up for GitHub

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Jump to bottom

failed: DeprecatedSupervisionSpec #29735

Closed
patriknw opened this issue Oct 12, 2020 · 0 comments
Closed

failed: DeprecatedSupervisionSpec #29735

patriknw opened this issue Oct 12, 2020 · 0 comments
Assignees
@johanandren
Labels
failed Tickets that indicate a CI failure, likely a flakey test t:cluster-sharding
Milestone
2.6.11

Comments

@patriknw
Copy link
Member

https://jenkins.akka.io:8498/job/akka-nightly-jdk11/753

--> [Supervision for a sharded actor (deprecated) must allow passivation and early stop] Start of log messages of test that [Failed(java.lang.AssertionError: assertion failed: timeout (20 seconds) during expectMsgClass waiting for class akka.cluster.sharding.SupervisionSpec$Response)]
| [DEBUG] [10/11/2020 11:45:57.903] [pool-1-thread-1-ScalaTest-running-DeprecatedSupervisionSpec] [WithLogCapturing(akka://DeprecatedSupervisionSpec)] Logging started for test [Supervision for a sharded actor (deprecated) must allow passivation and early stop]
| [INFO] [akkaMemberChanged][10/11/2020 11:45:57.905] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-3] [Cluster(akka://DeprecatedSupervisionSpec)] Cluster Node [akka://DeprecatedSupervisionSpec@127.0.1.1:34529] - Node [akka://DeprecatedSupervisionSpec@127.0.1.1:34529] is JOINING itself (with roles [dc-default], version [0.0.0]) and forming new cluster
| [INFO] [10/11/2020 11:45:57.906] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-3] [Cluster(akka://DeprecatedSupervisionSpec)] Cluster Node [akka://DeprecatedSupervisionSpec@127.0.1.1:34529] - is the new leader among reachable nodes (more leaders may exist)
| [INFO] [akkaMemberChanged][10/11/2020 11:45:57.906] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-3] [Cluster(akka://DeprecatedSupervisionSpec)] Cluster Node [akka://DeprecatedSupervisionSpec@127.0.1.1:34529] - Leader is moving node [akka://DeprecatedSupervisionSpec@127.0.1.1:34529] to [Up]
| [DEBUG] [10/11/2020 11:45:57.906] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-15] [akka.serialization.Serialization(akka://DeprecatedSupervisionSpec)] Using serializer [akka.cluster.ddata.protobuf.ReplicatorMessageSerializer] for message [akka.cluster.ddata.Replicator$Internal$DataEnvelope]
| [INFO] [10/11/2020 11:45:57.908] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-3] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy] passy: Idle entities will be passivated after [2.000 min]
| [DEBUG] [10/11/2020 11:45:57.908] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-3] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy] passy: Request shard [0] home. Coordinator [None]
| [DEBUG] [10/11/2020 11:45:57.908] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy] passy: Coordinator moved from [] to [akka://DeprecatedSupervisionSpec@127.0.1.1:34529]
| [DEBUG] [10/11/2020 11:45:57.909] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [TimerScheduler(akka://DeprecatedSupervisionSpec)] Cancel timer [RegisterRetry] with generation [2]
| [INFO] [akkaClusterSingletonStarted][10/11/2020 11:45:57.910] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-4] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator] Singleton manager starting singleton actor [akka://DeprecatedSupervisionSpec/system/sharding/passyCoordinator/singleton]
| [INFO] [10/11/2020 11:45:57.910] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-4] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator] ClusterSingletonManager state change [Start -> Oldest]
| [DEBUG] [10/11/2020 11:45:57.911] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-16] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/replicator] Received Get for key [passyCoordinatorState].
| [DEBUG] [10/11/2020 11:45:57.911] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-3] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/replicator/$a] ReadMajorityPlus [passyCoordinatorState] [1] of [1].
| [DEBUG] [10/11/2020 11:45:57.911] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-7] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator/singleton/coordinator] passy: Initial coordinator is empty.
| [INFO] [10/11/2020 11:45:57.911] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-7] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator/singleton/coordinator] passy: ShardCoordinator was moved to the active state State(Map())
| [DEBUG] [10/11/2020 11:45:58.174] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-17] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator/singleton/coordinator] passy: ShardRegion registered: [Actor[akka://DeprecatedSupervisionSpec/system/sharding/passy#-110054792]]
| [DEBUG] [10/11/2020 11:45:58.174] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-17] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator/singleton/coordinator] passy: Storing new coordinator state [State(Map())]
| [DEBUG] [10/11/2020 11:45:58.175] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/replicator] Received Update for key [passyCoordinatorState].
| [DEBUG] [10/11/2020 11:45:58.175] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/replicator/$b] WriteMajorityPlus [passyCoordinatorState] [1] of [1].
| [DEBUG] [10/11/2020 11:45:58.175] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-17] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator/singleton/coordinator] passy: The coordinator state was successfully updated with ShardRegionRegistered(Actor[akka://DeprecatedSupervisionSpec/system/sharding/passy#-110054792])
| [DEBUG] [10/11/2020 11:45:58.175] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-17] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator/singleton/coordinator] passy: New coordinator state after [ShardRegionRegistered(Actor[akka://DeprecatedSupervisionSpec/system/sharding/passy#-110054792])]: [State(Map())]
| [DEBUG] [10/11/2020 11:45:58.175] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [TimerScheduler(akka://DeprecatedSupervisionSpec)] Cancel timer [RegisterRetry] with generation [4]
| [DEBUG] [10/11/2020 11:45:58.175] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy] passy: Requesting shard home for [0] from coordinator at [Actor[akka://DeprecatedSupervisionSpec/system/sharding/passyCoordinator/singleton/coordinator#-711053276]]. [1] buffered messages.
| [DEBUG] [10/11/2020 11:45:58.175] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-17] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator/singleton/coordinator] passy: Storing new coordinator state [State(Map())]
| [DEBUG] [10/11/2020 11:45:58.175] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/replicator] Received Update for key [passyCoordinatorState].
| [DEBUG] [10/11/2020 11:45:58.175] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/replicator/$c] WriteMajorityPlus [passyCoordinatorState] [1] of [1].
| [DEBUG] [10/11/2020 11:45:58.176] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-17] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator/singleton/coordinator] passy: The coordinator state was successfully updated with ShardHomeAllocated(0,Actor[akka://DeprecatedSupervisionSpec/system/sharding/passy#-110054792])
| [DEBUG] [akkaShardAllocated][10/11/2020 11:45:58.176] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-17] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator/singleton/coordinator] passy: Shard [0] allocated at [Actor[akka://DeprecatedSupervisionSpec/system/sharding/passy#-110054792]]
| [DEBUG] [10/11/2020 11:45:58.176] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-4] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy] passy: Host Shard [0] 
| [DEBUG] [10/11/2020 11:45:58.176] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-17] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passyCoordinator/singleton/coordinator] passy: New coordinator state after [ShardHomeAllocated(0,Actor[akka://DeprecatedSupervisionSpec/system/sharding/passy#-110054792])]: [State(Map(0 -> Actor[akka://DeprecatedSupervisionSpec/system/sharding/passy#-110054792]))]
| [DEBUG] [akkaShardStarted][10/11/2020 11:45:58.176] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-4] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy] passy: Starting shard [0] in region
| [DEBUG] [10/11/2020 11:45:58.176] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-4] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy] passy: Shard [0] located at [Actor[akka://DeprecatedSupervisionSpec/system/sharding/passy#-110054792]]
| [WARN] [10/11/2020 11:45:58.177] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka.actor.ActorSystemImpl(DeprecatedSupervisionSpec)] Failed to load JFR flight recorder, falling back to noop. Exception: java.lang.ClassNotFoundException: akka.cluster.sharding.internal.jfr.JFRShardingFlightRecorder
| [DEBUG] [10/11/2020 11:45:58.177] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy/0] passy: Shard initialized
| [DEBUG] [10/11/2020 11:45:58.177] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-4] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy] passy: Shard was initialized [0]
| [DEBUG] [10/11/2020 11:45:58.177] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-4] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy] passy: Deliver [1] buffered messages for shard [0]
| [DEBUG] [10/11/2020 11:45:58.178] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy/0] passy: Started entity [Actor[akka://DeprecatedSupervisionSpec/system/sharding/passy/0/10#-858468183]] with entity id [10] in shard [0]
| [INFO] [10/11/2020 11:45:58.178] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-7] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy/0/10/child] Starting
| [DEBUG] [10/11/2020 11:45:58.179] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy/0] passy: Delivering message of type [java.lang.String] to [10]
| [INFO] [10/11/2020 11:45:58.179] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-18] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy/0/10/child] Passivating
| [INFO] [10/11/2020 11:45:58.179] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-18] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy/0/10/child] Stopping
| [DEBUG] [10/11/2020 11:45:58.180] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy/0] passy: Delivering message of type [java.lang.String] to [10]
| [DEBUG] [10/11/2020 11:45:58.180] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy/0] passy: Passivation started for [10]
| [DEBUG] [10/11/2020 11:45:58.180] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy/0] [10] passivating
| [WARN] [10/11/2020 11:45:58.180] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-20] [akka://DeprecatedSupervisionSpec/deadLetters] hello
| [DEBUG] [10/11/2020 11:45:58.180] [DeprecatedSupervisionSpec-akka.actor.internal-dispatcher-5] [akka://DeprecatedSupervisionSpec@127.0.1.1:34529/system/sharding/passy/0] passy: [10] terminated after passivating
| [INFO] [akkaDeadLetter][10/11/2020 11:45:58.180] [DeprecatedSupervisionSpec-akka.actor.default-dispatcher-19] [akka://DeprecatedSupervisionSpec/deadLetters] Message [java.lang.String] from Actor[akka://DeprecatedSupervisionSpec/system/testActor-152#-1818117096] to Actor[akka://DeprecatedSupervisionSpec/deadLetters] was not delivered. [1] dead letters encountered. If this is not an expected behavior then Actor[akka://DeprecatedSupervisionSpec/deadLetters] may have terminated unexpectedly. This logging can be turned off or adjusted with configuration settings 'akka.log-dead-letters' and 'akka.log-dead-letters-during-shutdown'.
| [DEBUG] [10/11/2020 11:46:18.182] [pool-1-thread-1-ScalaTest-running-DeprecatedSupervisionSpec] [WithLogCapturing(akka://DeprecatedSupervisionSpec)] Logging finished for test [Supervision for a sharded actor (deprecated) must allow passivation and early stop]
<-- [Supervision for a sharded actor (deprecated) must allow passivation and early stop] End of log messages of test that [Failed(java.lang.AssertionError: assertion failed: timeout (20 seconds) during expectMsgClass waiting for class akka.cluster.sharding.SupervisionSpec$Response)]
[info] - must allow passivation and early stop *** FAILED *** (20 seconds, 288 milliseconds)
[info]   java.lang.AssertionError: assertion failed: timeout (20 seconds) during expectMsgClass waiting for class akka.cluster.sharding.SupervisionSpec$Response
[info]   at scala.Predef$.assert(Predef.scala:223)
[info]   at akka.testkit.TestKitBase.expectMsgClass_internal(TestKit.scala:569)
[info]   at akka.testkit.TestKitBase.expectMsgType(TestKit.scala:551)
[info]   at akka.testkit.TestKitBase.expectMsgType$(TestKit.scala:550)
[info]   at akka.testkit.TestKit.expectMsgType(TestKit.scala:969)
[info]   at akka.cluster.sharding.DeprecatedSupervisionSpec.$anonfun$new$2(SupervisionSpec.scala:106)

Maybe similar to #29359
@patriknw patriknw added failed Tickets that indicate a CI failure, likely a flakey test t:cluster-sharding labels Oct 12, 2020
@johanandren johanandren mentioned this issue Dec 21, 2020
Merged
@johanandren johanandren added the 3 - in progress Someone is working on this ticket label Dec 21, 2020
@johanandren johanandren self-assigned this Dec 21, 2020
@patriknw patriknw added this to the 2.6.11 milestone Jan 4, 2021
@patriknw patriknw removed the 3 - in progress Someone is working on this ticket label Jan 4, 2021
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@johanandren johanandren

Labels
failed Tickets that indicate a CI failure, likely a flakey test t:cluster-sharding
Projects
None yet
Milestone
2.6.11
Development

No branches or pull requests
2 participants
@patriknw @johanandren