09:52:58.501 [DEBUG] [core.thing.internal.ThingRegistryImpl] - Creating thing for type 'nest:sdm_account'. 09:52:58.502 [DEBUG] [re.model.rule.jvmmodel.RulesRefresher] - Thing "nest:sdm_account:b71ffb52ad" added => rules are going to be refreshed 09:52:58.502 [DEBUG] [.core.thing.internal.ThingManagerImpl] - Thing 'nest:sdm_account:b71ffb52ad' is tracked by ThingManager. 09:52:58.502 [TRACE] [.internal.events.ThreadedEventHandler] - inspect event: org.osgi.service.event.Event [topic=openhab] {topic=openhab/things/nest:sdm_account:b71ffb52ad/added, type=ThingAddedEvent, payload={"channels":[],"label":"Nest SDM Account","configuration":{"sdmProjectId":"fb78eb3d-cb9d-4cbc-bbaa-39b9061c799e","sdmAuthorizationCode":"4/0AfJohXnO8LaWUTSnsbi0EAOBPNMNU2EaBaymr0sPebfc7Y2YV5_s4ZTz08LxzmXc4yEtgw","sdmClientId":"102228715403-up0gh8c9v8t54g91po32kkf96osr1s6v.apps.googleusercontent.com","sdmClientSecret":"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"},"properties":null,"UID":"nest:sdm_account:b71ffb52ad","thingTypeUID":"nest:sdm_account"}, timestamp=1702482778502} 09:52:58.503 [DEBUG] [.core.thing.internal.ThingManagerImpl] - Calling 'SDMThingHandlerFactory.registerHandler()' for thing 'nest:sdm_account:b71ffb52ad'. 09:52:58.503 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.EventLogger). 09:52:58.503 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.websocket.EventWebSocketAdapter). 09:52:58.503 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.rest.sse.internal.listeners.SseEventSubscriber). 09:52:58.503 [TRACE] [.internal.events.ThreadedEventHandler] - wait for event 09:52:58.503 [DEBUG] [internal.DiscoveryServiceRegistryImpl] - bundle org.openhab.core.config.discovery:4.0.4 (163)[org.openhab.core.config.discovery.internal.DiscoveryServiceRegistryImpl(84)] : dm DiscoveryService tracking 9 MultipleDynamic added {org.openhab.core.config.discovery.DiscoveryService}={service.id=534, service.bundleid=240, service.scope=singleton} (enter) 09:52:58.503 [TRACE] [g.openhab.core.io.rest.SseBroadcaster] - broadcast to potential 0 sinks 09:52:58.503 [TRACE] [.internal.events.ThreadedEventHandler] - inspect event: org.osgi.service.event.Event [topic=openhab] {topic=openhab/things/nest:sdm_account:b71ffb52ad/status, type=ThingStatusInfoEvent, payload={"status":"UNINITIALIZED","statusDetail":"NONE"}, timestamp=1702482778502} 09:52:58.503 [DEBUG] [internal.DiscoveryServiceRegistryImpl] - bundle org.openhab.core.config.discovery:4.0.4 (163)[org.openhab.core.config.discovery.internal.DiscoveryServiceRegistryImpl(84)] : dm DiscoveryService tracking 9 MultipleDynamic already active, binding {org.openhab.core.config.discovery.DiscoveryService}={service.id=534, service.bundleid=240, service.scope=singleton} 09:52:58.503 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.EventLogger). 09:52:58.503 [DEBUG] [internal.DiscoveryServiceRegistryImpl] - bundle org.openhab.core.config.discovery:4.0.4 (163)[org.openhab.core.config.discovery.internal.DiscoveryServiceRegistryImpl(84)] : invoking bind: addDiscoveryService: parameters [org.openhab.binding.nest.internal.sdm.discovery.SDMDiscoveryService] 09:52:58.504 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.metrics.ThingStateMetric). 09:52:58.504 [DEBUG] [internal.DiscoveryServiceRegistryImpl] - bundle org.openhab.core.config.discovery:4.0.4 (163)[org.openhab.core.config.discovery.internal.DiscoveryServiceRegistryImpl(84)] : invoked bind: addDiscoveryService 09:52:58.504 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.websocket.EventWebSocketAdapter). 09:52:58.504 [TRACE] [tor.internal.metrics.ThingStateMetric] - Received ThingStatusInfo(Changed)Event... 09:52:58.504 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.rest.sse.internal.listeners.SseEventSubscriber). 09:52:58.504 [DEBUG] [internal.DiscoveryServiceRegistryImpl] - bundle org.openhab.core.config.discovery:4.0.4 (163)[org.openhab.core.config.discovery.internal.DiscoveryServiceRegistryImpl(84)] : dm DiscoveryService tracking 9 MultipleDynamic added {org.openhab.core.config.discovery.DiscoveryService}={service.id=534, service.bundleid=240, service.scope=singleton} (exit) 09:52:58.504 [TRACE] [g.openhab.core.io.rest.SseBroadcaster] - broadcast to potential 0 sinks 09:52:58.504 [TRACE] [.internal.events.ThreadedEventHandler] - wait for event 09:52:58.504 [DEBUG] [.core.thing.internal.ThingManagerImpl] - Calling initialize handler for thing 'nest:sdm_account:b71ffb52ad' at 'org.openhab.binding.nest.internal.sdm.handler.SDMAccountHandler@648661cc'. 09:52:58.504 [TRACE] [.internal.events.ThreadedEventHandler] - inspect event: org.osgi.service.event.Event [topic=openhab] {topic=openhab/things/nest:sdm_account:b71ffb52ad/status, type=ThingStatusInfoEvent, payload={"status":"INITIALIZING","statusDetail":"NONE"}, timestamp=1702482778504} 09:52:58.505 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.EventLogger). 09:52:58.505 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.metrics.ThingStateMetric). 09:52:58.505 [DEBUG] [e.internal.common.CombinedClassLoader] - Loaded class "org.openhab.core.thing.binding.ThingHandler" by classloader "org.eclipse.osgi.internal.loader.EquinoxClassLoader@76377df6[org.openhab.core.thing:4.0.4(id=212)]" for "[interface org.openhab.core.thing.binding.ThingHandler]" 09:52:58.505 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.websocket.EventWebSocketAdapter). 09:52:58.505 [TRACE] [tor.internal.metrics.ThingStateMetric] - Received ThingStatusInfo(Changed)Event... 09:52:58.505 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.rest.sse.internal.listeners.SseEventSubscriber). 09:52:58.505 [DEBUG] [e.internal.common.CombinedClassLoader] - Loaded class "org.openhab.core.thing.binding.ThingHandlerCallback" by classloader "org.eclipse.osgi.internal.loader.EquinoxClassLoader@76377df6[org.openhab.core.thing:4.0.4(id=212)]" for "[interface org.openhab.core.thing.binding.ThingHandler]" 09:52:58.505 [TRACE] [g.openhab.core.io.rest.SseBroadcaster] - broadcast to potential 0 sinks 09:52:58.505 [TRACE] [.internal.events.ThreadedEventHandler] - wait for event 09:52:58.505 [DEBUG] [e.internal.common.CombinedClassLoader] - Loaded class "org.openhab.core.thing.Thing" by classloader "org.eclipse.osgi.internal.loader.EquinoxClassLoader@76377df6[org.openhab.core.thing:4.0.4(id=212)]" for "[interface org.openhab.core.thing.binding.ThingHandler]" 09:52:58.505 [TRACE] [.internal.events.ThreadedEventHandler] - inspect event: org.osgi.service.event.Event [topic=openhab] {topic=openhab/things/nest:sdm_account:b71ffb52ad/statuschanged, type=ThingStatusInfoChangedEvent, payload=[{"status":"INITIALIZING","statusDetail":"NONE"},{"status":"UNINITIALIZED","statusDetail":"NONE"}], timestamp=1702482778504} 09:52:58.505 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.EventLogger). 09:52:58.505 [DEBUG] [e.internal.common.CombinedClassLoader] - Loaded class "org.openhab.core.thing.ThingStatusInfo" by classloader "org.eclipse.osgi.internal.loader.EquinoxClassLoader@76377df6[org.openhab.core.thing:4.0.4(id=212)]" for "[interface org.openhab.core.thing.binding.ThingHandler]" 09:52:58.505 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.thing.internal.firmware.FirmwareUpdateServiceImpl). 09:52:58.506 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.websocket.EventWebSocketAdapter). 09:52:58.506 [DEBUG] [e.internal.common.CombinedClassLoader] - Loaded class "org.openhab.core.thing.ChannelUID" by classloader "org.eclipse.osgi.internal.loader.EquinoxClassLoader@76377df6[org.openhab.core.thing:4.0.4(id=212)]" for "[interface org.openhab.core.thing.binding.ThingHandler]" 09:52:58.506 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.config.discovery.internal.AutomaticInboxProcessor). 09:52:58.506 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.rest.sse.internal.listeners.SseEventSubscriber). 09:52:58.506 [TRACE] [.internal.events.ThreadedEventHandler] - wait for event 09:52:58.506 [TRACE] [g.openhab.core.io.rest.SseBroadcaster] - broadcast to potential 0 sinks 09:52:58.506 [TRACE] [openhab.core.config.core.ConfigParser] - Skipping field 'pubsubAuthorizationCode', because config has no entry for pubsubAuthorizationCode 09:52:58.507 [TRACE] [openhab.core.config.core.ConfigParser] - Skipping field 'pubsubClientId', because config has no entry for pubsubClientId 09:52:58.507 [TRACE] [openhab.core.config.core.ConfigParser] - Skipping field 'pubsubClientSecret', because config has no entry for pubsubClientSecret 09:52:58.507 [TRACE] [openhab.core.config.core.ConfigParser] - Skipping field 'pubsubProjectId', because config has no entry for pubsubProjectId 09:52:58.507 [TRACE] [openhab.core.config.core.ConfigParser] - Skipping field 'pubsubSubscriptionId', because config has no entry for pubsubSubscriptionId 09:52:58.507 [TRACE] [openhab.core.config.core.ConfigParser] - Setting value (String) 4/0AfJohXnO8LaWUTSnsbi0EAOBPNMNU2EaBaymr0sPebfc7Y2YV5_s4ZTz08LxzmXc4yEtgw to field 'sdmAuthorizationCode' in configuration class org.openhab.binding.nest.internal.sdm.config.SDMAccountConfiguration 09:52:58.507 [TRACE] [openhab.core.config.core.ConfigParser] - Setting value (String) 102228715403-up0gh8c9v8t54g91po32kkf96osr1s6v.apps.googleusercontent.com to field 'sdmClientId' in configuration class org.openhab.binding.nest.internal.sdm.config.SDMAccountConfiguration 09:52:58.507 [TRACE] [openhab.core.config.core.ConfigParser] - Setting value (String) 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 to field 'sdmClientSecret' in configuration class org.openhab.binding.nest.internal.sdm.config.SDMAccountConfiguration 09:52:58.507 [TRACE] [openhab.core.config.core.ConfigParser] - Setting value (String) fb78eb3d-cb9d-4cbc-bbaa-39b9061c799e to field 'sdmProjectId' in configuration class org.openhab.binding.nest.internal.sdm.config.SDMAccountConfiguration 09:52:58.508 [TRACE] [.internal.events.ThreadedEventHandler] - inspect event: org.osgi.service.event.Event [topic=openhab] {topic=openhab/things/nest:sdm_account:b71ffb52ad/status, type=ThingStatusInfoEvent, payload={"status":"UNKNOWN","statusDetail":"NONE"}, timestamp=1702482778508} 09:52:58.508 [TRACE] [e.internal.common.SafeCallManagerImpl] - Finished invocation of 'initialize()' on 'org.openhab.binding.nest.internal.sdm.handler.SDMAccountHandler@648661cc' 09:52:58.508 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.EventLogger). 09:52:58.508 [DEBUG] [et.http.internal.WebClientFactoryImpl] - shared http client requested 09:52:58.508 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.metrics.ThingStateMetric). 09:52:58.508 [TRACE] [e.internal.common.SafeCallManagerImpl] - Triggering submissions for 'org.openhab.binding.nest.internal.sdm.handler.SDMAccountHandler@648661cc' 09:52:58.508 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.websocket.EventWebSocketAdapter). 09:52:58.508 [TRACE] [tor.internal.metrics.ThingStateMetric] - Received ThingStatusInfo(Changed)Event... 09:52:58.508 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.rest.sse.internal.listeners.SseEventSubscriber). 09:52:58.508 [DEBUG] [mmon.registry.AbstractManagedProvider] - Added new element nest:sdm_account:b71ffb52ad to ManagedThingProvider. 09:52:58.508 [TRACE] [ore.storage.json.internal.JsonStorage] - deserialized value '[ "nest:sdm_account:a8e0c31bb6.sdm" ]' from Json 09:52:58.508 [TRACE] [g.openhab.core.io.rest.SseBroadcaster] - broadcast to potential 0 sinks 09:52:58.508 [TRACE] [.internal.events.ThreadedEventHandler] - wait for event 09:52:58.508 [DEBUG] [et.http.internal.WebClientFactoryImpl] - http client for consumer OAuthConnector requested 09:52:58.509 [TRACE] [ore.storage.json.internal.JsonStorage] - deserialized value 'org.openhab.core.thing.internal.ThingStorageEntity@15acddf8' from Json 09:52:58.509 [TRACE] [.internal.events.ThreadedEventHandler] - inspect event: org.osgi.service.event.Event [topic=openhab] {topic=openhab/things/nest:sdm_account:b71ffb52ad/statuschanged, type=ThingStatusInfoChangedEvent, payload=[{"status":"UNKNOWN","statusDetail":"NONE"},{"status":"INITIALIZING","statusDetail":"NONE"}], timestamp=1702482778508} 09:52:58.509 [DEBUG] [et.http.internal.WebClientFactoryImpl] - creating http client for consumer OAuthConnector 09:52:58.509 [DEBUG] [et.http.internal.WebClientFactoryImpl] - Setting up SSLContext for org.openhab.core.io.net.http.internal.ExtensibleTrustManagerImpl@1bc5f605 09:52:58.509 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.EventLogger). 09:52:58.509 [TRACE] [al.firmware.FirmwareUpdateServiceImpl] - No firmware update handler available for thing with UID nest:sdm_account:b71ffb52ad. 09:52:58.509 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.thing.internal.firmware.FirmwareUpdateServiceImpl). 09:52:58.509 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.websocket.EventWebSocketAdapter). 09:52:58.510 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.config.discovery.internal.AutomaticInboxProcessor). 09:52:58.510 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.rest.sse.internal.listeners.SseEventSubscriber). 09:52:58.510 [TRACE] [.internal.events.ThreadedEventHandler] - wait for event 09:52:58.510 [TRACE] [g.openhab.core.io.rest.SseBroadcaster] - broadcast to potential 0 sinks 09:52:58.510 [TRACE] [.internal.events.ThreadedEventHandler] - inspect event: org.osgi.service.event.Event [topic=openhab] {topic=openhab/things/nest:sdm_account:b71ffb52ad/status, type=ThingStatusInfoEvent, payload={"status":"OFFLINE","statusDetail":"CONFIGURATION_ERROR","description":"Failed to authorize SDM client. Check the authorization code or generate a new one."}, timestamp=1702482778510} 09:52:58.510 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.EventLogger). 09:52:58.511 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.metrics.ThingStateMetric). 09:52:58.511 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.websocket.EventWebSocketAdapter). 09:52:58.511 [TRACE] [tor.internal.metrics.ThingStateMetric] - Received ThingStatusInfo(Changed)Event... 09:52:58.511 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.rest.sse.internal.listeners.SseEventSubscriber). 09:52:58.511 [TRACE] [.internal.events.ThreadedEventHandler] - wait for event 09:52:58.511 [TRACE] [.internal.events.ThreadedEventHandler] - inspect event: org.osgi.service.event.Event [topic=openhab] {topic=openhab/things/nest:sdm_account:b71ffb52ad/statuschanged, type=ThingStatusInfoChangedEvent, payload=[{"status":"OFFLINE","statusDetail":"CONFIGURATION_ERROR","description":"Failed to authorize SDM client. Check the authorization code or generate a new one."},{"status":"UNKNOWN","statusDetail":"NONE"}], timestamp=1702482778510} 09:52:58.511 [TRACE] [g.openhab.core.io.rest.SseBroadcaster] - broadcast to potential 0 sinks 09:52:58.511 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.monitor.internal.EventLogger). 09:52:58.511 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.thing.internal.firmware.FirmwareUpdateServiceImpl). 09:52:58.511 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.websocket.EventWebSocketAdapter). 09:52:58.511 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.config.discovery.internal.AutomaticInboxProcessor). 09:52:58.511 [TRACE] [hab.core.internal.events.EventHandler] - Delegate event to subscriber (class org.openhab.core.io.rest.sse.internal.listeners.SseEventSubscriber). 09:52:58.512 [TRACE] [.internal.events.ThreadedEventHandler] - wait for event 09:52:58.512 [TRACE] [g.openhab.core.io.rest.SseBroadcaster] - broadcast to potential 0 sinks 09:52:58.832 [TRACE] [ore.storage.json.internal.JsonStorage] - deserialized value 'org.openhab.core.thing.internal.ThingStorageEntity@259a5c58' from Json 09:52:58.832 [TRACE] [al.firmware.FirmwareUpdateServiceImpl] - No firmware update handler available for thing with UID nest:sdm_account:b71ffb52ad. 09:52:58.864 [DEBUG] [.openhab.core.io.rest.sse.SseResource] - Sending alive event to SSE connections 09:52:58.865 [TRACE] [g.openhab.core.io.rest.SseBroadcaster] - broadcast to potential 0 sinks 09:52:58.865 [TRACE] [g.openhab.core.io.rest.SseBroadcaster] - broadcast to potential 1 sinks 09:53:00.353 [TRACE] [core.internal.scheduler.SchedulerImpl] - Scheduled task is run now. 09:53:00.354 [TRACE] [core.internal.scheduler.SchedulerImpl] - Scheduled a task to run in 59 seconds.