[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [event-loop] - id=0x5623e333b540: Initializing edge-triggered epoll
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [event-loop] - id=0x5623e333b540: Using eventfd for cross-thread notifications.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [event-loop] - id=0x5623e333b540: eventfd descriptor 6.
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [event-loop] - id=0x5623e333b540: Starting event-loop thread.
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [thread] - id=0x5623e3420e50: cpu affinity of cpu_id 0 was specified, attempting to honor the value.
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [event-loop] - id=0x5623e333e5e0: Initializing edge-triggered epoll
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [event-loop] - id=0x5623e333e5e0: Using eventfd for cross-thread notifications.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [event-loop] - id=0x5623e333e5e0: eventfd descriptor 8.
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [event-loop] - id=0x5623e333e5e0: Starting event-loop thread.
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [thread] - id=0x5623e34199d0: cpu affinity of cpu_id 1 was specified, attempting to honor the value.
[INFO] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: main loop started
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: subscribing to events on fd 6
[INFO] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: default timeout 100000, and max events to process per tick 100
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: waiting for a maximum of 100000 ms
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [dns] - id=0x5623e34192f0: Initializing default host resolver with 1 max host entries.
[INFO] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: main loop started
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: subscribing to events on fd 8
[INFO] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: default timeout 100000, and max events to process per tick 100
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [channel-bootstrap] - id=0x5623e33d1210: Initializing client bootstrap with event-loop group 0x5623e33bff50
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: waiting for a maximum of 100000 ms
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [tls-handler] - ctx: Certificate and key have been set, setting them up now.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [channel-bootstrap] - id=0x5623e33d1210: acquiring bootstrap reference
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [connection-manager] - id=0x5623e34d1270: Successfully created
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - client=0x5623e364a9e0: Initalizing MQTT client
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [channel-bootstrap] - id=0x5623e33d1210: acquiring bootstrap reference
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Creating new mqtt 311 connection
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-topic-tree] - tree=0x5623e364ae58: Creating new topic tree
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Setting connection success and failure handlers
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Setting connection interrupted and resumed handlers
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Setting connection closed handler
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Setting username and password
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Using websockets
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Opening connection
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Begin connecting process, switch state to CONNECTING.
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: using ping timeout of 10000000000 ns
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Transforming websocket handshake request.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [connection-manager] - id=0x5623e34d1270: Acquire connection
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [connection-manager] - id=0x5623e34d1270: snapshot - state=1, idle_connection_count=0, pending_acquire_count=1, pending_settings_count=0, pending_connect_count=1, vended_connection_count=0, open_connection_count=0, ref_count=1
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [connection-manager] - id=0x5623e34d1270: Requesting 1 new connections from http
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [http-connection] - static: attempting to initialize a new client channel to c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com:443
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [channel-bootstrap] - id=0x5623e33d1210: attempting to initialize a new client channel to c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com:443
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [channel-bootstrap] - id=0x5623e33d1210: acquiring bootstrap reference
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [dns] - id=0x5623e34192f0: Host resolution requested for c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [dns] - id=0x5623e34192f0: No cached entries found for c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com starting new resolver thread.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: resolving host c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: resolved record: 52.70.54.240
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: resolved record: 52.202.70.64
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: resolved record: 54.160.21.133
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static, resolving host c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com successful, returned 3 addresses
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: new address resolved 52.70.54.240 for host c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com caching
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: new address resolved 52.202.70.64 for host c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com caching
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: new address resolved 54.160.21.133 for host c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com caching
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: remaining record count for host 0
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: remaining record count for host 3
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: vending address 52.70.54.240 for host c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com to caller
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static, invoking resolution callback for host c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com with 1 addresses
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb9872700] [channel-bootstrap] - id=0x5623e33d1210: dns resolution completed. Kicking off connections on 1 addresses. First one back wins.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb9872700] [channel-bootstrap] - acquiring client connection args, args=0x5623e3659cb0
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb9872700] [event-loop] - id=0x5623e333e5e0: Scheduling task 0x7fdba4002570 cross-thread for timestamp 0
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb9872700] [event-loop] - id=0x5623e333e5e0: Waking up event-loop thread
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: wake up with 1 events to process.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: activity on fd 8, invoking handler.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: notified of cross-thread tasks to schedule
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: processing cross-thread tasks
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: task 0x7fdba4002570 pulled to event-loop, scheduling now.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdba4002570: Scheduling attempt_connection task for immediate execution
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: running scheduled tasks.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdba4002570: Running attempt_connection task with <Running> status
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: initializing with domain 0 and type 0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: setting socket options to: keep-alive 0, keep idle 0, keep-alive interval 0, keep-alive probe count 0.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: beginning connect.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: connecting to endpoint 52.70.54.240:443.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: connection pending waiting on event-loop notification or timeout.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: subscribing to events on fd 10
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: scheduling timeout task for 574648157853398.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: scheduling task 0x7fdbb0000c40 in-thread for timestamp 574648157853398
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0000c40: Scheduling (null) task for future execution at time 574648157853398
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: detected more scheduled tasks with the next occurring at 1999986917, using timeout of 1999.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: waiting for a maximum of 1999 ms
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: wake up with 1 events to process.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: activity on fd 10, invoking handler.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - fd=10: connection activity handler triggered
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: has not timed out yet proceeding with connection.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: un-subscribing from events on fd 10
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: scheduling task 0x7fdbb0000de0 in-thread for timestamp 0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0000de0: Scheduling epoll_event_loop_unsubscribe_cleanup task for immediate execution
[INFO] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: connection success
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: assigning to event loop 0x5623e333e5e0
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: subscribing to events on fd 10
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel-bootstrap] - id=0x5623e33d1210: client connection on socket 0x7fdbb00010a0 completed with error 0.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel-bootstrap] - id=0x5623e33d1210: Successful connection, creating a new channel using socket 0x7fdbb00010a0.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: Beginning creation and setup of new channel.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: scheduling task 0x7fdbb0000e50 in-thread for timestamp 0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0000e50: Scheduling on_channel_setup_complete task for immediate execution
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: running scheduled tasks.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0000de0: Running epoll_event_loop_unsubscribe_cleanup task with <Running> status
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0000e50: Running on_channel_setup_complete task with <Running> status
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: setup complete, notifying caller.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: no message pool is currently stored in the event-loop local storage, adding 0x7fdbb0001de0 with max message size 16384, message count 4, with 4 small blocks of 128 bytes.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel-bootstrap] - id=0x5623e33d1210: channel 0x7fdbb00018d0 setup succeeded: bootstrapping.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: creating new slot 0x7fdbb00122e0.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket-handler] - id=0x7fdbb0012890: Socket handler created with max_read_size of 16384
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] -  id=0x7fdbb00010a0 fd=10: subscribing to readable events
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel-bootstrap] - id=0x5623e33d1210: Setting up socket handler on channel 0x7fdbb00018d0 with handler 0x7fdbb0012890 on slot 0x7fdbb00122e0.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: creating new slot 0x7fdbb0000fc0.
[ERROR] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel-bootstrap] - id=0x5623e33d1210: channel 0x7fdbb00018d0 setup failed with error 30.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: channel shutdown task is scheduled
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: scheduling task with wrapper task id 0x7fdbb0001ad0.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: scheduling task 0x7fdbb0001ad0 in-thread for timestamp 0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0001ad0: Scheduling channel_shutdown task for immediate execution
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: detected more scheduled tasks with the next occurring at 0, using timeout of 0.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: waiting for a maximum of 0 ms
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: wake up with 1 events to process.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: activity on fd 10, invoking handler.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: is writable
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: processing write requests, invoked by the event-loop
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: running scheduled tasks.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0001ad0: Running channel_shutdown task with <Running> status
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: beginning shutdown process
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: shutting down slot 0x7fdbb00122e0 (the first one) in the read direction
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: shutting down slot 0x7fdbb00122e0, with handler 0x7fdbb0012890 in read direction with error code 30
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket-handler] - id=0x7fdbb0012890: shutting down read direction with error_code 30
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: handler 0x7fdbb0012890 shutdown in read dir completed.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: scheduling task 0x7fdbb00018f8 in-thread for timestamp 0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb00018f8: Scheduling (null) task for immediate execution
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: detected more scheduled tasks with the next occurring at 0, using timeout of 0.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: waiting for a maximum of 0 ms
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: wake up with 0 events to process.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: running scheduled tasks.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb00018f8: Running (null) task with <Running> status
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket-handler] - id=0x7fdbb0012890: shutting down write direction with error_code 30
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [socket] - id=0x7fdbb00010a0 fd=10: closing
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: un-subscribing from events on fd 10
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: scheduling task 0x7fdbb0001640 in-thread for timestamp 0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0001640: Scheduling epoll_event_loop_unsubscribe_cleanup task for immediate execution
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: scheduling task with wrapper task id 0x7fdbb0012930.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: scheduling task 0x7fdbb0012930 in-thread for timestamp 0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0012930: Scheduling socket_handler_close task for immediate execution
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: detected more scheduled tasks with the next occurring at 0, using timeout of 0.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: waiting for a maximum of 0 ms
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: wake up with 0 events to process.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: running scheduled tasks.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0001640: Running epoll_event_loop_unsubscribe_cleanup task with <Running> status
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0012930: Running socket_handler_close task with <Running> status
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: handler 0x7fdbb0012890 shutdown in write dir completed.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: scheduling task 0x7fdbb00018f8 in-thread for timestamp 0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb00018f8: Scheduling (null) task for immediate execution
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: detected more scheduled tasks with the next occurring at 0, using timeout of 0.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: waiting for a maximum of 0 ms
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: wake up with 0 events to process.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: running scheduled tasks.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb00018f8: Running (null) task with <Running> status
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel-bootstrap] - id=0x5623e33d1210: channel 0x7fdbb00018d0 shutdown with error 30.
[ERROR] [2023-08-08T17:35:38Z] [00007fdbba073700] [http-connection] - static: Client connection failed with error 30 (AWS_ERROR_PRIORITY_QUEUE_EMPTY).
[WARN] [2023-08-08T17:35:38Z] [00007fdbba073700] [connection-manager] - id=0x5623e34d1270: Failed to obtain new connection from http layer, error 30(Attempt to pop an item from an empty queue.)
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [connection-manager] - id=0x5623e34d1270: Failing excess connection acquisition with error code 30
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [connection-manager] - id=0x5623e34d1270: snapshot - state=1, idle_connection_count=0, pending_acquire_count=0, pending_settings_count=0, pending_connect_count=0, vended_connection_count=0, open_connection_count=0, ref_count=1
[WARN] [2023-08-08T17:35:38Z] [00007fdbba073700] [connection-manager] - id=0x5623e34d1270: Failed to complete connection acquisition with error_code 30(Attempt to pop an item from an empty queue.)
[WARN] [2023-08-08T17:35:38Z] [00007fdbba073700] [AuthCredentialsProvider] - id=0x5623e3515970: X509 provider failed to acquire a connection, error code 30(Attempt to pop an item from an empty queue.)
[ERROR] [2023-08-08T17:35:38Z] [00007fdbba073700] [AuthCredentialsProvider] - Failed to parse IoT Core response as Json document.
[WARN] [2023-08-08T17:35:38Z] [00007fdbba073700] [AuthCredentialsProvider] - (id=0x5623e3515970) X509 credentials provider failed to query credentials with error 30(Attempt to pop an item from an empty queue.)
[ERROR] [2023-08-08T17:35:38Z] [00007fdbba073700] [AuthSigning] - (id=0x5623e3652c00) Credentials Provider failed to source credentials with error 30(aws-c-common: AWS_ERROR_PRIORITY_QUEUE_EMPTY, Attempt to pop an item from an empty queue.)
[ERROR] [2023-08-08T17:35:38Z] [00007fdbba073700] [mqtt-client] - id=0x5623e364ab50: Failure reported by websocket handshake transform callback.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [mqtt-client] - id=0x5623e364ab50: Channel has been shutdown with error code 6146
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [mqtt-client] - id=0x5623e364ab50: All subscribe/unsubscribe and publish QoS>0 have been move to pending list
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [mqtt-client] - id=0x5623e364ab50: current state is 0
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [mqtt-client] - id=0x5623e364ab50: Initial connection attempt failed, calling callback
(F) 2023-Aug-08 17:35:38 [MQTT]  Connection failed with error aws-c-auth: AWS_AUTH_SIGNING_NO_CREDENTIALS, Attempt to sign an http request without credentials
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel-bootstrap] - releasing client connection args, args=0x5623e3659cb0
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Setting connection closed handler
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel] - id=0x7fdbb00018d0: destroying channel.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Last refcount on connection has been released, start destroying the connection.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel-bootstrap] - releasing client connection args, args=0x5623e3659cb0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - id=0x5623e364ab50: Destroying connection
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel-bootstrap] - destroying client connection args, args=0x5623e3659cb0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-topic-tree] - tree=0x5623e364ae58: Cleaning up topic tree
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [channel-bootstrap] - id=0x5623e33d1210: releasing bootstrap reference
[TRACE] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-topic-tree] - node=0x5623e3657e70: Destroying topic tree node
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: detected more scheduled tasks with the next occurring at 1996698762, using timeout of 1996.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: waiting for a maximum of 1996 ms
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [mqtt-client] - client=0x5623e364a9e0: Cleaning up MQTT client
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [channel-bootstrap] - id=0x5623e33d1210: releasing bootstrap reference
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [connection-manager] - id=0x5623e34d1270: release
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [connection-manager] - id=0x5623e34d1270: ref count now zero, starting shut down process
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [connection-manager] - id=0x5623e34d1270: manager release, failing 0 pending acquisitions
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [connection-manager] - id=0x5623e34d1270: snapshot - state=2, idle_connection_count=0, pending_acquire_count=0, pending_settings_count=0, pending_connect_count=0, vended_connection_count=0, open_connection_count=0, ref_count=0
[INFO] [2023-08-08T17:35:38Z] [00007fdbc0512980] [connection-manager] - id=0x5623e34d1270: Destroying self
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [channel-bootstrap] - id=0x5623e33d1210: releasing bootstrap reference
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [channel-bootstrap] - id=0x5623e33d1210: releasing bootstrap reference
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbc0512980] [channel-bootstrap] - id=0x5623e33d1210: bootstrap destroying
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: Either no requests have been made for an address for c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com for the duration of the ttl, or this thread is being forcibly shutdown. Killing thread.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: purging address 54.160.21.133 for host c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com from the cache due to cache eviction or shutdown
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: purging address 52.202.70.64 for host c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com from the cache due to cache eviction or shutdown
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb9872700] [dns] - static: purging address 52.70.54.240 for host c1nziiusqalu78.credentials.iot.us-east-1.amazonaws.com from the cache due to cache eviction or shutdown
[INFO] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [event-loop] - id=0x5623e333e5e0: Destroying event_loop
[INFO] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [event-loop] - id=0x5623e333e5e0: Stopping event-loop thread.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [event-loop] - id=0x5623e333e5e0: Scheduling task 0x5623e3419a88 cross-thread for timestamp 0
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [event-loop] - id=0x5623e333e5e0: Waking up event-loop thread
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: wake up with 1 events to process.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: activity on fd 8, invoking handler.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: notified of cross-thread tasks to schedule
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: processing cross-thread tasks
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: task 0x5623e3419a88 pulled to event-loop, scheduling now.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x5623e3419a88: Scheduling epoll_event_loop_stop task for immediate execution
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: running scheduled tasks.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x5623e3419a88: Running epoll_event_loop_stop task with <Running> status
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: detected more scheduled tasks with the next occurring at 1994195317, using timeout of 1994.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: exiting main loop
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: un-subscribing from events on fd 8
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba073700] [event-loop] - id=0x5623e333e5e0: scheduling task 0x7fdbb0000940 in-thread for timestamp 0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba073700] [task-scheduler] - id=0x7fdbb0000940: Scheduling epoll_event_loop_unsubscribe_cleanup task for immediate execution
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [task-scheduler] - id=0x7fdbb0000940: Running epoll_event_loop_unsubscribe_cleanup task with <Canceled> status
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [task-scheduler] - id=0x7fdbb0000c40: Running (null) task with <Canceled> status
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [socket] - task_id=0x7fdbb0000c40: timeout task triggered, evaluating timeouts.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [channel] - static: message pool 0x7fdbb0001de0 has been purged from the event-loop: likely because of shutdown
[INFO] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [event-loop] - id=0x5623e333b540: Destroying event_loop
[INFO] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [event-loop] - id=0x5623e333b540: Stopping event-loop thread.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [event-loop] - id=0x5623e333b540: Scheduling task 0x5623e3420f08 cross-thread for timestamp 0
[TRACE] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [event-loop] - id=0x5623e333b540: Waking up event-loop thread
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: wake up with 1 events to process.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: activity on fd 6, invoking handler.
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: notified of cross-thread tasks to schedule
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: processing cross-thread tasks
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: task 0x5623e3420f08 pulled to event-loop, scheduling now.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba874700] [task-scheduler] - id=0x5623e3420f08: Scheduling epoll_event_loop_stop task for immediate execution
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: running scheduled tasks.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba874700] [task-scheduler] - id=0x5623e3420f08: Running epoll_event_loop_stop task with <Running> status
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: no more scheduled tasks using default timeout.
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: exiting main loop
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: un-subscribing from events on fd 6
[TRACE] [2023-08-08T17:35:38Z] [00007fdbba874700] [event-loop] - id=0x5623e333b540: scheduling task 0x7fdbac001180 in-thread for timestamp 0
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbba874700] [task-scheduler] - id=0x7fdbac001180: Scheduling epoll_event_loop_unsubscribe_cleanup task for immediate execution
[DEBUG] [2023-08-08T17:35:38Z] [00007fdbb8e6a700] [task-scheduler] - id=0x7fdbac001180: Running epoll_event_loop_unsubscribe_cleanup task with <Canceled> status