Komponent wM-Bus do ESPHome (SzczepanLeon) wersja 3.x - wątek ogólny

Próbuję odczytać wodomierz Multical21, jednak jak na razie bez sukcesu. Nie mam pojęcia, co jest przyczyną. Jestem początkujący, ale może ktoś z większą wiedzą i doświadczenie będzie mógł pomóc na podstawie logów very_verbose i yamla. Hardware to ESP8266 i CC1101 868.950.

INFO ESPHome 2024.4.2
INFO Reading configuration /config/esphome/wodomierzesp8266.yaml...
INFO Detected timezone 'Europe/Warsaw'
INFO Starting log output from 192.168.1.73 using esphome API
INFO Successfully connected to wodomierzesp8266 @ 192.168.1.73 in 0.004s
INFO Successful handshake with wodomierzesp8266 @ 192.168.1.73 in 2.866s
[23:41:21][I][app:100]: ESPHome version 2024.4.2 compiled on May  9 2024, 23:37:43
[23:41:21][C][wifi:580]: WiFi:
[23:41:21][C][wifi:408]:   Local MAC: BC:FF:4D:82:96:B2
[23:41:21][C][wifi:413]:   SSID: 'SD'[redacted]
[23:41:21][C][wifi:416]:   IP Address: 192.168.1.73
[23:41:21][C][wifi:419]:   BSSID: 40:3F:8C:91:77:58[redacted]
[23:41:21][C][wifi:421]:   Hostname: 'wodomierzesp8266'
[23:41:21][C][wifi:423]:   Signal strength: -46 dB ▂▄▆█
[23:41:21][V][wifi:425]:   Priority: 0.0
[23:41:21][C][wifi:427]:   Channel: 1
[23:41:21][C][wifi:428]:   Subnet: 255.255.255.0
[23:41:21][C][wifi:429]:   Gateway: 192.168.1.1
[23:41:21][C][wifi:430]:   DNS1: 192.168.1.1
[23:41:21][C][wifi:431]:   DNS2: 0.0.0.0
[23:41:21][C][logger:166]: Logger:
[23:41:21][C][logger:167]:   Level: VERY_VERBOSE
[23:41:21][C][logger:169]:   Log Baud Rate: 115200
[23:41:21][C][logger:170]:   Hardware UART: UART0
[23:41:22][C][homeassistant.time:010]: Home Assistant Time:
[23:41:22][C][homeassistant.time:011]:   Timezone: 'CET-1CEST,M3.5.0,M10.5.0/3'
[23:41:22][C][captive_portal:088]: Captive Portal:
[23:41:22][C][web_server:169]: Web Server:
[23:41:22][C][web_server:170]:   Address: wodomierzesp8266.local:80
[23:41:22][C][mdns:115]: mDNS:
[23:41:22][C][mdns:116]:   Hostname: wodomierzesp8266
[23:41:22][V][mdns:117]:   Services:
[23:41:22][V][mdns:119]:   - _esphomelib, _tcp, 6053
[23:41:22][V][mdns:121]:     TXT: friendly_name = WodomierzESP8266
[23:41:22][V][mdns:121]:     TXT: version = 2024.4.2
[23:41:22][V][mdns:121]:     TXT: mac = bcff4d8296b2
[23:41:22][V][mdns:121]:     TXT: platform = ESP8266
[23:41:22][V][mdns:121]:     TXT: board = nodemcuv2
[23:41:22][V][mdns:121]:     TXT: network = wifi
[23:41:22][V][mdns:121]:     TXT: api_encryption = Noise_NNpsk0_25519_ChaChaPoly_SHA256
[23:41:22][V][mdns:119]:   - _http, _tcp, 80
[23:41:22][C][ota:096]: Over-The-Air Updates:
[23:41:22][C][ota:097]:   Address: wodomierzesp8266.local:8266
[23:41:22][C][ota:100]:   Using Password.
[23:41:22][C][ota:103]:   OTA version: 2.
[23:41:22][C][api:139]: API Server:
[23:41:22][C][api:140]:   Address: wodomierzesp8266.local:6053
[23:41:22][C][api:142]:   Using noise encryption: YES
[23:41:22][C][wmbus:372]: wM-Bus v3.2.1:
[23:41:22][C][wmbus:374]:   Clients:
[23:41:22][C][wmbus:376]:     wmbusmeters: 10.0.0.1:7227 TCP [rtl-wmbus]
[23:41:22][C][wmbus:385]:   LED:
[23:41:22][C][wmbus:386]:     Pin: GPIO0
[23:41:22][C][wmbus:387]:     Duration: 1000 ms
[23:41:22][C][wmbus:389]:   CC1101 frequency: 868.950 MHz
[23:41:22][C][wmbus:390]:   CC1101 SPI bus:
[23:41:22][C][wmbus:391]:     MOSI Pin: GPIO13
[23:41:22][C][wmbus:392]:     MISO Pin: GPIO12
[23:41:22][C][wmbus:393]:     CLK Pin:  GPIO14
[23:41:22][C][wmbus:394]:     CS Pin:   GPIO2
[23:41:22][C][wmbus:395]:     GDO0 Pin: GPIO5
[23:41:22][C][wmbus:396]:     GDO2 Pin: GPIO4
[23:41:22][C][wmbus:403]:   Available drivers:  amiplus, apator08, apator162, apatoreitn, bmeters, c5isf, compact5, dme07, elf, evo868, fhkvdataiii, flowiq2200, hydrocalm3, hydrus, iperl, itron, izar, kamheat, mkradio3, mkradio4, mkradio4a, multical21, qheat, qwater, rfmtx1, sharky774, topaseskr, ultrimis, unismart, vario451
[23:41:22][C][wmbus:421]:   Meter:
[23:41:22][C][wmbus:422]:     ID: 58074409 [0x03762529]
[23:41:22][C][wmbus:423]:     Type: multical21
[23:41:22][C][wmbus:424]:     Mode: T1
[23:41:22][C][wmbus:425]:     Key: '00000000000000000000000000000000'
[23:41:22][C][wmbus:427]:     Sensor '0x3762529 LQI wodomierz'
[23:41:22][C][wmbus:427]:       Device Class: 'signal_strength'
[23:41:22][C][wmbus:427]:       State Class: 'measurement'
[23:41:22][C][wmbus:427]:       Unit of Measurement: ''
[23:41:22][C][wmbus:427]:       Accuracy Decimals: 0
[23:41:22][C][wmbus:427]:     Sensor '0x3762529 RSSI wodomierz'
[23:41:22][C][wmbus:427]:       Device Class: 'signal_strength'
[23:41:22][C][wmbus:427]:       State Class: 'measurement'
[23:41:22][C][wmbus:427]:       Unit of Measurement: 'dBm'
[23:41:22][C][wmbus:427]:       Accuracy Decimals: 0
[23:41:22][C][wmbus:427]:     Sensor '0x3762529 Wodomierz'
[23:41:22][C][wmbus:427]:       Device Class: 'water'
[23:41:22][C][wmbus:427]:       State Class: 'total_increasing'
[23:41:22][C][wmbus:427]:       Unit of Measurement: 'm³'
[23:41:22][C][wmbus:427]:       Accuracy Decimals: 3
[23:41:22][C][wmbus:427]:       Icon: 'mdi:water'
[23:41:22][V][wmbus:427]:       Force Update: YES
[23:41:22][C][wmbus:421]:   Meter:
[23:41:22][C][wmbus:422]:     ID: 2952790005 [0xAFFFFFF5]
[23:41:22][C][wmbus:423]:     Type: text
[23:41:22][C][wmbus:424]:     Mode: T1
[23:41:22][C][wmbus:425]:     Key: ''
[23:41:30][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=148362 (now=158362)
[23:41:40][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=158362 (now=168362)
[23:41:50][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=168362 (now=178362)
[23:41:55][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=123288 (now=183288)
[23:42:00][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=178362 (now=188362)
[23:42:10][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=188362 (now=198362)
[23:42:20][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=198362 (now=208362)
[23:42:21][VV][api.connection:132]: Sending keepalive PING...
[23:42:21][VV][api.service:037]: send_ping_request: PingRequest {}
[23:42:21][VV][api.service:611]: on_ping_response: PingResponse {}
[23:42:30][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=208362 (now=218362)
[23:42:40][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=218362 (now=228362)
[23:42:40][V][rxLoop:167]: Have 40 bytes from CC1101 Rx, RSSI: -31 dBm LQI: 128
[23:42:40][D][mbus:023]: Processing C1 B frame
[23:42:40][V][mbus:027]: Frame: 25442D2C094407581B168D204B748B8F222FB90C9FC7CE6A7C0EC7D310E24F032D1DC61ACFA0 (38) [with CRC]
[23:42:40][V][mbus:165]: Validating CRC for Block1 + Block2
[23:42:40][V][crc:031]:     calculated: 0xCFA0, read: 0xCFA0
[23:42:40][V][mbus:062]: Frame: 23442D2C094407581B168D204B748B8F222FB90C9FC7CE6A7C0EC7D310E24F032D1DC61A (36) [without CRC]
[23:42:40][VV][wmbus:061]: Have data from CC1101 ...
[23:42:40][D][wmbus:176]: Meter ID [0x58074409] RSSI: -31 dBm LQI: 128 Frame: C1 B not found in configuration T: 23442D2C094407581B168D204B748B8F222FB90C9FC7CE6A7C0EC7D310E24F032D1DC61A (36)
[23:42:40][VV][wmbus:186]: Will send telegram to clients ...
[23:42:40][V][wmbus:228]: Will send RTLWMBUS telegram to 10.0.0.1:7227 via TCP
[23:42:45][E][wmbus:241]: Can't connect via TCP to 10.0.0.1:7227
[23:42:45][W][component:237]: Component wmbus took a long time for an operation (5088 ms).
[23:42:45][W][component:238]: Components should block for at most 30 ms.
[23:42:50][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=228362 (now=238362)
[23:42:55][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=183288 (now=243288)
[23:43:00][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=238362 (now=248362)
[23:43:10][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=248362 (now=258362)
[23:43:20][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=258362 (now=268362)
[23:43:21][VV][api.connection:132]: Sending keepalive PING...
[23:43:21][VV][api.service:037]: send_ping_request: PingRequest {}
[23:43:21][VV][api.service:611]: on_ping_response: PingResponse {}
[23:43:30][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=268362 (now=278362)
[23:43:40][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=278362 (now=288362)
[23:43:50][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=288362 (now=298362)
[23:43:55][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=243288 (now=303288)
[23:44:00][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=298362 (now=308362)
[23:44:03][I][ota:117]: Boot seems successful, resetting boot loop counter.
[23:44:10][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=308362 (now=318362)
[23:44:16][V][rxLoop:167]: Have 40 bytes from CC1101 Rx, RSSI: -31 dBm LQI: 128
[23:44:16][D][mbus:023]: Processing C1 B frame
[23:44:16][V][mbus:027]: Frame: 25442D2C094407581B168D204C888B8F22700F1F604E27EBC0B424A2D9C6E0DF6B391719E0FB (38) [with CRC]
[23:44:16][V][mbus:165]: Validating CRC for Block1 + Block2
[23:44:16][V][crc:031]:     calculated: 0xE0FB, read: 0xE0FB
[23:44:16][V][mbus:062]: Frame: 23442D2C094407581B168D204C888B8F22700F1F604E27EBC0B424A2D9C6E0DF6B391719 (36) [without CRC]
[23:44:16][VV][wmbus:061]: Have data from CC1101 ...
[23:44:16][D][wmbus:176]: Meter ID [0x58074409] RSSI: -31 dBm LQI: 128 Frame: C1 B not found in configuration T: 23442D2C094407581B168D204C888B8F22700F1F604E27EBC0B424A2D9C6E0DF6B391719 (36)
[23:44:16][VV][wmbus:186]: Will send telegram to clients ...
[23:44:16][V][wmbus:228]: Will send RTLWMBUS telegram to 10.0.0.1:7227 via TCP
[23:44:21][E][wmbus:241]: Can't connect via TCP to 10.0.0.1:7227
[23:44:21][W][component:237]: Component wmbus took a long time for an operation (5086 ms).
[23:44:21][W][component:238]: Components should block for at most 30 ms.
[23:44:21][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=318362 (now=329389)
[23:44:21][VV][api.connection:132]: Sending keepalive PING...
[23:44:21][VV][api.service:037]: send_ping_request: PingRequest {}
[23:44:21][VV][api.service:611]: on_ping_response: PingResponse {}
[23:44:30][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=328362 (now=338362)
[23:44:40][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=338362 (now=348362)
[23:44:50][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=348362 (now=358362)
[23:44:55][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=303288 (now=363288)
[23:45:00][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=358362 (now=368362)
[23:45:10][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=368362 (now=378362)
[23:45:20][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=378362 (now=388362)
[23:45:21][VV][api.connection:132]: Sending keepalive PING...
[23:45:21][VV][api.service:037]: send_ping_request: PingRequest {}
[23:45:21][VV][api.service:611]: on_ping_response: PingResponse {}
[23:45:30][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=388362 (now=398362)
[23:45:40][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=398362 (now=408362)
[23:45:50][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=408362 (now=418362)
[23:45:55][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=363288 (now=423288)
[23:46:00][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=418362 (now=428362)
[23:46:10][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=428362 (now=438362)
[23:46:20][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=438362 (now=448362)
[23:46:22][VV][api.connection:132]: Sending keepalive PING...
[23:46:22][VV][api.service:037]: send_ping_request: PingRequest {}
[23:46:22][VV][api.service:611]: on_ping_response: PingResponse {}
[23:46:30][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=448362 (now=458362)
[23:46:40][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=458362 (now=468362)
[23:46:50][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=468362 (now=478362)
[23:46:55][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=423288 (now=483288)
[23:47:00][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=478362 (now=488362)
[23:47:10][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=488362 (now=498362)
[23:47:20][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=498362 (now=508362)
[23:47:22][VV][api.connection:132]: Sending keepalive PING...
[23:47:22][VV][api.service:037]: send_ping_request: PingRequest {}
[23:47:22][VV][api.service:611]: on_ping_response: PingResponse {}
[23:47:26][V][rxLoop:167]: Have 40 bytes from CC1101 Rx, RSSI: -30 dBm LQI: 128
[23:47:26][D][mbus:023]: Processing C1 B frame
[23:47:26][V][mbus:027]: Frame: 25442D2C094407581B168D204EB08B8F22176859FCB6ACEF06C1D6F741EEA2F747E366BAA999 (38) [with CRC]
[23:47:26][V][mbus:165]: Validating CRC for Block1 + Block2
[23:47:26][V][crc:031]:     calculated: 0xA999, read: 0xA999
[23:47:26][V][mbus:062]: Frame: 23442D2C094407581B168D204EB08B8F22176859FCB6ACEF06C1D6F741EEA2F747E366BA (36) [without CRC]
[23:47:26][VV][wmbus:061]: Have data from CC1101 ...
[23:47:26][D][wmbus:176]: Meter ID [0x58074409] RSSI: -30 dBm LQI: 128 Frame: C1 B not found in configuration T: 23442D2C094407581B168D204EB08B8F22176859FCB6ACEF06C1D6F741EEA2F747E366BA (36)
[23:47:26][VV][wmbus:186]: Will send telegram to clients ...
[23:47:26][V][wmbus:228]: Will send RTLWMBUS telegram to 10.0.0.1:7227 via TCP
[23:47:32][E][wmbus:241]: Can't connect via TCP to 10.0.0.1:7227
[23:47:32][W][component:237]: Component wmbus took a long time for an operation (5088 ms).
[23:47:32][W][component:238]: Components should block for at most 30 ms.
[23:47:32][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=508362 (now=520221)
[23:47:40][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=518362 (now=528362)
[23:47:50][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=528362 (now=538363)
[23:47:55][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=483288 (now=543288)
[23:48:00][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=538362 (now=548362)
esphome:
  name: wodomierzesp8266
  friendly_name: WodomierzESP8266

esp8266:
  board: nodemcuv2

# Enable logging
logger:
  level: VERY_VERBOSE

# Enable Home Assistant API
api:
  encryption:
    key: "xxxxxxxxxxxxxxxx"

ota:
  password: "xxxxxxxxxxxxxxxxxxxxxxxxx"

wifi:
  ssid: xxxxxxxxxxxxxxx
  password: xxxxxxxxxxxxxxxxxxxxxxxxxxxx

  # Enable fallback hotspot (captive portal) in case wifi connection fails
  ap:
    ssid: "Wodomierzesp8266"
    password: "xxxxxxxxxxxxxxxxx"

time:
  - platform: homeassistant
    id: homeassistant_time

# Enable Web server
web_server:
  port: 80

captive_portal:

external_components:
  - source: github://SzczepanLeon/esphome-components@main
    components: [ wmbus ]


wmbus:
  frequency: 868.950
  mosi_pin: GPIO13 #D7 HMOSI
  miso_pin: GPIO12 #D6 HMISO
  clk_pin:  GPIO14 #D5 HSCLK
  cs_pin:   GPIO2 #D4 
  gdo0_pin: GPIO5 #D1 
  gdo2_pin: GPIO4 #D2

  led_pin: GPIO0
  led_blink_time: "1s"
#  sync_mode: True

  clients:
    - name: "wmbusmeters"
      ip_address: "10.0.0.1"
      port: 7227

#    meter_id: zzzzzzzz
sensor:
  - platform: wmbus
    meter_id: 58074409
    type: multical21
    key: "00000000000000000000000000000000"
    lqi:
      name: "LQI wodomierz"
    rssi:
      name: "RSSI wodomierz"
    total_water_m3:
      name: "Wodomierz"
      force_update: true

text_sensor:
  - platform: wmbus
    name: "Text debug for Apator 16-2"
    
  1. prawdopodobnie masz zły klucz
  1. Formatowanie poprawione.
  2. Czyli dane są szyfrowane i muszę posiadać klucz?

Niestety bez klucza sie nie uda, mam ten sam problem z moim miernikiem ciepła.

No to szkoda. Rozmawiałem z wodociągami, ale twierdzą, że wodomierze nie są szyfrowane i nikt do tej pory nie zgłaszał takiej sprawy. Chyba będę musiał ich bardziej przycisnąć.

I guess you are not using the wmbus clients, so you can disable that.

You are receiving C1 frames, but the default mode is T1.

So you should add mode: C1 under the type line.

Also, I would remove the key part with a # like this, if you sure there is no encryption.

You can disable this part as well, as that is for the Apator 16-2 for debugging.

1 polubienie

Thank you very much for your interest in my project and the tips you provided. I applied all the proposed changes, but still no data reading. Logs below.

INFO ESPHome 2024.4.2
INFO Reading configuration /config/esphome/wodomierzesp8266.yaml...
INFO Detected timezone 'Europe/Warsaw'
INFO Generating C++ source...
INFO Compiling app...
Processing wodomierzesp8266 (board: nodemcuv2; framework: arduino; platform: platformio/espressif8266@4.2.1)
--------------------------------------------------------------------------------
HARDWARE: ESP8266 80MHz, 80KB RAM, 4MB Flash
Dependency Graph
|-- ESPAsyncTCP-esphome @ 2.0.0
|-- ESPAsyncWebServer-esphome @ 3.1.0
|-- DNSServer @ 1.1.1
|-- ESP8266WiFi @ 1.0
|-- ESP8266mDNS @ 1.2
|-- noise-c @ 0.1.4
|-- ArduinoJson @ 6.18.5
|-- SPI @ 1.0
|-- SmartRC-CC1101-Driver-Lib @ 2.5.7+sha.b8c6af4
|-- wmbus-drivers @ 0.0.0+20240509205045.sha.1ad30e4
Compiling .pioenvs/wodomierzesp8266/src/main.cpp.o
Linking .pioenvs/wodomierzesp8266/firmware.elf
RAM:   [=====     ]  54.8% (used 44896 bytes from 81920 bytes)
Flash: [======    ]  57.9% (used 604433 bytes from 1044464 bytes)
Building .pioenvs/wodomierzesp8266/firmware.bin
esp8266_copy_factory_bin([".pioenvs/wodomierzesp8266/firmware.bin"], [".pioenvs/wodomierzesp8266/firmware.elf"])
========================= [SUCCESS] Took 14.41 seconds =========================
INFO Successfully compiled program.
INFO Connecting to 192.168.1.73
INFO Uploading /data/build/wodomierzesp8266/.pioenvs/wodomierzesp8266/firmware.bin (608592 bytes)
INFO Compressed to 415788 bytes
Uploading: [============================================================] 100% Done...

INFO Upload took 6.38 seconds, waiting for result...
INFO OTA successful
INFO Successfully uploaded program.
INFO Starting log output from 192.168.1.73 using esphome API
INFO Successfully connected to wodomierzesp8266 @ 192.168.1.73 in 19.428s
INFO Successful handshake with wodomierzesp8266 @ 192.168.1.73 in 3.114s
[11:33:13][I][app:100]: ESPHome version 2024.4.2 compiled on May 11 2024, 11:32:31
[11:33:13][C][wifi:580]: WiFi:
[11:33:13][C][wifi:408]:   Local MAC: BC:FF:4D:82:96:B2
[11:33:13][C][wifi:413]:   SSID: 'SD'[redacted]
[11:33:13][C][wifi:416]:   IP Address: 192.168.1.73
[11:33:13][C][wifi:419]:   BSSID: 40:3F:8C:91:77:58[redacted]
[11:33:13][C][wifi:421]:   Hostname: 'wodomierzesp8266'
[11:33:13][C][wifi:423]:   Signal strength: -45 dB ▂▄▆█
[11:33:13][V][wifi:425]:   Priority: 0.0
[11:33:13][C][wifi:427]:   Channel: 1
[11:33:13][C][wifi:428]:   Subnet: 255.255.255.0
[11:33:13][C][wifi:429]:   Gateway: 192.168.1.1
[11:33:13][C][wifi:430]:   DNS1: 192.168.1.1
[11:33:13][C][wifi:431]:   DNS2: 0.0.0.0
[11:33:13][C][logger:166]: Logger:
[11:33:13][C][logger:167]:   Level: VERY_VERBOSE
[11:33:13][C][logger:169]:   Log Baud Rate: 115200
[11:33:13][C][logger:170]:   Hardware UART: UART0
[11:33:13][C][homeassistant.time:010]: Home Assistant Time:
[11:33:13][C][homeassistant.time:011]:   Timezone: 'CET-1CEST,M3.5.0,M10.5.0/3'
[11:33:13][C][captive_portal:088]: Captive Portal:
[11:33:13][C][web_server:169]: Web Server:
[11:33:13][C][web_server:170]:   Address: wodomierzesp8266.local:80
[11:33:13][C][mdns:115]: mDNS:
[11:33:13][C][mdns:116]:   Hostname: wodomierzesp8266
[11:33:13][V][mdns:117]:   Services:
[11:33:13][V][mdns:119]:   - _esphomelib, _tcp, 6053
[11:33:13][V][mdns:121]:     TXT: friendly_name = WodomierzESP8266
[11:33:13][V][mdns:121]:     TXT: version = 2024.4.2
[11:33:13][V][mdns:121]:     TXT: mac = bcff4d8296b2
[11:33:13][V][mdns:121]:     TXT: platform = ESP8266
[11:33:13][V][mdns:121]:     TXT: board = nodemcuv2
[11:33:13][V][mdns:121]:     TXT: network = wifi
[11:33:13][V][mdns:121]:     TXT: api_encryption = Noise_NNpsk0_25519_ChaChaPoly_SHA256
[11:33:13][V][mdns:119]:   - _http, _tcp, 80
[11:33:13][C][ota:096]: Over-The-Air Updates:
[11:33:13][C][ota:097]:   Address: wodomierzesp8266.local:8266
[11:33:13][C][ota:100]:   Using Password.
[11:33:13][C][ota:103]:   OTA version: 2.
[11:33:13][C][api:139]: API Server:
[11:33:13][C][api:140]:   Address: wodomierzesp8266.local:6053
[11:33:13][C][api:142]:   Using noise encryption: YES
[11:33:13][C][wmbus:372]: wM-Bus v3.2.1:
[11:33:13][C][wmbus:385]:   LED:
[11:33:13][C][wmbus:386]:     Pin: GPIO0
[11:33:13][C][wmbus:387]:     Duration: 1000 ms
[11:33:13][C][wmbus:389]:   CC1101 frequency: 868.950 MHz
[11:33:13][C][wmbus:390]:   CC1101 SPI bus:
[11:33:13][C][wmbus:391]:     MOSI Pin: GPIO13
[11:33:13][C][wmbus:392]:     MISO Pin: GPIO12
[11:33:13][C][wmbus:393]:     CLK Pin:  GPIO14
[11:33:13][C][wmbus:394]:     CS Pin:   GPIO2
[11:33:13][C][wmbus:395]:     GDO0 Pin: GPIO5
[11:33:13][C][wmbus:396]:     GDO2 Pin: GPIO4
[11:33:13][C][wmbus:403]:   Available drivers:  amiplus, apator08, apator162, apatoreitn, bmeters, c5isf, compact5, dme07, elf, evo868, fhkvdataiii, flowiq2200, hydrocalm3, hydrus, iperl, itron, izar, kamheat, mkradio3, mkradio4, mkradio4a, multical21, qheat, qwater, rfmtx1, sharky774, topaseskr, ultrimis, unismart, vario451
[11:33:13][C][wmbus:421]:   Meter:
[11:33:13][C][wmbus:422]:     ID: 58074409 [0x03762529]
[11:33:13][C][wmbus:423]:     Type: multical21
[11:33:13][C][wmbus:424]:     Mode: C1
[11:33:13][C][wmbus:425]:     Key: '00000000000000000000000000000000'
[11:33:13][C][wmbus:427]:     Sensor '0x3762529 LQI wodomierz'
[11:33:13][C][wmbus:427]:       Device Class: 'signal_strength'
[11:33:13][C][wmbus:427]:       State Class: 'measurement'
[11:33:13][C][wmbus:427]:       Unit of Measurement: ''
[11:33:13][C][wmbus:427]:       Accuracy Decimals: 0
[11:33:13][C][wmbus:427]:     Sensor '0x3762529 RSSI wodomierz'
[11:33:13][C][wmbus:427]:       Device Class: 'signal_strength'
[11:33:13][C][wmbus:427]:       State Class: 'measurement'
[11:33:13][C][wmbus:427]:       Unit of Measurement: 'dBm'
[11:33:13][C][wmbus:427]:       Accuracy Decimals: 0
[11:33:13][C][wmbus:427]:     Sensor '0x3762529 Wodomierz'
[11:33:13][C][wmbus:427]:       Device Class: 'water'
[11:33:13][C][wmbus:427]:       State Class: 'total_increasing'
[11:33:13][C][wmbus:427]:       Unit of Measurement: 'm³'
[11:33:13][C][wmbus:427]:       Accuracy Decimals: 3
[11:33:13][C][wmbus:427]:       Icon: 'mdi:water'
[11:33:13][V][wmbus:427]:       Force Update: YES
[11:33:14][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=14899 (now=24899)
[11:33:24][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=24899 (now=34899)
[11:33:34][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=34899 (now=44899)
[11:33:44][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=44899 (now=54899)
[11:33:53][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=4087 (now=64087)
[11:33:54][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=54899 (now=64899)
[11:34:04][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=64899 (now=74899)
[11:34:13][VV][api.connection:132]: Sending keepalive PING...
[11:34:13][VV][api.service:037]: send_ping_request: PingRequest {}
[11:34:13][VV][api.service:611]: on_ping_response: PingResponse {}
[11:34:14][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=74899 (now=84899)
[11:34:24][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=84899 (now=94899)
[11:34:34][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=94899 (now=104899)
[11:34:44][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=104899 (now=114899)
[11:34:53][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=64087 (now=124087)
[11:34:54][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=114899 (now=124899)
[11:35:04][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=124899 (now=134899)
[11:35:13][VV][api.connection:132]: Sending keepalive PING...
[11:35:13][VV][api.service:037]: send_ping_request: PingRequest {}
[11:35:13][VV][api.service:611]: on_ping_response: PingResponse {}
[11:35:14][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=134899 (now=144899)
[11:35:24][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=144899 (now=154899)
[11:35:34][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=154899 (now=164899)
[11:35:42][V][rxLoop:167]: Have 40 bytes from CC1101 Rx, RSSI: -36 dBm LQI: 128
[11:35:42][D][mbus:023]: Processing C1 B frame
[11:35:42][V][mbus:027]: Frame: 25442D2C094407581B168D208E001290220F311B93945BAFF236A9C2244F8E7677F96919AB52 (38) [with CRC]
[11:35:42][V][mbus:165]: Validating CRC for Block1 + Block2
[11:35:42][V][crc:031]:     calculated: 0xAB52, read: 0xAB52
[11:35:42][V][mbus:062]: Frame: 23442D2C094407581B168D208E001290220F311B93945BAFF236A9C2244F8E7677F96919 (36) [without CRC]
[11:35:42][VV][wmbus:061]: Have data from CC1101 ...
[11:35:43][D][wmbus:176]: Meter ID [0x58074409] RSSI: -36 dBm LQI: 128 Frame: C1 B not found in configuration T: 23442D2C094407581B168D208E001290220F311B93945BAFF236A9C2244F8E7677F96919 (36)
[11:35:43][W][component:237]: Component wmbus took a long time for an operation (64 ms).
[11:35:43][W][component:238]: Components should block for at most 30 ms.
[11:35:44][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=164899 (now=174899)
[11:35:53][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=124087 (now=184087)
[11:35:54][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=174899 (now=184899)
[11:36:04][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=184899 (now=194899)
[11:36:13][VV][api.connection:132]: Sending keepalive PING...
[11:36:13][VV][api.service:037]: send_ping_request: PingRequest {}
[11:36:13][VV][api.service:611]: on_ping_response: PingResponse {}
[11:36:14][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=194899 (now=204899)
[11:36:24][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=204899 (now=214899)
[11:36:33][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[11:36:33][V][json:058]: Size after shrink 100 bytes
[11:36:33][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[11:36:33][V][json:058]: Size after shrink 132 bytes
[11:36:33][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[11:36:33][V][json:058]: Size after shrink 152 bytes
[11:36:33][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[11:36:33][V][json:058]: Size after shrink 156 bytes
[11:36:34][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=214899 (now=224899)
[11:36:44][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=224899 (now=234899)
[11:36:53][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=184087 (now=244087)
[11:36:54][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=234899 (now=244899)
[11:37:04][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=244899 (now=254899)
[11:37:13][VV][api.connection:132]: Sending keepalive PING...
[11:37:13][VV][api.service:037]: send_ping_request: PingRequest {}
[11:37:13][VV][api.service:611]: on_ping_response: PingResponse {}
[11:37:14][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=254899 (now=264899)
[11:37:16][V][rxLoop:167]: Have 47 bytes from CC1101 Rx, RSSI: -36 dBm LQI: 128
[11:37:16][D][mbus:023]: Processing C1 B frame
[11:37:16][V][mbus:027]: Frame: 2C442D2C094407581B168D208F1412902232FE5CB5E5EDC8A21B7A42D08355F398D7FA94D21248E40E2C45C5D3 (45) [with CRC]
[11:37:16][V][mbus:165]: Validating CRC for Block1 + Block2
[11:37:16][V][crc:031]:     calculated: 0xC5D3, read: 0xC5D3
[11:37:16][V][mbus:062]: Frame: 2A442D2C094407581B168D208F1412902232FE5CB5E5EDC8A21B7A42D08355F398D7FA94D21248E40E2C45 (43) [without CRC]
[11:37:16][VV][wmbus:061]: Have data from CC1101 ...
[11:37:16][D][wmbus:176]: Meter ID [0x58074409] RSSI: -36 dBm LQI: 128 Frame: C1 B not found in configuration T: 2A442D2C094407581B168D208F1412902232FE5CB5E5EDC8A21B7A42D08355F398D7FA94D21248E40E2C45 (43)
[11:37:16][W][component:237]: Component wmbus took a long time for an operation (61 ms).
[11:37:16][W][component:238]: Components should block for at most 30 ms.
[11:37:24][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=264899 (now=274899)
[11:37:34][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=274899 (now=284899)
[11:37:44][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=284899 (now=294899)
[11:37:53][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=244087 (now=304087)
[11:37:54][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=294899 (now=304899)
[11:38:01][I][ota:117]: Boot seems successful, resetting boot loop counter.
[11:38:04][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=304899 (now=314899)
[11:38:13][VV][api.connection:132]: Sending keepalive PING...
[11:38:13][VV][api.service:037]: send_ping_request: PingRequest {}
[11:38:13][VV][api.service:611]: on_ping_response: PingResponse {}
[11:38:14][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=314899 (now=324899)
[11:38:24][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=324899 (now=334899)
[11:38:34][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=334899 (now=344899)
[11:38:44][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=344899 (now=354899)
[11:38:47][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[11:38:47][V][json:058]: Size after shrink 100 bytes
[11:38:47][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[11:38:47][V][json:058]: Size after shrink 132 bytes
[11:38:47][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[11:38:47][V][json:058]: Size after shrink 152 bytes
[11:38:47][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[11:38:47][V][json:058]: Size after shrink 156 bytes
[11:38:50][V][rxLoop:167]: Have 40 bytes from CC1101 Rx, RSSI: -36 dBm LQI: 128
[11:38:50][D][mbus:023]: Processing C1 B frame
[11:38:50][V][mbus:027]: Frame: 25442D2C094407581B168D209038129022BE3462AA50E0A850C1955980D23FB3B257C6FA6F0D (38) [with CRC]
[11:38:50][V][mbus:165]: Validating CRC for Block1 + Block2
[11:38:50][V][crc:031]:     calculated: 0x6F0D, read: 0x6F0D
[11:38:50][V][mbus:062]: Frame: 23442D2C094407581B168D209038129022BE3462AA50E0A850C1955980D23FB3B257C6FA (36) [without CRC]
[11:38:50][VV][wmbus:061]: Have data from CC1101 ...
[11:38:50][D][wmbus:176]: Meter ID [0x58074409] RSSI: -36 dBm LQI: 128 Frame: C1 B not found in configuration T: 23442D2C094407581B168D209038129022BE3462AA50E0A850C1955980D23FB3B257C6FA (36)
[11:38:50][W][component:237]: Component wmbus took a long time for an operation (65 ms).
[11:38:50][W][component:238]: Components should block for at most 30 ms.
[11:38:53][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=304087 (now=364087)
[11:38:54][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=354899 (now=364899)
[11:39:04][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=364899 (now=374899)
esphome:
  name: wodomierzesp8266
  friendly_name: WodomierzESP8266

esp8266:
  board: nodemcuv2

# Enable logging
logger:
  level: VERY_VERBOSE

# Enable Home Assistant API
api:
  encryption:
    key: "xxxxxxxxxxxxxxxxxxxxxxxxxxx"

ota:
  password: "xxxxxxxxxxxxxxxxxxxxxxxxxxxx"

wifi:
  ssid: xxxxxxxxxxxxxxx
  password: xxxxxxxxxxxxxxxxxxxxxx

  # Enable fallback hotspot (captive portal) in case wifi connection fails
  ap:
    ssid: "Wodomierzesp8266"
    password: "xxxxxxxxxxxxx"

time:
  - platform: homeassistant
    id: homeassistant_time

# Enable Web server
web_server:
  port: 80

captive_portal:

external_components:
  - source: github://SzczepanLeon/esphome-components@main
    components: [ wmbus ]


wmbus:
  frequency: 868.950
  mosi_pin: GPIO13 #D7 HMOSI
  miso_pin: GPIO12 #D6 HMISO
  clk_pin:  GPIO14 #D5 HSCLK
  cs_pin:   GPIO2 #D4 
  gdo0_pin: GPIO5 #D1 
  gdo2_pin: GPIO4 #D2

  led_pin: GPIO0
  led_blink_time: "1s"
#  sync_mode: True

#  clients:
#    - name: "wmbusmeters"
#      ip_address: "10.0.0.1"
#      port: 7227

#    meter_id: zzzzzzzz
sensor:
  - platform: wmbus
    meter_id: 58074409
    type: multical21
    key: "00000000000000000000000000000000"
    mode: C1
    lqi:
      name: "LQI wodomierz"
    rssi:
      name: "RSSI wodomierz"
    total_water_m3:
      name: "Wodomierz"
      force_update: true

#text_sensor:
#  - platform: wmbus
#    name: "Text debug for Apator 16-2"
    `````````````

Could you try meter_id: 0x58074409 ?

It expects to match.

OK, I changed it.

[13:18:48][V][rxLoop:167]: Have 47 bytes from CC1101 Rx, RSSI: -36 dBm LQI: 128
[13:18:48][D][mbus:023]: Processing C1 B frame
[13:18:48][V][mbus:027]: Frame: 2C442D2C094407581B168D20CF74189022B60D75B80D9E2E9F23FA5B5621AFBC040C12B823EEA6D21079F58112 (45) [with CRC]
[13:18:48][V][mbus:165]: Validating CRC for Block1 + Block2
[13:18:48][V][crc:031]:     calculated: 0x8112, read: 0x8112
[13:18:48][V][mbus:062]: Frame: 2A442D2C094407581B168D20CF74189022B60D75B80D9E2E9F23FA5B5621AFBC040C12B823EEA6D21079F5 (43) [without CRC]
[13:18:48][VV][wmbus:061]: Have data from CC1101 ...
[13:18:48][D][wmbus:090]: Using driver 'multical21' for ID [0x58074409] RSSI: -36 dBm LQI: 128 Frame: C1 B T: 2A442D2C094407581B168D20CF74189022B60D75B80D9E2E9F23FA5B5621AFBC040C12B823EEA6D21079F5 (43)
[13:18:48][VV][wmbus:099]: Key defined, trying to decrypt telegram ...
[13:18:48][VV][utils:109]: (ELL)  CI: 8D  offset: 17
[13:18:48][VV][utils:110]: (ELL)  IV: 2D2C094407581B162074189022000000
[13:18:48][VV][utils:115]: (ELL) KEY: 00000000000000000000000000000000 (16)
[13:18:48][VV][utils:124]: (ELL) AES_CTR decrypting: B60D75B80D9E2E9F23FA5B5621AFBC040C12B823EEA6D21079F5 (26)
[13:18:48][VV][utils:152]: (ELL) AES_CTR  decrypted: 44FEE8581C3BDC4DA0E6F1C2B9AC87DB717F7F35C2BD1EC7A871 (26)
[13:18:48][V][wmbus:283]: Validating CRC for ELL payload
[13:18:48][D][crc:050]:     calculated: 0xB9A9, read: 0xFE44  !!!


full logs
INFO ESPHome 2024.4.2
INFO Reading configuration /config/esphome/wodomierzesp8266.yaml...
INFO Detected timezone 'Europe/Warsaw'
INFO Generating C++ source...
INFO Compiling app...
Processing wodomierzesp8266 (board: nodemcuv2; framework: arduino; platform: platformio/espressif8266@4.2.1)
--------------------------------------------------------------------------------
HARDWARE: ESP8266 80MHz, 80KB RAM, 4MB Flash
Dependency Graph
|-- ESPAsyncTCP-esphome @ 2.0.0
|-- ESPAsyncWebServer-esphome @ 3.1.0
|-- DNSServer @ 1.1.1
|-- ESP8266WiFi @ 1.0
|-- ESP8266mDNS @ 1.2
|-- noise-c @ 0.1.4
|-- ArduinoJson @ 6.18.5
|-- SPI @ 1.0
|-- SmartRC-CC1101-Driver-Lib @ 2.5.7+sha.b8c6af4
|-- wmbus-drivers @ 0.0.0+20240509205045.sha.1ad30e4
Compiling .pioenvs/wodomierzesp8266/src/main.cpp.o
Linking .pioenvs/wodomierzesp8266/firmware.elf
RAM:   [=====     ]  54.8% (used 44912 bytes from 81920 bytes)
Flash: [======    ]  57.9% (used 604449 bytes from 1044464 bytes)
Building .pioenvs/wodomierzesp8266/firmware.bin
esp8266_copy_factory_bin([".pioenvs/wodomierzesp8266/firmware.bin"], [".pioenvs/wodomierzesp8266/firmware.elf"])
========================= [SUCCESS] Took 14.37 seconds =========================
INFO Successfully compiled program.
INFO Connecting to 192.168.1.73
INFO Uploading /data/build/wodomierzesp8266/.pioenvs/wodomierzesp8266/firmware.bin (608608 bytes)
INFO Compressed to 415782 bytes
Uploading: [============================================================] 100% Done...

INFO Upload took 6.38 seconds, waiting for result...
INFO OTA successful
INFO Successfully uploaded program.
INFO Starting log output from 192.168.1.73 using esphome API
INFO Successfully connected to wodomierzesp8266 @ 192.168.1.73 in 19.407s
INFO Successful handshake with wodomierzesp8266 @ 192.168.1.73 in 3.037s
[13:17:33][I][app:100]: ESPHome version 2024.4.2 compiled on May 11 2024, 13:16:51
[13:17:33][C][wifi:580]: WiFi:
[13:17:33][C][wifi:408]:   Local MAC: BC:FF:4D:82:96:B2
[13:17:33][C][wifi:413]:   SSID: 'SD'[redacted]
[13:17:33][C][wifi:416]:   IP Address: 192.168.1.73
[13:17:33][C][wifi:419]:   BSSID: 40:3F:8C:91:77:58[redacted]
[13:17:33][C][wifi:421]:   Hostname: 'wodomierzesp8266'
[13:17:33][C][wifi:423]:   Signal strength: -45 dB ▂▄▆█
[13:17:33][V][wifi:425]:   Priority: 0.0
[13:17:33][C][wifi:427]:   Channel: 1
[13:17:33][C][wifi:428]:   Subnet: 255.255.255.0
[13:17:33][C][wifi:429]:   Gateway: 192.168.1.1
[13:17:33][C][wifi:430]:   DNS1: 192.168.1.1
[13:17:33][C][wifi:431]:   DNS2: 0.0.0.0
[13:17:33][C][logger:166]: Logger:
[13:17:33][C][logger:167]:   Level: VERY_VERBOSE
[13:17:33][C][logger:169]:   Log Baud Rate: 115200
[13:17:33][C][logger:170]:   Hardware UART: UART0
[13:17:33][C][homeassistant.time:010]: Home Assistant Time:
[13:17:33][C][homeassistant.time:011]:   Timezone: 'CET-1CEST,M3.5.0,M10.5.0/3'
[13:17:33][C][captive_portal:088]: Captive Portal:
[13:17:33][C][web_server:169]: Web Server:
[13:17:33][C][web_server:170]:   Address: wodomierzesp8266.local:80
[13:17:33][C][mdns:115]: mDNS:
[13:17:33][C][mdns:116]:   Hostname: wodomierzesp8266
[13:17:33][V][mdns:117]:   Services:
[13:17:33][V][mdns:119]:   - _esphomelib, _tcp, 6053
[13:17:33][V][mdns:121]:     TXT: friendly_name = WodomierzESP8266
[13:17:33][V][mdns:121]:     TXT: version = 2024.4.2
[13:17:33][V][mdns:121]:     TXT: mac = bcff4d8296b2
[13:17:33][V][mdns:121]:     TXT: platform = ESP8266
[13:17:33][V][mdns:121]:     TXT: board = nodemcuv2
[13:17:33][V][mdns:121]:     TXT: network = wifi
[13:17:33][V][mdns:121]:     TXT: api_encryption = Noise_NNpsk0_25519_ChaChaPoly_SHA256
[13:17:33][V][mdns:119]:   - _http, _tcp, 80
[13:17:33][C][ota:096]: Over-The-Air Updates:
[13:17:33][C][ota:097]:   Address: wodomierzesp8266.local:8266
[13:17:33][C][ota:100]:   Using Password.
[13:17:33][C][ota:103]:   OTA version: 2.
[13:17:33][C][api:139]: API Server:
[13:17:33][C][api:140]:   Address: wodomierzesp8266.local:6053
[13:17:33][C][api:142]:   Using noise encryption: YES
[13:17:33][C][wmbus:372]: wM-Bus v3.2.1:
[13:17:33][C][wmbus:385]:   LED:
[13:17:33][C][wmbus:386]:     Pin: GPIO0
[13:17:33][C][wmbus:387]:     Duration: 1000 ms
[13:17:33][C][wmbus:389]:   CC1101 frequency: 868.950 MHz
[13:17:33][C][wmbus:390]:   CC1101 SPI bus:
[13:17:33][C][wmbus:391]:     MOSI Pin: GPIO13
[13:17:33][C][wmbus:392]:     MISO Pin: GPIO12
[13:17:33][C][wmbus:393]:     CLK Pin:  GPIO14
[13:17:33][C][wmbus:394]:     CS Pin:   GPIO2
[13:17:33][C][wmbus:395]:     GDO0 Pin: GPIO5
[13:17:33][C][wmbus:396]:     GDO2 Pin: GPIO4
[13:17:33][C][wmbus:403]:   Available drivers:  amiplus, apator08, apator162, apatoreitn, bmeters, c5isf, compact5, dme07, elf, evo868, fhkvdataiii, flowiq2200, hydrocalm3, hydrus, iperl, itron, izar, kamheat, mkradio3, mkradio4, mkradio4a, multical21, qheat, qwater, rfmtx1, sharky774, topaseskr, ultrimis, unismart, vario451
[13:17:33][C][wmbus:421]:   Meter:
[13:17:33][C][wmbus:422]:     ID: 1476871177 [0x58074409]
[13:17:33][C][wmbus:423]:     Type: multical21
[13:17:33][C][wmbus:424]:     Mode: C1
[13:17:33][C][wmbus:425]:     Key: '00000000000000000000000000000000'
[13:17:33][C][wmbus:427]:     Sensor '0x58074409 LQI wodomierz'
[13:17:33][C][wmbus:427]:       Device Class: 'signal_strength'
[13:17:33][C][wmbus:427]:       State Class: 'measurement'
[13:17:33][C][wmbus:427]:       Unit of Measurement: ''
[13:17:33][C][wmbus:427]:       Accuracy Decimals: 0
[13:17:33][C][wmbus:427]:     Sensor '0x58074409 RSSI wodomierz'
[13:17:33][C][wmbus:427]:       Device Class: 'signal_strength'
[13:17:33][C][wmbus:427]:       State Class: 'measurement'
[13:17:33][C][wmbus:427]:       Unit of Measurement: 'dBm'
[13:17:33][C][wmbus:427]:       Accuracy Decimals: 0
[13:17:33][C][wmbus:427]:     Sensor '0x58074409 Wodomierz'
[13:17:33][C][wmbus:427]:       Device Class: 'water'
[13:17:33][C][wmbus:427]:       State Class: 'total_increasing'
[13:17:33][C][wmbus:427]:       Unit of Measurement: 'm³'
[13:17:33][C][wmbus:427]:       Accuracy Decimals: 3
[13:17:33][C][wmbus:427]:       Icon: 'mdi:water'
[13:17:33][V][wmbus:427]:       Force Update: YES
[13:17:37][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=17828 (now=27828)
[13:17:47][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=27828 (now=37828)
[13:17:48][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:17:48][V][json:058]: Size after shrink 100 bytes
[13:17:48][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:17:48][V][json:058]: Size after shrink 132 bytes
[13:17:48][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:17:48][V][json:058]: Size after shrink 156 bytes
[13:17:48][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:17:48][V][json:058]: Size after shrink 160 bytes
[13:17:57][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=37828 (now=47828)
[13:18:00][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=4294958587 (now=51291)
[13:18:07][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=47828 (now=57828)
[13:18:17][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=57828 (now=67828)
[13:18:27][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=67828 (now=77828)
[13:18:33][VV][api.connection:132]: Sending keepalive PING...
[13:18:33][VV][api.service:037]: send_ping_request: PingRequest {}
[13:18:33][VV][api.service:611]: on_ping_response: PingResponse {}
[13:18:37][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=77828 (now=87828)
[13:18:47][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=87828 (now=97828)
[13:18:48][V][rxLoop:167]: Have 47 bytes from CC1101 Rx, RSSI: -36 dBm LQI: 128
[13:18:48][D][mbus:023]: Processing C1 B frame
[13:18:48][V][mbus:027]: Frame: 2C442D2C094407581B168D20CF74189022B60D75B80D9E2E9F23FA5B5621AFBC040C12B823EEA6D21079F58112 (45) [with CRC]
[13:18:48][V][mbus:165]: Validating CRC for Block1 + Block2
[13:18:48][V][crc:031]:     calculated: 0x8112, read: 0x8112
[13:18:48][V][mbus:062]: Frame: 2A442D2C094407581B168D20CF74189022B60D75B80D9E2E9F23FA5B5621AFBC040C12B823EEA6D21079F5 (43) [without CRC]
[13:18:48][VV][wmbus:061]: Have data from CC1101 ...
[13:18:48][D][wmbus:090]: Using driver 'multical21' for ID [0x58074409] RSSI: -36 dBm LQI: 128 Frame: C1 B T: 2A442D2C094407581B168D20CF74189022B60D75B80D9E2E9F23FA5B5621AFBC040C12B823EEA6D21079F5 (43)
[13:18:48][VV][wmbus:099]: Key defined, trying to decrypt telegram ...
[13:18:48][VV][utils:109]: (ELL)  CI: 8D  offset: 17
[13:18:48][VV][utils:110]: (ELL)  IV: 2D2C094407581B162074189022000000
[13:18:48][VV][utils:115]: (ELL) KEY: 00000000000000000000000000000000 (16)
[13:18:48][VV][utils:124]: (ELL) AES_CTR decrypting: B60D75B80D9E2E9F23FA5B5621AFBC040C12B823EEA6D21079F5 (26)
[13:18:48][VV][utils:152]: (ELL) AES_CTR  decrypted: 44FEE8581C3BDC4DA0E6F1C2B9AC87DB717F7F35C2BD1EC7A871 (26)
[13:18:48][V][wmbus:283]: Validating CRC for ELL payload
[13:18:48][D][crc:050]:     calculated: 0xB9A9, read: 0xFE44  !!!
[13:18:48][W][component:237]: Component wmbus took a long time for an operation (131 ms).
[13:18:48][W][component:238]: Components should block for at most 30 ms.
[13:18:57][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=97828 (now=107828)
[13:19:00][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=51291 (now=111291)
[13:19:07][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=107828 (now=117828)
[13:19:09][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:19:09][V][json:058]: Size after shrink 100 bytes
[13:19:09][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:19:09][V][json:058]: Size after shrink 132 bytes
[13:19:09][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:19:09][V][json:058]: Size after shrink 156 bytes
[13:19:09][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:19:09][V][json:058]: Size after shrink 160 bytes
[13:19:17][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=117828 (now=127828)
[13:19:27][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=127828 (now=137828)
[13:19:33][VV][api.connection:132]: Sending keepalive PING...
[13:19:33][VV][api.service:037]: send_ping_request: PingRequest {}
[13:19:33][VV][api.service:611]: on_ping_response: PingResponse {}
[13:19:37][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=137828 (now=147828)
[13:19:47][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=147828 (now=157829)
[13:19:57][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=157828 (now=167828)
[13:20:00][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=111291 (now=171291)
[13:20:07][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=167828 (now=177828)
[13:20:17][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=177828 (now=187828)
[13:20:24][V][rxLoop:167]: Have 40 bytes from CC1101 Rx, RSSI: -37 dBm LQI: 128
[13:20:24][D][mbus:023]: Processing C1 B frame
[13:20:24][V][mbus:027]: Frame: 25442D2C094407581B168D20D098189022F48586B76E89334221E2C733377F86570F37E46568 (38) [with CRC]
[13:20:24][V][mbus:165]: Validating CRC for Block1 + Block2
[13:20:24][V][crc:031]:     calculated: 0x6568, read: 0x6568
[13:20:24][V][mbus:062]: Frame: 23442D2C094407581B168D20D098189022F48586B76E89334221E2C733377F86570F37E4 (36) [without CRC]
[13:20:24][VV][wmbus:061]: Have data from CC1101 ...
[13:20:24][D][wmbus:090]: Using driver 'multical21' for ID [0x58074409] RSSI: -37 dBm LQI: 128 Frame: C1 B T: 23442D2C094407581B168D20D098189022F48586B76E89334221E2C733377F86570F37E4 (36)
[13:20:24][VV][wmbus:099]: Key defined, trying to decrypt telegram ...
[13:20:24][VV][utils:109]: (ELL)  CI: 8D  offset: 17
[13:20:24][VV][utils:110]: (ELL)  IV: 2D2C094407581B162098189022000000
[13:20:24][VV][utils:115]: (ELL) KEY: 00000000000000000000000000000000 (16)
[13:20:24][VV][utils:124]: (ELL) AES_CTR decrypting: F48586B76E89334221E2C733377F86570F37E4 (19)
[13:20:24][VV][utils:152]: (ELL) AES_CTR  decrypted: 49160DE69BC9547C6A934FFB34EC3281335C45 (19)
[13:20:24][V][wmbus:283]: Validating CRC for ELL payload
[13:20:24][D][crc:050]:     calculated: 0x5C54, read: 0x1649  !!!
[13:20:24][W][component:237]: Component wmbus took a long time for an operation (109 ms).
[13:20:24][W][component:238]: Components should block for at most 30 ms.
[13:20:27][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=187828 (now=197828)
[13:20:33][VV][api.connection:132]: Sending keepalive PING...
[13:20:33][VV][api.service:037]: send_ping_request: PingRequest {}
[13:20:33][VV][api.service:611]: on_ping_response: PingResponse {}
[13:20:37][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=197828 (now=207828)
[13:20:47][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=207828 (now=217828)
[13:20:57][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=217828 (now=227828)
[13:21:00][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=171291 (now=231291)
[13:21:07][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=227828 (now=237828)
[13:21:17][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=237828 (now=247828)
[13:21:27][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=247828 (now=257828)
[13:21:33][VV][api.connection:132]: Sending keepalive PING...
[13:21:33][VV][api.service:037]: send_ping_request: PingRequest {}
[13:21:33][VV][api.service:611]: on_ping_response: PingResponse {}
[13:21:37][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=257828 (now=267828)
[13:21:47][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=267828 (now=277828)
[13:21:57][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=277828 (now=287828)
[13:22:00][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=231291 (now=291291)
[13:22:01][V][rxLoop:167]: Have 40 bytes from CC1101 Rx, RSSI: -37 dBm LQI: 128
[13:22:01][D][mbus:023]: Processing C1 B frame
[13:22:01][V][mbus:027]: Frame: 25442D2C094407581B168D20D1AC18902262382F9D88A21B697750330BF1E60D931DEC64B780 (38) [with CRC]
[13:22:01][V][mbus:165]: Validating CRC for Block1 + Block2
[13:22:01][V][crc:031]:     calculated: 0xB780, read: 0xB780
[13:22:01][V][mbus:062]: Frame: 23442D2C094407581B168D20D1AC18902262382F9D88A21B697750330BF1E60D931DEC64 (36) [without CRC]
[13:22:01][VV][wmbus:061]: Have data from CC1101 ...
[13:22:01][D][wmbus:090]: Using driver 'multical21' for ID [0x58074409] RSSI: -37 dBm LQI: 128 Frame: C1 B T: 23442D2C094407581B168D20D1AC18902262382F9D88A21B697750330BF1E60D931DEC64 (36)
[13:22:01][VV][wmbus:099]: Key defined, trying to decrypt telegram ...
[13:22:01][VV][utils:109]: (ELL)  CI: 8D  offset: 17
[13:22:01][VV][utils:110]: (ELL)  IV: 2D2C094407581B1620AC189022000000
[13:22:01][VV][utils:115]: (ELL) KEY: 00000000000000000000000000000000 (16)
[13:22:01][VV][utils:124]: (ELL) AES_CTR decrypting: 62382F9D88A21B697750330BF1E60D931DEC64 (19)
[13:22:01][VV][utils:152]: (ELL) AES_CTR  decrypted: 4A90A09BA180142322E80451A9522976083F6A (19)
[13:22:01][V][wmbus:283]: Validating CRC for ELL payload
[13:22:01][D][crc:050]:     calculated: 0x0C47, read: 0x904A  !!!
[13:22:01][W][component:237]: Component wmbus took a long time for an operation (109 ms).
[13:22:01][W][component:238]: Components should block for at most 30 ms.
[13:22:07][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=287828 (now=297828)
[13:22:17][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=297828 (now=307828)
[13:22:21][I][ota:117]: Boot seems successful, resetting boot loop counter.
[13:22:27][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=307828 (now=317828)
[13:22:30][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:22:30][V][json:058]: Size after shrink 100 bytes
[13:22:30][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:22:30][V][json:058]: Size after shrink 132 bytes
[13:22:30][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:22:30][V][json:058]: Size after shrink 156 bytes
[13:22:30][V][json:038]: Attempting to allocate 512 bytes for JSON serialization
[13:22:30][V][json:058]: Size after shrink 160 bytes
[13:22:33][VV][api.connection:132]: Sending keepalive PING...
[13:22:33][VV][api.service:037]: send_ping_request: PingRequest {}
[13:22:33][VV][api.service:611]: on_ping_response: PingResponse {}
[13:22:37][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=317828 (now=327828)
[13:22:47][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=327828 (now=337828)
[13:22:57][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=337828 (now=347828)
[13:23:00][VV][scheduler:225]: Running interval '' with interval=60000 last_execution=291291 (now=351291)
[13:23:07][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=347828 (now=357828)
[13:23:17][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=357828 (now=367828)
[13:23:19][V][rxLoop:167]: Have 59 bytes from CC1101 Rx, RSSI: -99 dBm LQI: 225
[13:23:19][D][mbus:034]: Processing T1 A frame
[13:23:19][V][mbus:045]: Frame: 39696C493E4AE95167D6DF50A63EABC485696FC198C7DC790D51AC98CA0F368D6C74B2421D34CC0AFA57D6FFBDBA709346A5B9EFFADF5FEFFFFBA7 (59) [RAW]
[13:23:19][V][3of6:083]: Decode 3 out of 6 failed..
[13:23:27][VV][scheduler:225]: Running interval '' with interval=10000 last_execution=367828 (now=377828)
[13:23:33][VV][api.connection:132]: Sending keepalive PING...
[13:23:33][VV][api.service:037]: send_ping_request: PingRequest {}
[13:23:33][VV][api.service:611]: on_ping_response: PingResponse {}


The CRC sums do not match, so a different key is probably required.

Now try to disable the key with # at the beginning of the line, or remove the whole line from the config.

after change:

[13:57:41][D][mbus:023]: Processing C1 B frame
[13:57:41][V][mbus:027]: Frame: 2C442D2C094407581B168D20E7E41A90226452FAF8978C2D5BA9F43D1E5E1B4F08F7E76ACD6A9A71A7DE7A2269 (45) [with CRC]
[13:57:41][V][mbus:165]: Validating CRC for Block1 + Block2
[13:57:41][V][crc:031]:     calculated: 0x2269, read: 0x2269
[13:57:41][V][mbus:062]: Frame: 2A442D2C094407581B168D20E7E41A90226452FAF8978C2D5BA9F43D1E5E1B4F08F7E76ACD6A9A71A7DE7A (43) [without CRC]
[13:57:41][VV][wmbus:061]: Have data from CC1101 ...
[13:57:41][D][wmbus:090]: Using driver 'multical21' for ID [0x58074409] RSSI: -37 dBm LQI: 128 Frame: C1 B T: 2A442D2C094407581B168D20E7E41A90226452FAF8978C2D5BA9F43D1E5E1B4F08F7E76ACD6A9A71A7DE7A (43)
[13:57:41][D][wmbus:161]: Can't get value(s) from telegram for ID [0x58074409]
[13:57:42][W][component:237]: Component wmbus took a long time for an operation (67 ms).
[13:57:42][W][component:238]: Components should block for at most 30 ms.

https://wmbusmeters.org/analyze/2C442D2C094407581B168D20E7E41A90226452FAF8978C2D5BA9F43D1E5E1B4F08F7E76ACD6A9A71A7DE7A2269

Yes, you will need a key for it. But now at least that is the only bit missing…

Yes, the progress with your help is significant. I will press the water supplier to give me the key. Once again, thank you very much and best regards. Have a nice day. :pray::ok_hand::wave:

1 polubienie

Panie @_Szczepan ie:)
Czy sharky774 potrzebuje klucza? Na wmbusmeters.org się dekoduje bez klucza, a komponent krzyczy “can’t get value…”

Panie @Mariusz_Woszczyński :wink:
Patrz pan na strone wmbusmetersa dokladnie. Czasami on korzysta z domyslnego klucza nie informujac o tym. Mozna to poznac po tym ze ten wyswietlany przez niego telegram jes juz zdekodowany.

Ślepy jestem, albo nie wiem gdzie i jak patrzeć.
Rozumiem, że jeśli korzysta z domyślnego klucza, to powinien poinformować jaki to klucz? Bo skąd inaczej go wyrwać…

https://wmbusmeters.org/analyze/3E44A5115534616941047A027030057E7F07BA7138777AE9DF58FAF3E511ED5777CFBC48EA137AC1773A65EB365465EFC09B07943CDB01787B5D62DA524F9B

telegram=|3E44A5115534616941047A027030052F2F_0C0E686600000C13569519003B3BBDEBDD3C2BBDEBDDDD0A5A84020A5E59020AA61800004C0E6735000

Widzisz ze jest inny - juz zdekodowany :wink:

Klucz w kodzie albo na forum poszukaj, on nie informuje jakim kluczem obrabiał ramkę.

1 polubienie

Działający klucz wyszperany w necie, dla potomności:

key: “51728910e66d83f851728910e66d83f8”

Podobno stosowany w wielu licznikach DIEHL.

Niestety z moim nie działa :frowning: