[
https://issues.apache.org/jira/browse/BROOKLYN-518?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=16053203#comment-16053203
]
Svetoslav Neykov commented on BROOKLYN-518:
-------------------------------------------
There's also a (failed) attempt for a fix in related area of the code -
https://github.com/apache/brooklyn-server/pull/641.
> newEnricherForServiceStateFromProblemsAndUp fails to update to RUNNING
> ----------------------------------------------------------------------
>
> Key: BROOKLYN-518
> URL: https://issues.apache.org/jira/browse/BROOKLYN-518
> Project: Brooklyn
> Issue Type: Bug
> Reporter: Svetoslav Neykov
>
> I saw the problem in the integration tests build at \[1]. It's an infrequent
> failure - first time I notice it, but looks like a real problem.
> Exception:
> {noformat}
> failed succeeds-eventually, 21 attempts, 3000ms elapsed: AssertionError:
> entity=Application[tcp7p0x7]; attribute=Sensor: service.state
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle) expected [running] but
> found [on-fire]
> Stacktrace
> java.lang.AssertionError: failed succeeds-eventually, 21 attempts,
> 3000ms elapsed: AssertionError: entity=Application[tcp7p0x7];
> attribute=Sensor: service.state
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle) expected [running] but
> found [on-fire]
> at
> org.apache.brooklyn.test.Asserts.succeedsEventually(Asserts.java:1012)
> at org.apache.brooklyn.test.Asserts.succeedsEventually(Asserts.java:895)
> at
> org.apache.brooklyn.core.entity.EntityAsserts.assertAttributeEqualsEventually(EntityAsserts.java:71)
> at
> org.apache.brooklyn.core.entity.lifecycle.ServiceStateLogicTest.assertAttributeEqualsEventually(ServiceStateLogicTest.java:338)
> at
> org.apache.brooklyn.core.entity.lifecycle.ServiceStateLogicTest.testManuallySettingIndicatorsOnApplications(ServiceStateLogicTest.java:269)
> at
> org.apache.brooklyn.core.entity.lifecycle.ServiceStateLogicTest.testManuallySettingIndicatorsOnApplicationsManyTimes(ServiceStateLogicTest.java:162)
> ...
> Caused by: java.lang.AssertionError: entity=Application[tcp7p0x7];
> attribute=Sensor: service.state
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle) expected [running] but
> found [on-fire]
> at org.apache.brooklyn.test.Asserts.fail(Asserts.java:758)
> at org.apache.brooklyn.test.Asserts.failNotEquals(Asserts.java:148)
> at org.apache.brooklyn.test.Asserts.assertEquals(Asserts.java:470)
> at
> org.apache.brooklyn.core.entity.EntityAsserts.assertAttributeEquals(EntityAsserts.java:58)
> at
> org.apache.brooklyn.core.entity.EntityAsserts$1.run(EntityAsserts.java:74)
> at
> org.apache.brooklyn.test.Asserts$RunnableAdapter.call(Asserts.java:1366)
> at org.apache.brooklyn.test.Asserts.succeedsEventually(Asserts.java:973)
> ... 34 more
> {noformat}
> Interesting bit from the log:
> {noformat}
> 2017-06-17 01:24:25,551 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState [main]: Setting
> TestEntityImpl{id=hplgmxsx06} on-fire due to problems when expected running,
> up=false, not-up-indicators: {}
> 2017-06-17 01:24:28,552 INFO o.apache.brooklyn.test.Asserts [main]:
> succeedsEventually exceeded max attempts or timeout - 21 attempts lasting
> 3000 ms, for
> RunnableAdapter(org.apache.brooklyn.core.entity.EntityAsserts$1@6402ddfc)
> {noformat}
> Note that just before the failure {{SERVICE_UP}} was confirmed to be true
> (second line fails):
> {noformat}
> assertAttributeEqualsEventually(app, Attributes.SERVICE_UP, true);
> assertAttributeEqualsEventually(app, Attributes.SERVICE_STATE_ACTUAL,
> Lifecycle.RUNNING);
> {noformat}
> ---
> Failing test run:
> {noformat}
> 2017-06-17 01:24:25,000 INFO o.a.b.t.s.LoggingVerboseReporter [main]: TESTNG
> INVOKING: "Surefire test" -
> org.apache.brooklyn.core.entity.lifecycle.ServiceStateLogicTest.testManuallySettingIndicatorsOnApplicationsManyTimes()
> success: 100%
> 2017-06-17 01:24:25,002 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.sensor.added value Sensor:
> service.notUp.indicators (java.util.Map) on TestEntityImpl{id=xnvxswt1vg}
> 2017-06-17 01:24:25,095 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.sensor.added value Sensor: service.state.expected
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle$Transition) on
> TestEntityImpl{id=xnvxswt1vg}
> 2017-06-17 01:24:25,095 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-nYK4CxsC-1]: Setting TestEntityImpl{id=xnvxswt1vg}
> on-fire due to problems when expected running, up=false, not-up-indicators:
> {test-indicator-1=We're also pretending to block service up}
> 2017-06-17 01:24:25,095 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-nYK4CxsC-1]: Setting Application[tcp7p0x7] on-fire due
> to problems when expected null / up=true:
> {service-lifecycle-indicators-from-children-and-members=Required entity not
> healthy: TestEntityImpl{id=xnvxswt1vg}}
> 2017-06-17 01:24:25,189 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-nYK4CxsC-3]: Setting Application[tcp7p0x7] on-fire due
> to problems when expected null / up=true:
> {service-lifecycle-indicators-from-children-and-members=Not enough entities
> running to be quorate}
> 2017-06-17 01:24:25,192 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.children.removed value
> TestEntityImpl{id=xnvxswt1vg} on Application[tcp7p0x7]
> 2017-06-17 01:24:25,192 DEBUG o.a.b.e.s.AbstractAggregator
> [brooklyn-execmanager-nYK4CxsC-2]:
> ComputeServiceIndicatorsFromChildrenAndMembers{uniqueTag=service-lifecycle-indicators-from-children-and-members,
> running=true, entity=Application[tcp7p0x7], id=jf7azd1k8q} stopped listening
> to TestEntityImpl{id=xnvxswt1vg}
> 2017-06-17 01:24:25,192 DEBUG o.a.b.c.m.i.LocalEntityManager [main]:
> org.apache.brooklyn.core.mgmt.internal.LocalEntityManager@69fb63c5 stopped
> management of entity TestEntityImpl{id=xnvxswt1vg}
> 2017-06-17 01:24:25,192 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-nYK4CxsC-3]: Setting Application[tcp7p0x7] on-fire due
> to problems when expected null / up=true:
> {service-lifecycle-indicators-from-children-and-members=Not enough entities
> running to be quorate}
> 2017-06-17 01:24:25,225 DEBUG o.a.b.c.l.BasicLocationRegistry
> [brooklyn-execmanager-nYK4CxsC-3]: Location resolvers are:
> {id=org.apache.brooklyn.core.location.DefinedLocationByIdResolver@787648d9,
> named=org.apache.brooklyn.core.location.NamedLocationResolver@49d1a803,
> brooklyn.catalog=org.apache.brooklyn.core.location.CatalogLocationResolver@75da0403,
>
> portForwardManager=org.apache.brooklyn.core.location.access.PortForwardManagerLocationResolver@588b9749,
> byon=org.apache.brooklyn.location.byon.ByonLocationResolver@12713c01,
> single=org.apache.brooklyn.location.byon.SingleMachineLocationResolver@56a41ffc,
> host=org.apache.brooklyn.location.byon.HostLocationResolver@737bf337,
> localhost=org.apache.brooklyn.location.localhost.LocalhostLocationResolver@77ce13ce,
> multi=org.apache.brooklyn.location.multi.MultiLocationResolver@6cc4a802}
> 2017-06-17 01:24:25,225 DEBUG o.a.b.c.l.BasicLocationRegistry
> [brooklyn-execmanager-nYK4CxsC-3]: Found 0 defined locations from properties
> (*.named.* syntax): []
> 2017-06-17 01:24:25,225 DEBUG o.a.b.c.c.i.CatalogInitialization
> [brooklyn-execmanager-nYK4CxsC-3]: Populating catalog unofficially
> (org.apache.brooklyn.core.catalog.internal.BasicBrooklynCatalog@1ae90199)
> 2017-06-17 01:24:25,225 DEBUG o.a.b.c.c.i.CatalogInitialization
> [brooklyn-execmanager-nYK4CxsC-3]: Loading initial catalog from
> classpath://brooklyn/empty.catalog.bom
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-nYK4CxsC-3]: Forcing catalog load on access of catalog
> items
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-nYK4CxsC-3]: Loading catalog for
> LocalManagementContext[?-nYK4CxsC]
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.internal.CatalogDo
> [brooklyn-execmanager-nYK4CxsC-3]: Loading catalog
> Loaded:CatalogDto{name=empty catalog, contentsDescription=empty catalog,
> expected to be reset later}(not yet loaded) into null
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.internal.CatalogDo
> [brooklyn-execmanager-nYK4CxsC-3]: Building cache for
> Loaded:CatalogDto{name=empty catalog, contentsDescription=empty catalog,
> expected to be reset later}(not yet loaded)
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-nYK4CxsC-3]: Loaded catalog for
> LocalManagementContext[?-nYK4CxsC]: Loaded:CatalogDto{name=empty catalog,
> contentsDescription=empty catalog, expected to be reset later}(size 0);
> search classpath is
> AggregateClassLoader[sun.misc.Launcher$AppClassLoader@330bedb4,
> AggregateClassLoader[]]
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-nYK4CxsC-3]: Resetting
> org.apache.brooklyn.core.catalog.internal.BasicBrooklynCatalog@1ae90199
> catalog to CatalogDto{contentsDescription=explicit-catalog-reset}
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.internal.CatalogDo
> [brooklyn-execmanager-nYK4CxsC-3]: Loading catalog
> Loaded:CatalogDto{contentsDescription=explicit-catalog-reset}(not yet loaded)
> into null
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.internal.CatalogDo
> [brooklyn-execmanager-nYK4CxsC-3]: Building cache for
> Loaded:CatalogDto{contentsDescription=explicit-catalog-reset}(not yet loaded)
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-nYK4CxsC-3]: Reloaded catalog for
> org.apache.brooklyn.core.catalog.internal.BasicBrooklynCatalog@1ae90199, now
> switching
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-nYK4CxsC-3]: Adding manual catalog item to
> LocalManagementContext[?-nYK4CxsC]: # Licensed to the Apache Software
> Foundation (ASF) under one
> # or more contributor license agreements. See the NOTICE file
> # distributed with this work for additional information
> # regarding copyright ownership. The ASF licenses this file
> # to you under the Apache License, Version 2.0 (the
> # "License"); you may not use this file except in compliance
> # with the License. You may obtain a copy of the License at
> #
> # http://www.apache.org/licenses/LICENSE-2.0
> #
> # Unless required by applicable law or agreed to in writing,
> # software distributed under the License is distributed on an
> # "AS IS" BASIS, WITHOUT WARRANTIES OR CONDITIONS OF ANY
> # KIND, either express or implied. See the License for the
> # specific language governing permissions and limitations
> # under the License.
> #
> brooklyn.catalog: {}
> 2017-06-17 01:24:25,226 INFO o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-nYK4CxsC-3]: No Camp-YAML parser registered for parsing
> catalog item DSL; skipping DSL-parsing
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.c.i.CatalogInitialization
> [brooklyn-execmanager-nYK4CxsC-3]: Loaded initial catalog from
> classpath://brooklyn/empty.catalog.bom: []
> 2017-06-17 01:24:25,226 DEBUG o.a.b.c.m.i.EffectorUtils
> [brooklyn-execmanager-nYK4CxsC-3]: Invoking effector start on
> Application[tcp7p0x7]
> 2017-06-17 01:24:25,227 DEBUG o.a.b.c.entity.AbstractEntity
> [brooklyn-execmanager-nYK4CxsC-3]: Emitting sensor notification
> entity.sensor.added value Sensor: service.state.expected
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle$Transition) on
> Application[tcp7p0x7]
> 2017-06-17 01:24:25,227 DEBUG o.a.b.c.m.i.LocalUsageManager
> [brooklyn-execmanager-nYK4CxsC-3]: Storing application lifecycle usage event:
> application Application[tcp7p0x7] in state starting
> 2017-06-17 01:24:25,227 DEBUG o.a.b.c.e.t.StartableMethods
> [brooklyn-execmanager-nYK4CxsC-3]: Starting entity Application[tcp7p0x7] at []
> 2017-06-17 01:24:25,228 DEBUG o.a.b.util.repeat.Repeater
> [brooklyn-execmanager-nYK4CxsC-3]: Repeater: unsatisfied during iteration 1
> (200ms remaining)
> 2017-06-17 01:24:25,429 DEBUG o.a.b.util.repeat.Repeater
> [brooklyn-execmanager-nYK4CxsC-3]: Repeater: condition not satisfied, with
> 201.0ms elapsed (limit 200ms)
> 2017-06-17 01:24:25,429 WARN o.a.b.c.e.l.ServiceStateLogic
> [brooklyn-execmanager-nYK4CxsC-3]: Service is not up when setting running on
> Application[tcp7p0x7]; delayed 201ms but Sensor: service.isUp
> (java.lang.Boolean) did not recover from false;
> not-up-indicators={service-lifecycle-indicators-from-children-and-members=No
> entities present}
> 2017-06-17 01:24:25,429 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-nYK4CxsC-3]: Setting Application[tcp7p0x7] on-fire due
> to problems when expected running, up=false, problems:
> {service-lifecycle-indicators-from-children-and-members=Not enough entities
> running to be quorate}
> 2017-06-17 01:24:25,429 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-nYK4CxsC-0]: Setting Application[tcp7p0x7] on-fire due
> to problems when expected running, up=false, problems:
> {service-lifecycle-indicators-from-children-and-members=Not enough entities
> running to be quorate}
> 2017-06-17 01:24:25,429 DEBUG o.a.b.c.m.i.LocalUsageManager
> [brooklyn-execmanager-nYK4CxsC-3]: Storing application lifecycle usage event:
> application Application[tcp7p0x7] in state running
> 2017-06-17 01:24:25,429 DEBUG o.a.b.c.t.e.TestApplication
> [brooklyn-execmanager-nYK4CxsC-3]: Started application Application[tcp7p0x7]
> 2017-06-17 01:24:25,483 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.children.added value TestEntityImpl{id=hplgmxsx06}
> on Application[tcp7p0x7]
> 2017-06-17 01:24:25,484 DEBUG o.a.b.e.s.AbstractMultipleSensorAggregator
> [brooklyn-execmanager-nYK4CxsC-2]:
> ComputeServiceIndicatorsFromChildrenAndMembers{uniqueTag=service-lifecycle-indicators-from-children-and-members,
> running=true, entity=Application[tcp7p0x7], id=jf7azd1k8q} listening to
> TestEntityImpl{id=hplgmxsx06}
> 2017-06-17 01:24:25,486 DEBUG o.a.b.c.m.i.LocalSubscriptionManager [main]:
> Creating subscription kVMH5B9k for TestEntityImpl{id=hplgmxsx06} on
> TestEntityImpl{id=hplgmxsx06} Sensor: service.notUp.indicators
> (java.util.Map) in SubscriptionContext(AA+3C)
> 2017-06-17 01:24:25,486 DEBUG o.a.b.c.m.i.LocalSubscriptionManager [main]:
> Creating subscription k6lGpM9f for TestEntityImpl{id=hplgmxsx06} on
> TestEntityImpl{id=hplgmxsx06} Sensor: service.problems (java.util.Map) in
> SubscriptionContext(AA+3C)
> 2017-06-17 01:24:25,486 DEBUG o.a.b.c.m.i.LocalSubscriptionManager [main]:
> Creating subscription EKjjp0n0 for TestEntityImpl{id=hplgmxsx06} on
> TestEntityImpl{id=hplgmxsx06} Sensor: service.isUp (java.lang.Boolean) in
> SubscriptionContext(AA+3C)
> 2017-06-17 01:24:25,486 DEBUG o.a.b.c.m.i.LocalSubscriptionManager [main]:
> Creating subscription YrSJUi9h for TestEntityImpl{id=hplgmxsx06} on
> TestEntityImpl{id=hplgmxsx06} Sensor: service.state.expected
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle$Transition) in
> SubscriptionContext(AA+3C)
> 2017-06-17 01:24:25,486 DEBUG o.a.b.c.m.i.LocalEntityManager [main]:
> org.apache.brooklyn.core.mgmt.internal.LocalEntityManager@69fb63c5 starting
> management of entity TestEntityImpl{id=hplgmxsx06}
> 2017-06-17 01:24:25,550 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.sensor.added value Sensor:
> service.notUp.indicators (java.util.Map) on TestEntityImpl{id=hplgmxsx06}
> 2017-06-17 01:24:25,550 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.sensor.added value Sensor: service.state.expected
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle$Transition) on
> TestEntityImpl{id=hplgmxsx06}
> 2017-06-17 01:24:25,551 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState [main]: Setting
> TestEntityImpl{id=hplgmxsx06} on-fire due to problems when expected running,
> up=false, not-up-indicators: {}
> 2017-06-17 01:24:28,552 INFO o.apache.brooklyn.test.Asserts [main]:
> succeedsEventually exceeded max attempts or timeout - 21 attempts lasting
> 3000 ms, for
> RunnableAdapter(org.apache.brooklyn.core.entity.EntityAsserts$1@6402ddfc)
> 2017-06-17 01:24:28,552 INFO o.apache.brooklyn.test.Asserts [main]: failed
> succeeds-eventually, 21 attempts, 3000ms elapsed (rethrowing):
> java.lang.AssertionError: entity=Application[tcp7p0x7]; attribute=Sensor:
> service.state (org.apache.brooklyn.core.entity.lifecycle.Lifecycle) expected
> [running] but found [on-fire]
> 2017-06-17 01:24:28,553 WARN o.a.b.c.e.l.ServiceStateLogicTest [main]:
> Expected Application[tcp7p0x7] eventually to have Sensor: service.state
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle) = running; instead:
> 2017-06-17 01:24:28,560 INFO o.a.b.t.s.LoggingVerboseReporter [main]: TESTNG
> FAILED: "Surefire test" -
> org.apache.brooklyn.core.entity.lifecycle.ServiceStateLogicTest.testManuallySettingIndicatorsOnApplicationsManyTimes()
> finished in 3556 ms (16 of 100)
> java.lang.AssertionError: failed succeeds-eventually, 21 attempts, 3000ms
> elapsed: AssertionError: entity=Application[tcp7p0x7]; attribute=Sensor:
> service.state (org.apache.brooklyn.core.entity.lifecycle.Lifecycle) expected
> [running] but found [on-fire]
> at
> org.apache.brooklyn.test.Asserts.succeedsEventually(Asserts.java:1012)
> at org.apache.brooklyn.test.Asserts.succeedsEventually(Asserts.java:895)
> at
> org.apache.brooklyn.core.entity.EntityAsserts.assertAttributeEqualsEventually(EntityAsserts.java:71)
> at
> org.apache.brooklyn.core.entity.lifecycle.ServiceStateLogicTest.assertAttributeEqualsEventually(ServiceStateLogicTest.java:338)
> at
> org.apache.brooklyn.core.entity.lifecycle.ServiceStateLogicTest.testManuallySettingIndicatorsOnApplications(ServiceStateLogicTest.java:269)
> at
> org.apache.brooklyn.core.entity.lifecycle.ServiceStateLogicTest.testManuallySettingIndicatorsOnApplicationsManyTimes(ServiceStateLogicTest.java:162)
> Caused by: java.lang.AssertionError: entity=Application[tcp7p0x7];
> attribute=Sensor: service.state
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle) expected [running] but
> found [on-fire]
> at org.apache.brooklyn.test.Asserts.fail(Asserts.java:758)
> at org.apache.brooklyn.test.Asserts.failNotEquals(Asserts.java:148)
> at org.apache.brooklyn.test.Asserts.assertEquals(Asserts.java:470)
> at
> org.apache.brooklyn.core.entity.EntityAsserts.assertAttributeEquals(EntityAsserts.java:58)
> at
> org.apache.brooklyn.core.entity.EntityAsserts$1.run(EntityAsserts.java:74)
> at
> org.apache.brooklyn.test.Asserts$RunnableAdapter.call(Asserts.java:1366)
> at org.apache.brooklyn.test.Asserts.succeedsEventually(Asserts.java:973)
> ... 34 more
> {noformat}
> Successful test run:
> {noformat}
> 2017-06-17 01:24:24,404 INFO o.a.b.t.s.LoggingVerboseReporter [main]: TESTNG
> INVOKING: "Surefire test" -
> org.apache.brooklyn.core.entity.lifecycle.ServiceStateLogicTest.testManuallySettingIndicatorsOnApplicationsManyTimes()
> success: 100%
> 2017-06-17 01:24:24,406 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.sensor.added value Sensor:
> service.notUp.indicators (java.util.Map) on TestEntityImpl{id=wgtl9250zd}
> 2017-06-17 01:24:24,497 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.sensor.added value Sensor: service.state.expected
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle$Transition) on
> TestEntityImpl{id=wgtl9250zd}
> 2017-06-17 01:24:24,497 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-gD8L8lGG-0]: Setting TestEntityImpl{id=wgtl9250zd}
> on-fire due to problems when expected running, up=false, not-up-indicators:
> {test-indicator-1=We're also pretending to block service up}
> 2017-06-17 01:24:24,498 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-gD8L8lGG-0]: Setting Application[h21cegjd] on-fire due
> to problems when expected null / up=true:
> {service-lifecycle-indicators-from-children-and-members=Required entity not
> healthy: TestEntityImpl{id=wgtl9250zd}}
> 2017-06-17 01:24:24,592 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-gD8L8lGG-0]: Setting Application[h21cegjd] on-fire due
> to problems when expected null / up=true:
> {service-lifecycle-indicators-from-children-and-members=Not enough entities
> running to be quorate}
> 2017-06-17 01:24:24,594 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.children.removed value
> TestEntityImpl{id=wgtl9250zd} on Application[h21cegjd]
> 2017-06-17 01:24:24,594 DEBUG o.a.b.e.s.AbstractAggregator
> [brooklyn-execmanager-gD8L8lGG-3]:
> ComputeServiceIndicatorsFromChildrenAndMembers{uniqueTag=service-lifecycle-indicators-from-children-and-members,
> running=true, entity=Application[h21cegjd], id=kg73ier5l4} stopped listening
> to TestEntityImpl{id=wgtl9250zd}
> 2017-06-17 01:24:24,594 DEBUG o.a.b.c.m.i.LocalEntityManager [main]:
> org.apache.brooklyn.core.mgmt.internal.LocalEntityManager@1adc30fe stopped
> management of entity TestEntityImpl{id=wgtl9250zd}
> 2017-06-17 01:24:24,594 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-gD8L8lGG-0]: Setting Application[h21cegjd] on-fire due
> to problems when expected null / up=true:
> {service-lifecycle-indicators-from-children-and-members=Not enough entities
> running to be quorate}
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.l.BasicLocationRegistry
> [brooklyn-execmanager-gD8L8lGG-0]: Location resolvers are:
> {id=org.apache.brooklyn.core.location.DefinedLocationByIdResolver@3055c8c3,
> named=org.apache.brooklyn.core.location.NamedLocationResolver@3f881fd0,
> brooklyn.catalog=org.apache.brooklyn.core.location.CatalogLocationResolver@2048a127,
>
> portForwardManager=org.apache.brooklyn.core.location.access.PortForwardManagerLocationResolver@29996c13,
> byon=org.apache.brooklyn.location.byon.ByonLocationResolver@3714aa33,
> single=org.apache.brooklyn.location.byon.SingleMachineLocationResolver@481d559e,
> host=org.apache.brooklyn.location.byon.HostLocationResolver@2d399423,
> localhost=org.apache.brooklyn.location.localhost.LocalhostLocationResolver@4f228c63,
> multi=org.apache.brooklyn.location.multi.MultiLocationResolver@5d75f286}
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.l.BasicLocationRegistry
> [brooklyn-execmanager-gD8L8lGG-0]: Found 0 defined locations from properties
> (*.named.* syntax): []
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.i.CatalogInitialization
> [brooklyn-execmanager-gD8L8lGG-0]: Populating catalog unofficially
> (org.apache.brooklyn.core.catalog.internal.BasicBrooklynCatalog@7fe6ed13)
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.i.CatalogInitialization
> [brooklyn-execmanager-gD8L8lGG-0]: Loading initial catalog from
> classpath://brooklyn/empty.catalog.bom
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-gD8L8lGG-0]: Forcing catalog load on access of catalog
> items
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-gD8L8lGG-0]: Loading catalog for
> LocalManagementContext[?-gD8L8lGG]
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.internal.CatalogDo
> [brooklyn-execmanager-gD8L8lGG-0]: Loading catalog
> Loaded:CatalogDto{name=empty catalog, contentsDescription=empty catalog,
> expected to be reset later}(not yet loaded) into null
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.internal.CatalogDo
> [brooklyn-execmanager-gD8L8lGG-0]: Building cache for
> Loaded:CatalogDto{name=empty catalog, contentsDescription=empty catalog,
> expected to be reset later}(not yet loaded)
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-gD8L8lGG-0]: Loaded catalog for
> LocalManagementContext[?-gD8L8lGG]: Loaded:CatalogDto{name=empty catalog,
> contentsDescription=empty catalog, expected to be reset later}(size 0);
> search classpath is
> AggregateClassLoader[sun.misc.Launcher$AppClassLoader@330bedb4,
> AggregateClassLoader[]]
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-gD8L8lGG-0]: Resetting
> org.apache.brooklyn.core.catalog.internal.BasicBrooklynCatalog@7fe6ed13
> catalog to CatalogDto{contentsDescription=explicit-catalog-reset}
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.internal.CatalogDo
> [brooklyn-execmanager-gD8L8lGG-0]: Loading catalog
> Loaded:CatalogDto{contentsDescription=explicit-catalog-reset}(not yet loaded)
> into null
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.internal.CatalogDo
> [brooklyn-execmanager-gD8L8lGG-0]: Building cache for
> Loaded:CatalogDto{contentsDescription=explicit-catalog-reset}(not yet loaded)
> 2017-06-17 01:24:24,628 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-gD8L8lGG-0]: Reloaded catalog for
> org.apache.brooklyn.core.catalog.internal.BasicBrooklynCatalog@7fe6ed13, now
> switching
> 2017-06-17 01:24:24,629 DEBUG o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-gD8L8lGG-0]: Adding manual catalog item to
> LocalManagementContext[?-gD8L8lGG]: # Licensed to the Apache Software
> Foundation (ASF) under one
> # or more contributor license agreements. See the NOTICE file
> # distributed with this work for additional information
> # regarding copyright ownership. The ASF licenses this file
> # to you under the Apache License, Version 2.0 (the
> # "License"); you may not use this file except in compliance
> # with the License. You may obtain a copy of the License at
> #
> # http://www.apache.org/licenses/LICENSE-2.0
> #
> # Unless required by applicable law or agreed to in writing,
> # software distributed under the License is distributed on an
> # "AS IS" BASIS, WITHOUT WARRANTIES OR CONDITIONS OF ANY
> # KIND, either express or implied. See the License for the
> # specific language governing permissions and limitations
> # under the License.
> #
> brooklyn.catalog: {}
> 2017-06-17 01:24:24,629 INFO o.a.b.c.c.i.BasicBrooklynCatalog
> [brooklyn-execmanager-gD8L8lGG-0]: No Camp-YAML parser registered for parsing
> catalog item DSL; skipping DSL-parsing
> 2017-06-17 01:24:24,629 DEBUG o.a.b.c.c.i.CatalogInitialization
> [brooklyn-execmanager-gD8L8lGG-0]: Loaded initial catalog from
> classpath://brooklyn/empty.catalog.bom: []
> 2017-06-17 01:24:24,629 DEBUG o.a.b.c.m.i.EffectorUtils
> [brooklyn-execmanager-gD8L8lGG-0]: Invoking effector start on
> Application[h21cegjd]
> 2017-06-17 01:24:24,629 DEBUG o.a.b.c.entity.AbstractEntity
> [brooklyn-execmanager-gD8L8lGG-0]: Emitting sensor notification
> entity.sensor.added value Sensor: service.state.expected
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle$Transition) on
> Application[h21cegjd]
> 2017-06-17 01:24:24,629 DEBUG o.a.b.c.m.i.LocalUsageManager
> [brooklyn-execmanager-gD8L8lGG-0]: Storing application lifecycle usage event:
> application Application[h21cegjd] in state starting
> 2017-06-17 01:24:24,629 DEBUG o.a.b.c.e.t.StartableMethods
> [brooklyn-execmanager-gD8L8lGG-0]: Starting entity Application[h21cegjd] at []
> 2017-06-17 01:24:24,630 DEBUG o.a.b.util.repeat.Repeater
> [brooklyn-execmanager-gD8L8lGG-0]: Repeater: unsatisfied during iteration 1
> (200ms remaining)
> 2017-06-17 01:24:24,831 DEBUG o.a.b.util.repeat.Repeater
> [brooklyn-execmanager-gD8L8lGG-0]: Repeater: condition not satisfied, with
> 201.0ms elapsed (limit 200ms)
> 2017-06-17 01:24:24,831 WARN o.a.b.c.e.l.ServiceStateLogic
> [brooklyn-execmanager-gD8L8lGG-0]: Service is not up when setting running on
> Application[h21cegjd]; delayed 201ms but Sensor: service.isUp
> (java.lang.Boolean) did not recover from false;
> not-up-indicators={service-lifecycle-indicators-from-children-and-members=No
> entities present}
> 2017-06-17 01:24:24,831 WARN
> o.a.b.c.e.l.ServiceStateLogic$ComputeServiceState
> [brooklyn-execmanager-gD8L8lGG-0]: Setting Application[h21cegjd] on-fire due
> to problems when expected running, up=false, problems:
> {service-lifecycle-indicators-from-children-and-members=Not enough entities
> running to be quorate}
> 2017-06-17 01:24:24,831 DEBUG o.a.b.c.m.i.LocalUsageManager
> [brooklyn-execmanager-gD8L8lGG-0]: Storing application lifecycle usage event:
> application Application[h21cegjd] in state running
> 2017-06-17 01:24:24,831 DEBUG o.a.b.c.t.e.TestApplication
> [brooklyn-execmanager-gD8L8lGG-0]: Started application Application[h21cegjd]
> 2017-06-17 01:24:24,875 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.children.added value TestEntityImpl{id=ui0mvrmewx}
> on Application[h21cegjd]
> 2017-06-17 01:24:24,875 DEBUG o.a.b.e.s.AbstractMultipleSensorAggregator
> [brooklyn-execmanager-gD8L8lGG-0]:
> ComputeServiceIndicatorsFromChildrenAndMembers{uniqueTag=service-lifecycle-indicators-from-children-and-members,
> running=true, entity=Application[h21cegjd], id=kg73ier5l4} listening to
> TestEntityImpl{id=ui0mvrmewx}
> 2017-06-17 01:24:24,876 DEBUG o.a.b.c.m.i.LocalSubscriptionManager [main]:
> Creating subscription Pzf6nLmd for TestEntityImpl{id=ui0mvrmewx} on
> TestEntityImpl{id=ui0mvrmewx} Sensor: service.notUp.indicators
> (java.util.Map) in SubscriptionContext(XblPX)
> 2017-06-17 01:24:24,876 DEBUG o.a.b.c.m.i.LocalSubscriptionManager [main]:
> Creating subscription OIdUSX3x for TestEntityImpl{id=ui0mvrmewx} on
> TestEntityImpl{id=ui0mvrmewx} Sensor: service.problems (java.util.Map) in
> SubscriptionContext(XblPX)
> 2017-06-17 01:24:24,876 DEBUG o.a.b.c.m.i.LocalSubscriptionManager [main]:
> Creating subscription J6MyNHl9 for TestEntityImpl{id=ui0mvrmewx} on
> TestEntityImpl{id=ui0mvrmewx} Sensor: service.isUp (java.lang.Boolean) in
> SubscriptionContext(XblPX)
> 2017-06-17 01:24:24,876 DEBUG o.a.b.c.m.i.LocalSubscriptionManager [main]:
> Creating subscription HdrOSlAa for TestEntityImpl{id=ui0mvrmewx} on
> TestEntityImpl{id=ui0mvrmewx} Sensor: service.state.expected
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle$Transition) in
> SubscriptionContext(XblPX)
> 2017-06-17 01:24:24,876 DEBUG o.a.b.c.m.i.LocalEntityManager [main]:
> org.apache.brooklyn.core.mgmt.internal.LocalEntityManager@1adc30fe starting
> management of entity TestEntityImpl{id=ui0mvrmewx}
> 2017-06-17 01:24:24,939 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.sensor.added value Sensor:
> service.notUp.indicators (java.util.Map) on TestEntityImpl{id=ui0mvrmewx}
> 2017-06-17 01:24:24,940 DEBUG o.a.b.c.entity.AbstractEntity [main]: Emitting
> sensor notification entity.sensor.added value Sensor: service.state.expected
> (org.apache.brooklyn.core.entity.lifecycle.Lifecycle$Transition) on
> TestEntityImpl{id=ui0mvrmewx}
> 2017-06-17 01:24:24,941 INFO o.a.b.t.s.LoggingVerboseReporter [main]: TESTNG
> PASSED: "Surefire test" -
> org.apache.brooklyn.core.entity.lifecycle.ServiceStateLogicTest.testManuallySettingIndicatorsOnApplicationsManyTimes()
> finished in 537 ms (15 of 100)
> {noformat}
> \[1]
> https://builds.apache.org/view/B/view/Brooklyn/job/brooklyn-integration-tests/76/
--
This message was sent by Atlassian JIRA
(v6.4.14#64029)
