2020-02-08 11:55:27 -07:00
|
|
|
const settings = require('../util/settings');
|
|
|
|
const logger = require('../util/logger');
|
|
|
|
const assert = require('assert');
|
|
|
|
const topicRegex = new RegExp(`^${settings.get().mqtt.base_topic}/bridge/ota_update/.+$`);
|
|
|
|
const BaseExtension = require('./baseExtension');
|
2020-02-16 08:00:15 -07:00
|
|
|
const MINUTES_10 = 1000 * 60 * 10;
|
2020-02-08 11:55:27 -07:00
|
|
|
|
|
|
|
class OTAUpdate extends BaseExtension {
|
2020-02-09 12:44:37 -07:00
|
|
|
constructor(zigbee, mqtt, state, publishEntityState, eventBus) {
|
|
|
|
super(zigbee, mqtt, state, publishEntityState, eventBus);
|
|
|
|
this.inProgress = new Set();
|
2020-02-16 08:00:15 -07:00
|
|
|
this.lastChecked = {};
|
2020-02-09 12:44:37 -07:00
|
|
|
}
|
|
|
|
|
2020-02-08 11:55:27 -07:00
|
|
|
onMQTTConnected() {
|
|
|
|
this.mqtt.subscribe(`${settings.get().mqtt.base_topic}/bridge/ota_update/check`);
|
|
|
|
this.mqtt.subscribe(`${settings.get().mqtt.base_topic}/bridge/ota_update/update`);
|
|
|
|
}
|
|
|
|
|
2020-02-16 08:00:15 -07:00
|
|
|
async onZigbeeEvent(type, data, mappedDevice, settingsDevice) {
|
|
|
|
if (data.type !== 'commandQueryNextImageRequest' || !mappedDevice.hasOwnProperty('ota')) return;
|
|
|
|
|
|
|
|
// When a device does a next image request, it will usually do it a few times after each other
|
|
|
|
// with only 10 - 60 seconds inbetween. It doesn' make sense to check for a new update
|
|
|
|
// each time.
|
|
|
|
const check = this.lastChecked.hasOwnProperty(data.device.ieeeAddr) ?
|
|
|
|
(Date.now() - this.lastChecked[data.device.ieeeAddr]) > MINUTES_10 : true;
|
|
|
|
if (!check || this.inProgress.has(data.device.ieeeAddr)) return;
|
|
|
|
|
|
|
|
this.lastChecked[data.device.ieeeAddr] = Date.now();
|
|
|
|
const available = await mappedDevice.ota.isUpdateAvailable(data.device, logger, data.data);
|
|
|
|
this.publishEntityState(data.device.ieeeAddr, {update_available: available});
|
2020-02-20 12:01:26 -07:00
|
|
|
|
|
|
|
if (available) {
|
|
|
|
const message = `Update available for '${settingsDevice.friendly_name}'`;
|
|
|
|
logger.info(message);
|
|
|
|
this.mqtt.log('ota_update', message, {status: 'available', device: settingsDevice.friendly_name});
|
|
|
|
}
|
2020-02-16 08:00:15 -07:00
|
|
|
}
|
|
|
|
|
2020-02-09 12:44:37 -07:00
|
|
|
async readSoftwareBuildIDAndDateCode(device, update) {
|
2020-02-13 13:10:44 -07:00
|
|
|
try {
|
|
|
|
const endpoint = device.endpoints.find((e) => e.supportsInputCluster('genBasic'));
|
|
|
|
const result = await endpoint.read('genBasic', ['dateCode', 'swBuildId']);
|
2020-02-09 12:44:37 -07:00
|
|
|
|
2020-02-13 13:10:44 -07:00
|
|
|
if (update) {
|
|
|
|
device.softwareBuildID = result.swBuildId;
|
|
|
|
device.dateCode = result.dateCode;
|
|
|
|
device.save();
|
|
|
|
}
|
2020-02-09 12:44:37 -07:00
|
|
|
|
2020-02-13 13:10:44 -07:00
|
|
|
return {softwareBuildID: result.swBuildId, dateCode: result.dateCode};
|
|
|
|
} catch (e) {
|
|
|
|
return null;
|
|
|
|
}
|
2020-02-09 12:44:37 -07:00
|
|
|
}
|
|
|
|
|
2020-02-08 11:55:27 -07:00
|
|
|
async onMQTTMessage(topic, message) {
|
|
|
|
if (!topic.match(topicRegex)) {
|
|
|
|
return null;
|
|
|
|
}
|
|
|
|
|
|
|
|
const device = this.zigbee.resolveEntity(message);
|
|
|
|
assert(device != null && device.type === 'device', 'Device not found or not a device');
|
|
|
|
if (!device.mapped || !device.mapped.ota) {
|
2020-02-14 15:41:34 -07:00
|
|
|
const message = `Device '${device.name}' does not support OTA updates`;
|
|
|
|
logger.error(message);
|
|
|
|
this.mqtt.log('ota_update', message, {status: `not_supported`, device: device.name});
|
2020-02-08 11:55:27 -07:00
|
|
|
return;
|
|
|
|
}
|
|
|
|
|
2020-02-09 12:44:37 -07:00
|
|
|
if (this.inProgress.has(device.device.ieeeAddr)) {
|
|
|
|
logger.error(`Update or check already in progress for '${device.name}', skipping...`);
|
|
|
|
return;
|
|
|
|
}
|
|
|
|
this.inProgress.add(device.device.ieeeAddr);
|
2020-02-08 11:55:27 -07:00
|
|
|
|
|
|
|
const type = topic.split('/')[3];
|
2020-02-09 12:44:37 -07:00
|
|
|
if (type === 'check') {
|
2020-02-14 15:41:34 -07:00
|
|
|
const message = `Checking if update available for '${device.name}'`;
|
|
|
|
logger.info(message);
|
|
|
|
this.mqtt.log('ota_update', message, {status: `checking_if_available`, device: device.name});
|
2020-02-09 12:44:37 -07:00
|
|
|
try {
|
|
|
|
const available = await device.mapped.ota.isUpdateAvailable(device.device, logger);
|
2020-02-14 15:41:34 -07:00
|
|
|
const message=(available ?
|
|
|
|
`Update available for '${device.name}'` : `No update available for '${device.name}'`);
|
|
|
|
logger.info(message);
|
|
|
|
const meta = {status: available ? 'available' : 'not_available', device: device.name};
|
|
|
|
this.mqtt.log('ota_update', message, meta);
|
2020-02-16 08:00:15 -07:00
|
|
|
this.publishEntityState(device.device.ieeeAddr, {update_available: available});
|
|
|
|
this.lastChecked[device.device.ieeeAddr] = Date.now();
|
2020-02-09 12:44:37 -07:00
|
|
|
} catch (error) {
|
2020-02-14 15:41:34 -07:00
|
|
|
const message = `Failed to check if update available for '${device.name}' (${error.message})`;
|
|
|
|
logger.error(message);
|
|
|
|
this.mqtt.log('ota_update', message, {status: `check_failed`, device: device.name});
|
2020-02-09 12:44:37 -07:00
|
|
|
}
|
|
|
|
} else { // type === 'update'
|
2020-02-14 15:41:34 -07:00
|
|
|
const message = `Updating '${device.name}' to latest firmware`;
|
|
|
|
logger.info(message);
|
|
|
|
this.mqtt.log('ota_update', message, {status: `update_in_progress`, device: device.name});
|
2020-02-09 12:44:37 -07:00
|
|
|
try {
|
|
|
|
const onProgress = (progress, remaining) => {
|
|
|
|
let message = `Update of '${device.name}' at ${progress}%`;
|
|
|
|
if (remaining) {
|
|
|
|
message += `, +- ${Math.round(remaining / 60)} minutes remaining`;
|
|
|
|
}
|
2020-02-08 11:55:27 -07:00
|
|
|
|
2020-02-09 12:44:37 -07:00
|
|
|
logger.info(message);
|
2020-02-14 15:41:34 -07:00
|
|
|
this.mqtt.log('ota_update', message, {status: `update_progress`, device: device.name, progress});
|
2020-02-09 12:44:37 -07:00
|
|
|
};
|
2020-02-08 11:55:27 -07:00
|
|
|
|
2020-02-09 12:44:37 -07:00
|
|
|
const from_ = await this.readSoftwareBuildIDAndDateCode(device.device, false);
|
|
|
|
await device.mapped.ota.updateToLatest(device.device, logger, onProgress);
|
|
|
|
const to = await this.readSoftwareBuildIDAndDateCode(device.device, true);
|
|
|
|
const [fromS, toS] = [JSON.stringify(from_), JSON.stringify(to)];
|
2020-02-14 15:41:34 -07:00
|
|
|
const message = `Finished update of '${device.name}'` + (to ? `, from '${fromS}' to '${toS}'` : ``);
|
|
|
|
logger.info(message);
|
|
|
|
const meta = {status: `update_succeeded`, device: device.name, from: from_, to};
|
|
|
|
this.mqtt.log('ota_update', message, meta);
|
2020-02-16 08:00:15 -07:00
|
|
|
this.publishEntityState(device.device.ieeeAddr, {update_available: false});
|
2020-02-09 12:44:37 -07:00
|
|
|
} catch (error) {
|
2020-02-14 15:41:34 -07:00
|
|
|
const message = `Update of '${device.name}' failed (${error.message})`;
|
|
|
|
logger.error(message);
|
|
|
|
this.mqtt.log('ota_update', message, {status: `update_failed`, device: device.name});
|
2020-02-09 12:44:37 -07:00
|
|
|
}
|
2020-02-08 11:55:27 -07:00
|
|
|
}
|
2020-02-09 12:44:37 -07:00
|
|
|
|
|
|
|
this.inProgress.delete(device.device.ieeeAddr);
|
2020-02-08 11:55:27 -07:00
|
|
|
}
|
|
|
|
}
|
|
|
|
|
|
|
|
module.exports = OTAUpdate;
|