---
# System prepended metadata

title: トラブルシューティングログ
tags: [greengrass]

---

---
tags: greengrass
---


# トラブルシューティングログ

# このエラーは？

```
FAILED_NO_STATE_CHANGE: Failed to negotiate component 'com.example.HellOguraPiDockerComponentoWorld' version with cloud and no local applicable version satisfying requirement '{thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi==1.1.5, thinggroup/MyGreengrassCoreGroup==1.2.1}'.
```

# /dev/video0がbusyの場合

dockerのpsが残っているのが原因なので、killする。


# あるComponent
``
## 下がデプロイのときのComponentのログ

```python=
2021-03-17T20:23:26.058Z [INFO] (pool-2-thread-50) com.example.WeAreTheWorld: shell-runner-start. {scriptName=services.com.example.WeAreTheWorld.lifecycle.Run, serviceName=com.example.WeAreTheWorld, currentState=STARTING, command=["if true; then echo '---- message is true ----'; else echo '---- message is fal..."]}
2021-03-17T20:23:26.192Z [INFO] (Copier) com.example.WeAreTheWorld: stdout. ---- message is true ----. {scriptName=services.com.example.WeAreTheWorld.lifecycle.Run, serviceName=com.example.WeAreTheWorld, currentState=RUNNING}
2021-03-17T20:23:26.199Z [INFO] (Copier) com.example.WeAreTheWorld: Run script exited. {exitCode=0, serviceName=com.example.WeAreTheWorld, currentState=RUNNING}
```

この下のresetに`/Message`を入れないと、前にDeployしたものが**暗黙的**に引き継がれるので、超注意！

```json=
{
  "reset": [
    "/Message"
  ],
  "merge": {
    "Message": "hello"
  }
}
```

## そのRecipes

```json=

{
  "RecipeFormatVersion": "2020-01-25",
  "ComponentName": "com.example.WeAreTheWorld",
  "ComponentVersion": "1.0.3",
  "ComponentType": "aws.greengrass.generic",
  "ComponentDescription": "My first AWS IoT Greengrass component.",
  "ComponentPublisher": "Amazon",
  "ComponentConfiguration": {
    "DefaultConfiguration": {
      "Message": "true"
    }
  },
  "Manifests": [
    {
      "Platform": {
        "os": "linux"
      },
      "Name": "Linux",
      "Lifecycle": {
        "Run": "if {configuration:/Message}; then echo '---- message is true ----'; else echo '---- message is false ----'; fi"
      },
      "Artifacts": []
    }
  ],
  "Lifecycle": {}
}
```


## リスタート時のGreengrassのlog

少なくともS3やDownloadの文字はなさそう

```python
2021-03-17T12:25:49.062Z [WARN] (Thread-1) com.aws.greengrass.lifecyclemanager.Kernel: Shutting down Nucleus due to external signal. {}
2021-03-17T12:25:49.135Z [INFO] (Thread-1) com.aws.greengrass.lifecyclemanager.KernelLifecycle: system-shutdown. {main=services.main:FINISHED}
2021-03-17T12:25:49.257Z [INFO] (Thread-1) com.aws.greengrass.lifecyclemanager.Kernel: effective-config-dump-complete. {file=/greengrass/v2/config/effectiveConfig.yaml}
2021-03-17T12:25:49.316Z [INFO] (Copier) com.aws.greengrass.lifecyclemanager.GenericExternalService: Run script exited. {exitCode=143, serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=RUNNING}
2021-03-17T12:25:49.316Z [INFO] (Copier) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=RUNNING, newState=ERRORED}
2021-03-17T12:25:49.318Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=RUNNING, newState=ERRORED}
2021-03-17T12:25:49.334Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=ERRORED, newState=STOPPING}
2021-03-17T12:25:49.334Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=ERRORED, newState=STOPPING}
2021-03-17T12:25:49.360Z [INFO] (pool-2-thread-22) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-close. Service is now closing. {serviceName=main, currentState=FINISHED}
2021-03-17T12:25:49.365Z [INFO] (pool-2-thread-23) com.aws.greengrass.lifecyclemanager.GenericExternalService: Shutdown initiated. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=STOPPING}
2021-03-17T12:25:49.366Z [INFO] (pool-2-thread-23) com.aws.greengrass.lifecyclemanager.GenericExternalService: generic-service-shutdown. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=STOPPING}
2021-03-17T12:25:49.369Z [INFO] (pool-2-thread-25) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-close. Service is now closing. {serviceName=com.example.HelloWorld, currentState=FINISHED}
2021-03-17T12:25:49.371Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=STOPPING, newState=INSTALLED}
2021-03-17T12:25:49.372Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=STOPPING, newState=INSTALLED}
2021-03-17T12:25:49.370Z [INFO] (pool-2-thread-24) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-close. Service is now closing. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=STOPPING}
2021-03-17T12:25:49.374Z [INFO] (pool-2-thread-23) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-awaiting-start. waiting for dependencies to start. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=INSTALLED}
2021-03-17T12:25:49.374Z [INFO] (pool-2-thread-23) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-starting. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=INSTALLED}
2021-03-17T12:25:49.375Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: Stopping backingTask waiting for dependency ready. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=INSTALLED}
2021-03-17T12:25:49.376Z [INFO] (pool-2-thread-23) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:25:49.376Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=INSTALLED, newState=FINISHED}
2021-03-17T12:25:49.376Z [INFO] (com.example.HelloWorld-lifecycle) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-close. Service is now closing. {serviceName=UpdateSystemPolicyService, currentState=RUNNING}
2021-03-17T12:25:49.376Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:25:49.377Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=STARTING, newState=STOPPING}
2021-03-17T12:25:49.377Z [INFO] (UpdateSystemPolicyService-lifecycle) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-report-state. {serviceName=UpdateSystemPolicyService, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:25:49.378Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=STARTING, newState=FINISHED}
2021-03-17T12:25:49.378Z [INFO] (UpdateSystemPolicyService-lifecycle) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-set-state. {serviceName=UpdateSystemPolicyService, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:25:49.379Z [INFO] (main-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-close. Service is now closing. {serviceName=aws.greengrass.Nucleus, currentState=FINISHED}
2021-03-17T12:25:49.378Z [INFO] (pool-2-thread-22) com.aws.greengrass.deployment.DeploymentService: service-close. Service is now closing. {serviceName=DeploymentService, currentState=RUNNING}
2021-03-17T12:25:49.381Z [INFO] (main-lifecycle) com.aws.greengrass.status.FleetStatusService: service-close. Service is now closing. {serviceName=FleetStatusService, currentState=RUNNING}
2021-03-17T12:25:49.383Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.telemetry.TelemetryAgent: service-close. Service is now closing. {serviceName=TelemetryAgent, currentState=RUNNING}
2021-03-17T12:25:49.387Z [INFO] (UpdateSystemPolicyService-lifecycle) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-report-state. {serviceName=UpdateSystemPolicyService, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:25:49.388Z [INFO] (UpdateSystemPolicyService-lifecycle) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: Stopping backingTask start. {serviceName=UpdateSystemPolicyService, currentState=STOPPING}
2021-03-17T12:25:49.390Z [WARN] (pool-2-thread-16) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-run-interrupted. Service interrupted while running startup. {serviceName=UpdateSystemPolicyService, currentState=STOPPING}
2021-03-17T12:25:49.387Z [INFO] (FleetStatusService-lifecycle) com.aws.greengrass.status.FleetStatusService: service-report-state. {serviceName=FleetStatusService, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:25:49.391Z [INFO] (FleetStatusService-lifecycle) com.aws.greengrass.status.FleetStatusService: service-set-state. {serviceName=FleetStatusService, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:25:49.393Z [INFO] (FleetStatusService-lifecycle) com.aws.greengrass.status.FleetStatusService: service-report-state. {serviceName=FleetStatusService, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:25:49.393Z [INFO] (FleetStatusService-lifecycle) com.aws.greengrass.status.FleetStatusService: service-set-state. {serviceName=FleetStatusService, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:25:49.389Z [INFO] (UpdateSystemPolicyService-lifecycle) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-set-state. {serviceName=UpdateSystemPolicyService, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:25:49.396Z [INFO] (Thread-1) com.aws.greengrass.lifecyclemanager.KernelLifecycle: Waiting for services to shutdown. {}
2021-03-17T12:25:49.390Z [INFO] (TelemetryAgent-lifecycle) com.aws.greengrass.telemetry.TelemetryAgent: service-report-state. {serviceName=TelemetryAgent, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:25:49.400Z [INFO] (TelemetryAgent-lifecycle) com.aws.greengrass.telemetry.TelemetryAgent: service-set-state. {serviceName=TelemetryAgent, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:25:49.404Z [INFO] (pool-2-thread-26) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-close. Service is now closing. {serviceName=com.example.MyDockerComponent, currentState=FINISHED}
2021-03-17T12:25:49.406Z [INFO] (com.example.HelloWorld-lifecycle) com.aws.greengrass.telemetry.TelemetryAgent: Cancelling all telemetry scheduled tasks.. {serviceName=TelemetryAgent, currentState=STOPPING}
2021-03-17T12:25:49.406Z [INFO] (DeploymentService-lifecycle) com.aws.greengrass.deployment.DeploymentService: service-report-state. {serviceName=DeploymentService, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:25:49.407Z [INFO] (DeploymentService-lifecycle) com.aws.greengrass.deployment.DeploymentService: service-set-state. {serviceName=DeploymentService, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:25:49.408Z [INFO] (TelemetryAgent-lifecycle) com.aws.greengrass.telemetry.TelemetryAgent: service-report-state. {serviceName=TelemetryAgent, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:25:49.409Z [INFO] (TelemetryAgent-lifecycle) com.aws.greengrass.telemetry.TelemetryAgent: service-set-state. {serviceName=TelemetryAgent, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:25:49.564Z [INFO] (DeploymentService-lifecycle) com.aws.greengrass.deployment.DeploymentService: service-report-state. {serviceName=DeploymentService, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:25:49.565Z [INFO] (DeploymentService-lifecycle) com.aws.greengrass.deployment.DeploymentService: Stopping backingTask start. {serviceName=DeploymentService, currentState=STOPPING}
2021-03-17T12:25:49.565Z [INFO] (DeploymentService-lifecycle) com.aws.greengrass.deployment.DeploymentService: service-set-state. {serviceName=DeploymentService, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:25:49.566Z [WARN] (pool-2-thread-19) com.aws.greengrass.deployment.DeploymentService: service-run-interrupted. Service interrupted while running startup. {serviceName=DeploymentService, currentState=FINISHED}
2021-03-17T12:25:49.576Z [WARN] (pool-2-thread-18) com.aws.greengrass.mqttclient.MqttClient: Shutting down spooler task. {}
2021-03-17T12:25:49.577Z [WARN] (FleetStatusService-lifecycle) com.aws.greengrass.status.FleetStatusService: service-state-transition-interrupted. Service lifecycle thread interrupted. Thread will exit now. {serviceName=FleetStatusService, currentState=FINISHED}
2021-03-17T12:25:49.577Z [INFO] (Serialized listener processor) com.aws.greengrass.lifecyclemanager.KernelLifecycle: executor-service-shutdown-initiated. {}
2021-03-17T12:25:49.584Z [INFO] (Thread-1) com.aws.greengrass.lifecyclemanager.KernelLifecycle: Waiting for executors to shutdown. {}
2021-03-17T12:25:49.591Z [INFO] (Thread-1) com.aws.greengrass.lifecyclemanager.KernelLifecycle: executor-service-shutdown-complete. {}
2021-03-17T12:25:49.597Z [INFO] (Thread-1) com.aws.greengrass.lifecyclemanager.KernelLifecycle: context-shutdown-initiated. {}
2021-03-17T12:25:49.619Z [INFO] (Thread-1) com.aws.greengrass.lifecyclemanager.KernelLifecycle: context-shutdown-complete. {}
2021-03-17T12:26:12.646Z [INFO] (main) com.aws.greengrass.util.platforms.Platform: Getting platform instance com.aws.greengrass.util.platforms.unix.UnixPlatform.. {}
2021-03-17T12:26:12.869Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: No ongoing deployment detected. Proceed as default. {}
2021-03-17T12:26:12.872Z [INFO] (main) com.aws.greengrass.config.Configuration: config-loading. Read configuration from a file path. {path=/greengrass/v2/config/config.tlog}
2021-03-17T12:26:14.171Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: effective-config-dump-complete. {file=/greengrass/v2/config/effectiveConfig.yaml}
2021-03-17T12:26:19.897Z [INFO] (main) com.aws.greengrass.lifecyclemanager.KernelLifecycle: system-start. Launch Nucleus. {configPath=/greengrass/v2/config, rootPath=/greengrass/v2, version=2.0.4}
2021-03-17T12:26:20.329Z [INFO] (main) software.amazon.awssdk.eventstreamrpc.RpcServer: IpcServer started.... {}
2021-03-17T12:26:20.437Z [INFO] (main) com.aws.greengrass.mqttclient.spool.Spool: Spooler has been configured. {maxSizeInBytes=2621440, storageType=Memory, keepQos0WhenOffline=false}
2021-03-17T12:26:20.969Z [INFO] (main) com.aws.greengrass.lifecyclemanager.KernelLifecycle: Found Plugin: DeploymentService. {}
2021-03-17T12:26:20.981Z [INFO] (main) com.aws.greengrass.lifecyclemanager.KernelLifecycle: Found Plugin: UpdateSystemPolicyService. {}
2021-03-17T12:26:20.988Z [INFO] (main) com.aws.greengrass.lifecyclemanager.KernelLifecycle: Found Plugin: FleetStatusService. {}
2021-03-17T12:26:20.993Z [INFO] (main) com.aws.greengrass.lifecyclemanager.KernelLifecycle: Found Plugin: TelemetryAgent. {}
2021-03-17T12:26:20.997Z [INFO] (main) com.aws.greengrass.lifecyclemanager.KernelLifecycle: Found Plugin: TokenExchangeService. {}
2021-03-17T12:26:21.005Z [INFO] (main) com.aws.greengrass.lifecyclemanager.KernelLifecycle: serviceImplementors: {UpdateSystemPolicyService:class com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService...}. {}
2021-03-17T12:26:21.016Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: Attempt to load service from plugins. {serviceName=FleetStatusService}
2021-03-17T12:26:21.103Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: service-loaded. {serviceName=FleetStatusService}
2021-03-17T12:26:21.104Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: Attempt to load service from plugins. {serviceName=com.example.MyDockerComponent}
2021-03-17T12:26:21.132Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: generic-service-loaded. {serviceName=com.example.MyDockerComponent}
2021-03-17T12:26:21.139Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: Attempt to load service from plugins. {serviceName=DeploymentService}
2021-03-17T12:26:21.147Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: service-loaded. {serviceName=DeploymentService}
2021-03-17T12:26:22.299Z [INFO] (main) com.aws.greengrass.componentmanager.GreengrassComponentServiceClientFactory: initialize-greengrass-client. {service-region=ap-northeast-1, service-endpoint=https://greengrass-ats.iot.ap-northeast-1.amazonaws.com:8443}
2021-03-17T12:26:22.468Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: Attempt to load service from plugins. {serviceName=com.example.HellOguraPiDockerComponentoWorld}
2021-03-17T12:26:22.487Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: generic-service-loaded. {serviceName=com.example.HellOguraPiDockerComponentoWorld}
2021-03-17T12:26:22.493Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: Attempt to load service from plugins. {serviceName=com.example.HelloWorld}
2021-03-17T12:26:22.508Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: generic-service-loaded. {serviceName=com.example.HelloWorld}
2021-03-17T12:26:22.511Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: Attempt to load service from plugins. {serviceName=TelemetryAgent}
2021-03-17T12:26:22.539Z [INFO] (pool-2-thread-5) com.aws.greengrass.mqttclient.AwsIotMqttClient: Connecting to AWS IoT Core. {clientId=MyGreengrassCoreDeviceOfSenseTimeRaspberryPi}
2021-03-17T12:26:22.660Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: service-loaded. {serviceName=TelemetryAgent}
2021-03-17T12:26:22.664Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: Attempt to load service from plugins. {serviceName=aws.greengrass.Nucleus}
2021-03-17T12:26:22.678Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: generic-service-loaded. {serviceName=aws.greengrass.Nucleus}
2021-03-17T12:26:22.682Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: Attempt to load service from plugins. {serviceName=UpdateSystemPolicyService}
2021-03-17T12:26:22.689Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: service-loaded. {serviceName=UpdateSystemPolicyService}
2021-03-17T12:26:22.691Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: Attempt to load service from plugins. {serviceName=main}
2021-03-17T12:26:22.716Z [INFO] (main) com.aws.greengrass.lifecyclemanager.GenericExternalService: Waiting for the desired state list. {serviceName=main, currentState=NEW}
2021-03-17T12:26:22.727Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: generic-service-loaded. {serviceName=main}
2021-03-17T12:26:22.780Z [INFO] (main) com.aws.greengrass.lifecyclemanager.Kernel: effective-config-dump-complete. {file=/greengrass/v2/config/effectiveConfig.yaml}
2021-03-17T12:26:22.781Z [INFO] (main) com.aws.greengrass.lifecyclemanager.KernelLifecycle: system-start. {main=services.main:NEW}
2021-03-17T12:26:22.806Z [INFO] (DeploymentService-lifecycle) com.aws.greengrass.deployment.DeploymentService: service-report-state. {serviceName=DeploymentService, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.807Z [INFO] (DeploymentService-lifecycle) com.aws.greengrass.deployment.DeploymentService: service-set-state. {serviceName=DeploymentService, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.815Z [INFO] (pool-2-thread-16) com.aws.greengrass.deployment.DeploymentService: service-awaiting-start. waiting for dependencies to start. {serviceName=DeploymentService, currentState=INSTALLED}
2021-03-17T12:26:22.816Z [INFO] (UpdateSystemPolicyService-lifecycle) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-report-state. {serviceName=UpdateSystemPolicyService, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.816Z [INFO] (pool-2-thread-16) com.aws.greengrass.deployment.DeploymentService: service-starting. {serviceName=DeploymentService, currentState=INSTALLED}
2021-03-17T12:26:22.816Z [INFO] (UpdateSystemPolicyService-lifecycle) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-set-state. {serviceName=UpdateSystemPolicyService, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.817Z [INFO] (pool-2-thread-16) com.aws.greengrass.deployment.DeploymentService: service-report-state. {serviceName=DeploymentService, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.819Z [INFO] (com.example.HelloWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HelloWorld, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.820Z [INFO] (TelemetryAgent-lifecycle) com.aws.greengrass.telemetry.TelemetryAgent: service-report-state. {serviceName=TelemetryAgent, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.820Z [INFO] (com.example.HelloWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HelloWorld, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.820Z [INFO] (TelemetryAgent-lifecycle) com.aws.greengrass.telemetry.TelemetryAgent: service-set-state. {serviceName=TelemetryAgent, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.826Z [INFO] (aws.greengrass.Nucleus-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=aws.greengrass.Nucleus, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.827Z [INFO] (main-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=main, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.828Z [INFO] (FleetStatusService-lifecycle) com.aws.greengrass.status.FleetStatusService: service-report-state. {serviceName=FleetStatusService, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.829Z [INFO] (FleetStatusService-lifecycle) com.aws.greengrass.status.FleetStatusService: service-set-state. {serviceName=FleetStatusService, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.829Z [INFO] (main-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=main, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.830Z [INFO] (aws.greengrass.Nucleus-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=aws.greengrass.Nucleus, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:22.831Z [INFO] (DeploymentService-lifecycle) com.aws.greengrass.deployment.DeploymentService: service-set-state. {serviceName=DeploymentService, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.837Z [INFO] (pool-2-thread-13) com.aws.greengrass.status.FleetStatusService: service-awaiting-start. waiting for dependencies to start. {serviceName=FleetStatusService, currentState=INSTALLED}
2021-03-17T12:26:22.838Z [INFO] (pool-2-thread-19) com.aws.greengrass.telemetry.TelemetryAgent: service-awaiting-start. waiting for dependencies to start. {serviceName=TelemetryAgent, currentState=INSTALLED}
2021-03-17T12:26:22.838Z [INFO] (pool-2-thread-13) com.aws.greengrass.status.FleetStatusService: service-starting. {serviceName=FleetStatusService, currentState=INSTALLED}
2021-03-17T12:26:22.839Z [INFO] (pool-2-thread-18) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-awaiting-start. waiting for dependencies to start. {serviceName=aws.greengrass.Nucleus, currentState=INSTALLED}
2021-03-17T12:26:22.839Z [INFO] (pool-2-thread-13) com.aws.greengrass.status.FleetStatusService: service-report-state. {serviceName=FleetStatusService, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.840Z [INFO] (FleetStatusService-lifecycle) com.aws.greengrass.status.FleetStatusService: service-set-state. {serviceName=FleetStatusService, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.840Z [INFO] (pool-2-thread-18) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-starting. {serviceName=aws.greengrass.Nucleus, currentState=INSTALLED}
2021-03-17T12:26:22.841Z [INFO] (pool-2-thread-18) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=aws.greengrass.Nucleus, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.842Z [INFO] (aws.greengrass.Nucleus-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=aws.greengrass.Nucleus, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.843Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentService: Starting up the Deployment Service. {serviceName=DeploymentService, currentState=STARTING}
2021-03-17T12:26:22.844Z [INFO] (pool-2-thread-19) com.aws.greengrass.telemetry.TelemetryAgent: service-starting. {serviceName=TelemetryAgent, currentState=INSTALLED}
2021-03-17T12:26:22.844Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentService: service-report-state. {serviceName=DeploymentService, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:22.844Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentService: Running deployment service. {serviceName=DeploymentService, currentState=STARTING}
2021-03-17T12:26:22.844Z [INFO] (pool-2-thread-19) com.aws.greengrass.telemetry.TelemetryAgent: service-report-state. {serviceName=TelemetryAgent, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.845Z [INFO] (TelemetryAgent-lifecycle) com.aws.greengrass.telemetry.TelemetryAgent: service-set-state. {serviceName=TelemetryAgent, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.836Z [INFO] (pool-2-thread-15) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-awaiting-start. waiting for dependencies to start. {serviceName=UpdateSystemPolicyService, currentState=INSTALLED}
2021-03-17T12:26:22.847Z [INFO] (pool-2-thread-15) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-starting. {serviceName=UpdateSystemPolicyService, currentState=INSTALLED}
2021-03-17T12:26:22.848Z [INFO] (pool-2-thread-15) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-report-state. {serviceName=UpdateSystemPolicyService, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.846Z [INFO] (DeploymentService-lifecycle) com.aws.greengrass.deployment.DeploymentService: service-set-state. {serviceName=DeploymentService, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:22.853Z [INFO] (pool-2-thread-20) com.aws.greengrass.status.FleetStatusService: service-report-state. {serviceName=FleetStatusService, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:22.857Z [INFO] (UpdateSystemPolicyService-lifecycle) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-set-state. {serviceName=UpdateSystemPolicyService, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.853Z [INFO] (pool-2-thread-18) com.aws.greengrass.telemetry.TelemetryAgent: service-report-state. {serviceName=TelemetryAgent, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:22.861Z [INFO] (TelemetryAgent-lifecycle) com.aws.greengrass.telemetry.TelemetryAgent: service-set-state. {serviceName=TelemetryAgent, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:22.864Z [INFO] (pool-2-thread-21) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=aws.greengrass.Nucleus, currentState=STARTING, newState=FINISHED}
2021-03-17T12:26:22.865Z [INFO] (pool-2-thread-21) com.aws.greengrass.lifecyclemanager.GenericExternalService: generic-service-finished. Nothing done. {serviceName=aws.greengrass.Nucleus, currentState=STARTING}
2021-03-17T12:26:22.854Z [INFO] (pool-2-thread-19) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-awaiting-start. waiting for dependencies to start. {serviceName=com.example.HelloWorld, currentState=INSTALLED}
2021-03-17T12:26:22.867Z [INFO] (pool-2-thread-19) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-starting. {serviceName=com.example.HelloWorld, currentState=INSTALLED}
2021-03-17T12:26:22.849Z [INFO] (pool-2-thread-16) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-awaiting-start. waiting for dependencies to start. {serviceName=main, currentState=INSTALLED}
2021-03-17T12:26:22.859Z [INFO] (FleetStatusService-lifecycle) com.aws.greengrass.status.FleetStatusService: service-set-state. {serviceName=FleetStatusService, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:22.873Z [INFO] (pool-2-thread-19) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HelloWorld, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.865Z [INFO] (aws.greengrass.Nucleus-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=aws.greengrass.Nucleus, currentState=STARTING, newState=STOPPING}
2021-03-17T12:26:22.874Z [INFO] (com.example.HelloWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HelloWorld, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:22.874Z [INFO] (aws.greengrass.Nucleus-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=aws.greengrass.Nucleus, currentState=STARTING, newState=FINISHED}
2021-03-17T12:26:22.867Z [INFO] (pool-2-thread-20) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-report-state. {serviceName=UpdateSystemPolicyService, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:22.875Z [INFO] (aws.greengrass.Nucleus-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=aws.greengrass.Nucleus, currentState=FINISHED, newState=STOPPING}
2021-03-17T12:26:22.876Z [INFO] (UpdateSystemPolicyService-lifecycle) com.aws.greengrass.lifecyclemanager.UpdateSystemPolicyService: service-set-state. {serviceName=UpdateSystemPolicyService, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:22.878Z [INFO] (pool-2-thread-21) com.aws.greengrass.lifecyclemanager.GenericExternalService: Shutdown initiated. {serviceName=aws.greengrass.Nucleus, currentState=STOPPING}
2021-03-17T12:26:22.879Z [INFO] (pool-2-thread-21) com.aws.greengrass.lifecyclemanager.GenericExternalService: generic-service-shutdown. {serviceName=aws.greengrass.Nucleus, currentState=STOPPING}
2021-03-17T12:26:22.880Z [INFO] (aws.greengrass.Nucleus-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=aws.greengrass.Nucleus, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:26:22.881Z [INFO] (aws.greengrass.Nucleus-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=aws.greengrass.Nucleus, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:26:22.960Z [INFO] (Thread-3) com.aws.greengrass.mqttclient.AwsIotMqttClient: Successfully connected to AWS IoT Core. {clientId=MyGreengrassCoreDeviceOfSenseTimeRaspberryPi, sessionPresent=true}
2021-03-17T12:26:22.981Z [INFO] (pool-2-thread-19) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HelloWorld, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:22.982Z [INFO] (com.example.HelloWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HelloWorld, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:23.074Z [INFO] (Copier) com.aws.greengrass.lifecyclemanager.GenericExternalService: Run script exited. {exitCode=0, serviceName=com.example.HelloWorld, currentState=RUNNING}
2021-03-17T12:26:23.076Z [INFO] (Copier) com.aws.greengrass.lifecyclemanager.GenericExternalService: generic-service-stopping. Service finished running. {serviceName=com.example.HelloWorld, currentState=RUNNING}
2021-03-17T12:26:23.077Z [INFO] (com.example.HelloWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HelloWorld, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:26:23.078Z [INFO] (com.example.HelloWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HelloWorld, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:26:23.079Z [INFO] (pool-2-thread-19) com.aws.greengrass.lifecyclemanager.GenericExternalService: Shutdown initiated. {serviceName=com.example.HelloWorld, currentState=STOPPING}
2021-03-17T12:26:23.080Z [INFO] (pool-2-thread-19) com.aws.greengrass.lifecyclemanager.GenericExternalService: generic-service-shutdown. {serviceName=com.example.HelloWorld, currentState=STOPPING}
2021-03-17T12:26:23.081Z [INFO] (com.example.HelloWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HelloWorld, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:26:23.082Z [INFO] (com.example.HelloWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HelloWorld, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:26:23.091Z [INFO] (pool-2-thread-6) com.aws.greengrass.deployment.ShadowDeploymentListener: Subscribed to update named shadow accepted topic. {}
2021-03-17T12:26:23.178Z [INFO] (pool-2-thread-5) com.aws.greengrass.deployment.IotJobsHelper: Subscribed to deployment job execution update.. {ThingName=MyGreengrassCoreDeviceOfSenseTimeRaspberryPi}
2021-03-17T12:26:23.253Z [INFO] (pool-2-thread-6) com.aws.greengrass.deployment.ShadowDeploymentListener: Subscribed to get named shadow topic. {}
2021-03-17T12:26:23.282Z [INFO] (pool-2-thread-6) com.aws.greengrass.deployment.ShadowDeploymentListener: Published to get named shadow topic. {}
2021-03-17T12:26:23.309Z [INFO] (pool-2-thread-5) com.aws.greengrass.deployment.IotJobsHelper: Subscribed to deployment job event notifications.. {ThingName=MyGreengrassCoreDeviceOfSenseTimeRaspberryPi}
2021-03-17T12:26:23.317Z [INFO] (pool-2-thread-5) com.aws.greengrass.deployment.IotJobsHelper: Connection established to IoT cloud. {ThingName=MyGreengrassCoreDeviceOfSenseTimeRaspberryPi}
2021-03-17T12:26:23.473Z [INFO] (pool-2-thread-5) com.aws.greengrass.status.FleetStatusService: fss-status-update-published. Status update published to FSS. {serviceName=FleetStatusService, currentState=RUNNING}
2021-03-17T12:26:23.526Z [INFO] (Thread-3) com.aws.greengrass.deployment.ShadowDeploymentListener: Added shadow deployment job. {ID=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:8}
2021-03-17T12:26:23.535Z [INFO] (Thread-3) com.aws.greengrass.deployment.IotJobsHelper: No deployment job found. {ThingName=MyGreengrassCoreDeviceOfSenseTimeRaspberryPi}
2021-03-17T12:26:24.547Z [INFO] (com.example.MyDockerComponent-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.MyDockerComponent, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:24.548Z [INFO] (com.example.MyDockerComponent-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.MyDockerComponent, currentState=NEW, newState=INSTALLED}
2021-03-17T12:26:24.550Z [INFO] (pool-2-thread-17) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-awaiting-start. waiting for dependencies to start. {serviceName=com.example.MyDockerComponent, currentState=INSTALLED}
2021-03-17T12:26:24.551Z [INFO] (pool-2-thread-17) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-starting. {serviceName=com.example.MyDockerComponent, currentState=INSTALLED}
2021-03-17T12:26:24.552Z [INFO] (pool-2-thread-17) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.MyDockerComponent, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:24.553Z [INFO] (com.example.MyDockerComponent-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.MyDockerComponent, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:26:24.561Z [INFO] (pool-2-thread-17) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.MyDockerComponent, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:24.562Z [INFO] (com.example.MyDockerComponent-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.MyDockerComponent, currentState=STARTING, newState=RUNNING}
2021-03-17T12:26:30.591Z [INFO] (Copier) com.aws.greengrass.lifecyclemanager.GenericExternalService: Run script exited. {exitCode=0, serviceName=com.example.MyDockerComponent, currentState=RUNNING}
2021-03-17T12:26:30.592Z [INFO] (Copier) com.aws.greengrass.lifecyclemanager.GenericExternalService: generic-service-stopping. Service finished running. {serviceName=com.example.MyDockerComponent, currentState=RUNNING}
2021-03-17T12:26:30.595Z [INFO] (com.example.MyDockerComponent-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.MyDockerComponent, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:26:30.598Z [INFO] (com.example.MyDockerComponent-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.MyDockerComponent, currentState=RUNNING, newState=STOPPING}
2021-03-17T12:26:30.599Z [INFO] (pool-2-thread-17) com.aws.greengrass.lifecyclemanager.GenericExternalService: Shutdown initiated. {serviceName=com.example.MyDockerComponent, currentState=STOPPING}
2021-03-17T12:26:30.600Z [INFO] (pool-2-thread-17) com.aws.greengrass.lifecyclemanager.GenericExternalService: generic-service-shutdown. {serviceName=com.example.MyDockerComponent, currentState=STOPPING}
2021-03-17T12:26:30.601Z [INFO] (com.example.MyDockerComponent-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.MyDockerComponent, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:26:30.602Z [INFO] (com.example.MyDockerComponent-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.MyDockerComponent, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:27:33.401Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentService: Received deployment in the queue. {deploymentId=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:8, DeploymentType=SHADOW, serviceName=DeploymentService, currentState=RUNNING}
2021-03-17T12:27:33.402Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentService: Received deployment document in queue. {document={"deploymentId":"79d21b9a-edcc-435a-86f9-adab019baf8a","deploymentName":"particular-deploy-sensetime","configurationArn":"arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:8","creationTimestamp":1615981605276,"components":{"com.example.HellOguraPiDockerComponentoWorld":{"version":"1.1.5","configurationUpdate":{"merge":{"Message":"false"}}},"com.example.HelloWorld":{"version":"1.0.3"}},"failureHandlingPolicy":"ROLLBACK","componentUpdatePolicy":{"timeout":60,"action":"NOTIFY_COMPONENTS"},"configurationValidationPolicy":{"timeout":60}}, serviceName=DeploymentService, currentState=RUNNING}
2021-03-17T12:27:33.637Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.ShadowDeploymentListener: Updated reported state for deployment. {CONFIGURATION_ARN=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:8, status=IN_PROGRESS}
2021-03-17T12:27:33.653Z [WARN] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentDirectoryManager: Deployment directory already exists. Clean up outdated artifacts and create new. {directory=/greengrass/v2/deployments/arn.aws.greengrass.ap-northeast-1.904148038607.configuration.thing+MyGreengrassCoreDeviceOfSenseTimeRaspberryPi.8}
2021-03-17T12:27:33.695Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentDirectoryManager: Create work directory for new deployment. {deploymentId=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:8, link=/greengrass/v2/deployments/ongoing, directory=/greengrass/v2/deployments/arn.aws.greengrass.ap-northeast-1.904148038607.configuration.thing+MyGreengrassCoreDeviceOfSenseTimeRaspberryPi.8}
2021-03-17T12:27:33.709Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentDirectoryManager: Persist deployment metadata. {file=/greengrass/v2/deployments/arn.aws.greengrass.ap-northeast-1.904148038607.configuration.thing+MyGreengrassCoreDeviceOfSenseTimeRaspberryPi.8/deployment_metadata.json, deploymentId=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:8}
2021-03-17T12:27:33.772Z [INFO] (pool-2-thread-17) com.aws.greengrass.deployment.DeploymentService: deployment-task-execution. Starting deployment task. {Deployment service config={ComponentToGroups={aws.greengrass.Nucleus={}, com.example.HellOguraPiDockerComponentoWorld={arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thinggroup/MyGreengrassCoreGroup:25=thinggroup/MyGreengrassCoreGroup}, com.example.HelloWorld={arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thinggroup/MyGreengrassCoreGroup:25=thinggroup/MyGreengrassCoreGroup}, com.example.MyDockerComponent={arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thinggroup/MyGreengrassCoreGroup:25=thinggroup/MyGreengrassCoreGroup}}, dependencies=[], GroupToRootComponents={thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi={com.example.HelloWorld={groupConfigArn=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:1, groupConfigName=thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi, version=1.0.3}}, thinggroup/MyGreengrassCoreGroup={com.example.HellOguraPiDockerComponentoWorld={groupConfigArn=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thinggroup/MyGreengrassCoreGroup:25, groupConfigName=thinggroup/MyGreengrassCoreGroup, version=1.1.8}, com.example.HelloWorld={groupConfigArn=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thinggroup/MyGreengrassCoreGroup:25, groupConfigName=thinggroup/MyGreengrassCoreGroup, version=1.0.3}, com.example.MyDockerComponent={groupConfigArn=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thinggroup/MyGreengrassCoreGroup:25, groupConfigName=thinggroup/MyGreengrassCoreGroup, version=1.0.0}}}, LastSuccessfulShadowDeploymentId=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:1, runtime={ProcessedDeployments={}}, version=0.0.0}, deploymentId=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:8, serviceName=DeploymentService, currentState=RUNNING}
2021-03-17T12:27:33.773Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentService: Started deployment execution. {serviceName=DeploymentService, currentState=RUNNING, deployment=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:8}
2021-03-17T12:27:37.861Z [INFO] (pool-2-thread-5) com.aws.greengrass.componentmanager.DependencyResolver: resolve-group-dependencies-start. Start to resolve group dependencies. {targetComponents=[com.example.HellOguraPiDockerComponentoWorld, com.example.HelloWorld], componentToVersionRequirements={com.example.MyDockerComponent={thinggroup/MyGreengrassCoreGroup==1.0.0}, com.example.HellOguraPiDockerComponentoWorld={thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi==1.1.5, thinggroup/MyGreengrassCoreGroup==1.1.8}, com.example.HelloWorld={thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi==1.0.3, thinggroup/MyGreengrassCoreGroup==1.0.3}}}
2021-03-17T12:27:37.864Z [INFO] (pool-2-thread-5) com.aws.greengrass.componentmanager.ComponentManager: resolve-component-version-start. Resolving component version starts. {component=com.example.HellOguraPiDockerComponentoWorld, versionRequirements={thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi==1.1.5, thinggroup/MyGreengrassCoreGroup==1.1.8}}
2021-03-17T12:27:37.865Z [INFO] (pool-2-thread-5) com.aws.greengrass.componentmanager.ComponentManager: Searching for best candidate locally on the device.. {VersionRequirements={thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi==1.1.5, thinggroup/MyGreengrassCoreGroup==1.1.8}, ComponentName=com.example.HellOguraPiDockerComponentoWorld}
2021-03-17T12:27:37.871Z [INFO] (pool-2-thread-5) com.aws.greengrass.componentmanager.ComponentManager: No running component satisfies the requirement. Searching in the local component store.. {}
2021-03-17T12:27:37.876Z [INFO] (pool-2-thread-5) com.aws.greengrass.componentmanager.ComponentManager: Can't find a local candidate that satisfies the requirement.. {}
2021-03-17T12:27:37.877Z [INFO] (pool-2-thread-5) com.aws.greengrass.componentmanager.ComponentManager: negotiate-version-with-cloud-start. Negotiating version with cloud. {}
2021-03-17T12:27:52.601Z [ERROR] (pool-2-thread-5) com.aws.greengrass.componentmanager.ComponentManager: Failed to negotiate version with cloud and no local version to fall back to. {componentName=com.example.HellOguraPiDockerComponentoWorld, versionRequirement={thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi==1.1.5, thinggroup/MyGreengrassCoreGroup==1.1.8}}
2021-03-17T12:28:03.780Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentService: Current deployment finished. {DeploymentId=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:8, serviceName=DeploymentService, currentState=RUNNING}
2021-03-17T12:28:13.195Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.ShadowDeploymentListener: Updated reported state for deployment. {CONFIGURATION_ARN=arn:aws:greengrass:ap-northeast-1:904148038607:configuration:thing/MyGreengrassCoreDeviceOfSenseTimeRaspberryPi:8, status=FAILED}
2021-03-17T12:28:13.219Z [INFO] (pool-2-thread-13) com.aws.greengrass.status.FleetStatusService: fss-status-update-published. Status update published to FSS. {serviceName=FleetStatusService, currentState=RUNNING}
2021-03-17T12:28:13.222Z [INFO] (pool-2-thread-13) com.aws.greengrass.deployment.DeploymentDirectoryManager: Persist link to last deployment. {link=/greengrass/v2/deployments/previous-failure}
2021-03-17T12:28:47.445Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=NEW, newState=INSTALLED}
2021-03-17T12:28:47.446Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=NEW, newState=INSTALLED}
2021-03-17T12:28:47.448Z [INFO] (pool-2-thread-14) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-awaiting-start. waiting for dependencies to start. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=INSTALLED}
2021-03-17T12:28:47.449Z [INFO] (pool-2-thread-14) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-starting. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=INSTALLED}
2021-03-17T12:28:47.449Z [INFO] (pool-2-thread-14) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:28:47.450Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:28:47.458Z [INFO] (pool-2-thread-14) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=STARTING, newState=RUNNING}
2021-03-17T12:28:47.459Z [INFO] (com.example.HellOguraPiDockerComponentoWorld-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=com.example.HellOguraPiDockerComponentoWorld, currentState=STARTING, newState=RUNNING}
2021-03-17T12:28:47.460Z [INFO] (pool-2-thread-16) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-starting. {serviceName=main, currentState=INSTALLED}
2021-03-17T12:28:47.461Z [INFO] (pool-2-thread-16) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=main, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:28:47.462Z [INFO] (main-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=main, currentState=INSTALLED, newState=STARTING}
2021-03-17T12:28:47.463Z [INFO] (pool-2-thread-16) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=main, currentState=STARTING, newState=FINISHED}
2021-03-17T12:28:47.464Z [INFO] (pool-2-thread-16) com.aws.greengrass.lifecyclemanager.GenericExternalService: generic-service-finished. Nothing done. {serviceName=main, currentState=STARTING}
2021-03-17T12:28:47.464Z [INFO] (main-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=main, currentState=STARTING, newState=STOPPING}
2021-03-17T12:28:47.465Z [INFO] (main-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=main, currentState=STARTING, newState=FINISHED}
2021-03-17T12:28:47.466Z [INFO] (main-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=main, currentState=FINISHED, newState=STOPPING}
2021-03-17T12:28:47.466Z [INFO] (pool-2-thread-16) com.aws.greengrass.lifecyclemanager.GenericExternalService: Shutdown initiated. {serviceName=main, currentState=STOPPING}
2021-03-17T12:28:47.467Z [INFO] (pool-2-thread-16) com.aws.greengrass.lifecyclemanager.GenericExternalService: generic-service-shutdown. {serviceName=main, currentState=STOPPING}
2021-03-17T12:28:47.468Z [INFO] (main-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-report-state. {serviceName=main, currentState=STOPPING, newState=FINISHED}
2021-03-17T12:28:47.469Z [INFO] (main-lifecycle) com.aws.greengrass.lifecyclemanager.GenericExternalService: service-set-state. {serviceName=main, currentState=STOPPING, newState=FINISHED}

```