[ 4710.753541] python3.8[7287]: [CLOUD MGR:03-05 14:03:11:DEBUG:2529]:client:_easy_log: Sending PINGREQ [ 4711.002754] python3.8[7287]: [CLOUD MGR:03-05 14:03:11:DEBUG:2529]:client:_easy_log: Received PINGRESP [ 4741.178599] python3.8[7287]: [CLOUD MGR:03-05 14:03:41:DEBUG:2529]:client:_easy_log: Sending PINGREQ [ 4751.786725] python3.8[507]: PING 8.8.8.8 (8.8.8.8): 56 data bytes [ 4751.786995] python3.8[507]: --- 8.8.8.8 ping statistics --- [ 4751.787101] python3.8[507]: 3 packets transmitted, 0 packets received, 100% packet loss [ 4756.795731] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:2529]:client:_easy_log: Received PUBLISH (d0, q0, r0, m0), '$iothub/methods/POST/ExecuteControlCommand /?$rid=29', ... (492 bytes) [ 4756.804362] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:INFO:0253]:mqtt_transport:on_message: message received on $iothub/methods/POST/ExecuteControlCommand/?$rid=2 9 [ 4756.816165] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0104]:pipeline_thread:wrapper: Starting _on_mqtt_message_received in pipeline thread [ 4756.824252] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0337]:pipeline_stages_mqtt:_on_mqtt_message_received: MQTTTransportStage: message received on topic $i othub/methods/POST/ExecuteControlCommand/?$rid=29 [ 4756.827691] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0104]:pipeline_thread:wrapper: Starting _on_pipeline_event in callback thread [ 4756.849254] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0337]:sync_handler_manager:_receiver_handler_runner: HANDLER RUNNER (_on_method_request_received): Inv oking handler [ 4756.859652] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:INFO:0036]:azure_receive_handler:received_message_handler: Executing Control Command [ 4756.859913] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:INFO:0046]:azure_receive_handler:received_message_handler: <----- {"metadata": {"msg_type": "CTL"}, "request ": {"req_command": "toggle_favorite", "response_msg_type": "json", "request_params": null, "cloud_msg_payload": {"data": {"type": "Control", "code": "FAVORITE_CTRL", "attributes": [{"id": "2", "name": "favb", "state": "ON"}]}}}} [ 4756.860255] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0079]:external_io_zeromq:send_external_msg: Sending message : {"metadata": {"msg_type": "CTL"}, "reque st": {"req_command": "toggle_favorite", "response_msg_type": "json", "request_params": null, "cloud_msg_payload": {"data": {"type": "Control", "code": "FAVORITE_CTRL" , "attributes": [{"id": "2", "name": "favb", "state": "ON"}]}}}} [ 4756.871643] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:INFO:0408]:sync_clients:send_method_response: Sending method response to Hub... [ 4756.876009] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0401]:mqtt_pipeline:send_method_response: Starting SendMethodResponseOperation on the pipeline [ 4756.890352] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0104]:pipeline_thread:wrapper: Starting run_op in pipeline thread [ 4757.235028] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0191]:pipeline_ops_base:spawn_worker_op: SendMethodResponseOperation: creating worker op of type MQTTP ublishOperation [ 4757.235124] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0261]:pipeline_stages_mqtt:_run_op: MQTTTransportStage(MQTTPublishOperation): publishing on $iothub/me thods/res/200/?$rid=29 [ 4757.235198] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:INFO:0541]:mqtt_transport:publish: publishing on $iothub/methods/res/200/?$rid=29 [ 4757.235273] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:2529]:client:_easy_log: Sending PUBLISH (d0, q1, r0, m223), 'b'$iothub/methods/res/200/?$rid=29'', ... (4 bytes) [ 4757.235343] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0550]:mqtt_transport:publish: _mqtt_client.publish returned rc=0 [ 4757.235409] python3.8[7287]: [CLOUD MGR:03-05 14:03:57:DEBUG:0594]:mqtt_transport:establish_operation: Waiting for response on MID: 223 [ 4771.456567] python3.8[7287]: [CLOUD MGR:03-05 14:04:11:DEBUG:0023]:cloud_sysd_mgr:notify_systemd: Systemd Notified : Cloud Mgr [ 4771.937553] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0204]:mqtt_transport:on_disconnect: disconnected with result code: 16 [ 4772.087988] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0208]:mqtt_transport:on_disconnect: File "/usr/lib/python3.8/threading.py", line 890, in _bootstrap [ 4772.088275] python3.8[7287]: self._bootstrap_inner() [ 4772.088378] python3.8[7287]: File "/usr/lib/python3.8/threading.py", line 932, in _bootstrap_inner [ 4772.088457] python3.8[7287]: self.run() [ 4772.088529] python3.8[7287]: File "/usr/lib/python3.8/threading.py", line 870, in run [ 4772.088597] python3.8[7287]: self._target(*self._args, **self._kwargs) [ 4772.088666] python3.8[7287]: File "/usr/lib/python3.8/site-packages/paho/mqtt/client.py", line 3591, in _thread_main [ 4772.088734] python3.8[7287]: self.loop_forever(retry_first_connection=True) [ 4772.088799] python3.8[7287]: File "/usr/lib/python3.8/site-packages/paho/mqtt/client.py", line 1756, in loop_forever [ 4772.088863] python3.8[7287]: rc = self._loop(timeout) [ 4772.088929] python3.8[7287]: File "/usr/lib/python3.8/site-packages/paho/mqtt/client.py", line 1185, in _loop [ 4772.088995] python3.8[7287]: return self.loop_misc() [ 4772.089059] python3.8[7287]: File "/usr/lib/python3.8/site-packages/paho/mqtt/client.py", line 1610, in loop_misc [ 4772.089123] python3.8[7287]: self._check_keepalive() [ 4772.089194] python3.8[7287]: File "/usr/lib/python3.8/site-packages/paho/mqtt/client.py", line 2560, in _check_keepalive [ 4772.089258] python3.8[7287]: self._do_on_disconnect(rc) [ 4772.089472] python3.8[7287]: File "/usr/lib/python3.8/site-packages/paho/mqtt/client.py", line 3475, in _do_on_disconnect [ 4772.089608] python3.8[7287]: on_disconnect(self, self._userdata, rc) [ 4772.089679] python3.8[7287]: File "/usr/lib/python3.8/site-packages/azure/iot/device/common/mqtt_transport.py", line 208, in on_disconnect [ 4772.089745] python3.8[7287]: logger.debug("".join(traceback.format_stack())) [ 4772.096111] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0295]:mqtt_transport:_force_transport_disconnect_and_cleanup: Forcing paho disconnect to prevent it fro m automatically reconnecting [ 4772.108473] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0314]:mqtt_transport:_force_transport_disconnect_and_cleanup: in paho thread. nulling _thread [ 4772.120756] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0317]:mqtt_transport:_force_transport_disconnect_and_cleanup: Done forcing paho disconnect [ 4772.131663] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0104]:pipeline_thread:wrapper: Starting _on_mqtt_disconnected in pipeline thread [ 4772.150808] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0204]:mqtt_transport:on_disconnect: disconnected with result code: 0 [ 4772.160699] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0398]:pipeline_stages_mqtt:_on_mqtt_disconnected: MQTTTransportStage: _on_mqtt_disconnect called: Clien t or broker did not communicate in the keepalive interval. [ 4772.160954] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:1139]:pipeline_stages_base:_handle_pipeline_event: ConnectionStateStage(DisconnectedEvent): State chan ges CONNECTED -> DISCONNECTED. Attempting to reconnect [ 4772.164237] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0104]:pipeline_thread:wrapper: Starting _on_mqtt_disconnected in pipeline thread [ 4772.175905] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0310]:pipeline_stages_base:_handle_pipeline_event: PipelineRootStage: DisconnectedEvent received. Call ing on_disconnected_handler [ 4772.186868] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0104]:pipeline_thread:wrapper: Starting _on_disconnected in callback thread [ 4772.205217] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0104]:pipeline_thread:wrapper: Starting on_reconnect_timer_expired in pipeline thread [ 4772.207427] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0138]:abstract_clients:_on_disconnected: Connection State - Disconnected [ 4772.211749] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0147]:abstract_clients:_on_disconnected: Cleared all pending method requests due to disconnect [ 4772.225863] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0365]:sync_handler_manager:_client_event_handler_runner: HANDLER RUNNER (CLIENT EVENT): event received. Invoking > handler [ 4772.226898] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0444]:pipeline_stages_mqtt:_on_mqtt_disconnected: MQTTTransportStage: Unexpected disconnect (no pending connection op) [ 4772.229529] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0328]:pipeline_stages_base:_handle_pipeline_event: PipelineRootStage: BackgroundExceptionEvent receive d. Calling on_background_exception_handler [ 4772.246178] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0104]:pipeline_thread:wrapper: Starting _on_background_exception in callback thread [ 4772.267531] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0144]:azure_cloud_conn_mgr:handle_on_connection_state_change: handle_on_connection_state_change disconn ected. reconnecting. [ 4772.267786] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0146]:azure_cloud_conn_mgr:handle_on_connection_state_change: Network is Down!!! [ 4772.269590] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0426]:oob_cb:send_no_network: Azure Client is disconnected from Azure Hub [ 4772.275210] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:WARNING:0028]:handle_exceptions:handle_background_exception: Exception caught in background thread. Unable to handle. [ 4772.276419] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:WARNING:0029]:handle_exceptions:handle_background_exception: ['azure.iot.device.common.transport_exceptions. ConnectionDroppedError: Unexpected disconnection\n'] [ 4772.278927] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0400]:pipeline_stages_mqtt:_on_mqtt_disconnected: MQTTTransportStage: _on_mqtt_disconnect called [ 4772.290364] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0377]:sync_handler_manager:_client_event_handler_runner: No handler for event set. Skipping handler invocation [ 4772.291707] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0239]:sync_clients:disconnect: Disconnecting from Hub... [ 4772.293298] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0241]:sync_clients:disconnect: Executing initial disconnect [ 4772.629526] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0269]:mqtt_pipeline:disconnect: Starting DisconnectOperation on the pipeline [ 4772.629705] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0104]:pipeline_thread:wrapper: Starting run_op in pipeline thread [ 4772.629816] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:WARNING:1182]:pipeline_stages_base:_handle_pipeline_event: ConnectionStateStage: DisconnectEvent received wh ile in unexpected state - ConnectionState.DISCONNECTED [ 4772.629903] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:1187]:pipeline_stages_base:_handle_pipeline_event: ConnectionStateStage(DisconnectedEvent): State chan ges ConnectionState.DISCONNECTED -> DISCONNECTED. Unexpected disconnect in unexpected state [ 4772.629982] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0310]:pipeline_stages_base:_handle_pipeline_event: PipelineRootStage: DisconnectedEvent received. Call ing on_disconnected_handler [ 4772.630903] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0104]:pipeline_thread:wrapper: Starting _on_disconnected in callback thread [ 4772.631055] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0138]:abstract_clients:_on_disconnected: Connection State - Disconnected [ 4772.631140] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0147]:abstract_clients:_on_disconnected: Cleared all pending method requests due to disconnect [ 4772.631224] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0365]:sync_handler_manager:_client_event_handler_runner: HANDLER RUNNER (CLIENT EVENT): event received. Invoking > handler [ 4772.631307] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0444]:pipeline_stages_mqtt:_on_mqtt_disconnected: MQTTTransportStage: Unexpected disconnect (no pending connection op) [ 4772.631380] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0328]:pipeline_stages_base:_handle_pipeline_event: PipelineRootStage: BackgroundExceptionEvent receive d. Calling on_background_exception_handler [ 4772.631452] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0104]:pipeline_thread:wrapper: Starting _on_background_exception in callback thread [ 4772.631521] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:WARNING:0028]:handle_exceptions:handle_background_exception: Exception caught in background thread. Unable to handle. [ 4772.631599] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:WARNING:0029]:handle_exceptions:handle_background_exception: ['azure.iot.device.common.transport_exceptions. ConnectionDroppedError: Unexpected disconnection\n'] [ 4772.633153] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0188]:sync_handler_manager:handler_callback: HANDLER (CLIENT_EVENT): Successfully completed invocation [ 4772.633359] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0377]:sync_handler_manager:_client_event_handler_runner: No handler for event set. Skipping handler invocation [ 4772.633464] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:1316]:pipeline_stages_base:on_reconnect_timer_expired: ConnectionStateStage: Reconnect timer expired. State is ConnectionState.DISCONNECTED. [ 4772.633547] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:1332]:pipeline_stages_base:on_reconnect_timer_expired: ConnectionStateStage: Starting reconnection [ 4772.633628] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:1333]:pipeline_stages_base:on_reconnect_timer_expired: ConnectionStateStage: State changes ConnectionS tate.DISCONNECTED -> CONNECTING. Sending new connect op down in reconnect attempt [ 4772.633704] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0194]:pipeline_stages_mqtt:_run_op: MQTTTransportStage(ConnectOperation): connecting [ 4772.969090] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0073]:pipeline_stages_mqtt:_start_connection_watchdog: MQTTTransportStage(ConnectOperation): Starting watchdog [ 4772.969270] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:DEBUG:0384]:mqtt_transport:connect: connecting to mqtt broker [ 4772.969358] python3.8[7287]: [CLOUD MGR:03-05 14:04:12:INFO:0395]:mqtt_transport:connect: Connect using port 8883 (TCP) [ 4772.969432] python3.8[7287]: [CLOUD MGR:03-05 14:04:13:INFO:0120]:timer_func:__process_slots: Deleting timer: heartbeat [ 4797.288932] python3.8[881]: PING 8.8.8.8 (8.8.8.8): 56 data bytes [ 4797.289157] python3.8[881]: --- 8.8.8.8 ping statistics --- [ 4797.289260] python3.8[881]: 3 packets transmitted, 0 packets received, 100% packet loss [ 4813.493489] python3.8[7287]: [CLOUD MGR:03-05 14:04:53:DEBUG:0023]:cloud_sysd_mgr:notify_systemd: Systemd Notified : Cloud Mgr [ 4813.992693] python3.8[1065]: PING 8.8.8.8 (8.8.8.8): 56 data bytes [ 4813.992921] python3.8[1065]: --- 8.8.8.8 ping statistics --- [ 4813.993022] python3.8[1065]: 3 packets transmitted, 0 packets received, 100% packet loss [ 4817.896613] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:INFO:0295]:mqtt_transport:_force_transport_disconnect_and_cleanup: Forcing paho disconnect to prevent it fro m automatically reconnecting [ 4817.899142] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0317]:mqtt_transport:_force_transport_disconnect_and_cleanup: Done forcing paho disconnect [ 4817.908259] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:INFO:0208]:pipeline_stages_mqtt:_run_op: transport.connect raised error [ 4817.971807] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:INFO:0209]:pipeline_stages_mqtt:_run_op: Traceback (most recent call last): [ 4817.972088] python3.8[7287]: File "/usr/lib/python3.8/site-packages/azure/iot/device/common/mqtt_transport.py", line 396, in connect [ 4817.972191] python3.8[7287]: rc = self._mqtt_client.connect( [ 4817.972269] python3.8[7287]: File "/usr/lib/python3.8/site-packages/paho/mqtt/client.py", line 914, in connect [ 4817.972369] python3.8[7287]: return self.reconnect() [ 4817.972452] python3.8[7287]: File "/usr/lib/python3.8/site-packages/paho/mqtt/client.py", line 1073, in reconnect [ 4817.972522] python3.8[7287]: sock.do_handshake() [ 4817.972591] python3.8[7287]: File "/usr/lib/python3.8/ssl.py", line 1309, in do_handshake [ 4817.972657] python3.8[7287]: self._sslobj.do_handshake() [ 4817.972720] python3.8[7287]: socket.timeout: _ssl.c:1091: The handshake operation timed out [ 4817.973417] python3.8[7287]: The above exception was the direct cause of the following exception: [ 4817.973565] python3.8[7287]: Traceback (most recent call last): [ 4817.973645] python3.8[7287]: File "/usr/lib/python3.8/site-packages/azure/iot/device/common/pipeline/pipeline_stages_mqtt.py", line 206, in _run_op [ 4817.973719] python3.8[7287]: self.transport.connect(password=password) [ 4817.973790] python3.8[7287]: File "/usr/lib/python3.8/site-packages/azure/iot/device/common/mqtt_transport.py", line 419, in connect [ 4817.973860] python3.8[7287]: raise exceptions.ConnectionFailedError() from e [ 4817.973926] python3.8[7287]: azure.iot.device.common.transport_exceptions.ConnectionFailedError [ 4817.978541] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0121]:pipeline_stages_mqtt:_cancel_connection_watchdog: MQTTTransportStage(ConnectOperation): cancelli ng watchdog [ 4817.987151] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0109]:pipeline_ops_base:complete: ConnectOperation: completing with error [ 4817.993659] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:1249]:pipeline_stages_base:on_reconnect_complete: ConnectionStateStage(ConnectOperation): on_connect_c omplete error= state=ConnectionState.CONNECTING [ 4817.995482] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:1260]:pipeline_stages_base:on_reconnect_complete: ConnectionStateStage: State change ConnectionState.C ONNECTING -> DISCONNECTED [ 4818.001781] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0328]:pipeline_stages_base:_handle_pipeline_event: PipelineRootStage: BackgroundExceptionEvent receive d. Calling on_background_exception_handler [ 4818.004843] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0104]:pipeline_thread:wrapper: Starting _on_background_exception in callback thread [ 4818.009119] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:1273]:pipeline_stages_base:on_reconnect_complete: ConnectionStateStage: Reconnect failed. Starting rec onnection timer [ 4818.013407] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:WARNING:0028]:handle_exceptions:handle_background_exception: Exception caught in background thread. Unable to handle. [ 4818.017207] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:WARNING:0029]:handle_exceptions:handle_background_exception: ['azure.iot.device.common.transport_exceptions. ConnectionFailedError\n'] [ 4818.021404] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0377]:sync_handler_manager:_client_event_handler_runner: No handler for event set. Skipping handler invocation [ 4818.025957] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:1367]:pipeline_stages_base:_clear_reconnect_timer: ConnectionStateStage: clearing reconnect timer [ 4818.028660] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:1026]:pipeline_stages_base:_run_op: ConnectionStateStage(DisconnectOperation): State is already DISCON NECTED. Completing operation [ 4818.032132] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0111]:pipeline_ops_base:complete: DisconnectOperation: completing without error [ 4818.034473] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0104]:pipeline_thread:wrapper: Starting on_complete in callback thread [ 4818.038577] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0050]:evented_callback:wrapping_callback: Callback completed with result None [ 4818.041812] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0245]:sync_clients:disconnect: Successfully executed initial disconnect [ 4818.044047] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0249]:sync_clients:disconnect: Stopping handlers... [ 4818.046320] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0427]:sync_handler_manager:_stop_receiver_handler_runner: Adding HandlerRunnerKillerSentinel to inbox corresponding to _on_message_received handler runner [ 4818.050240] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0436]:sync_handler_manager:_stop_receiver_handler_runner: Waiting for _on_message_received handler run ner to exit... [ 4818.382512] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0326]:sync_handler_manager:_receiver_handler_runner: HANDLER RUNNER (_on_message_received): HandlerRun nerKillerSentinel found in inbox. Exiting. [ 4818.382702] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0440]:sync_handler_manager:_stop_receiver_handler_runner: Handler runner for _on_message_received has been stopped [ 4818.382844] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0427]:sync_handler_manager:_stop_receiver_handler_runner: Adding HandlerRunnerKillerSentinel to inbox corresponding to _on_method_request_received handler runner [ 4818.382952] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0436]:sync_handler_manager:_stop_receiver_handler_runner: Waiting for _on_method_request_received hand ler runner to exit... [ 4818.383037] python3.8[7287]: [CLOUD MGR:03-05 14:04:58:DEBUG:0326]:sync_handler_manager:_receiver_handler_runner: HANDLER RUNNER (_on_method_request_received): Han dlerRunnerKillerSentinel found in inbox. Exiting.