Skip to content
New issue

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

Sign up for GitHub

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

Already on GitHub? Sign in to your account

Jump to bottom

tedge-agent can leave an operation in a non-final state if the service is restarted #3149

Open
reubenmiller opened this issue Oct 2, 2024 · 0 comments
Open

tedge-agent can leave an operation in a non-final state if the service is restarted #3149

reubenmiller opened this issue Oct 2, 2024 · 0 comments
Assignees
@gligorisaev
Labels
bug Something isn't working theme:workflows

Comments

@reubenmiller
Copy link
Contributor

reubenmiller commented Oct 2, 2024 •
edited
Loading

Describe the bug

An operation can be left in a non final state (e.g. anything other than successful or failed) if the tedge-agent is shutdown whilst processing a workflow state. For cloud operations this generally means that the operation will be left in the EXECUTING state (as the mapper relies on these status updates to publish the operation status to the cloud).

If the tedge-agent is processing a workflow state, and then receives a SIGTERM, then the agent saves the next state as "failed", but the local MQTT message is not published (as the agent is still shutting down). If the "next" state is "failed", then the tedge-agent will not try to republish the command's MQTT message as "failed" is a final state (and waiting the operation to be cleared via an empty retain message).

Looking at the tedge-agent logs, it shows that the status update failed to send:

Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.972204101Z  INFO tedge_api::workflow::log::command_log: => moving to example @ failed
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.973304352Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/example/local-1727906852" }, payload: "{"logPath":"/var/log/tedge/agent/workflow-example-local-1727906852.log","reason":"sleep killed by signal 15","status":"failed"}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.973503103Z ERROR Runtime: Actor WorkflowActor-10 has finished unsuccessfully: ChannelError(SendError(SendError { kind: Disconnected }))
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.973518978Z  INFO Runtime: All actors have finished

Below shows an exert from the custom workflow (firmware_update) which shows the commit state's script being killed via SIGTERM (15), where the SIGTERM sent to the state script is due to the tedge-agent actor being shutdown (also via a SIGTERM).

==================================================================
Triggered example workflow
==================================================================

topic:     te/device/child02///cmd/example/local-1727906852
operation: example
cmd_id:    local-1727906852
time:      2024-10-02T22:07:32.931748348Z

==================================================================

----------------------[ example @ init | time=2024-10-02T22:07:32.933776768Z ]----------------------

State:    {"logPath":"/var/log/tedge/agent/workflow-example-local-1727906852.log","status":"init"}

Action:   move to executing state

=> moving to example @ executing

----------------------[ example @ executing | time=2024-10-02T22:07:32.939933069Z ]----------------------

State:    {"logPath":"/var/log/tedge/agent/workflow-example-local-1727906852.log","status":"executing"}

Action:   sleep 1000000

Killed by signal: 15

stderr (EMPTY)

stdout (EMPTY)
=> moving to example @ failed

----------------------[ example @ failed | time=2024-10-02T22:07:43.011961995Z ]----------------------

State:    {"logPath":"/var/log/tedge/agent/workflow-example-local-1727906852.log","reason":"sleep killed by signal 15","resumed_at":"1727906862.0","status":"failed"}

Action:   wait for the requester to finalize the command

To Reproduce

This behaviour was first experienced when creating a dummy firmware_update operation, however the following minimal workflow/procedure can be used to reproduce the issue:

  1. Create the following workflow on a thin-edge.io device

    cat <<EOT > /etc/tedge/operations/example.toml
operation = "example"

[init]
action = "proceed"
on_success = "executing"

[executing]
script = "sleep 120"
on_success = "successful"

[successful]
action = "cleanup"

[failed]
action = "cleanup"
EOT

  2. Restart tedge-agent (so it will reload the new workflow)

    systemctl restart tedge-agent

  3. Trigger the workflow and restart it (to simulate interrupting the tedge-agent service with a SIGTERM)

    TOPIC="$(tedge config get mqtt.topic_root)/$(tedge config get mqtt.device_topic_id)/cmd/example/local-$(date +%s)"
tedge mqtt pub -r -q 1 "$TOPIC" '{"status":"init"}'

sleep 10
systemctl restart tedge-agent
echo "Check if the operation"
tedge mqtt sub "$TOPIC"

    The error condition is that the operation message published to the local MQTT broker will remain in the state and is not updated by the agent to set it to failed.

  4. Cleanup the operation. This step is to remove the message from the MQTT broker

    tedge mqtt pub -r "$TOPIC" ''

Expected behavior

The tedge-agent should leave a local operation in a non-final state (e.g. successful or failed). Ideally the tedge-agent should remember if it was successful publishing the operation status update or not, and retry it until it is successful.

Screenshots

Environment (please complete the following information):

  • OS [incl. version]: Debian 12
  • Hardware [incl. revision]: Container
  • System-Architecture [e.g. result of "uname -a"]: aarch64 / arm64
  • thin-edge.io version [e.g. 0.1.0]: 1.3.0

Additional context

tedge-agent logs (debug level)

Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.91599274Z DEBUG MQTT recv: [te/device/child02///cmd/example/local-1727906852 qos=1] {"status":"init"}
Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.919216412Z DEBUG Mqtt-Request-Converter: recv Some(MqttMessage(MqttMessage { topic: Topic { name: "te/device/child02///cmd/example/local-1727906852" }, payload: "{"status":"init"}", qos: AtLeastOnce, retain: false }))
Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.935506645Z  INFO tedge_agent::operation_workflows::actor: Moving example operation to state: executing
Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.938747234Z  INFO tedge_api::workflow::log::command_log: => moving to example @ executing
Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.939789944Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/example/local-1727906852" }, payload: "{"logPath":"/var/log/tedge/agent/workflow-example-local-1727906852.log","status":"executing"}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.939841277Z DEBUG Mqtt-Request-Converter: recv Some(InternalCommandState(InternalCommandState(GenericCommandState { topic: Topic { name: "te/device/child02///cmd/example/local-1727906852" }, status: "executing", payload: Object {"logPath": String("/var/log/tedge/agent/workflow-example-local-1727906852.log"), "status": String("executing")}, invoking_command_topic: None })))
Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.939960069Z DEBUG MQTT pub: [te/device/child02///cmd/example/local-1727906852 qos=1 retained] {"logPath":"/var/log/tedge/agent/workflow-example-local-1727906852.log","status":"executing"}
Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.940031402Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/example/local-1727906852, Pkid = 19, Payload Size = 93
Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.941241488Z  INFO tedge_agent::operation_workflows::actor: Processing example operation executing step with script: sleep 1000000
Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.941296113Z DEBUG Script: recv Some(Execute { command: "sleep", args: ["1000000"], timeouts: None })
Oct 02 22:07:32 child02 tedge-agent[1200]: 2024-10-02T22:07:32.957338763Z DEBUG MQTT recv: [te/device/child02///cmd/example/local-1727906852 qos=1] {"logPath":"/var/log/tedge/agent/workflow-example-local-1727906852.log","status":"executing"}
Oct 02 22:07:42 child02 systemd[1]: Stopping tedge-agent.service - tedge-agent is a thin-edge.io component to support operations....
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949221649Z DEBUG Signal-Handler: send Shutdown
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949259149Z  INFO Runtime: Shutting down
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949287774Z DEBUG Runtime: Successfully sent shutdown request to Uploader-4
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949304524Z DEBUG Runtime: Successfully sent shutdown request to MQTT-1
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949320607Z DEBUG Runtime: Successfully sent shutdown request to Signal-Handler-0
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949347024Z DEBUG Runtime: Successfully sent shutdown request to HealthMonitorActor-11
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949358482Z DEBUG Runtime: Successfully sent shutdown request to WorkflowActor-10
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949362566Z DEBUG Runtime: Successfully sent shutdown request to LogManager-6
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949379232Z DEBUG Runtime: Successfully sent shutdown request to FsWatcher-2
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949391732Z DEBUG Runtime: Successfully sent shutdown request to Script-9
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949395191Z DEBUG Runtime: Successfully sent shutdown request to SoftwareManagerActor-8
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949399524Z DEBUG Runtime: Successfully sent shutdown request to RestartManagerActor-7
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949454107Z DEBUG device/child02/service/tedge-agent: recv None
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.949638149Z DEBUG Uploader: recv None
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.950455942Z DEBUG Signal-Handler: recv None
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.950611151Z DEBUG rumqttc::state: Publish. Topic = te/device/child02/service/tedge-agent/status/health, Pkid = 20, Payload Size = 28
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.950749609Z DEBUG rumqttc::state: Disconnect
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.950774943Z  INFO mqtt_channel::connection: MQTT connection closed
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.95207582Z DEBUG Log Manager: recv None
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952172695Z DEBUG SoftwareManager: recv None
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952191653Z DEBUG Script: recv None
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.95220857Z DEBUG RestartManager: recv None
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952112737Z DEBUG Runtime: Successfully sent shutdown request to ConfigManager-5
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952254695Z DEBUG Runtime: Successfully sent shutdown request to Downloader-3
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952307445Z  INFO Runtime: Actor has finished: HealthMonitorActor-11
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952379279Z  INFO Runtime: Actor has finished: Uploader-4
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952397404Z  INFO Runtime: Actor has finished: MQTT-1
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952459737Z  INFO Runtime: Actor has finished: Signal-Handler-0
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952467029Z  INFO Runtime: Actor has finished: FsWatcher-2
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952471112Z  INFO Runtime: Actor has finished: LogManager-6
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.95247457Z  INFO Runtime: Actor has finished: Script-9
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952478154Z  INFO Runtime: Actor has finished: RestartManagerActor-7
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952481737Z  INFO Runtime: Actor has finished: SoftwareManagerActor-8
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952515654Z DEBUG Downloader: recv None
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952552737Z DEBUG Tedge-Config-Manager: recv None
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952623737Z  INFO Runtime: Actor has finished: Downloader-3
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.952638696Z  INFO Runtime: Actor has finished: ConfigManager-5
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.972204101Z  INFO tedge_api::workflow::log::command_log: => moving to example @ failed
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.973304352Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/example/local-1727906852" }, payload: "{"logPath":"/var/log/tedge/agent/workflow-example-local-1727906852.log","reason":"sleep killed by signal 15","status":"failed"}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.973503103Z ERROR Runtime: Actor WorkflowActor-10 has finished unsuccessfully: ChannelError(SendError(SendError { kind: Disconnected }))
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.973518978Z  INFO Runtime: All actors have finished
Oct 02 22:07:42 child02 tedge-agent[1200]: 2024-10-02T22:07:42.97366577Z DEBUG sm-agent: flockfile::unix: Lockfile deleted ""/run/lock/tedge-agent.lock""
Oct 02 22:07:42 child02 systemd[1]: tedge-agent.service: Deactivated successfully.
Oct 02 22:07:42 child02 systemd[1]: Stopped tedge-agent.service - tedge-agent is a thin-edge.io component to support operations..
Oct 02 22:07:42 child02 systemd[1]: tedge-agent.service: Consumed 2.333s CPU time.
Oct 02 22:07:42 child02 systemd[1]: Starting tedge-agent.service - tedge-agent is a thin-edge.io component to support operations....
Oct 02 22:07:42 child02 systemd[1]: Started tedge-agent.service - tedge-agent is a thin-edge.io component to support operations..
Oct 02 22:07:42 child02 tedge-agent[1490]: 2024-10-02T22:07:42.988011542Z DEBUG tedge_config::tedge_config_cli::tedge_config_location: Loading configuration from "/etc/tedge/tedge.toml"
Oct 02 22:07:42 child02 tedge-agent[1490]: 2024-10-02T22:07:42.988046958Z DEBUG mqtt_channel::config: Using CA directory: /etc/ssl/certs
Oct 02 22:07:42 child02 tedge-agent[1490]: 2024-10-02T22:07:42.992810841Z DEBUG mqtt_channel::config: Using client certificate: /etc/tedge/device-certs/tedge-agent.crt
Oct 02 22:07:42 child02 tedge-agent[1490]: 2024-10-02T22:07:42.992838966Z DEBUG mqtt_channel::config: Using client private key: /etc/tedge/device-certs/tedge-agent.key
Oct 02 22:07:42 child02 tedge-agent[1490]: 2024-10-02T22:07:42.993170591Z DEBUG tedge_config::tedge_config_cli::tedge_config_location: Loading configuration from "/etc/tedge/tedge.toml"
Oct 02 22:07:42 child02 tedge-agent[1490]: 2024-10-02T22:07:42.9933948Z DEBUG tedge_config::tedge_config_cli::tedge_config_location: Loading configuration from "/etc/tedge/tedge.toml"
Oct 02 22:07:42 child02 tedge-agent[1490]: 2024-10-02T22:07:42.993656258Z DEBUG tedge_config::tedge_config_cli::tedge_config_location: Loading configuration from "/etc/tedge/tedge.toml"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007508405Z DEBUG flockfile::unix: Lockfile created "/run/lock/tedge-agent.lock"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007529446Z  INFO tedge_agent::agent: tedge-agent starting
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007556363Z  INFO sm-agent: tedge_agent::agent: Starting tedge-agent v1.3.1~42+ga50bdcf
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007574405Z DEBUG sm-agent:sm-agent: tedge_utils::file: Creating the directory "/etc/tedge/.agent"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007579196Z DEBUG sm-agent:sm-agent: tedge_utils::file: Applying desired user and group for already existing dir: "/etc/tedge/.agent"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00758653Z DEBUG sm-agent:sm-agent: tedge_utils::file: Creating the directory "/var/log/tedge/agent"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007595155Z DEBUG sm-agent:sm-agent: tedge_utils::file: Applying desired user and group for already existing dir: "/var/log/tedge/agent"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007604072Z DEBUG sm-agent:sm-agent: tedge_utils::file: Creating the directory "/var/tedge"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007606905Z DEBUG sm-agent:sm-agent: tedge_utils::file: Applying desired user and group for already existing dir: "/var/tedge"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007612655Z DEBUG sm-agent:sm-agent: tedge_utils::file: Creating the directory "/var/tedge/file-transfer"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00762028Z DEBUG sm-agent:sm-agent: tedge_utils::file: Applying desired user and group for already existing dir: "/var/tedge/file-transfer"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00762453Z DEBUG sm-agent:sm-agent: tedge_utils::file: Creating the directory "/var/tedge/cache"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007627447Z DEBUG sm-agent:sm-agent: tedge_utils::file: Applying desired user and group for already existing dir: "/var/tedge/cache"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.007630738Z DEBUG sm-agent:sm-agent: tedge_utils::file: Creating the directory "/etc/tedge/operations"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00763378Z DEBUG sm-agent:sm-agent: tedge_utils::file: Applying desired user and group for already existing dir: "/etc/tedge/operations"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00768528Z  INFO Runtime: Started
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008066739Z  INFO sm-agent: tedge_agent::operation_workflows: Using operation workflow definition from "/etc/tedge/operations/device_profile.toml" for 'device_profile' operation
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008253697Z  INFO sm-agent: tedge_agent::operation_workflows: Using operation workflow definition from "/etc/tedge/operations/firmware_update.toml" for 'firmware_update' operation
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008369114Z  INFO sm-agent: tedge_agent::operation_workflows: Using operation workflow definition from "/etc/tedge/operations/example.toml" for 'example' operation
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008706407Z  INFO sm-agent: tedge_config_manager::config: Using the configuration from /etc/tedge/plugins/tedge-configuration-plugin.toml
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008847032Z  INFO sm-agent: log_manager::config: Using the configuration from /etc/tedge/plugins/tedge-log-plugin.toml
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008919657Z  INFO sm-agent: tedge_agent::agent: Running as a child device, tedge_to_te_converter and File Transfer Service disabled
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008930574Z DEBUG sm-agent: Runtime: schedule Spawn(Signal-Handler)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008949324Z  INFO sm-agent: MQTT sub: te/device/child02///cmd/+/+
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008952449Z  INFO sm-agent: MQTT sub: te/device/child02/service/tedge-agent/cmd/health/check
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008954699Z  WARN sm-agent: MQTT sub: ignoring overlapping subscription to te/device/child02///cmd/health/check
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00895724Z DEBUG sm-agent: Runtime: schedule Spawn(MQTT)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008960365Z DEBUG sm-agent: Runtime: schedule Spawn(FsWatcher)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008963949Z DEBUG sm-agent: Runtime: schedule Spawn(Downloader)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00896674Z DEBUG sm-agent: Runtime: schedule Spawn(Uploader)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00896999Z DEBUG sm-agent: Runtime: schedule Spawn(ConfigManager)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008968532Z  INFO Runtime: Running Signal-Handler-0
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00897349Z DEBUG sm-agent: Runtime: schedule Spawn(LogManager)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008987157Z  INFO Runtime: Running MQTT-1
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.008996532Z  WARN sm-agent: tedge_agent::state_repository::state: Cannot use "/data/tedge/agent" to store tedge-agent state: No such file or directory (os error 2)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009002657Z  INFO sm-agent: tedge_agent::state_repository::state: Use "/etc/tedge/.agent/restart-current-operation" to store tedge-agent restart-current-operation state
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00900524Z DEBUG sm-agent: Runtime: schedule Spawn(RestartManagerActor)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009010032Z  WARN sm-agent: tedge_agent::state_repository::state: Cannot use "/data/tedge/agent" to store tedge-agent state: No such file or directory (os error 2)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.00901974Z  INFO sm-agent: tedge_agent::state_repository::state: Use "/etc/tedge/.agent/software-current-operation" to store tedge-agent software-current-operation state
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009023615Z DEBUG sm-agent: Runtime: schedule Spawn(SoftwareManagerActor)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009027699Z DEBUG sm-agent: Runtime: schedule Spawn(Script)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009068574Z  INFO Runtime: Running FsWatcher-2
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009077324Z  INFO Runtime: Running Downloader-3
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009101282Z  INFO Runtime: Running Uploader-4
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009128366Z  INFO Runtime: Running ConfigManager-5
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009200366Z  INFO Runtime: Running LogManager-6
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009209282Z  INFO Runtime: Running RestartManagerActor-7
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009203032Z  WARN sm-agent: tedge_agent::state_repository::state: Cannot use "/data/tedge/agent" to store tedge-agent state: No such file or directory (os error 2)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009266324Z  INFO tedge_config_manager::config: Using the configuration from /etc/tedge/plugins/tedge-configuration-plugin.toml
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009310866Z  INFO sm-agent: tedge_agent::state_repository::state: Use "/etc/tedge/.agent/workflows" to store tedge-agent workflows state
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009325032Z DEBUG sm-agent: Runtime: schedule Spawn(WorkflowActor)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009346574Z DEBUG sm-agent: Runtime: schedule Spawn(HealthMonitorActor)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009217574Z  INFO Runtime: Running SoftwareManagerActor-8
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009392324Z  INFO Runtime: Running Script-9
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009401491Z  INFO Runtime: Running WorkflowActor-10
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009417283Z  INFO Runtime: Running HealthMonitorActor-11
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009430908Z DEBUG device/child02/service/tedge-agent: send MqttMessage { topic: Topic { name: "te/device/child02/service/tedge-agent" }, payload: "{"@parent":"device/child02//","@type":"service","type":"service"}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009596325Z DEBUG device/child02/service/tedge-agent: send MqttMessage { topic: Topic { name: "te/device/child02/service/tedge-agent/status/health" }, payload: "{"pid":1490,"status":"up","time":1727906863.0095108}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009673408Z  INFO tedge_log_manager::actor: Reloading supported log types
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009685991Z  INFO log_manager::config: Using the configuration from /etc/tedge/plugins/tedge-log-plugin.toml
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009831783Z DEBUG Tedge-Config-Manager: send Metadata { topic: Topic { name: "te/device/child02///cmd/config_snapshot" }, types: ["modem", "system.toml", "tedge-configuration-plugin", "tedge.toml"] }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.0098862Z  INFO mqtt_channel::connection: MQTT connecting to broker: host=tedge:8883, session_name=Some("tedge-agent#te/device/child02//")
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.009898033Z DEBUG Tedge-Config-Manager: send Metadata { topic: Topic { name: "te/device/child02///cmd/config_update" }, types: ["modem", "system.toml", "tedge-configuration-plugin", "tedge.toml"] }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.010575368Z DEBUG tedge_config::tedge_config_cli::tedge_config_location: Loading configuration from "/etc/tedge/tedge.toml"
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.010725785Z DEBUG rustls::client::hs: No cached session for DnsName("tedge")
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.010784451Z DEBUG rustls::client::hs: Not resuming any session
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.010791326Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/device_profile" }, payload: "{}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.010819826Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/example" }, payload: "{}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.01082891Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/firmware_update" }, payload: "{}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.010832576Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/restart" }, payload: "{}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.011554036Z DEBUG Log Manager: send LogUploadCmdMetadata(LogUploadCmdMetadata { types: ["all-workflows", "firmware_update", "restart", "shell", "software-management"] })
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.01189062Z DEBUG rustls::client::hs: Using ciphersuite TLS13_AES_256_GCM_SHA384
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.011905703Z DEBUG rustls::client::tls13: Not resuming
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.011997703Z DEBUG rustls::client::tls13: TLS1.3 encrypted extensions: []
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.01201012Z DEBUG rustls::client::hs: ALPN protocol is None
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.012019828Z DEBUG rustls::client::tls13: Got CertificateRequest CertificateRequestPayloadTLS13 { context: , extensions: [SignatureAlgorithms([ECDSA_NISTP256_SHA256, ECDSA_NISTP384_SHA384, ECDSA_NISTP521_SHA512, ED25519, ED448, Unknown(2057), Unknown(2058), Unknown(2059), RSA_PSS_SHA256, RSA_PSS_SHA384, RSA_PSS_SHA512, RSA_PKCS1_SHA256, RSA_PKCS1_SHA384, RSA_PKCS1_SHA512, Unknown(771), Unknown(769)])] }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.01202662Z DEBUG rustls::client::common: Attempting client auth
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.01406679Z  INFO tedge_agent::operation_workflows::actor: Waiting failed example operation to be cleared
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.01408804Z DEBUG Mqtt-Request-Converter: recv Some(GenericCommandData(Metadata(GenericCommandMetadata { operation: "config_snapshot", payload: Object {"types": Array [String("modem"), String("system.toml"), String("tedge-configuration-plugin"), String("tedge.toml")]} })))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.01411029Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/config_snapshot" }, payload: "{"types":["modem","system.toml","tedge-configuration-plugin","tedge.toml"]}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.014122706Z DEBUG Mqtt-Request-Converter: recv Some(GenericCommandData(Metadata(GenericCommandMetadata { operation: "config_update", payload: Object {"types": Array [String("modem"), String("system.toml"), String("tedge-configuration-plugin"), String("tedge.toml")]} })))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.014133415Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/config_update" }, payload: "{"types":["modem","system.toml","tedge-configuration-plugin","tedge.toml"]}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.01413729Z DEBUG Mqtt-Request-Converter: recv Some(GenericCommandData(Metadata(GenericCommandMetadata { operation: "log_upload", payload: Object {"types": Array [String("all-workflows"), String("firmware_update"), String("restart"), String("shell"), String("software-management")]} })))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.014141915Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/log_upload" }, payload: "{"types":["all-workflows","firmware_update","restart","shell","software-management"]}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 sudo[1498]:    tedge : PWD=/ ; USER=root ; COMMAND=/etc/tedge/sm-plugins/container list
Oct 02 22:07:43 child02 sudo[1498]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=997)
Oct 02 22:07:43 child02 sudo[1498]: pam_unix(sudo:session): session closed for user root
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.037974451Z ERROR plugin_sm::plugin_manager: File /etc/tedge/sm-plugins/container in plugin directory does not support list operation and may not be a valid plugin, skipping.
Oct 02 22:07:43 child02 sudo[1512]:    tedge : PWD=/ ; USER=root ; COMMAND=/etc/tedge/sm-plugins/container-group list
Oct 02 22:07:43 child02 sudo[1512]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=997)
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.055639062Z  INFO mqtt_channel::connection: MQTT connection established
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.055669853Z DEBUG rumqttc::state: Subscribe. Topics = [Filter = te/device/child02///cmd/+/+, Qos = AtLeastOnce, Filter = te/device/child02/service/tedge-agent/cmd/health/check, Qos = AtLeastOnce], Pkid = 1
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056107146Z DEBUG MQTT pub: [te/device/child02/service/tedge-agent qos=1 retained] {"@parent":"device/child02//","@type":"service","type":"service"}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056195021Z DEBUG MQTT pub: [te/device/child02/service/tedge-agent/status/health qos=1 retained] {"pid":1490,"status":"up","time":1727906863.0095108}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056201646Z DEBUG MQTT pub: [te/device/child02///cmd/device_profile qos=1 retained] {}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056204563Z DEBUG MQTT pub: [te/device/child02///cmd/example qos=1 retained] {}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056206396Z DEBUG MQTT pub: [te/device/child02///cmd/firmware_update qos=1 retained] {}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056210729Z DEBUG MQTT pub: [te/device/child02///cmd/restart qos=1 retained] {}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056216604Z DEBUG MQTT pub: [te/device/child02///cmd/config_snapshot qos=1 retained] {"types":["modem","system.toml","tedge-configuration-plugin","tedge.toml"]}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056219063Z DEBUG MQTT pub: [te/device/child02///cmd/config_update qos=1 retained] {"types":["modem","system.toml","tedge-configuration-plugin","tedge.toml"]}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056220688Z DEBUG MQTT pub: [te/device/child02///cmd/log_upload qos=1 retained] {"types":["all-workflows","firmware_update","restart","shell","software-management"]}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056342188Z DEBUG rumqttc::state: Publish. Topic = te/device/child02/service/tedge-agent, Pkid = 2, Payload Size = 65
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056373396Z DEBUG rumqttc::state: Publish. Topic = te/device/child02/service/tedge-agent/status/health, Pkid = 3, Payload Size = 52
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056480438Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/device_profile, Pkid = 4, Payload Size = 2
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056496188Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/example, Pkid = 5, Payload Size = 2
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056506146Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/firmware_update, Pkid = 6, Payload Size = 2
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056520563Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/restart, Pkid = 7, Payload Size = 2
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056526188Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/config_snapshot, Pkid = 8, Payload Size = 75
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056531521Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/config_update, Pkid = 9, Payload Size = 75
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056536688Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/log_upload, Pkid = 10, Payload Size = 85
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.05657598Z DEBUG MQTT recv: [te/device/child02///cmd/example/local-1727906852 qos=1 retained] {"logPath":"/var/log/tedge/agent/workflow-example-local-1727906852.log","status":"executing"}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.056593438Z DEBUG Mqtt-Request-Converter: recv Some(MqttMessage(MqttMessage { topic: Topic { name: "te/device/child02///cmd/example/local-1727906852" }, payload: "{"logPath":"/var/log/tedge/agent/workflow-example-local-1727906852.log","status":"executing"}", qos: AtLeastOnce, retain: true }))
Oct 02 22:07:43 child02 sudo[1512]: pam_unix(sudo:session): session closed for user root
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.153181794Z ERROR plugin_sm::plugin_manager: File /etc/tedge/sm-plugins/container-group in plugin directory does not support list operation and may not be a valid plugin, skipping.
Oct 02 22:07:43 child02 sudo[1588]:    tedge : PWD=/ ; USER=root ; COMMAND=/etc/tedge/sm-plugins/apt list
Oct 02 22:07:43 child02 sudo[1588]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=997)
Oct 02 22:07:43 child02 sudo[1588]: pam_unix(sudo:session): session closed for user root
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.158951053Z  INFO plugin_sm::plugin_manager: Plugin activated: /etc/tedge/sm-plugins/apt
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.159024928Z  INFO plugin_sm::plugin_manager: Default plugin type: apt
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.161669266Z DEBUG SoftwareManager: send SoftwareCommandMetadata(SoftwareCommandMetadata { types: ["apt"] })
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.161714099Z DEBUG Mqtt-Request-Converter: recv Some(GenericCommandData(Metadata(GenericCommandMetadata { operation: "software_list", payload: Object {"types": Array [String("apt")]} })))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.161726557Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/software_list" }, payload: "{"types":["apt"]}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.161734724Z DEBUG Mqtt-Request-Converter: recv Some(GenericCommandData(Metadata(GenericCommandMetadata { operation: "software_update", payload: Object {"types": Array [String("apt")]} })))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.161738599Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/software_update" }, payload: "{"types":["apt"]}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.161744266Z DEBUG MQTT pub: [te/device/child02///cmd/software_list qos=1 retained] {"types":["apt"]}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.161746932Z DEBUG MQTT pub: [te/device/child02///cmd/software_update qos=1 retained] {"types":["apt"]}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.161762599Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/software_list, Pkid = 11, Payload Size = 17
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.161811599Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/software_update, Pkid = 12, Payload Size = 17
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.204384789Z DEBUG MQTT recv: [te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z qos=1] {"status":"init"}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.204428581Z DEBUG Mqtt-Request-Converter: recv Some(MqttMessage(MqttMessage { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, payload: "{"status":"init"}", qos: AtLeastOnce, retain: false }))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.208723463Z  INFO tedge_agent::operation_workflows::actor: Moving software_list operation to state: scheduled
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.211200675Z  INFO tedge_api::workflow::log::command_log: => moving to software_list @ scheduled
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.212069176Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, payload: "{"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"scheduled"}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.212088384Z DEBUG Mqtt-Request-Converter: recv Some(InternalCommandState(InternalCommandState(GenericCommandState { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, status: "scheduled", payload: Object {"logPath": String("/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log"), "status": String("scheduled")}, invoking_command_topic: None })))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.212115884Z DEBUG MQTT pub: [te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z qos=1 retained] {"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"scheduled"}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.212135134Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z, Pkid = 13, Payload Size = 124
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.212666635Z  INFO tedge_agent::operation_workflows::actor: Executing builtin:software_list operation scheduled step
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.213876345Z  INFO tedge_api::workflow::log::command_log: => moving to software_list @ executing
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.214488638Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, payload: "{"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"executing"}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.214539513Z DEBUG Mqtt-Request-Converter: recv Some(InternalCommandState(InternalCommandState(GenericCommandState { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, status: "executing", payload: Object {"logPath": String("/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log"), "status": String("executing")}, invoking_command_topic: None })))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.214553846Z DEBUG MQTT pub: [te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z qos=1 retained] {"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"executing"}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.214562055Z DEBUG SoftwareManager: recv Some(SoftwareListCommand(Command { target: EntityTopicId("device/child02//"), cmd_id: "c8y-mapper-2024-10-02T22:07:43.162204766Z", payload: SoftwareListCommandPayload { status: Scheduled, current_software_list: [], log_path: Some("/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log") } }))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.214567971Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z, Pkid = 14, Payload Size = 124
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.215907015Z  INFO tedge_agent::operation_workflows::actor: software_list operation executing: waiting for sub-operation completion
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.216363391Z DEBUG SoftwareManager: send SoftwareListCommand(Command { target: EntityTopicId("device/child02//"), cmd_id: "c8y-mapper-2024-10-02T22:07:43.162204766Z", payload: SoftwareListCommandPayload { status: Executing, current_software_list: [], log_path: Some("/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log") } })
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.216800142Z DEBUG Mqtt-Request-Converter: recv Some(GenericCommandData(State(GenericCommandState { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, status: "executing", payload: Object {"logPath": String("/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log"), "status": String("executing")}, invoking_command_topic: None })))
Oct 02 22:07:43 child02 sudo[1592]:    tedge : PWD=/tmp ; USER=root ; COMMAND=/etc/tedge/sm-plugins/apt list
Oct 02 22:07:43 child02 sudo[1592]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=997)
Oct 02 22:07:43 child02 sudo[1592]: pam_unix(sudo:session): session closed for user root
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.222212358Z DEBUG SoftwareManager: send SoftwareListCommand(Command { target: EntityTopicId("device/child02//"), cmd_id: "c8y-mapper-2024-10-02T22:07:43.162204766Z", payload: SoftwareListCommandPayload { status: Successful, current_software_list: [SoftwareList { plugin_type: "apt", modules: [SoftwareModuleItem { name: "adduser", version: Some("3.134"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "apt", version: Some("2.6.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "apt-transport-https", version: Some("2.6.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "base-files", version: Some("12.4+deb12u7"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "base-passwd", version: Some("3.6.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "bash", version: Some("5.2.15-2+b7"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "bsdutils", version: Some("1:2.38.1-5+deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "c8y-command-plugin", version: Some("0.0.2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "ca-certificates", version: Some("20230311"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "coreutils", version: Some("9.1-1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "curl", version: Some("7.88.1-10+deb12u7"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "dash", version: Some("0.5.12-2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "debconf", version: Some("1.5.82"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "debian-archive-keyring", version: Some("2023.3+deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "debianutils", version: Some("5.7-0.5~deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "diffutils", version: Some("1:3.8-4"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "dirmngr", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "dmsetup", version: Some("2:1.02.185-2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "docker-ce-cli", version: Some("5:27.3.1-1~debian.12~bookworm"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "docker-compose-plugin", version: Some("2.29.7-1~debian.12~bookworm"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "dpkg", version: Some("1.21.22"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "e2fsprogs", version: Some("1.47.0-2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "findutils", version: Some("4.9.0-4"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gcc-12-base", version: Some("12.2.0-14"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gnupg", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gnupg-l10n", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gnupg-utils", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gnupg2", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gpg", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gpg-agent", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gpg-wks-client", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gpg-wks-server", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gpgconf", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gpgsm", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gpgv", version: Some("2.2.40-1.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "grep", version: Some("3.8-5"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "gzip", version: Some("1.12-1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "hostname", version: Some("3.23+nmu1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "init-system-helpers", version: Some("1.65.2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "login", version: Some("1:4.13+dfsg1-1+b1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "logsave", version: Some("1.47.0-2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "mawk", version: Some("1.3.4.20200120-3.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "mosquitto", version: Some("2.0.11-1.2+deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "mount", version: Some("2.38.1-5+deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "ncurses-base", version: Some("6.4-4"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "ncurses-bin", version: Some("6.4-4"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "openssh-client", version: Some("1:9.2p1-2+deb12u3"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "openssh-server", version: Some("1:9.2p1-2+deb12u3"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "openssh-sftp-server", version: Some("1:9.2p1-2+deb12u3"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "openssl", version: Some("3.0.14-1~deb12u2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "passwd", version: Some("1:4.13+dfsg1-1+b1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "perl-base", version: Some("5.36.0-7+deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "pinentry-curses", version: Some("1.2.1-1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "procps", version: Some("2:4.0.2-3"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "readline-common", version: Some("8.2-1.3"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "runit-helper", version: Some("2.15.2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "sed", version: Some("4.9-1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "sensible-utils", version: Some("0.0.17+nmu1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "ssh", version: Some("1:9.2p1-2+deb12u3"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "step-ca", version: Some("0.27.4"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "step-cli", version: Some("0.27.4-1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "sudo", version: Some("1.9.13p3-1+deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "systemd", version: Some("252.30-1~deb12u2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "systemd-sysv", version: Some("252.30-1~deb12u2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "sysvinit-utils", version: Some("3.06-4"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "tar", version: Some("1.34+dfsg-1.2+deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "tedge", version: Some("1.3.1~42+ga50bdcf"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "tedge-agent", version: Some("1.3.1~42+ga50bdcf"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "tedge-apt-plugin", version: Some("1.3.1~42+ga50bdcf"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "tedge-container-plugin", version: Some("1.3.1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "tedge-inventory-plugin", version: Some("0.0.3"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "tedge-pki-smallstep-ca", version: Some("0.0.22"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "tedge-pki-smallstep-client", version: Some("0.0.22"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "tzdata", version: Some("2024a-0+deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "ucf", version: Some("3.0043+nmu1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "usr-is-merged", version: Some("37~deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "util-linux", version: Some("2.38.1-5+deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "util-linux-extra", version: Some("2.38.1-5+deb12u1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "vim-common", version: Some("2:9.0.1378-2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "vim-tiny", version: Some("2:9.0.1378-2"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "wget", version: Some("1.21.3-1+b1"), url: None, action: None, reason: None }, SoftwareModuleItem { name: "zlib1g", version: Some("1:1.2.13.dfsg-1"), url: None, action: None, reason: None }] }], log_path: Some("/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log") } })
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.222379817Z DEBUG Mqtt-Request-Converter: recv Some(GenericCommandData(State(GenericCommandState { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, status: "successful", payload: Object {"currentSoftwareList": Array [Object {"modules": Array [Object {"name": String("adduser"), "version": String("3.134")}, Object {"name": String("apt"), "version": String("2.6.1")}, Object {"name": String("apt-transport-https"), "version": String("2.6.1")}, Object {"name": String("base-files"), "version": String("12.4+deb12u7")}, Object {"name": String("base-passwd"), "version": String("3.6.1")}, Object {"name": String("bash"), "version": String("5.2.15-2+b7")}, Object {"name": String("bsdutils"), "version": String("1:2.38.1-5+deb12u1")}, Object {"name": String("c8y-command-plugin"), "version": String("0.0.2")}, Object {"name": String("ca-certificates"), "version": String("20230311")}, Object {"name": String("coreutils"), "version": String("9.1-1")}, Object {"name": String("curl"), "version": String("7.88.1-10+deb12u7")}, Object {"name": String("dash"), "version": String("0.5.12-2")}, Object {"name": String("debconf"), "version": String("1.5.82")}, Object {"name": String("debian-archive-keyring"), "version": String("2023.3+deb12u1")}, Object {"name": String("debianutils"), "version": String("5.7-0.5~deb12u1")}, Object {"name": String("diffutils"), "version": String("1:3.8-4")}, Object {"name": String("dirmngr"), "version": String("2.2.40-1.1")}, Object {"name": String("dmsetup"), "version": String("2:1.02.185-2")}, Object {"name": String("docker-ce-cli"), "version": String("5:27.3.1-1~debian.12~bookworm")}, Object {"name": String("docker-compose-plugin"), "version": String("2.29.7-1~debian.12~bookworm")}, Object {"name": String("dpkg"), "version": String("1.21.22")}, Object {"name": String("e2fsprogs"), "version": String("1.47.0-2")}, Object {"name": String("findutils"), "version": String("4.9.0-4")}, Object {"name": String("gcc-12-base"), "version": String("12.2.0-14")}, Object {"name": String("gnupg"), "version": String("2.2.40-1.1")}, Object {"name": String("gnupg-l10n"), "version": String("2.2.40-1.1")}, Object {"name": String("gnupg-utils"), "version": String("2.2.40-1.1")}, Object {"name": String("gnupg2"), "version": String("2.2.40-1.1")}, Object {"name": String("gpg"), "version": String("2.2.40-1.1")}, Object {"name": String("gpg-agent"), "version": String("2.2.40-1.1")}, Object {"name": String("gpg-wks-client"), "version": String("2.2.40-1.1")}, Object {"name": String("gpg-wks-server"), "version": String("2.2.40-1.1")}, Object {"name": String("gpgconf"), "version": String("2.2.40-1.1")}, Object {"name": String("gpgsm"), "version": String("2.2.40-1.1")}, Object {"name": String("gpgv"), "version": String("2.2.40-1.1")}, Object {"name": String("grep"), "version": String("3.8-5")}, Object {"name": String("gzip"), "version": String("1.12-1")}, Object {"name": String("hostname"), "version": String("3.23+nmu1")}, Object {"name": String("init-system-helpers"), "version": String("1.65.2")}, Object {"name": String("login"), "version": String("1:4.13+dfsg1-1+b1")}, Object {"name": String("logsave"), "version": String("1.47.0-2")}, Object {"name": String("mawk"), "version": String("1.3.4.20200120-3.1")}, Object {"name": String("mosquitto"), "version": String("2.0.11-1.2+deb12u1")}, Object {"name": String("mount"), "version": String("2.38.1-5+deb12u1")}, Object {"name": String("ncurses-base"), "version": String("6.4-4")}, Object {"name": String("ncurses-bin"), "version": String("6.4-4")}, Object {"name": String("openssh-client"), "version": String("1:9.2p1-2+deb12u3")}, Object {"name": String("openssh-server"), "version": String("1:9.2p1-2+deb12u3")}, Object {"name": String("openssh-sftp-server"), "version": String("1:9.2p1-2+deb12u3")}, Object {"name": String("openssl"), "version": String("3.0.14-1~deb12u2")}, Object {"name": String("passwd"), "version": String("1:4.13+dfsg1-1+b1")}, Object {"name": String("perl-base"), "version": String("5.36.0-7+deb12u1")}, Object {"name": String("pinentry-curses"), "version": String("1.2.1-1")}, Object {"name": String("procps"), "version": String("2:4.0.2-3")}, Object {"name": String("readline-common"), "version": String("8.2-1.3")}, Object {"name": String("runit-helper"), "version": String("2.15.2")}, Object {"name": String("sed"), "version": String("4.9-1")}, Object {"name": String("sensible-utils"), "version": String("0.0.17+nmu1")}, Object {"name": String("ssh"), "version": String("1:9.2p1-2+deb12u3")}, Object {"name": String("step-ca"), "version": String("0.27.4")}, Object {"name": String("step-cli"), "version": String("0.27.4-1")}, Object {"name": String("sudo"), "version": String("1.9.13p3-1+deb12u1")}, Object {"name": String("systemd"), "version": String("252.30-1~deb12u2")}, Object {"name": String("systemd-sysv"), "version": String("252.30-1~deb12u2")}, Object {"name": String("sysvinit-utils"), "version": String("3.06-4")}, Object {"name": String("tar"), "version": String("1.34+dfsg-1.2+deb12u1")}, Object {"name": String("tedge"), "version": String("1.3.1~42+ga50bdcf")}, Object {"name": String("tedge-agent"), "version": String("1.3.1~42+ga50bdcf")}, Object {"name": String("tedge-apt-plugin"), "version": String("1.3.1~42+ga50bdcf")}, Object {"name": String("tedge-container-plugin"), "version": String("1.3.1")}, Object {"name": String("tedge-inventory-plugin"), "version": String("0.0.3")}, Object {"name": String("tedge-pki-smallstep-ca"), "version": String("0.0.22")}, Object {"name": String("tedge-pki-smallstep-client"), "version": String("0.0.22")}, Object {"name": String("tzdata"), "version": String("2024a-0+deb12u1")}, Object {"name": String("ucf"), "version": String("3.0043+nmu1")}, Object {"name": String("usr-is-merged"), "version": String("37~deb12u1")}, Object {"name": String("util-linux"), "version": String("2.38.1-5+deb12u1")}, Object {"name": String("util-linux-extra"), "version": String("2.38.1-5+deb12u1")}, Object {"name": String("vim-common"), "version": String("2:9.0.1378-2")}, Object {"name": String("vim-tiny"), "version": String("2:9.0.1378-2")}, Object {"name": String("wget"), "version": String("1.21.3-1+b1")}, Object {"name": String("zlib1g"), "version": String("1:1.2.13.dfsg-1")}], "type": String("apt")}], "logPath": String("/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log"), "status": String("successful")}, invoking_command_topic: None })))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.223928027Z  INFO tedge_agent::software_manager::actor: Checking if tedge got self updated
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.223942694Z  INFO tedge_agent::software_manager::actor: Current running version: 1.3.1~42+ga50bdcf
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.224594779Z  INFO tedge_agent::software_manager::actor: Installed binary version: 1.3.1~42+ga50bdcf
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.224607404Z DEBUG SoftwareManager: recv Some(SoftwareListCommand(Command { target: EntityTopicId("device/child02//"), cmd_id: "c8y-mapper-2024-10-02T22:07:43.162204766Z", payload: SoftwareListCommandPayload { status: Executing, current_software_list: [], log_path: Some("/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log") } }))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.22461357Z  INFO tedge_agent::software_manager::actor: Checking if tedge got self updated
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.224615029Z  INFO tedge_agent::software_manager::actor: Current running version: 1.3.1~42+ga50bdcf
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.224934821Z DEBUG MqttPublisher: send MqttMessage { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, payload: "{"currentSoftwareList":[{"modules":[{"name":"adduser","version":"3.134"},{"name":"apt","version":"2.6.1"},{"name":"apt-transport-https","version":"2.6.1"},{"name":"base-files","version":"12.4+deb12u7"},{"name":"base-passwd","version":"3.6.1"},{"name":"bash","version":"5.2.15-2+b7"},{"name":"bsdutils","version":"1:2.38.1-5+deb12u1"},{"name":"c8y-command-plugin","version":"0.0.2"},{"name":"ca-certificates","version":"20230311"},{"name":"coreutils","version":"9.1-1"},{"name":"curl","version":"7.88.1-10+deb12u7"},{"name":"dash","version":"0.5.12-2"},{"name":"debconf","version":"1.5.82"},{"name":"debian-archive-keyring","version":"2023.3+deb12u1"},{"name":"debianutils","version":"5.7-0.5~deb12u1"},{"name":"diffutils","version":"1:3.8-4"},{"name":"dirmngr","version":"2.2.40-1.1"},{"name":"dmsetup","version":"2:1.02.185-2"},{"name":"docker-ce-cli","version":"5:27.3.1-1~debian.12~bookworm"},{"name":"docker-compose-plugin","version":"2.29.7-1~debian.12~bookworm"},{"name":"dpkg","version":"1.21.22"},{"name":"e2fsprogs","version":"1.47.0-2"},{"name":"findutils","version":"4.9.0-4"},{"name":"gcc-12-base","version":"12.2.0-14"},{"name":"gnupg","version":"2.2.40-1.1"},{"name":"gnupg-l10n","version":"2.2.40-1.1"},{"name":"gnupg-utils","version":"2.2.40-1.1"},{"name":"gnupg2","version":"2.2.40-1.1"},{"name":"gpg","version":"2.2.40-1.1"},{"name":"gpg-agent","version":"2.2.40-1.1"},{"name":"gpg-wks-client","version":"2.2.40-1.1"},{"name":"gpg-wks-server","version":"2.2.40-1.1"},{"name":"gpgconf","version":"2.2.40-1.1"},{"name":"gpgsm","version":"2.2.40-1.1"},{"name":"gpgv","version":"2.2.40-1.1"},{"name":"grep","version":"3.8-5"},{"name":"gzip","version":"1.12-1"},{"name":"hostname","version":"3.23+nmu1"},{"name":"init-system-helpers","version":"1.65.2"},{"name":"login","version":"1:4.13+dfsg1-1+b1"},{"name":"logsave","version":"1.47.0-2"},{"name":"mawk","version":"1.3.4.20200120-3.1"},{"name":"mosquitto","version":"2.0.11-1.2+deb12u1"},{"name":"mount","version":"2.38.1-5+deb12u1"},{"name":"ncurses-base","version":"6.4-4"},{"name":"ncurses-bin","version":"6.4-4"},{"name":"openssh-client","version":"1:9.2p1-2+deb12u3"},{"name":"openssh-server","version":"1:9.2p1-2+deb12u3"},{"name":"openssh-sftp-server","version":"1:9.2p1-2+deb12u3"},{"name":"openssl","version":"3.0.14-1~deb12u2"},{"name":"passwd","version":"1:4.13+dfsg1-1+b1"},{"name":"perl-base","version":"5.36.0-7+deb12u1"},{"name":"pinentry-curses","version":"1.2.1-1"},{"name":"procps","version":"2:4.0.2-3"},{"name":"readline-common","version":"8.2-1.3"},{"name":"runit-helper","version":"2.15.2"},{"name":"sed","version":"4.9-1"},{"name":"sensible-utils","version":"0.0.17+nmu1"},{"name":"ssh","version":"1:9.2p1-2+deb12u3"},{"name":"step-ca","version":"0.27.4"},{"name":"step-cli","version":"0.27.4-1"},{"name":"sudo","version":"1.9.13p3-1+deb12u1"},{"name":"systemd","version":"252.30-1~deb12u2"},{"name":"systemd-sysv","version":"252.30-1~deb12u2"},{"name":"sysvinit-utils","version":"3.06-4"},{"name":"tar","version":"1.34+dfsg-1.2+deb12u1"},{"name":"tedge","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-agent","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-apt-plugin","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-container-plugin","version":"1.3.1"},{"name":"tedge-inventory-plugin","version":"0.0.3"},{"name":"tedge-pki-smallstep-ca","version":"0.0.22"},{"name":"tedge-pki-smallstep-client","version":"0.0.22"},{"name":"tzdata","version":"2024a-0+deb12u1"},{"name":"ucf","version":"3.0043+nmu1"},{"name":"usr-is-merged","version":"37~deb12u1"},{"name":"util-linux","version":"2.38.1-5+deb12u1"},{"name":"util-linux-extra","version":"2.38.1-5+deb12u1"},{"name":"vim-common","version":"2:9.0.1378-2"},{"name":"vim-tiny","version":"2:9.0.1378-2"},{"name":"wget","version":"1.21.3-1+b1"},{"name":"zlib1g","version":"1:1.2.13.dfsg-1"}],"type":"apt"}],"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"successful"}", qos: AtLeastOnce, retain: true }
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.225028196Z DEBUG MQTT pub: [te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z qos=1 retained] {"currentSoftwareList":[{"modules":[{"name":"adduser","version":"3.134"},{"name":"apt","version":"2.6.1"},{"name":"apt-transport-https","version":"2.6.1"},{"name":"base-files","version":"12.4+deb12u7"},{"name":"base-passwd","version":"3.6.1"},{"name":"bash","version":"5.2.15-2+b7"},{"name":"bsdutils","version":"1:2.38.1-5+deb12u1"},{"name":"c8y-command-plugin","version":"0.0.2"},{"name":"ca-certificates","version":"20230311"},{"name":"coreutils","version":"9.1-1"},{"name":"curl","version":"7.88.1-10+deb12u7"},{"name":"dash","version":"0.5.12-2"},{"name":"debconf","version":"1.5.82"},{"name":"debian-archive-keyring","version":"2023.3+deb12u1"},{"name":"debianutils","version":"5.7-0.5~deb12u1"},{"name":"diffutils","version":"1:3.8-4"},{"name":"dirmngr","version":"2.2.40-1.1"},{"name":"dmsetup","version":"2:1.02.185-2"},{"name":"docker-ce-cli","version":"5:27.3.1-1~debian.12~bookworm"},{"name":"docker-compose-plugin","version":"2.29.7-1~debian.12~bookworm"},{"name":"dpkg","version":"1.21.22"},{"name":"e2fsprogs","version":"1.47.0-2"},{"name":"findutils","version":"4.9.0-4"},{"name":"gcc-12-base","version":"12.2.0-14"},{"name":"gnupg","version":"2.2.40-1.1"},{"name":"gnupg-l10n","version":"2.2.40-1.1"},{"name":"gnupg-utils","version":"2.2.40-1.1"},{"name":"gnupg2","version":"2.2.40-1.1"},{"name":"gpg","version":"2.2.40-1.1"},{"name":"gpg-agent","version":"2.2.40-1.1"},{"name":"gpg-wks-client","version":"2.2.40-1.1"},{"name":"gpg-wks-server","version":"2.2.40-1.1"},{"name":"gpgconf","version":"2.2.40-1.1"},{"name":"gpgsm","version":"2.2.40-1.1"},{"name":"gpgv","version":"2.2.40-1.1"},{"name":"grep","version":"3.8-5"},{"name":"gzip","version":"1.12-1"},{"name":"hostname","version":"3.23+nmu1"},{"name":"init-system-helpers","version":"1.65.2"},{"name":"login","version":"1:4.13+dfsg1-1+b1"},{"name":"logsave","version":"1.47.0-2"},{"name":"mawk","version":"1.3.4.20200120-3.1"},{"name":"mosquitto","version":"2.0.11-1.2+deb12u1"},{"name":"mount","version":"2.38.1-5+deb12u1"},{"name":"ncurses-base","version":"6.4-4"},{"name":"ncurses-bin","version":"6.4-4"},{"name":"openssh-client","version":"1:9.2p1-2+deb12u3"},{"name":"openssh-server","version":"1:9.2p1-2+deb12u3"},{"name":"openssh-sftp-server","version":"1:9.2p1-2+deb12u3"},{"name":"openssl","version":"3.0.14-1~deb12u2"},{"name":"passwd","version":"1:4.13+dfsg1-1+b1"},{"name":"perl-base","version":"5.36.0-7+deb12u1"},{"name":"pinentry-curses","version":"1.2.1-1"},{"name":"procps","version":"2:4.0.2-3"},{"name":"readline-common","version":"8.2-1.3"},{"name":"runit-helper","version":"2.15.2"},{"name":"sed","version":"4.9-1"},{"name":"sensible-utils","version":"0.0.17+nmu1"},{"name":"ssh","version":"1:9.2p1-2+deb12u3"},{"name":"step-ca","version":"0.27.4"},{"name":"step-cli","version":"0.27.4-1"},{"name":"sudo","version":"1.9.13p3-1+deb12u1"},{"name":"systemd","version":"252.30-1~deb12u2"},{"name":"systemd-sysv","version":"252.30-1~deb12u2"},{"name":"sysvinit-utils","version":"3.06-4"},{"name":"tar","version":"1.34+dfsg-1.2+deb12u1"},{"name":"tedge","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-agent","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-apt-plugin","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-container-plugin","version":"1.3.1"},{"name":"tedge-inventory-plugin","version":"0.0.3"},{"name":"tedge-pki-smallstep-ca","version":"0.0.22"},{"name":"tedge-pki-smallstep-client","version":"0.0.22"},{"name":"tzdata","version":"2024a-0+deb12u1"},{"name":"ucf","version":"3.0043+nmu1"},{"name":"usr-is-merged","version":"37~deb12u1"},{"name":"util-linux","version":"2.38.1-5+deb12u1"},{"name":"util-linux-extra","version":"2.38.1-5+deb12u1"},{"name":"vim-common","version":"2:9.0.1378-2"},{"name":"vim-tiny","version":"2:9.0.1378-2"},{"name":"wget","version":"1.21.3-1+b1"},{"name":"zlib1g","version":"1:1.2.13.dfsg-1"}],"type":"apt"}],"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"successful"}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.225057488Z DEBUG rumqttc::state: Publish. Topic = te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z, Pkid = 15, Payload Size = 3958
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.225113613Z  INFO tedge_agent::software_manager::actor: Installed binary version: 1.3.1~42+ga50bdcf
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.225318905Z DEBUG MQTT recv: [te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z qos=1] {"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"scheduled"}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.22547578Z DEBUG MQTT recv: [te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z qos=1] {"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"executing"}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.225487822Z DEBUG MQTT recv: [te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z qos=1] {"currentSoftwareList":[{"modules":[{"name":"adduser","version":"3.134"},{"name":"apt","version":"2.6.1"},{"name":"apt-transport-https","version":"2.6.1"},{"name":"base-files","version":"12.4+deb12u7"},{"name":"base-passwd","version":"3.6.1"},{"name":"bash","version":"5.2.15-2+b7"},{"name":"bsdutils","version":"1:2.38.1-5+deb12u1"},{"name":"c8y-command-plugin","version":"0.0.2"},{"name":"ca-certificates","version":"20230311"},{"name":"coreutils","version":"9.1-1"},{"name":"curl","version":"7.88.1-10+deb12u7"},{"name":"dash","version":"0.5.12-2"},{"name":"debconf","version":"1.5.82"},{"name":"debian-archive-keyring","version":"2023.3+deb12u1"},{"name":"debianutils","version":"5.7-0.5~deb12u1"},{"name":"diffutils","version":"1:3.8-4"},{"name":"dirmngr","version":"2.2.40-1.1"},{"name":"dmsetup","version":"2:1.02.185-2"},{"name":"docker-ce-cli","version":"5:27.3.1-1~debian.12~bookworm"},{"name":"docker-compose-plugin","version":"2.29.7-1~debian.12~bookworm"},{"name":"dpkg","version":"1.21.22"},{"name":"e2fsprogs","version":"1.47.0-2"},{"name":"findutils","version":"4.9.0-4"},{"name":"gcc-12-base","version":"12.2.0-14"},{"name":"gnupg","version":"2.2.40-1.1"},{"name":"gnupg-l10n","version":"2.2.40-1.1"},{"name":"gnupg-utils","version":"2.2.40-1.1"},{"name":"gnupg2","version":"2.2.40-1.1"},{"name":"gpg","version":"2.2.40-1.1"},{"name":"gpg-agent","version":"2.2.40-1.1"},{"name":"gpg-wks-client","version":"2.2.40-1.1"},{"name":"gpg-wks-server","version":"2.2.40-1.1"},{"name":"gpgconf","version":"2.2.40-1.1"},{"name":"gpgsm","version":"2.2.40-1.1"},{"name":"gpgv","version":"2.2.40-1.1"},{"name":"grep","version":"3.8-5"},{"name":"gzip","version":"1.12-1"},{"name":"hostname","version":"3.23+nmu1"},{"name":"init-system-helpers","version":"1.65.2"},{"name":"login","version":"1:4.13+dfsg1-1+b1"},{"name":"logsave","version":"1.47.0-2"},{"name":"mawk","version":"1.3.4.20200120-3.1"},{"name":"mosquitto","version":"2.0.11-1.2+deb12u1"},{"name":"mount","version":"2.38.1-5+deb12u1"},{"name":"ncurses-base","version":"6.4-4"},{"name":"ncurses-bin","version":"6.4-4"},{"name":"openssh-client","version":"1:9.2p1-2+deb12u3"},{"name":"openssh-server","version":"1:9.2p1-2+deb12u3"},{"name":"openssh-sftp-server","version":"1:9.2p1-2+deb12u3"},{"name":"openssl","version":"3.0.14-1~deb12u2"},{"name":"passwd","version":"1:4.13+dfsg1-1+b1"},{"name":"perl-base","version":"5.36.0-7+deb12u1"},{"name":"pinentry-curses","version":"1.2.1-1"},{"name":"procps","version":"2:4.0.2-3"},{"name":"readline-common","version":"8.2-1.3"},{"name":"runit-helper","version":"2.15.2"},{"name":"sed","version":"4.9-1"},{"name":"sensible-utils","version":"0.0.17+nmu1"},{"name":"ssh","version":"1:9.2p1-2+deb12u3"},{"name":"step-ca","version":"0.27.4"},{"name":"step-cli","version":"0.27.4-1"},{"name":"sudo","version":"1.9.13p3-1+deb12u1"},{"name":"systemd","version":"252.30-1~deb12u2"},{"name":"systemd-sysv","version":"252.30-1~deb12u2"},{"name":"sysvinit-utils","version":"3.06-4"},{"name":"tar","version":"1.34+dfsg-1.2+deb12u1"},{"name":"tedge","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-agent","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-apt-plugin","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-container-plugin","version":"1.3.1"},{"name":"tedge-inventory-plugin","version":"0.0.3"},{"name":"tedge-pki-smallstep-ca","version":"0.0.22"},{"name":"tedge-pki-smallstep-client","version":"0.0.22"},{"name":"tzdata","version":"2024a-0+deb12u1"},{"name":"ucf","version":"3.0043+nmu1"},{"name":"usr-is-merged","version":"37~deb12u1"},{"name":"util-linux","version":"2.38.1-5+deb12u1"},{"name":"util-linux-extra","version":"2.38.1-5+deb12u1"},{"name":"vim-common","version":"2:9.0.1378-2"},{"name":"vim-tiny","version":"2:9.0.1378-2"},{"name":"wget","version":"1.21.3-1+b1"},{"name":"zlib1g","version":"1:1.2.13.dfsg-1"}],"type":"apt"}],"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"successful"}
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.226088239Z  INFO tedge_agent::operation_workflows::actor: Waiting successful software_list operation to be cleared
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.226125739Z DEBUG Mqtt-Request-Converter: recv Some(MqttMessage(MqttMessage { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, payload: "{"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"scheduled"}", qos: AtLeastOnce, retain: false }))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.226139948Z DEBUG Mqtt-Request-Converter: recv Some(MqttMessage(MqttMessage { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, payload: "{"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"executing"}", qos: AtLeastOnce, retain: false }))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.226147448Z DEBUG Mqtt-Request-Converter: recv Some(MqttMessage(MqttMessage { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, payload: "{"currentSoftwareList":[{"modules":[{"name":"adduser","version":"3.134"},{"name":"apt","version":"2.6.1"},{"name":"apt-transport-https","version":"2.6.1"},{"name":"base-files","version":"12.4+deb12u7"},{"name":"base-passwd","version":"3.6.1"},{"name":"bash","version":"5.2.15-2+b7"},{"name":"bsdutils","version":"1:2.38.1-5+deb12u1"},{"name":"c8y-command-plugin","version":"0.0.2"},{"name":"ca-certificates","version":"20230311"},{"name":"coreutils","version":"9.1-1"},{"name":"curl","version":"7.88.1-10+deb12u7"},{"name":"dash","version":"0.5.12-2"},{"name":"debconf","version":"1.5.82"},{"name":"debian-archive-keyring","version":"2023.3+deb12u1"},{"name":"debianutils","version":"5.7-0.5~deb12u1"},{"name":"diffutils","version":"1:3.8-4"},{"name":"dirmngr","version":"2.2.40-1.1"},{"name":"dmsetup","version":"2:1.02.185-2"},{"name":"docker-ce-cli","version":"5:27.3.1-1~debian.12~bookworm"},{"name":"docker-compose-plugin","version":"2.29.7-1~debian.12~bookworm"},{"name":"dpkg","version":"1.21.22"},{"name":"e2fsprogs","version":"1.47.0-2"},{"name":"findutils","version":"4.9.0-4"},{"name":"gcc-12-base","version":"12.2.0-14"},{"name":"gnupg","version":"2.2.40-1.1"},{"name":"gnupg-l10n","version":"2.2.40-1.1"},{"name":"gnupg-utils","version":"2.2.40-1.1"},{"name":"gnupg2","version":"2.2.40-1.1"},{"name":"gpg","version":"2.2.40-1.1"},{"name":"gpg-agent","version":"2.2.40-1.1"},{"name":"gpg-wks-client","version":"2.2.40-1.1"},{"name":"gpg-wks-server","version":"2.2.40-1.1"},{"name":"gpgconf","version":"2.2.40-1.1"},{"name":"gpgsm","version":"2.2.40-1.1"},{"name":"gpgv","version":"2.2.40-1.1"},{"name":"grep","version":"3.8-5"},{"name":"gzip","version":"1.12-1"},{"name":"hostname","version":"3.23+nmu1"},{"name":"init-system-helpers","version":"1.65.2"},{"name":"login","version":"1:4.13+dfsg1-1+b1"},{"name":"logsave","version":"1.47.0-2"},{"name":"mawk","version":"1.3.4.20200120-3.1"},{"name":"mosquitto","version":"2.0.11-1.2+deb12u1"},{"name":"mount","version":"2.38.1-5+deb12u1"},{"name":"ncurses-base","version":"6.4-4"},{"name":"ncurses-bin","version":"6.4-4"},{"name":"openssh-client","version":"1:9.2p1-2+deb12u3"},{"name":"openssh-server","version":"1:9.2p1-2+deb12u3"},{"name":"openssh-sftp-server","version":"1:9.2p1-2+deb12u3"},{"name":"openssl","version":"3.0.14-1~deb12u2"},{"name":"passwd","version":"1:4.13+dfsg1-1+b1"},{"name":"perl-base","version":"5.36.0-7+deb12u1"},{"name":"pinentry-curses","version":"1.2.1-1"},{"name":"procps","version":"2:4.0.2-3"},{"name":"readline-common","version":"8.2-1.3"},{"name":"runit-helper","version":"2.15.2"},{"name":"sed","version":"4.9-1"},{"name":"sensible-utils","version":"0.0.17+nmu1"},{"name":"ssh","version":"1:9.2p1-2+deb12u3"},{"name":"step-ca","version":"0.27.4"},{"name":"step-cli","version":"0.27.4-1"},{"name":"sudo","version":"1.9.13p3-1+deb12u1"},{"name":"systemd","version":"252.30-1~deb12u2"},{"name":"systemd-sysv","version":"252.30-1~deb12u2"},{"name":"sysvinit-utils","version":"3.06-4"},{"name":"tar","version":"1.34+dfsg-1.2+deb12u1"},{"name":"tedge","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-agent","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-apt-plugin","version":"1.3.1~42+ga50bdcf"},{"name":"tedge-container-plugin","version":"1.3.1"},{"name":"tedge-inventory-plugin","version":"0.0.3"},{"name":"tedge-pki-smallstep-ca","version":"0.0.22"},{"name":"tedge-pki-smallstep-client","version":"0.0.22"},{"name":"tzdata","version":"2024a-0+deb12u1"},{"name":"ucf","version":"3.0043+nmu1"},{"name":"usr-is-merged","version":"37~deb12u1"},{"name":"util-linux","version":"2.38.1-5+deb12u1"},{"name":"util-linux-extra","version":"2.38.1-5+deb12u1"},{"name":"vim-common","version":"2:9.0.1378-2"},{"name":"vim-tiny","version":"2:9.0.1378-2"},{"name":"wget","version":"1.21.3-1+b1"},{"name":"zlib1g","version":"1:1.2.13.dfsg-1"}],"type":"apt"}],"logPath":"/var/log/tedge/agent/workflow-software_list-c8y-mapper-2024-10-02T22:07:43.162204766Z.log","status":"successful"}", qos: AtLeastOnce, retain: false }))
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.350662055Z DEBUG MQTT recv: [te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z qos=1]
Oct 02 22:07:43 child02 tedge-agent[1490]: 2024-10-02T22:07:43.350703846Z DEBUG Mqtt-Request-Converter: recv Some(MqttMessage(MqttMessage { topic: Topic { name: "te/device/child02///cmd/software_list/c8y-mapper-2024-10-02T22:07:43.162204766Z" }, payload: "", qos: AtLeastOnce, retain: false }))
@reubenmiller reubenmiller added bug Something isn't working theme:workflows labels Oct 2, 2024
@didier-wenzek didier-wenzek self-assigned this Oct 28, 2024
didier-wenzek added a commit to didier-wenzek/thin-edge.io that referenced this issue Oct 28, 2024
@didier-wenzek
Reproduce thin-edge#3149
ecbd54e 
Signed-off-by: Didier Wenzek <[email protected]>
@didier-wenzek didier-wenzek mentioned this issue Oct 28, 2024
Merged
13 tasks
didier-wenzek added a commit to didier-wenzek/thin-edge.io that referenced this issue Oct 29, 2024
@didier-wenzek
fixup! Reproduce thin-edge#3149
fdb6031
didier-wenzek added a commit to didier-wenzek/thin-edge.io that referenced this issue Nov 4, 2024
@didier-wenzek
Reproduce thin-edge#3149
8f6f960 
Signed-off-by: Didier Wenzek <[email protected]>
@didier-wenzek didier-wenzek mentioned this issue Nov 4, 2024
Open
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Assignees

@gligorisaev gligorisaev

Labels
bug Something isn't working theme:workflows
Projects
None yet
Milestone
No milestone
Development

No branches or pull requests
3 participants
@reubenmiller @didier-wenzek @gligorisaev