I was cheering a bit too early...
It now seems that the synchronisation only occurs once.
If I restart the master, either with a reboot, or a domoticz restart, or a plugin restart (either disable/enable or update the logging) then the values are arriving at the slave without problems, but only once.
I see no error messages in the Domoticz log. I ran the plugin on the master with more logging (debug or extra verbose) and as far as I can interpret it is not sending further values after the intial once after startup. I checked the sensors themselves on master also, they are updated no problem, so it should send updates.
I also tried manually to subscribe to domoticz/out but don't see anything happening, not even the first time when the sync is succesfull. When I send a message to domoticz/out I see it in the manually subscribed terminal window. Addition: If I subscribe to mqttSync/master2slave/masterParameters/1 or mqttSync/master2slave/masterValues/1 then I see exactly one update being published, again only one.
Any idea?
This is what I see in the log after the initial update when I set logging to extra verbose.
Code: Select all
2025-07-10 20:05:26.018 mqtt sync: Pushing 'onHeartbeatCallback' on to queue
2025-07-10 20:05:26.068 mqtt sync: Processing 'onHeartbeatCallback' message
2025-07-10 20:05:26.069 mqtt sync: Calling message handler 'onHeartbeat' on 'module' type object.
2025-07-10 20:05:26.069 mqtt sync: onHeartbeat:
2025-07-10 20:05:26.069 mqtt sync: Pushing 'WriteDirective' on to queue
2025-07-10 20:05:26.069 mqtt sync: Pushing 'WriteDirective' on to queue
2025-07-10 20:05:26.069 mqtt sync: Processing 'WriteDirective' message
2025-07-10 20:05:26.070 mqtt sync: Sending 2 bytes of data
2025-07-10 20:05:26.070 mqtt sync: c0 00 .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. �
2025-07-10 20:05:26.070 mqtt sync: Processing 'WriteDirective' message
2025-07-10 20:05:26.070 mqtt sync: Sending 2 bytes of data
2025-07-10 20:05:26.070 mqtt sync: c0 00 .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. �
2025-07-10 20:05:26.071 mqtt sync: Pushing 'ReadEvent' on to queue
2025-07-10 20:05:26.071 mqtt sync: Pushing 'ReadEvent' on to queue
2025-07-10 20:05:26.121 mqtt sync: Processing 'ReadEvent' message
2025-07-10 20:05:26.121 mqtt sync: Received 2 bytes of data
2025-07-10 20:05:26.122 mqtt sync: d0 00 .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. Ю
2025-07-10 20:05:26.122 mqtt sync: Pushing 'onMessageCallback' on to queue
2025-07-10 20:05:26.122 mqtt sync: Processing 'ReadEvent' message
2025-07-10 20:05:26.122 mqtt sync: Received 2 bytes of data
2025-07-10 20:05:26.123 mqtt sync: d0 00 .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. Ю
2025-07-10 20:05:26.123 mqtt sync: Pushing 'onMessageCallback' on to queue
2025-07-10 20:05:26.123 mqtt sync: Processing 'onMessageCallback' message
2025-07-10 20:05:26.124 mqtt sync: Calling message handler 'onMessage' on 'module' type object.
2025-07-10 20:05:26.124 mqtt sync: Processing 'onMessageCallback' message
2025-07-10 20:05:26.124 mqtt sync: Calling message handler 'onMessage' on 'module' type object.
And this is what I see during the very first sync.
Code: Select all
2025-07-10 20:08:44.912 mqtt sync: Slave::onConnect: Status 0, Description Success
2025-07-10 20:08:44.912 mqtt sync: onSlaveConnected:
2025-07-10 20:08:44.912 mqtt sync: MqttClient/Slave::SendId:
2025-07-10 20:08:44.912 mqtt sync: MqttClient/Slave::SendId: ID: Domoticz_domoticz-mqtt-sync_3_Slave_2025-07-10 20:08:43, lwtTopic: mqttSync/master2slave/lwt/slaveOnMaster, lwtData: {"state": "down", "version": "1.0.0"}
2025-07-10 20:08:44.912 mqtt sync: Pushing 'WriteDirective' on to queue
2025-07-10 20:08:44.912 mqtt sync: Processing 'WriteDirective' message
2025-07-10 20:08:44.912 mqtt sync: Sending 150 bytes of data
2025-07-10 20:08:44.912 mqtt sync: 10 93 01 00 04 4d 51 54 54 04 26 00 3c 00 37 44 6f 6d 6f 74 .Ӯ..MQTT.&.<.7Domot
2025-07-10 20:08:44.912 mqtt sync: 69 63 7a 5f 64 6f 6d 6f 74 69 63 7a 2d 6d 71 74 74 2d 73 79 icz_domoticz-mqtt-sy
2025-07-10 20:08:44.912 mqtt sync: 6e 63 5f 33 5f 53 6c 61 76 65 5f 32 30 32 35 2d 30 37 2d 31 nc_3_Slave_2025-07-1
2025-07-10 20:08:44.912 mqtt sync: 30 20 32 30 3a 30 38 3a 34 33 00 27 6d 71 74 74 53 79 6e 63 0.20:08:43.'mqttSync
2025-07-10 20:08:44.912 mqtt sync: 2f 6d 61 73 74 65 72 32 73 6c 61 76 65 2f 6c 77 74 2f 73 6c /master2slave/lwt/sl
2025-07-10 20:08:44.912 mqtt sync: 61 76 65 4f 6e 4d 61 73 74 65 72 00 25 7b 22 73 74 61 74 65 aveOnMaster.%{"state
2025-07-10 20:08:44.912 mqtt sync: 22 3a 20 22 64 6f 77 6e 22 2c 20 22 76 65 72 73 69 6f 6e 22 ":."down",."version"
2025-07-10 20:08:44.912 mqtt sync: 3a 20 22 31 2e 30 2e 30 22 7d .. .. .. .. .. .. .. .. .. .. :."1.0.0"}
2025-07-10 20:08:44.913 mqtt sync: Pushing 'ReadEvent' on to queue
2025-07-10 20:08:44.963 mqtt sync: Processing 'ReadEvent' message
2025-07-10 20:08:44.963 mqtt sync: Received 4 bytes of data
2025-07-10 20:08:44.963 mqtt sync: 20 02 00 00 .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. ....
2025-07-10 20:08:44.963 mqtt sync: Pushing 'onMessageCallback' on to queue
2025-07-10 20:08:44.963 mqtt sync: Processing 'onMessageCallback' message
2025-07-10 20:08:44.963 mqtt sync: Calling message handler 'onMessage' on 'module' type object.
2025-07-10 20:08:44.963 mqtt sync: Slave::onMessage: Connection established
2025-07-10 20:08:44.963 mqtt sync: Slave::onSlaveMqttConAck:
2025-07-10 20:08:44.963 mqtt sync: MqttClient/Slave::Publish: mqttSync/master2slave/lwt/slaveOnMaster ({"state": "up", "version": "1.0.0", "since": "2025-07-10 20:08:43"})
2025-07-10 20:08:44.963 mqtt sync: Pushing 'WriteDirective' on to queue
2025-07-10 20:08:44.963 mqtt sync: sendParametersAndValuesToSlave:
2025-07-10 20:08:44.963 mqtt sync: MqttClient/Slave::Publish: mqttSync/master2slave/masterParameters/1 ({"Name": "Temperature1", "Type": 80, "SubType": 5, "SwitchType": 0, "Sequence": "2025-07-10 20:08:43"})
2025-07-10 20:08:44.963 mqtt sync: Pushing 'WriteDirective' on to queue
2025-07-10 20:08:44.963 mqtt sync: MqttClient/Slave::Publish: mqttSync/master2slave/masterParameters/2 ({"Name": "Temperature2", "Type": 80, "SubType": 5, "SwitchType": 0, "Sequence": "2025-07-10 20:08:43"})
2025-07-10 20:08:44.963 mqtt sync: Pushing 'WriteDirective' on to queue
2025-07-10 20:08:44.964 mqtt sync: MqttClient/Slave::Publish: mqttSync/master2slave/masterValues/1 ({"allowSlaveUpdate": true, "nValue": 0, "sValue": "24.4", "LastUpdate": "2025-07-10 20:08:42", "Sequence": "2025-07-10 20:08:43"})
2025-07-10 20:08:44.964 mqtt sync: Pushing 'WriteDirective' on to queue
2025-07-10 20:08:44.964 mqtt sync: MqttClient/Slave::Publish: mqttSync/master2slave/masterValues/2 ({"allowSlaveUpdate": true, "nValue": 0, "sValue": "24.0", "LastUpdate": "2025-07-10 20:08:12", "Sequence": "2025-07-10 20:08:43"})
2025-07-10 20:08:44.964 mqtt sync: Pushing 'WriteDirective' on to queue
2025-07-10 20:08:44.964 mqtt sync: subscribeSlaveValuesFromMaster:
2025-07-10 20:08:44.964 mqtt sync: MqttClient/Slave::Subscribe: mqttSync/master2slave/slaveValues/#
2025-07-10 20:08:44.964 mqtt sync: Pushing 'WriteDirective' on to queue
2025-07-10 20:08:44.964 mqtt sync: Processing 'WriteDirective' message
2025-07-10 20:08:44.964 mqtt sync: Sending 110 bytes of data
2025-07-10 20:08:44.964 mqtt sync: 31 6c 00 27 6d 71 74 74 53 79 6e 63 2f 6d 61 73 74 65 72 32 1l.'mqttSync/master2
2025-07-10 20:08:44.964 mqtt sync: 73 6c 61 76 65 2f 6c 77 74 2f 73 6c 61 76 65 4f 6e 4d 61 73 slave/lwt/slaveOnMas
2025-07-10 20:08:44.964 mqtt sync: 74 65 72 7b 22 73 74 61 74 65 22 3a 20 22 75 70 22 2c 20 22 ter{"state":."up",."
2025-07-10 20:08:44.964 mqtt sync: 76 65 72 73 69 6f 6e 22 3a 20 22 31 2e 30 2e 30 22 2c 20 22 version":."1.0.0",."
2025-07-10 20:08:44.964 mqtt sync: 73 69 6e 63 65 22 3a 20 22 32 30 32 35 2d 30 37 2d 31 30 20 since":."2025-07-10.
2025-07-10 20:08:44.964 mqtt sync: 32 30 3a 30 38 3a 34 33 22 7d .. .. .. .. .. .. .. .. .. .. 20:08:43"}
2025-07-10 20:08:44.964 mqtt sync: Processing 'WriteDirective' message
2025-07-10 20:08:44.965 mqtt sync: Sending 147 bytes of data
2025-07-10 20:08:44.965 mqtt sync: 31 90 01 00 28 6d 71 74 74 53 79 6e 63 2f 6d 61 73 74 65 72 1Ю.(mqttSync/master
2025-07-10 20:08:44.965 mqtt sync: 32 73 6c 61 76 65 2f 6d 61 73 74 65 72 50 61 72 61 6d 65 74 2slave/masterParamet
2025-07-10 20:08:44.965 mqtt sync: 65 72 73 2f 31 7b 22 4e 61 6d 65 22 3a 20 22 54 65 6d 70 65 ers/1{"Name":."Tempe
2025-07-10 20:08:44.965 mqtt sync: 72 61 74 75 72 65 31 22 2c 20 22 54 79 70 65 22 3a 20 38 30 rature1",."Type":.80
2025-07-10 20:08:44.965 mqtt sync: 2c 20 22 53 75 62 54 79 70 65 22 3a 20 35 2c 20 22 53 77 69 ,."SubType":.5,."Swi
2025-07-10 20:08:44.965 mqtt sync: 74 63 68 54 79 70 65 22 3a 20 30 2c 20 22 53 65 71 75 65 6e tchType":.0,."Sequen
2025-07-10 20:08:44.965 mqtt sync: 63 65 22 3a 20 22 32 30 32 35 2d 30 37 2d 31 30 20 32 30 3a ce":."2025-07-10.20:
2025-07-10 20:08:44.965 mqtt sync: 30 38 3a 34 33 22 7d .. .. .. .. .. .. .. .. .. .. .. .. .. 08:43"}
2025-07-10 20:08:44.965 mqtt sync: Processing 'WriteDirective' message
2025-07-10 20:08:44.965 mqtt sync: Sending 147 bytes of data
2025-07-10 20:08:44.965 mqtt sync: 31 90 01 00 28 6d 71 74 74 53 79 6e 63 2f 6d 61 73 74 65 72 1Ю.(mqttSync/master
2025-07-10 20:08:44.965 mqtt sync: 32 73 6c 61 76 65 2f 6d 61 73 74 65 72 50 61 72 61 6d 65 74 2slave/masterParamet
2025-07-10 20:08:44.965 mqtt sync: 65 72 73 2f 32 7b 22 4e 61 6d 65 22 3a 20 22 54 65 6d 70 65 ers/2{"Name":."Tempe
2025-07-10 20:08:44.965 mqtt sync: 72 61 74 75 72 65 32 22 2c 20 22 54 79 70 65 22 3a 20 38 30 rature2",."Type":.80
2025-07-10 20:08:44.965 mqtt sync: 2c 20 22 53 75 62 54 79 70 65 22 3a 20 35 2c 20 22 53 77 69 ,."SubType":.5,."Swi
2025-07-10 20:08:44.965 mqtt sync: 74 63 68 54 79 70 65 22 3a 20 30 2c 20 22 53 65 71 75 65 6e tchType":.0,."Sequen
2025-07-10 20:08:44.965 mqtt sync: 63 65 22 3a 20 22 32 30 32 35 2d 30 37 2d 31 30 20 32 30 3a ce":."2025-07-10.20:
2025-07-10 20:08:44.965 mqtt sync: 30 38 3a 34 33 22 7d .. .. .. .. .. .. .. .. .. .. .. .. .. 08:43"}
2025-07-10 20:08:44.965 mqtt sync: Processing 'WriteDirective' message
2025-07-10 20:08:44.965 mqtt sync: Sending 170 bytes of data
2025-07-10 20:08:44.965 mqtt sync: 31 a7 01 00 24 6d 71 74 74 53 79 6e 63 2f 6d 61 73 74 65 72 1Ǯ.$mqttSync/master
2025-07-10 20:08:44.965 mqtt sync: 32 73 6c 61 76 65 2f 6d 61 73 74 65 72 56 61 6c 75 65 73 2f 2slave/masterValues/
2025-07-10 20:08:44.965 mqtt sync: 31 7b 22 61 6c 6c 6f 77 53 6c 61 76 65 55 70 64 61 74 65 22 1{"allowSlaveUpdate"
2025-07-10 20:08:44.965 mqtt sync: 3a 20 74 72 75 65 2c 20 22 6e 56 61 6c 75 65 22 3a 20 30 2c :.true,."nValue":.0,
2025-07-10 20:08:44.965 mqtt sync: 20 22 73 56 61 6c 75 65 22 3a 20 22 32 34 2e 34 22 2c 20 22 ."sValue":."24.4",."
2025-07-10 20:08:44.965 mqtt sync: 4c 61 73 74 55 70 64 61 74 65 22 3a 20 22 32 30 32 35 2d 30 LastUpdate":."2025-0
2025-07-10 20:08:44.965 mqtt sync: 37 2d 31 30 20 32 30 3a 30 38 3a 34 32 22 2c 20 22 53 65 71 7-10.20:08:42",."Seq
2025-07-10 20:08:44.965 mqtt sync: 75 65 6e 63 65 22 3a 20 22 32 30 32 35 2d 30 37 2d 31 30 20 uence":."2025-07-10.
2025-07-10 20:08:44.965 mqtt sync: 32 30 3a 30 38 3a 34 33 22 7d .. .. .. .. .. .. .. .. .. .. 20:08:43"}
2025-07-10 20:08:44.965 mqtt sync: Processing 'WriteDirective' message
2025-07-10 20:08:44.965 mqtt sync: Sending 170 bytes of data
2025-07-10 20:08:44.965 mqtt sync: 31 a7 01 00 24 6d 71 74 74 53 79 6e 63 2f 6d 61 73 74 65 72 1Ǯ.$mqttSync/master
2025-07-10 20:08:44.965 mqtt sync: 32 73 6c 61 76 65 2f 6d 61 73 74 65 72 56 61 6c 75 65 73 2f 2slave/masterValues/
2025-07-10 20:08:44.966 mqtt sync: 32 7b 22 61 6c 6c 6f 77 53 6c 61 76 65 55 70 64 61 74 65 22 2{"allowSlaveUpdate"
2025-07-10 20:08:44.966 mqtt sync: 3a 20 74 72 75 65 2c 20 22 6e 56 61 6c 75 65 22 3a 20 30 2c :.true,."nValue":.0,
2025-07-10 20:08:44.966 mqtt sync: 20 22 73 56 61 6c 75 65 22 3a 20 22 32 34 2e 30 22 2c 20 22 ."sValue":."24.0",."
2025-07-10 20:08:44.966 mqtt sync: 4c 61 73 74 55 70 64 61 74 65 22 3a 20 22 32 30 32 35 2d 30 LastUpdate":."2025-0
2025-07-10 20:08:44.966 mqtt sync: 37 2d 31 30 20 32 30 3a 30 38 3a 31 32 22 2c 20 22 53 65 71 7-10.20:08:12",."Seq
2025-07-10 20:08:44.966 mqtt sync: 75 65 6e 63 65 22 3a 20 22 32 30 32 35 2d 30 37 2d 31 30 20 uence":."2025-07-10.
2025-07-10 20:08:44.966 mqtt sync: 32 30 3a 30 38 3a 34 33 22 7d .. .. .. .. .. .. .. .. .. .. 20:08:43"}
2025-07-10 20:08:44.966 mqtt sync: Processing 'WriteDirective' message
2025-07-10 20:08:44.966 mqtt sync: Sending 42 bytes of data
2025-07-10 20:08:44.966 mqtt sync: 82 28 00 01 00 23 6d 71 74 74 53 79 6e 63 2f 6d 61 73 74 65 ¨...#mqttSync/maste
2025-07-10 20:08:44.966 mqtt sync: 72 32 73 6c 61 76 65 2f 73 6c 61 76 65 56 61 6c 75 65 73 2f r2slave/slaveValues/
2025-07-10 20:08:44.966 mqtt sync: 23 00 .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. #.
2025-07-10 20:08:45.009 mqtt sync: Pushing 'ReadEvent' on to queue
2025-07-10 20:08:45.016 mqtt sync: Processing 'ReadEvent' message
2025-07-10 20:08:45.016 mqtt sync: Received 5 bytes of data
2025-07-10 20:08:45.016 mqtt sync: 90 03 00 01 00 .. .. .. .. .. .. .. .. .. .. .. .. .. .. .. Ю...
2025-07-10 20:08:45.016 mqtt sync: Pushing 'onMessageCallback' on to queue
2025-07-10 20:08:45.016 mqtt sync: Processing 'onMessageCallback' message
2025-07-10 20:08:45.016 mqtt sync: Calling message handler 'onMessage' on 'module' type object.