the CRB board(hardware) log shows connected and report errer code -11,but the device in azure shows nothing

Zhang, Huifeng 21 Reputation points
2020-12-10T06:49:45.35+00:00

https://intel-x6000e-out-of-band.azureiotcentral.com/devices/details/1wwdzjv6okp/urn:idejzxwc9nf:l6md6h0icf0:miau4xgl
46841-azure.png

log error report:
[00:00:31.953,186] <inf> OOB_MQTT_CLIENT: Listening to commands from cloud...

[00:00:36.933,471] <dbg> net_mqtt.mqtt_input: (0x600aa5f0): state:0x00000006
[00:00:36.942,901] <dbg> net_mqtt_rx.mqtt_read_message_chunk: (0x600aa5f0): [CID 0x600a1fa4]: Transport read error: -11
[00:00:36.956,573] <inf> OOB_MQTT_CLIENT: Connected to cloud...

============
PSE BringUp ============
BringUp Version: 0.9.0.1
Build date-time: Dec 7 2020 - 05:28:11
Build Machine: e1c0167ffd55
Compiler ver: 8.3.0
Commit: - dirty

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

BUP: early init - DRAM adrs:
BUP: sync path by default 0x79000000
HW revision: 0x1
BUP: cold boot
BUP: vnn req/ack - 0x100000 0x3F
BUP: fusa_ctrl = 0x0 0x2
BUP: RT_NTWK_CTRL - 0x400 0x0
BUP: iccm_lmt & misc_opt - 0x4 0x1 0xF008000 0x50101400 0x0 0x0 0xF007500 0x0 0xF003000 0x8004200 0x8004200 0xF00A600 0x0 0x0 0x7000CC60 0x79000000 0x4 0x3 0xF00B900 0x50101000 0x1A 0xF00C800 0x50101000 0x1A 0xF00DE00 0x50100398 0x1 0x50100010 0x0 0x50100018 0xD824 0xF00EB00 0x0 0x0 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x7000CC60 0x79000000 0x4 0x8004200 0x8004200
SRAM ECC Correction Enabled by default! - 0x0
sram_enable done!
SRAM - MPU cfg - 0x308F025 0x1308CF25
BUP: loading cycle: 0x1
BUP: starting DMA...SRAM test 0x12345678 0x8004200 0x8004200
BUP: D3 status: 0x18180018
BUP: Image modules' count: 0x3
BUP: sz/off/adrs/off_lmt: 0x1D54 0x2760 0x70000000 0x275C 0xF00A600 0x0 0x0 0x70000000 0x79002760 0x1D54 0x3 0xF00B900 0x50101000 0x1A 0xF00C800 0x50101000 0x1A 0xF00DE00 0x50100398 0x1 0x50100010 0x0 0x50100018 0xD824 0xF00EB00 0x0 0x0 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x70000000 0x79002760 0x1D54
BUP: sz/off/adrs/off_lmt: 0xE1202 0x44C0 0x60000000 0x275C 0xF00A600 0x0 0x0 0x60000000 0x790044C0 0xE1202 0x3 0xF00B900 0x50101000 0x1A 0xF00C800 0x50101000 0x1A 0xF00DE00 0x50100398 0x1 0x50100010 0x0 0x50100018 0xD824 0xF00EB00 0x0 0x0 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x60000000 0x790044C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x60010000 0x790144C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x60020000 0x790244C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x60030000 0x790344C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x60040000 0x790444C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x60050000 0x790544C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x60060000 0x790644C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x60070000 0x790744C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x60080000 0x790844C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x60090000 0x790944C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x600A0000 0x790A44C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x600B0000 0x790B44C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x600C0000 0x790C44C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x600D0000 0x790D44C0 0x10000 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x600E0000 0x790E44C0 0x1202
BUP: sz/off/adrs/off_lmt: 0xA10 0xE56C2 0x70008800 0x275C 0xF00A600 0x0 0x0 0x70008800 0x790E56C2 0xA10 0x3 0xF00B900 0x50101000 0x1A 0xF00C800 0x50101000 0x1A 0xF00DE00 0x50100398 0x1 0x50100010 0x0 0x50100018 0xD824 0xF00EB00 0x0 0x0 0xF010200 0x3F 0xF011300 0x50101400 0x50100000 0x501003A0 0x101 0xF012D00 0x70008800 0x790E56C2 0xA10
BUP: DMA done 0x8004200 0x8004200 0x60000000
: 0x600BC000 0x6001FA4D 0x6001FB29 0x6001F769
BUP: MSP|EntryPnt: 0x600BC000 0x6001FA4D 0xF007500 0xF004500
BUP: Ready jump into FW!
BUP: vnn req/ack - 0x100000 0x3F

uart:~$ [00:00:00.014,007] <inf> OOB_SEC_HC: [sec_heci] enter sec_hc_init

uart:~$ [00:00:00.014,526] <inf> eth_dwc_eqos: DWC EQoS MAC IP Version 0x52
uart:~$ [00:00:00.014,526] <inf> eth_dwc_eqos: DWC EQoS obtain MAC addr 00:00:00:00:00:00
uart:~$ [00:00:00.014,556] <inf> eth_dw_tsn: EST: depth=512, ti_wid=24, tils_max=7 tqcnt=8
uart:~$ [00:00:00.014,556] <inf> eth_dw_tsn: FPE capable
uart:~$ uart:~$ ***** Booting Zephyr OS 1.14.2-intel *****

FW VERSION: 0.17.12
FW HW IP: PSE_0_00
FW BUILD: DATE 12072020, TIME 052816, BY root@e1c0167ffd55

[00:00:00.273,010] <inf> phy_marvell_88e1512: PHY Init Success
uart:~$ [00:00:00.599,243] <wrn> net_sock_tls: No entropy device on the system, TLS communication may be insecure!
uart:~$ [00:00:00.600,524] <inf> tsn_net_service: Configured MAC addr to interface index1
uart:~$ [00:00:00.600,555] <dbgPSE ECLite and OOB services [intel_ehl_rvp]

user_app_framework.user_app_init: user_app_init:0x600de988

uart:~$ [00:00:00.600,555] <dbg> user_app_framework.user_app_init: appmem_init_part_part0

uart:~$ --- 11 messages dropped ---
[00:00:00.600,585] <dbg> user_app_framework.user_app_init: appmem_init_part_part1

uart:~$ [00:00:00.600,585] <dbg> user_app_framework.user_app_init: appmem_init_part_part2

uart:~$ [00:00:00.600,585] <dbg> user_app_framework.user_app_init: appmem_init_part_part3

uart:~$ [00:00:00.600,585] <dbg> user_app_framework.user_app_init: INIT_ALL_USER_MODE_APP

uart:~$ [00:00:00.600,616] <dbg> user_app_framework.init_user_mode_app0: init_user_mode_app0

uart:~$ [00:00:00.600,738] <dbg> user_app_framework.user_app_init: INIT_ALL_USER_MODE_APP

uart:~$ [00:00:00.600,738] <dbg> user_app_framework.init_user_mode_app1: init_user_mode_app1

uart:~$ [00:00:00.600,799] <dbg> user_app_framework.user_app_init: INIT_ALL_USER_MODE_APP

uart:~$ [00:00:00.600,830] <dbg> user_app_framework.init_user_mode_app2: init_user_mode_app2

uart:~$ [00:00:00.600,921] <dbg> user_app_framework.user_app_init: INIT_ALL_USER_MODE_APP

uart:~$ [00:00:00.601,318] <dbg> user_app_framework.grant_driver_access: Device:PWM_1, handle:0x600de8a4

uart:~$ [00:00:00.601,379] <dbg> user_app_framework.grant_driver_access: Device:TGPIO_0, handle:0x00000000

uart:~$ [00:00:00.601,379] <err> user_app_framework.grant_driver_access: error device bind req for: TGPIO_0

uart:~$ [00:00:00.601,409] <dbg> user_app_framework.grant_driver_access: no device access request for App:2

uart:~$ [00:00:00.601,409] <dbg> user_app_framework.grant_driver_access: no device access request for App:3

uart:~$ [00:00:00.628,631] <dbg> OOB_EHL.oob_init_config: Starting EHL OOB CFG task

uart:~$ [00:00:00.628,692] <dbg> user_app_framework.user_app_init: k_thread_start 0x600a7198

uart:~$ [00:00:00.629,516] <dbg> user_app_framework.user_app_init: k_thread_start 0x600a8efc

uart:~$ [00:00:00.629,882] <dbg> user_app_framework.user_app_init: k_thread_start 0x600a88cc

uart:~$ [00:00:00.630,157] <dbg> OOB_EHL.ehl_oob_main_service: Starting EHL OOB main service task

uart:~$ [00:00:00.630,615] <dbg> OOB_EHL.ehl_oob_main_service: EHL OOB main service task completed

uart:~$ [00:00:00.631,256] <wrn> cse: not supporting control response commands
uart:~$ [00:00:00.631,378] <dbg> user_app_framework.user_app_init: k_thread_start 0x600a5e18

uart:~$ [00:00:00.642,364] <inf> SEC_INTERNAL: sec_int_start: start

uart:~$ [00:00:00.642,395] <inf> SEC_INTERNAL: .
uart:~$ [00:00:00.642,425] <inf> SEC_INTERNAL: .
uart:~$ [00:00:00.642,456] <inf> SEC_INTERNAL: .
uart:~$ [00:00:00.642,486] <inf> SEC_INTERNAL: .
uart:~$ [00:00:00.642,517] <inf> SEC_INTERNAL: .
uart:~$ [00:00:00.642,547] <inf> SEC_INTERNAL:

uart:~$ uart:~$ uart:~$ mctp discovery completed. service initialized.
--- 5 messages dropped ---
[00:00:01.159,606] <inf> SEC_INTERNAL:

uart:~$ [00:00:01.213,043] <inf> OOB_SEC_HC: [sec_heci] sec_hc_event_callback: , Event: 1

uart:~$ --- 19 messages dropped ---
[00:00:01.213,165] <inf> OOB_SEC_HC: [sec_heci] k_sem_take status: 0, new heci event 1

uart:~$ --- 3943 messages dropped ---
[00:00:01.229,522] <inf> OOB_SEC_HC: Send Response for: SEC_HC_STATUS_OOB

uart:~$ --- 1 messages dropped ---
[00:00:01.359,954] <inf> OOB_SEC_HC: 61
uart:~$ --- 134 messages dropped ---
[00:00:01.359,985] <inf> OOB_SEC_HC: 62
uart:~$ --- 781 messages dropped ---
[00:00:01.360,015] <inf> OOB_SEC_HC: 63
uart:~$ --- 85 messages dropped ---
[00:00:01.360,015] <inf> OOB_SEC_HC: 64
uart:~$ [00:00:01.360,046] <inf> OOB_SEC_HC:

uart:~$ --- 580 messages dropped ---
[00:00:01.360,076] <inf> OOB_SEC_HC: get SEC_HC_TYPE_256_OWN_PUB_KEY data

uart:~$ --- 74 messages dropped ---
[00:00:01.385,375] <inf> OOB_SEC_HC: p_ctx_param_len: 8

uart:~$ --- 570 messages dropped ---
[00:00:01.385,375] <inf> OOB_SEC_HC: get SEC_HC_TYPE_256_OWN_PUB_KEY data:
[Hex]
uart:~$ --- 159 messages dropped ---
[00:00:01.385,406] <inf> OOB_SEC_HC: 61
uart:~$ --- 53 messages dropped ---
[00:00:01.385,437] <inf> OOB_SEC_HC: 62
uart:~$ --- 214 messages dropped ---
[00:00:01.385,467] <inf> OOB_SEC_HC: 64
uart:~$ --- 49 messages dropped ---
[00:00:01.417,053] <inf> OOB_SEC_HC: 72
uart:~$ --- 73 messages dropped ---
[00:00:01.440,155] <inf> OOB_SEC_HC: 8c
uart:~$ --- 181 messages dropped ---
[00:00:01.444,183] <inf> OOB_SEC_HC: 0d
uart:~$ [00:00:01.463,378] <inf> OOB_SEC_HC: b5
uart:~$ --- 1717 messages dropped ---
[00:00:01.646,697] <inf> OOB_SEC_HC: 7e
uart:~$ [00:00:01.899,414] <inf> OOB_SEC_HC: (rxhdr->length) :0x00000008

uart:~$ [00:00:01.899,444] <inf> OOB_SEC_HC: (rxhdr->command) :0x00000014

uart:~$ [00:00:01.899,475] <inf> OOB_SEC_HC: p_ctx_param_len: 8

uart:~$ [00:00:01.899,475] <inf> OOB_SEC_HC: [get ipc buf data]:
[Hex]
uart:~$ [00:00:01.899,505] <inf> OOB_SEC_HC: 20
uart:~$ [00:00:01.899,536] <inf> OOB_SEC_HC: 81
uart:~$ [00:00:01.899,566] <inf> OOB_SEC_HC: 00
uart:~$ [00:00:01.899,566] <inf> OOB_SEC_HC: 14
uart:~$ [00:00:01.899,597] <inf> OOB_SEC_HC: 00
uart:~$ [00:00:01.899,627] <inf> OOB_SEC_HC: 04
uart:~$ [00:00:01.899,658] <inf> OOB_SEC_HC: 00
uart:~$ [00:00:01.899,658] <inf> OOB_SEC_HC: 00
uart:~$ [00:00:01.899,688] <inf> OOB_SEC_HC:

uart:~$ [00:00:01.899,749] <inf> OOB_SEC_HC: [sec_heci] sec_hc_process_cmd

uart:~$ [00:00:01.899,749] <inf> OOB_SEC_HC: >> [SEC_HC_INIT_ACK2]

uart:~$ [00:00:01.899,780] <inf> OOB_SEC_HC: len =4

uart:~$ [00:00:01.899,810] <inf> OOB_SEC_HC: [

uart:~$ [00:00:01.899,810] <inf> OOB_SEC_HC: len =0

uart:~$ [00:00:01.899,841] <inf> OOB_SEC_HC: ]

uart:~$ [00:00:01.899,871] <inf> OOB_SEC_HC: No of Seeds to be Released: 1

uart:~$ [00:00:01.899,902] <inf> OOB_SEC_HC: Free seed index: 0

uart:~$ [00:00:01.900,054] <inf> OOB_SEC_HC: Exiting sec_hc_process_cmd

uart:~$ uart:~$ uart:~$ EC Events: Disabled
[00:00:02.189,270] <inf> SEC_INTERNAL: sec_int_start_init_flag == 1: 1020

uart:~$ [00:00:02.189,300] <inf> SEC_INTERNAL: sec_int_start: BIOS IPC received

uart:~$ [00:00:02.189,300] <inf> OOB_EHL: PSE-OOB BIOS IPC startup succeeded...
uart:~$ [00:00:02.189,331] <dbg> OOB_CREDENTIALS.populate_credentials: Fetching credentials through BIOS IPC
uart:~$ [00:00:02.202,239] <dbg> OOB_CREDENTIALS.populate_credentials: Cloud type from BIOS: Azure
uart:~$ [00:00:02.202,239] <dbg> OOB_CREDENTIALS.populate_credentials: cloud_adapter: 1 size: 5
uart:~$ [00:00:02.215,057] <dbg> OOB_CREDENTIALS.populate_credentials: token: SharedAccessSignature sr=iotc-e0927e36-bc65-45f6-8c28-1061b877f523.azure-devices.net&sig=AzIGqXgehwpOIcCx50yAk31MrQes7Xp0/qNqD8CO7Es%3D&se=33164533673 size: 150
uart:~$ [00:00:02.227,966] <dbg> OOB_CREDENTIALS.populate_credentials: username: iotc-e0927e36-bc65-45f6-8c28-1061b877f523.azure-devices.net/1wwdzjv6okp/?api-version=2018-06-30 size: 95
uart:~$ [00:00:02.239,990] <inf> phy_marvell_88e1512: PHY Link Up Speed 100Mbps Duplex:Full
uart:~$ [00:00:02.240,936] <dbg> OOB_CREDENTIALS.populate_credentials: mqtt client id : 1wwdzjv6okp size: 11
uart:~$ [00:00:02.253,692] <dbg> OOB_CREDENTIALS.populate_credentials: cloud host url: iotc-e0927e36-bc65-45f6-8c28-1061b877f523.azure-devices.net size: 59
uart:~$ [00:00:02.266,418] <dbg> OOB_CREDENTIALS.populate_credentials: cloud port :8883 size: 4
uart:~$ [00:00:02.279,144] <dbg> OOB_CREDENTIALS.populate_credentials: proxy url : size: 0
uart:~$ [00:00:02.291,870] <dbg> OOB_CREDENTIALS.populate_credentials: proxy port :1080 size: 4
uart:~$ [00:00:02.305,023] <dbg> OOB_CREDENTIALS.populate_credentials: creds->trusted_ca: -----BEGIN CERTIFICATE-----
MIIDdzCCAl+gAwIBAgIEAgAAuTANBgkqhkiG9w0BAQUFADBaMQswCQYDVQQGEwJJ
RTESMBAGA1UEChMJQmFsdGltb3JlMRMwEQYDVQQLEwpDeWJlclRydXN0MSIwIAYD
VQQDExlCYWx0aW1vcmUgQ3liZXJUcnVzdCBSb290MB4XDTAwMDUxMjE4NDYwMFoX
DTI1MDUxMjIzNTkwMFowWjELMAkGA1UEBhMCSUUxEjAQBgNVBAoTCUJhbHRpbW9y
ZTETMBEGA1UECxMKQ3liZXJUcnVzdDEiMCAGA1UEAxMZQmFsdGltb3JlIEN5YmVy
VHJ1c3QgUm9vdDCCASIwDQYJKoZIhvcNAQEBBQADggEPADCCAQoCggEBAKMEuyKr
mD1X6CZymrV51Cni4eiVgLGw41uOKymaZN+hXe2wCQVt2yguzmKiYv60iNoS6zjr
IZ3AQSsBUnuId9Mcj8e6uYi1agnnc+gRQKfRzMpijS3ljwumUNKoUMMo6vWrJYeK
mpYcqWe4PwzV9/lSEy/CG9VwcPCPwBLKBsua4dnKM3p31vjsufFoREJIE9LAwqSu
XmD+tqYF/LTdB1kC1FkYmGP1pWPgkAx9XbIGevOF6uvUA65ehD5f/xXtabz5OTZy
dc93Uk3zyZAsuT3lySNTPx8kmCFcB5kpvcY67Oduhjprl3RjM71oGDHweI12v/ye
jl0qhqdNkNwnGjkCAwEAAaNFMEMwHQYDVR0OBBYEFOWdWTCCR1jMrPoIVDaGezq1
BE3wMBIGA1UdEwEB/wQIMAYBAf8CAQMwDgYDVR0PAQH/BAQDAgEGMA0GCSqGSIb3
DQEBBQUAA4IBAQCFDF2O5G9RaEIFoN27TyclhAO992T9Ldcw46QQF+vaKSm2eT92
9hkTI7gQCvlYpNRhcL0EYWoSihfVCr3FvDB81ukMJY2GQE/szKN+OMY3EU/t3Wgx
jkzSswF07r51XgdIGn9w/xZchMB5hbgF/X++ZRGjD8ACtPhSNzkE1akxehi/oCr0
Epn3o0WC4zxe9Z2etciefC7IpJ5OCBRLbf1wbWsaY71k5h+3zvDyny67G7fyUIhz
ksLi4xaNmjICq44Y3ekQEe5+NauQrz4wlHrQMz2nZQ/1/I6eYs9HRCwBXbsdtTLS
R9I4LtD+gdwyah617jzV/OeBHRnDJELqYzmp
-----END CERTIFICATE-----
size: 1283
uart:~$ [00:00:02.305,053] <inf> OOB_EHL: Net Interface (0x600defc0) is up
uart:~$ [00:00:02.305,145] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ uart:~$ uart:~$ [00:00:02.819,274] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ [00:00:03.329,650] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ uart:~$ [00:00:03.849,853] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ [00:00:04.360,229] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ uart:~$ [00:00:04.879,791] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ [00:00:05.390,106] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ uart:~$ [00:00:05.908,996] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ [00:00:06.419,372] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ uart:~$ [00:00:06.937,713] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ [00:00:07.448,089] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ uart:~$ [00:00:07.965,759] <inf> OOB_EHL: Waiting for DHCP to assign address
uart:~$ [00:00:08.390,808] <inf> net_dhcpv4: Received: 192.168.0.187
uart:~$ [00:00:08.390,960] <inf> OOB_EHL: DHCPv4 address: 192.168.0.187
uart:~$ [00:00:08.390,991] <inf> OOB_EHL: Lease time: 604800 seconds
uart:~$ [00:00:08.391,021] <inf> OOB_EHL: Subnet: 255.255.255.0
uart:~$ [00:00:08.391,052] <inf> OOB_EHL: Router: 192.168.0.1
uart:~$ [00:00:08.483,551] <inf> OOB_EHL: DHCPV4 acquired !!
uart:~$ [00:00:08.483,612] <inf> OOB_MQTT_CLIENT: Init Public certificate
uart:~$ [00:00:08.483,673] <inf> OOB_MQTT_CLIENT: Device Cloud Initiated
uart:~$ [00:00:08.483,673] <inf> OOB_EHL: Enable PM flows for OOB
uart:~$ [00:00:08.483,703] <inf> OOB_EHL: EHL-OOB Init configuration completed
uart:~$ uart:~$ uart:~$ [00:00:08.800,354] <inf> OOB_MQTT_CLIENT: DNS resolved for iotc-e0927e36-bc65-45f6-8c28-1061b877f523.azure-devices.net:8883
uart:~$ [00:00:08.800,811] <dbg> net_mqtt_sock_tls.mqtt_client_tls_connect: (0x600a8ac0): Created socket 0
uart:~$ uart:~$ [00:00:16.210,327] <dbg> net_mqtt_sock_tls.mqtt_client_tls_connect: (0x600a8ac0): Connect completed
uart:~$ [00:00:16.210,632] <dbg> net_mqtt_enc.connect_request_encode: (0x600a8ac0): Encoding Protocol Description. Str:MQTT%s: (%p): << msg type:0x%02x length:0x%08x Size:00000004.
uart:~$ [00:00:16.210,845] <dbg> net_mqtt_enc.pack_utf8_str: (0x600a8ac0): >> str_size:00000006 cur:0x600a26f5, end:0x600a2af0
uart:~$ [00:00:16.211,029] <dbg> net_mqtt_enc.pack_uint16: (0x600a8ac0): >> val:0004 cur:0x600a26f5, end:0x600a2af0
uart:~$ [00:00:16.211,181] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.211,364] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.211,547] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.211,700] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.211,883] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.212,036] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.212,280] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.212,463] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.212,738] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.212,921] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.213,104] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.213,439] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.213,623] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.213,806] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.213,989] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.214,233] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.214,385] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.214,569] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.214,752] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.217,529] <dbg> net_mqtt.<log_strdup alloc failed>
uart:~$ uart:~$ uart:~$ [00:00:16.370,483] <inf> OOB_SEC_HC: [sec_heci] sec_hc_event_callback: , Event: 2

uart:~$ [00:00:16.370,788] <inf> OOB_SEC_HC: [sec_heci] k_sem_take status: 0, new heci event 2

uart:~$ [00:00:16.370,788] <inf> OOB_SEC_HC: [sec_heci]disconnect request conn 1

uart:~$ [00:00:16.617,523] <dbg> net_mqtt.mqtt_input: (0x600a8ac0): state:0x00000002
uart:~$ [00:00:16.617,736] <dbg> net_mqtt_dec.unpack_uint8: (0x600a8ac0): >> cur:0x600a22f0, end:0x600a22f2
uart:~$ [00:00:16.617,858] <dbg> net_mqtt_dec.unpack_uint8: (0x600a8ac0): << val:20
uart:~$ [00:00:16.618,011] <dbg> net_mqtt_dec.packet_length_decode: (0x600a8ac0): length:0x00000002
uart:~$ [00:00:16.618,194] <dbg> net_mqtt_rx.<log_strdup alloc failed>
uart:~$ [00:00:16.618,377] <dbg> net_mqtt_dec.<log_strdup alloc failed>
uart:~$ [00:00:16.618,499] <dbg> net_mqtt_dec.<log_strdup alloc failed>
uart:~$ [00:00:16.618,682] <dbg> net_mqtt_dec.<log_strdup alloc failed>
uart:~$ [00:00:16.618,804] <dbg> net_mqtt_dec.<log_strdup alloc failed>
uart:~$ [00:00:16.618,957] <dbg> net_mqtt_dec.<log_strdup alloc failed>
uart:~$ [00:00:16.619,110] <dbg> net_mqtt_rx.<log_strdup alloc failed>
uart:~$ [00:00:16.619,293] <dbg> OOB_MQTT_CLIENT.<log_strdup alloc failed>
uart:~$ [00:00:16.619,537] <dbg> OOB_MQTT_CLIENT.<log_strdup alloc failed>
uart:~$ [00:00:16.619,781] <dbg> net_mqtt.<log_strdup alloc failed>
uart:~$ [00:00:16.620,025] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.620,208] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.620,391] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.620,574] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.620,758] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.620,941] <dbg> net_mqtt_enc.<log_strdup alloc failed>
uart:~$ [00:00:16.621,093] <dbg> net_mqtt_enc.<log_strdup alloc failed>00:16.621,246] <dbg> n[00:00:16.621,459] <dbg> net_mqtt_enc.<log_strdup alloc failed>
[00:00:16.621,612] <dbg> net_mqtt.<log_strdup alloc failed>
[00:00:16.622,985] <dbg> net_mqtt.<log_strdup alloc failed>
[00:00:16.623,199] <dbg> net_mqtt.<log_strdup alloc failed>
[00:00:16.623,321] <inf> OOB_MQTT_CLIENT: <log_strdup alloc failed>
[00:00:16.833,557] <dbg> net_mqtt.mqtt_input: (0x600a8ac0): state:0x00000006
[00:00:16.833,770] <dbg> net_mqtt_dec.unpack_uint8: (0x600a8ac0): >> cur:0x600a22f0, end:0x600a22f2
[00:00:16.833,923] <dbg> net_mqtt_dec.unpack_uint8: (0x600a8ac0): << val:90
[00:00:16.834,045] <dbg> net_mqtt_dec.packet_length_decode: (0x600a8ac0): length:0x00000003
[00:00:16.834,259] <dbg> net_mqtt_rx.<log_strdup alloc failed>
[00:00:16.834,411] <dbg> net_mqtt_dec.<log_strdup alloc failed>
[00:00:16.834,533] <dbg> net_mqtt_dec.<log_strdup alloc failed>
[00:00:16.834,686] <dbg> net_mqtt_dec.<log_strdup alloc failed>
[00:00:16.834,808] <dbg> net_mqtt_dec.<log_strdup alloc failed>
***** MPU FAULT *****
Data Access Violation
MMFAR Address: 0x600af7d0
***** Hardware exception *****
Current thread ID = 0x600a8ac0
Faulting instruction address = 0x600021b8
Fatal fault in thread 0x600a8ac0! Aborting.
d>
log_strdup alloc et_mqtt_enc.<log_strdup alloc failed>
uart:~$ uart:~$ uart:~$ [00:00:21.858,978] <dbg> net_mqtt.mqtt_input: (0x600aa5f0): state:0x00000006
[00:00:21.868,408] <dbg> net_mqtt_rx.mqtt_read_message_chunk: (0x600aa5f0): [CID 0x600a1fa4]: Transport read error: -11
[00:00:21.882,080] <inf> OOB_MQTT_CLIENT: Connected to cloud...

[00:00:21.890,258] <inf> OOB_MQTT_CLIENT: Listening to commands from cloud...

EC Events: Enabled
EC Events: Enabled
[00:00:26.896,972] <dbg> net_mqtt.mqtt_input: (0x600aa5f0): state:0x00000006
[00:00:26.906,402] <dbg> net_mqtt_rx.mqtt_read_message_chunk: (0x600aa5f0): [CID 0x600a1fa4]: Transport read error: -11
[00:00:26.920,074] <inf> OOB_MQTT_CLIENT: Connected to cloud...

[00:00:26.928,253] <inf> OOB_MQTT_CLIENT: Listening to commands from cloud...

[00:00:31.921,905] <dbg> net_mqtt.mqtt_input: (0x600aa5f0): state:0x00000006
[00:00:31.931,335] <dbg> net_mqtt_rx.mqtt_read_message_chunk: (0x600aa5f0): [CID 0x600a1fa4]: Transport read error: -11
[00:00:31.945,007] <inf> OOB_MQTT_CLIENT: Connected to cloud...

[00:00:31.953,186] <inf> OOB_MQTT_CLIENT: Listening to commands from cloud...

[00:00:36.933,471] <dbg> net_mqtt.mqtt_input: (0x600aa5f0): state:0x00000006
[00:00:36.942,901] <dbg> net_mqtt_rx.mqtt_read_message_chunk: (0x600aa5f0): [CID 0x600a1fa4]: Transport read error: -11
[00:00:36.956,573] <inf> OOB_MQTT_CLIENT: Connected to cloud...

[00:00:36.964,752] <inf> OOB_MQTT_CLIENT: Listening to commands from cloud...

[00:00:41.942,108] <dbg> net_mqtt.mqtt_input: (0x600aa5f0): state:0x00000006
[00:00:41.951,538] <dbg> net_mqtt_rx.mqtt_read_message_chunk: (0x600aa5f0): [CID 0x600a1fa4]: Transport read error: -11
[00:00:41.965,209] <inf> OOB_MQTT_CLIENT: Connected to cloud...

[00:00:41.973,388] <inf> OOB_MQTT_CLIENT: Listening to commands from cloud...

Azure IoT Central
Azure IoT Central
An Azure hosted internet of things (IoT) application platform.
357 questions
Azure IoT SDK
Azure IoT SDK
An Azure software development kit that facilitates building applications that connect to Azure IoT services.
211 questions
0 comments No comments
{count} votes

Accepted answer
  1. JoyDutt 821 Reputation points
    2020-12-10T15:51:10.51+00:00

    At high level it seems connection issue - 3 things can hint based on analysis of your logs-

    1)
    uart:~$ [00:00:00.599,243] <wrn> net_sock_tls: No entropy device on the system, TLS communication may be insecure!

    But I see some certificate too being used at end of logs

    2)
    uart:~$ [00:00:00.642,364] <inf> SEC_INTERNAL: sec_int_start: start
    Here the discovery is started but messages are getting dropped.
    uart:~$ uart:~$ uart:~$ mctp discovery completed. service initialized.
    --- 5 messages dropped ---
    [00:00:01.159,606] <inf> SEC_INTERNAL:

    3) Waiting for DHCP to assign address

    May be this would help :https://learn.microsoft.com/en-us/azure/iot-central/core/troubleshoot-connection

    1 person found this answer helpful.

0 additional answers

Sort by: Most helpful