ebusd-esp32 icon indicating copy to clipboard operation
ebusd-esp32 copied to clipboard
verified publisher icon john30

Wifi Error CCMP replay detected

Open JosemyAB opened this issue 1 year ago • 6 comments

I'm using the v5 adapter with this setup: image

Ebus mode is plain

I'm runing the ebusd deamon in a docker container with this setup:

# EBUSD
  ebusd: 
    container_name: ebusd 
    image: john30/ebusd:v23.3
    privileged: true
    environment: 
      EBUSD_DEVICE: "192.168.1.170:9999" 
      EBUSD_ACCESSLEVEL: "*" 
      EBUSD_SCANCONFIG:
      EBUSD_CONFIGPATH: "/ebusd-configuration/latest/en" 
      EBUSD_POLLINTERVAL: 10
      EBUSD_LATENCY: 20
      EBUSD_MQTTINT: "/ebusd-configuration/mqtt-hassio.cfg"
      EBUSD_MQTTJSON: ""
      EBUSD_MQTTHOST: "192.168.1.6" 
      EBUSD_MQTTPORT: "1883"
      EBUSD_MQTTUSER: "****"
      EBUSD_MQTTPASS: "****"
      TZ: "Europe/Madrid"      
    volumes: 
      - /docker/ebusd/etc:/etc/ebusd 
      - /docker/ebusd/ebusd-configuration:/ebusd-configuration
      - /docker/ebusd/var:/var
      - /etc/localtime:/etc/localtime:ro 
    restart: always 
    depends_on: 
      - mosquitto

And I get a lot of warnings:

Warning	
host: errors: protocol

And this error:

wifi:
19:38:49		
CCMP replay detected: A1=dc:54:75:92:8c:9c A2=04:d9:f5:c5:f5:30 PN=21749, RSC=21750 seq=52960
image

I'm running the last version of the firwmare (2024-03-30) and ebusd 23.3

Am I doing something wrong?

JosemyAB avatar Mar 31 '24 17:03 JosemyAB

I attach the log file of the Ebusd deamon. I don't see anything related, but just in case _ebusd_logs.txt

JosemyAB avatar Mar 31 '24 17:03 JosemyAB

why do you use plain mode? thats basically dropping all the adantages in the first place. never saw CCMP messages before, so might be something with your access point and you should probably check there

john30 avatar Apr 01 '24 05:04 john30

With the enhanced mode I have some typical error messages like "arbitration lost", "ERR: SYN received", etc. With the plain mode I don't get any of them. In any case these errors are not serious at all, are they?

On the other hand, what about the "host: errors: protocol" warnings? What do they mean?

JosemyAB avatar Apr 01 '24 05:04 JosemyAB

a bit of googling reveals that this replay could really mean that somebody is trying to hack you. anyway, you might want to try the newest version just released as there were tons of commits related to wifi in ESP-IDF again

john30 avatar Apr 20 '24 10:04 john30

Hello @john30 I just updated the adapter to the last version and the result has not been good. The daemon started to write errors in the logs like: [bus error] send to fe: ERR: SYN received, retry and [bus notice] arbitration won in invalid state receive command

After a few minutes, it wasn't able to read any field from the BUS.

I rolled back to the version [20240330](https://adapter.ebusd.eu/v5/ChangeLog#20240330) and it has started to work well again.

I'm running the daemon using the official docker container with this setup in the docker-compose.yml file:

# EBUSD
  ebusd: 
    container_name: ebusd
    labels:
      - "com.centurylinklabs.watchtower.enable=false"
    image: john30/ebusd:v23.3
    privileged: true
    environment: 
      EBUSD_DEVICE: "ens:192.168.1.170:9999" 
      EBUSD_ACCESSLEVEL: "*" 
      EBUSD_SCANCONFIG:
      EBUSD_CONFIGPATH: "/ebusd-configuration/latest/en" 
      EBUSD_POLLINTERVAL: 10
      EBUSD_LATENCY: 10
      EBUSD_MQTTINT: "/ebusd-configuration/mqtt-hassio.cfg"
      EBUSD_MQTTJSON: ""
      EBUSD_MQTTHOST: "192.168.1.6" 
      EBUSD_MQTTPORT: "1883"
      EBUSD_MQTTUSER: "*****"
      EBUSD_MQTTPASS: "******"
      TZ: "Europe/Madrid"      
    volumes: 
      - /docker/ebusd/etc:/etc/ebusd 
      - /docker/ebusd/ebusd-configuration:/ebusd-configuration
      - /docker/ebusd/var:/var
      - /etc/localtime:/etc/localtime:ro 
    restart: always 
    depends_on: 
      - mosquitto

This is the log of the daemon:

2024-05-03 10:21:12.294 [main notice] ebusd stopped
2024-05-03 10:21:13.364 [bus notice] device status: transport opened
2024-05-03 10:21:13.366 [main notice] ebusd 23.3.23.3 started with broadcast scan on device: 192.168.1.170:9999, TCP, enhanced
2024-05-03 10:21:13.373 [bus notice] bus started with own address 31/36
2024-05-03 10:21:13.373 [bus notice] device status: reset, supports info
2024-05-03 10:21:13.375 [bus notice] device status: extra info: firmware 1.1[4414].1[4414], jumpers 0x0b
2024-05-03 10:21:13.375 [mqtt notice] connection established
2024-05-03 10:21:13.400 [bus notice] signal acquired
2024-05-03 10:21:13.619 [bus notice] new master 71, master count 2
2024-05-03 10:21:13.694 [bus notice] new master 03, master count 3
2024-05-03 10:21:13.694 [update notice] received unknown MS cmd: 7108b5110107 / 050000000001
2024-05-03 10:21:13.970 [update notice] received unknown MS cmd: 7108b50303010108 / 080205192201235600
2024-05-03 10:21:14.246 [update notice] received unknown MS cmd: 7108b50303010109 / 08020612170123f002
2024-05-03 10:21:15.230 [update notice] received unknown MS cmd: 03e8b512060b0000000000 / 0b0000000001ffffffffff00
2024-05-03 10:21:15.714 [update notice] received unknown MS cmd: 7108b5110100 / 09ee00ff000000008000
2024-05-03 10:21:16.241 [update notice] received unknown MS cmd: 7108b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:16.709 [update notice] received unknown MS cmd: 7108b5110107 / 050000000001
2024-05-03 10:21:17.180 [bus notice] new master 10, master count 4
2024-05-03 10:21:17.274 [update notice] received unknown MS cmd: 1008b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:17.539 [update notice] received unknown MS cmd: 1076b5110101 / 09ffff0080ff39000065
2024-05-03 10:21:17.803 [update notice] received unknown MS cmd: 1076b512030f0001 / 07cc01002f031b03
2024-05-03 10:21:18.069 [update notice] received unknown MS cmd: 1008b51009000000ffffff070000 / 0101
2024-05-03 10:21:18.331 [update notice] received unknown MS cmd: 1076b51009000000ffffff050000 / 0101
2024-05-03 10:21:18.730 [update notice] received unknown MS cmd: 7108b5110100 / 09ee00ff000000008000
2024-05-03 10:21:19.256 [update notice] received unknown MS cmd: 7108b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:19.723 [update notice] received unknown MS cmd: 7108b5110107 / 050000000001
2024-05-03 10:21:20.012 [update notice] received unknown MS cmd: 7108b51a0405493200 / 0a49082f00000000000000
2024-05-03 10:21:20.428 [update notice] received unknown MS cmd: 7108b507030bffff / 0100
2024-05-03 10:21:21.770 [update notice] received unknown MS cmd: 7108b5110100 / 09ee00ff000000008000
2024-05-03 10:21:22.253 [update notice] received unknown MS cmd: 7108b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:22.718 [update notice] received unknown MS cmd: 7108b5110107 / 050000000001
2024-05-03 10:21:23.374 [main notice] starting initial broadcast scan
2024-05-03 10:21:23.452 [bus error] send to fe: ERR: SYN received, retry
2024-05-03 10:21:23.542 [bus notice] arbitration won in invalid state receive command
2024-05-03 10:21:23.597 [bus error] send to fe: ERR: SYN received, retry
2024-05-03 10:21:24.103 [bus notice] arbitration won in invalid state skip
2024-05-03 10:21:24.323 [bus error] send to fe: ERR: SYN received
2024-05-03 10:21:24.323 [main error] initial scan failed: ERR: SYN received
2024-05-03 10:21:24.762 [update notice] received unknown MS cmd: 7108b5110100 / 09ee00ff000000008000
2024-05-03 10:21:25.049 [update notice] received unknown MS cmd: 7108b51a04054a3201 / 0a4a082f00000000000000
2024-05-03 10:21:25.278 [update notice] received unknown MS cmd: 7108b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:25.441 [update notice] received unknown MS cmd: 03e8b512060b0000000000 / 0b0000000001ffffffffff00
2024-05-03 10:21:25.735 [update notice] received unknown MS cmd: 7108b5110107 / 050000000001
2024-05-03 10:21:27.332 [update notice] received unknown MS cmd: 1008b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:27.597 [update notice] received unknown MS cmd: 1076b5110101 / 09ffff0080ff39000065
2024-05-03 10:21:27.778 [update notice] received unknown MS cmd: 7108b5110100 / 09ee00ff000000008000
2024-05-03 10:21:27.914 [update notice] received unknown MS cmd: 1076b512030f0001 / 07cc01002f031b03
2024-05-03 10:21:28.141 [update notice] received unknown MS cmd: 1008b51009000000ffffff070000 / 0101
2024-05-03 10:21:28.277 [update notice] received unknown MS cmd: 7108b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:28.496 [update notice] received unknown MS cmd: 1076b51009000000ffffff050000 / 0101
2024-05-03 10:21:28.748 [update notice] received unknown MS cmd: 7108b5110107 / 050000000001
2024-05-03 10:21:30.538 [update notice] received unknown MS cmd: 7108b507030bffff / 0100
2024-05-03 10:21:30.806 [update notice] received unknown MS cmd: 7108b5110100 / 09ee00ff000000008000
2024-05-03 10:21:31.289 [update notice] received unknown MS cmd: 7108b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:31.799 [update notice] received unknown MS cmd: 7108b5110107 / 050000000001
2024-05-03 10:21:33.782 [update notice] received unknown MS cmd: 7108b5110100 / 09ee00ff000000008000
2024-05-03 10:21:34.309 [update notice] received unknown MS cmd: 7108b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:34.323 [main notice] starting initial broadcast scan
2024-05-03 10:21:34.399 [bus error] send to fe: ERR: SYN received, retry
2024-05-03 10:21:34.490 [bus notice] arbitration won in invalid state receive command
2024-05-03 10:21:34.544 [bus error] send to fe: ERR: SYN received, retry
2024-05-03 10:21:35.094 [bus notice] arbitration won in invalid state skip
2024-05-03 10:21:35.307 [bus notice] arbitration won in invalid state receive response ACK
2024-05-03 10:21:35.605 [bus notice] arbitration won in invalid state receive response ACK
2024-05-03 10:21:35.854 [bus notice] arbitration won in invalid state receive response ACK
2024-05-03 10:21:36.074 [bus error] send to fe: ERR: SYN received
2024-05-03 10:21:36.074 [main error] initial scan failed: ERR: SYN received
2024-05-03 10:21:36.814 [update notice] received unknown MS cmd: 7108b5110100 / 09ee00ff000000008000
2024-05-03 10:21:37.258 [update notice] received unknown MS cmd: 7108b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:37.394 [update notice] received unknown MS cmd: 1008b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:37.658 [update notice] received unknown MS cmd: 1076b5110101 / 09ffff0080ff39000065
2024-05-03 10:21:37.785 [update notice] received unknown MS cmd: 7108b5110107 / 050000000001
2024-05-03 10:21:37.962 [update notice] received unknown MS cmd: 1076b512030f0001 / 07cc01002f031b03
2024-05-03 10:21:38.048 [bus notice] max. symbols per second: 114
2024-05-03 10:21:38.229 [update notice] received unknown MS cmd: 1008b51009000000ffffff070000 / 0101
2024-05-03 10:21:38.491 [update notice] received unknown MS cmd: 1076b51009000000ffffff050000 / 0101
2024-05-03 10:21:39.834 [update notice] received unknown MS cmd: 7108b5110100 / 09ee00ff000000008000
2024-05-03 10:21:40.122 [update notice] received unknown MS cmd: 7108b51a04054e3201 / 0a4e082f00000000000000
2024-05-03 10:21:40.389 [update notice] received unknown MS cmd: 7108b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:40.635 [update notice] received unknown MS cmd: 7108b507030bffff / 0100
2024-05-03 10:21:40.888 [update notice] received unknown MS cmd: 7108b5110107 / 050000000001
2024-05-03 10:21:41.334 [update notice] received unknown MS cmd: 7108b50303010100 / 080200192502165600
2024-05-03 10:21:41.654 [update notice] received unknown MS cmd: 7108b50303010101 / 080200192502165600
2024-05-03 10:21:41.929 [update notice] received unknown MS cmd: 7108b50303010102 / 080230182502165600
2024-05-03 10:21:42.244 [update notice] received unknown MS cmd: 7108b50303010103 / 080220172502165600
2024-05-03 10:21:42.559 [update notice] received unknown MS cmd: 7108b50303010104 / 080201212201235600
2024-05-03 10:21:42.835 [update notice] received unknown MS cmd: 7108b50303010105 / 080256202201235600
2024-05-03 10:21:43.154 [update notice] received unknown MS cmd: 7108b50303010106 / 080256202201235600
2024-05-03 10:21:43.421 [update notice] received unknown MS cmd: 7108b5110101 / 091e1e0080ffff0000ff
2024-05-03 10:21:43.845 [update notice] received unknown MS cmd: 7108b5110107 / 050000000001
2024-05-03 10:21:44.546 [update notice] received unknown MS cmd: 7108b50303010107 / 080228202201235600
2024-05-03 10:21:44.865 [update notice] received unknown MS cmd: 7108b50303010108 / 080205192201235600
2024-05-03 10:21:45.141 [update notice] received unknown MS cmd: 7108b50303010109 / 08020612170123f002
2024-05-03 10:21:45.785 [update notice] received unknown MS cmd: 03e8b512060b0000000000 / 0b0000000001ffffffffff00
2024-05-03 10:21:45.922 [update notice] received unknown MS cmd: 7108b5110100 / 09ee00ff000000008000
2024-05-03 10:21:46.075 [main notice] starting initial broadcast scan
2024-05-03 10:21:46.141 [bus error] send to fe: ERR: SYN received, retry
2024-05-03 10:21:46.232 [bus notice] arbitration won in invalid state receive command
2024-05-03 10:21:46.291 [bus error] send to fe: ERR: SYN received, retry
2024-05-03 10:21:46.844 [bus notice] arbitration won in invalid state skip
2024-05-03 10:21:47.073 [bus notice] arbitration won in invalid state receive response ACK
2024-05-03 10:21:47.343 [bus notice] arbitration won in invalid state receive response ACK
2024-05-03 10:21:47.562 [bus error] send to fe: ERR: SYN received
2024-05-03 10:21:47.562 [main error] initial scan failed: ERR: SYN received

JosemyAB avatar May 03 '24 08:05 JosemyAB

please check with the new version 20240505 just published if this is still the case

john30 avatar May 05 '24 18:05 john30

Ey John! sorry for the late response! Today I've updated the adapter to the last version 20240825

Now I don't have the CCMP error, so it has been fixed. On the other hand the enhanced mode is working well now for my machine

Thanks for your hard work!

I have a couple new things. They don't look very bad but just in case you think they should be fixed:

  • read_host_tcp: recv: errno 104
  • read_host_tcp: recv: errno 128

This is the log: image

JosemyAB avatar Sep 05 '24 06:09 JosemyAB

these happen when the host (ebusd here) closes the connection, so nothing unusual but logged anyway to be aware of potential other socket errors that might occur

john30 avatar Oct 08 '24 05:10 john30