search

nevi-me / esp32-c3-matter-minimal

Reproducing the matter-rs build failure on an ESP32 RISC-V project
1 stars 1 forks source link

Homekit Error #3

Open suyulin opened 1 year ago

suyulin commented 1 year ago

hi, I encountered an error while using Apple's Home for network setup.

 (5872) esp_netif_handlers: sta ip: 192.168.1.109, mask: 255.255.255.0, gw: 192.168.1.1
I (5872) esp32_c3_matter_minimal: Wifi netif up
I (5872) esp32_c3_matter_minimal: wifi connected
I (5872) esp32_c3_matter_minimal: free memory: 251620
I (5882) esp32_c3_matter_minimal: Commisinging data
I (5892) matter::pairing::code: Pairing Code: 0087-6800-071
I (5892) matter::pairing: qrcode_data: MT:Y.K90Q1212Z6Q66D33P084L90Z.I332SQ43I15T0
I (6152) matter::pairing::qr:
█████████████████████████████████████
█████████████████████████████████████
████ ▄▄▄▄▄ █▀██ █▀▀▄ █  ▄█ ▄▄▄▄▄ ████
████ █   █ █ ▀█▀▄▄█▄▀▄ ▄▄█ █   █ ████
████ █▄▄▄█ ██▄ █ ██ ▄ ▀▀▀█ █▄▄▄█ ████
████▄▄▄▄▄▄▄█ █▄█ █ ▀ █ █ █▄▄▄▄▄▄▄████
████▄▀▀▀▀▀▄█▄▀█ █▀██ ▀ ██▄ ▀▀ ▄ ▀████
████▀█  ▀▀▄ ▄▄▀▄▄ ▄▄▄█▀█▄██▄ ▄▀▀▄████
████▀ ▀ █▄▄▀▄▀▀█ ▄█▄ ▀ ▀█ ██   ▀▀████
████ █  █▀▄█  ▄▀▀██▀█▀█ ▀▄ ▀ ██ ▄████
████▀▄▄█▄ ▄ ▀ ▀ ▄▀▀█▄▀█▀▄▄▀▄▄▀ ▀ ████
████ ▄▀█▄█▄ ▄█▀▄█▀█▄█▄▄▄█▄█  ▄  ▀████
████▄█▄██▄▄█▀▀   █ ▄█▀█▄ ▄▄▄ ▄▀▀▄████
████ ▄▄▄▄▄ ██▀█ ▄█▀▀▀▀ ▀ █▄█ ▄▄ ▄████
████ █   █ ██ ▀█▄▄ █▄▀██▄▄▄ ▄▄ ▀▄████
████ █▄▄▄█ ██ ▀▀ ▄█▄▀▄▀█▀▄▀ ▀  ▄█████
████▄▄▄▄▄▄▄█▄█████▄▄██▄▄█▄██▄█▄▄█████
█████████████████████████████████████
▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀▀
I (6322) matter::sys::sys_espidf: mDNS Registration Type _matterc._udp,_S0,_L250
I (6322) matter::sys::sys_espidf: mDNS properties [["D", "250"], ["CM", "1"], ["DN", "OnOff Light"], ["VP", "65521+32768"], ["SII", "5000"], ["SAI", "300"], ["PH", "33"], ["PI", ""]]
I (6342) esp_idf_svc::mdns: Initializing MDNS
Added OnOff Light Device type at endpoint id: 1
Data Model now is: node:
endpoint 0: clusters:[ { id:29, attrs[ 65532: 0, 65531: custom-attribute, 0: custom-attribute, 1: custom-attribute, 3: custom-attribute, 2: custom-attribute ],  },  { id:40, attrs[ 65532: 0, 65531: custom-attribute, 0: 1, 2: 65521, 4: 32768, 7: 2, 9: 1, 10: "1", 15: "aabbccdd" ],  },  { id:48, attrs[ 65532: 0, 65531: custom-attribute, 0: 0, 2: 2, 3: 2, 1: custom-attribute ],  },  { id:49, attrs[ 65532: 4, 65531: custom-attribute ],  },  { id:60, attrs[ 65532: 0, 65531: custom-attribute, 0: custom-attribute, 1: custom-attribute, 2: custom-attribute ],  },  { id:62, attrs[ 65532: 0, 65531: custom-attribute, 5: custom-attribute, 1: custom-attribute, 2: 3, 3: custom-attribute ],  },  { id:31, attrs[ 65532: 0, 65531: custom-attribute, 0: custom-attribute, 1: custom-attribute, 2: 4, 3: 3, 4: 3 ],  }]
endpoint 1: clusters:[ { id:29, attrs[ 65532: 0, 65531: custom-attribute, 0: custom-attribute, 1: custom-attribute, 3: custom-attribute, 2: custom-attribute ],  },  { id:6, attrs[ 65532: 0, 65531: custom-attribute, 0: false ],  }]

free memory: 186396
I (25212) wifi:<ba-add>idx:1 (ifx:0, 6c:b1:58:b5:80:c3), tid:0, ssn:44, winSize:64
I (25222) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (25222) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964133
I (25232) matter::transport::session: Creating new session
I (25242) matter::transport::proto_hdr: [decode] ExId: 62835, Proto: 0, Opcode: 32, Flags: R|I|
I (25252) matter::transport::exchange: Creating new exchange
I (25252) matter::secure_channel::core: Received Opcode: PBKDFParamRequest
I (25262) matter::secure_channel::core: Received Data:
I (25272) matter::tlv::parser: TLV list:
{
    1: len[32][17, 68, aa, 86, 11, 6a, 12, 38, 69, 66, 62, 56, 66, 5a, 43, 97, 8c, 66, 2e, 35, dc, ab, 8e, 83, e8, 5d, bd, f9, b, a0, 88, 36]
    2: U16(6130)
    3: U8(0)
    4: False
    5: {
        1: U16(5000)
        2: U16(300)
    }
}
---------
I (25302) matter::secure_channel::core: Sending response
I (25302) matter::tlv::parser: TLV list:
{
    1: len[32][17, 68, aa, 86, 11, 6a, 12, 38, 69, 66, 62, 56, 66, 5a, 43, 97, 8c, 66, 2e, 35, dc, ab, 8e, 83, e8, 5d, bd, f9, b, a0, 88, 36]
    2: len[32][4d, 65, 71, 3c, f9, 96, 92, c4, 7a, e6, 7c, c1, 5d, 2c, dc, c, d2, 17, 48, 51, d7, a1, 2, a, 87, 56, c7, c6, 17, ca, 72, cc]
    3: U8(1)
    4: {
        1: U16(2000)
        2: len[32][ea, f2, ec, dd, 1b, f, 8b, f0, 18, 21, d4, 48, 26, 24, e1, c8, 55, 21, 19, 4, 66, 8d, b9, 79, 0, 3b, c1, e5, 2a, 9f, ac, 70]
    }
}
---------
I (25352) matter::transport::exchange: Sending with proto id: 0 opcode: 33
I (25362) matter::transport::proto_hdr: [encode] ExId: 62835, Proto: 0, Opcode: 33, Flags: R|A|
Message Sent to [::ffff:192.168.1.112]:5541

I (25372) matter::transport::mgr: Exchange Mgr: {  Session Mgr: {[
{ peer: [::ffff:192.168.1.112]:5541
, peer_nodeid: Some(17018366065166934804), local: 0, remote: 0, msg_ctr: 39896560, mode: PlainText, ts: SystemTime { tv_sec: 19685, tv_nsec: 790218000 }, },
], next_sess_id: 2},
  Exchanges: [
{ exch_id: 62835, sess_index: 0, role: Responder, data: None, mrp: ReliableMessage { retrans: Some(RetransEntry { msg_ctr: 39896559 }), ack: None }, state: Open, },
  ]
}
I (25642) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (25642) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964134
I (25652) matter::transport::proto_hdr: [decode] ExId: 62835, Proto: 0, Opcode: 16, Flags: A|I|
I (25662) matter::secure_channel::core: Received Opcode: MRPStandAloneAck
I (25672) matter::secure_channel::core: Received Data:
I (25682) matter::tlv::parser: TLV list:
---------
I (25682) matter::transport::mgr: Exchange Mgr: {  Session Mgr: {[
{ peer: [::ffff:192.168.1.112]:5541
, peer_nodeid: Some(17018366065166934804), local: 0, remote: 0, msg_ctr: 39896560, mode: PlainText, ts: SystemTime { tv_sec: 19686, tv_nsec: 86217000 }, },
], next_sess_id: 2},
  Exchanges: [
{ exch_id: 62835, sess_index: 0, role: Responder, data: None, mrp: ReliableMessage { retrans: None, ack: None }, state: Open, },
  ]
}
I (25812) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (25812) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964135
I (25822) matter::transport::proto_hdr: [decode] ExId: 62835, Proto: 0, Opcode: 34, Flags: R|A|I|
I (25832) matter::secure_channel::core: Received Opcode: PASEPake1
I (25832) matter::secure_channel::core: Received Data:
I (25842) matter::tlv::parser: TLV list:
{
    1: len[65][4, 2, de, eb, c1, 6b, 38, ba, 7, 9e, 60, 90, cd, a, 74, 16, 93, 64, 3a, ff, 6c, b4, 3f, 71, 4b, 80, 94, 39, 60, b0, 70, 25, 9e, 26, 42, aa, 85, 71, 81, 6c, ab, 48, 1a, 73, 90, d6, 68, c3, 8b, a9, 63, 84, f, 69, a1, ec, 7c, e7, 6f, fc, a5, 8d, c, d5, 5f]
}
---------
I (28892) matter::secure_channel::core: Sending response
I (28902) matter::tlv::parser: TLV list:
{
    1: len[65][4, 11, 35, 13, 63, 3e, de, 87, b1, 1d, 76, 16, 44, b2, 81, 9e, 6a, 19, 7, 7a, 81, ea, 19, dc, cb, ab, 3e, 53, cf, 3a, 17, 7e, d3, 32, 70, 44, e7, eb, 3, 4e, fc, 6, fe, 39, 48, 16, 90, d7, f6, c0, 78, d1, e1, d9, 7f, 3e, 34, b6, 3d, 79, d8, 17, 7d, 75, 50]
    2: len[32][8d, 47, 98, ff, 6d, 81, d2, 2f, 40, e1, ae, e1, c7, 2b, 4, 78, cf, 5b, 55, c2, 26, f0, 6c, c0, ca, 36, b3, 4, a6, 58, b6, fb]
}
---------
I (28932) matter::transport::exchange: Sending with proto id: 0 opcode: 35
I (28942) matter::transport::proto_hdr: [encode] ExId: 62835, Proto: 0, Opcode: 35, Flags: R|A|
Message Sent to [::ffff:192.168.1.112]:5541

I (28952) matter::transport::mgr: Exchange Mgr: {  Session Mgr: {[
{ peer: [::ffff:192.168.1.112]:5541
, peer_nodeid: Some(17018366065166934804), local: 0, remote: 0, msg_ctr: 39896561, mode: PlainText, ts: SystemTime { tv_sec: 19689, tv_nsec: 373976000 }, },
], next_sess_id: 2},
  Exchanges: [
{ exch_id: 62835, sess_index: 0, role: Responder, data: None, mrp: ReliableMessage { retrans: Some(RetransEntry { msg_ctr: 39896560 }), ack: None }, state: Open, },
  ]
}
I (29002) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (29012) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964135
I (29022) matter::transport::session: Dropping duplicate packet
E (29022) matter::transport::mgr: Error in recv: Duplicate
E (29032) matter::transport::mgr: Error in handle_rxtx
I (29042) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (29042) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964135
I (29062) matter::transport::session: Dropping duplicate packet
E (29062) matter::transport::mgr: Error in recv: Duplicate
E (29072) matter::transport::mgr: Error in handle_rxtx
I (29082) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (29082) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964135
I (29102) matter::transport::session: Dropping duplicate packet
E (29102) matter::transport::mgr: Error in recv: Duplicate
E (29112) matter::transport::mgr: Error in handle_rxtx
I (29122) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (29122) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964135
I (29142) matter::transport::session: Dropping duplicate packet
E (29142) matter::transport::mgr: Error in recv: Duplicate
E (29152) matter::transport::mgr: Error in handle_rxtx
I (29152) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (29162) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964136
I (29182) matter::transport::proto_hdr: [decode] ExId: 62835, Proto: 0, Opcode: 16, Flags: A|I|
I (29182) matter::secure_channel::core: Received Opcode: MRPStandAloneAck
I (29192) matter::secure_channel::core: Received Data:
I (29202) matter::tlv::parser: TLV list:
---------
I (29202) matter::transport::mgr: Exchange Mgr: {  Session Mgr: {[
{ peer: [::ffff:192.168.1.112]:5541
, peer_nodeid: Some(17018366065166934804), local: 0, remote: 0, msg_ctr: 39896561, mode: PlainText, ts: SystemTime { tv_sec: 19689, tv_nsec: 608368000 }, },
], next_sess_id: 2},
  Exchanges: [
{ exch_id: 62835, sess_index: 0, role: Responder, data: None, mrp: ReliableMessage { retrans: None, ack: None }, state: Open, },
  ]
}
I (29242) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (29252) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964137
I (29262) matter::transport::proto_hdr: [decode] ExId: 62835, Proto: 0, Opcode: 64, Flags: R|A|I|
I (29272) matter::secure_channel::core: Received Opcode: StatusReport
I (29282) matter::secure_channel::core: Received Data:
I (29292) matter::tlv::parser: TLV list:
S16(0)
S8(0)
S8(2)
E (29292) matter::tlv::parser: Invalid value found: 0 self TLVListIterator { buf: [1, 0, 0, 0, 0, 0, 2, 0], current: 8, left: 0 } size 1
---------
E (29312) matter::secure_channel::core: OpCode Not Handled: StatusReport
E (29312) matter::transport::mgr: Error in proto_demux InvalidOpcode
E (29322) matter::transport::mgr: Error in handle_rxtx
I (29502) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (29502) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964137
I (29512) matter::transport::session: Dropping duplicate packet
E (29522) matter::transport::mgr: Error in recv: Duplicate
E (29522) matter::transport::mgr: Error in handle_rxtx
I (29802) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (29802) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964137
I (29812) matter::transport::session: Dropping duplicate packet
E (29822) matter::transport::mgr: Error in recv: Duplicate
E (29832) matter::transport::mgr: Error in handle_rxtx
I (30422) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (30422) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964137
I (30432) matter::transport::session: Dropping duplicate packet
E (30442) matter::transport::mgr: Error in recv: Duplicate
E (30442) matter::transport::mgr: Error in handle_rxtx
I (31262) matter::transport::session: Received from src: [::ffff:192.168.1.112]:5541

I (31262) matter::transport::plain_hdr: [decode] flags: SRC_ADDR_PRESENT, session type: None, sess_id: 0, ctr: 142964137
I (31272) matter::transport::session: Dropping duplicate packet
E (31282) matter::transport::mgr: Error in recv: Duplicate
E (31282) matter::transport::mgr: Error in handle_rxtx
nevi-me commented 1 year ago

Hey @suyulin I'd consider this repo to be outdated as there has been a lot of progress since I tried this out. A better repo to look at is https://github.com/bjoernQ/matter-rs-experiment