-- attributes DROP TABLE IF EXISTS attributes_cache_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' CREATE TABLE attributes_cache_v9 ( ieee ieee NOT NULL, endpoint_id INTEGER NOT NULL, cluster INTEGER NOT NULL, attrid INTEGER NOT NULL, value BLOB NOT NULL, -- Quirks can create "virtual" clusters and endpoints that won\'t be present in the -- DB but whose values still need to be cached FOREIGN KEY(ieee) REFERENCES devices_v9(ieee) ON DELETE CASCADE )', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' CREATE TABLE attributes_cache_v9 ( ieee ieee NOT NULL, endpoint_id INTEGER NOT NULL, cluster INTEGER NOT NULL, attrid INTEGER NOT NULL, value BLOB NOT NULL, -- Quirks can create "virtual" clusters and endpoints that won\'t be present in the -- DB but whose values still need to be cached FOREIGN KEY(ieee) REFERENCES devices_v9(ieee) ON DELETE CASCADE )', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' CREATE UNIQUE INDEX attributes_idx_v9 ON attributes_cache_v9(ieee, endpoint_id, cluster, attrid)', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' CREATE UNIQUE INDEX attributes_idx_v9 ON attributes_cache_v9(ieee, endpoint_id, cluster, attrid)', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' -- groups DROP TABLE IF EXISTS groups_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' -- groups DROP TABLE IF EXISTS groups_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' CREATE TABLE groups_v9 ( group_id INTEGER NOT NULL, name TEXT NOT NULL )', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' CREATE TABLE groups_v9 ( group_id INTEGER NOT NULL, name TEXT NOT NULL )', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' CREATE UNIQUE INDEX groups_idx_v9 ON groups_v9(group_id)', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' CREATE UNIQUE INDEX groups_idx_v9 ON groups_v9(group_id)', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' -- group members DROP TABLE IF EXISTS group_members_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' -- group members DROP TABLE IF EXISTS group_members_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' CREATE TABLE group_members_v9 ( group_id INTEGER NOT NULL, ieee ieee NOT NULL, endpoint_id INTEGER NOT NULL, FOREIGN KEY(group_id) REFERENCES groups_v9(group_id) ON DELETE CASCADE, FOREIGN KEY(ieee, endpoint_id) REFERENCES endpoints_v9(ieee, endpoint_id) ON DELETE CASCADE )', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' CREATE TABLE group_members_v9 ( group_id INTEGER NOT NULL, ieee ieee NOT NULL, endpoint_id INTEGER NOT NULL, FOREIGN KEY(group_id) REFERENCES groups_v9(group_id) ON DELETE CASCADE, FOREIGN KEY(ieee, endpoint_id) REFERENCES endpoints_v9(ieee, endpoint_id) ON DELETE CASCADE )', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' CREATE UNIQUE INDEX group_members_idx_v9 ON group_members_v9(group_id, ieee, endpoint_id)', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' CREATE UNIQUE INDEX group_members_idx_v9 ON group_members_v9(group_id, ieee, endpoint_id)', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' -- relays DROP TABLE IF EXISTS relays_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' -- relays DROP TABLE IF EXISTS relays_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' CREATE TABLE relays_v9 ( ieee ieee NOT NULL, relays BLOB NOT NULL, FOREIGN KEY(ieee) REFERENCES devices_v9(ieee) ON DELETE CASCADE )', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' CREATE TABLE relays_v9 ( ieee ieee NOT NULL, relays BLOB NOT NULL, FOREIGN KEY(ieee) REFERENCES devices_v9(ieee) ON DELETE CASCADE )', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' CREATE UNIQUE INDEX relays_idx_v9 ON relays_v9(ieee)', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' CREATE UNIQUE INDEX relays_idx_v9 ON relays_v9(ieee)', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' -- unsupported attributes DROP TABLE IF EXISTS unsupported_attributes_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' -- unsupported attributes DROP TABLE IF EXISTS unsupported_attributes_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' CREATE TABLE unsupported_attributes_v9 ( ieee ieee NOT NULL, endpoint_id INTEGER NOT NULL, cluster INTEGER NOT NULL, attrid INTEGER NOT NULL, FOREIGN KEY(ieee) REFERENCES devices_v9(ieee) ON DELETE CASCADE, FOREIGN KEY(ieee, endpoint_id, cluster) REFERENCES in_clusters_v9(ieee, endpoint_id, cluster) ON DELETE CASCADE )', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' CREATE TABLE unsupported_attributes_v9 ( ieee ieee NOT NULL, endpoint_id INTEGER NOT NULL, cluster INTEGER NOT NULL, attrid INTEGER NOT NULL, FOREIGN KEY(ieee) REFERENCES devices_v9(ieee) ON DELETE CASCADE, FOREIGN KEY(ieee, endpoint_id, cluster) REFERENCES in_clusters_v9(ieee, endpoint_id, cluster) ON DELETE CASCADE )', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' CREATE UNIQUE INDEX unsupported_attributes_idx_v9 ON unsupported_attributes_v9(ieee, endpoint_id, cluster, attrid)', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' CREATE UNIQUE INDEX unsupported_attributes_idx_v9 ON unsupported_attributes_v9(ieee, endpoint_id, cluster, attrid)', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, ' ', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, ' ', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'INSERT INTO devices_v9 (ieee, nwk, status, last_seen) SELECT ieee, nwk, status, last_seen / 1000.0 FROM devices_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'INSERT INTO devices_v9 (ieee, nwk, status, last_seen) SELECT ieee, nwk, status, last_seen / 1000.0 FROM devices_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, "SELECT name FROM sqlite_master WHERE type='table'", []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, "SELECT name FROM sqlite_master WHERE type='table'", []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM endpoints_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM endpoints_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'INSERT INTO endpoints_v9 VALUES (?,?,?,?,?)', (00:21:2e:ff:ff:08:5d:a9, 1, 260, 5, 1)) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'INSERT INTO endpoints_v9 VALUES (?,?,?,?,?)', (00:21:2e:ff:ff:08:5d:a9, 1, 260, 5, 1)) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'INSERT INTO endpoints_v9 VALUES (?,?,?,?,?)', (00:21:2e:ff:ff:08:5d:a9, 80, 56832, 1, 1)) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'INSERT INTO endpoints_v9 VALUES (?,?,?,?,?)', (00:21:2e:ff:ff:08:5d:a9, 80, 56832, 1, 1)) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM in_clusters_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM in_clusters_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'INSERT INTO in_clusters_v9 VALUES (?,?,?)', (00:21:2e:ff:ff:08:5d:a9, 1, 25)) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'INSERT INTO in_clusters_v9 VALUES (?,?,?)', (00:21:2e:ff:ff:08:5d:a9, 1, 25)) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM out_clusters_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM out_clusters_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM groups_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM groups_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM group_members_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM group_members_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM relays_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM relays_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM attributes_cache_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM attributes_cache_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM neighbors_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM neighbors_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM node_descriptors_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM node_descriptors_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'INSERT INTO node_descriptors_v9 VALUES (?,?,?,?,?,?,?,?,?,?,?,?,?,?)', (00:21:2e:ff:ff:08:5d:a9, 0, 0, 1, 0, 0, 8, 15, 4405, 71, 43, 64, 43, 0)) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'INSERT INTO node_descriptors_v9 VALUES (?,?,?,?,?,?,?,?,?,?,?,?,?,?)', (00:21:2e:ff:ff:08:5d:a9, 0, 0, 1, 0, 0, 8, 15, 4405, 71, 43, 64, 43, 0)) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM unsupported_attributes_v8', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM unsupported_attributes_v8', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'COMMIT', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'COMMIT', []) completed [2022-06-24 08:29:18][DEBUG] : Loading application state [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM devices_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM devices_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM node_descriptors_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM node_descriptors_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM endpoints_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM endpoints_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM in_clusters_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM in_clusters_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM out_clusters_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM out_clusters_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM attributes_cache_v9 WHERE attrid=4 OR attrid=5', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM attributes_cache_v9 WHERE attrid=4 OR attrid=5', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : Checking quirks for None None (00:21:2e:ff:ff:08:5d:a9) [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {232, 230} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {232, 230} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {11, 13} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {232, 230} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {232, 230} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {11, 13} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {232, 230} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {232, 230} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {11, 13} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {232, 230} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {232, 230} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {1} {80, 1} [2022-06-24 08:29:18][DEBUG] : Considering [2022-06-24 08:29:18][DEBUG] : Fail because endpoint list mismatch: {11, 13} {80, 1} [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM attributes_cache_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM attributes_cache_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM unsupported_attributes_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM unsupported_attributes_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM groups_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM groups_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM group_members_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM group_members_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM relays_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM relays_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 'SELECT * FROM neighbors_v9', []) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 'SELECT * FROM neighbors_v9', []) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial(, 64) [2022-06-24 08:29:18][DEBUG] : operation functools.partial(, 64) completed [2022-06-24 08:29:18][DEBUG] : executing functools.partial() [2022-06-24 08:29:18][DEBUG] : operation functools.partial() completed [2022-06-24 08:29:18][DEBUG] : Connection made [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a02000800010022 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a02000a000300220e01 [2022-06-24 08:29:18][DEBUG] : Read parameter protocol_version response: [270] [2022-06-24 08:29:18][DEBUG] : Command Command.version (0,) [2022-06-24 08:29:18][DEBUG] : Send: 0x0d0300090000000000 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0d0300090000077226 [2022-06-24 08:29:18][DEBUG] : Version response: 26720700 [2022-06-24 08:29:18][DEBUG] : Command Command.device_state (0, 0, 0) [2022-06-24 08:29:18][DEBUG] : Send: 0x0704000800000000 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0704000800a20072 [2022-06-24 08:29:18][DEBUG] : Device state response: [, 0, 114] [2022-06-24 08:29:18][DEBUG] : Network state transition: OFFLINE -> CONNECTED [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a05000800010001 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a05001000090001a95d08ffff2e2100 [2022-06-24 08:29:18][DEBUG] : Read parameter mac_address response: [00:21:2e:ff:ff:08:5d:a9] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a06000800010009 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a0600090002000901 [2022-06-24 08:29:18][DEBUG] : Read parameter aps_designed_coordinator response: [1] [2022-06-24 08:29:18][DEBUG] : Command Command.write_parameter (5, , b'X\x02\x00\x00') [2022-06-24 08:29:18][DEBUG] : Send: 0x0b07000c0005002658020000 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0b07000800010026 [2022-06-24 08:29:18][DEBUG] : Write parameter watchdog_ttl: SUCCESS [2022-06-24 08:29:18][DEBUG] : Command Command.device_state (0, 0, 0) [2022-06-24 08:29:18][DEBUG] : Send: 0x0708000800000000 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0708000800a20026 [2022-06-24 08:29:18][DEBUG] : Device state response: [, 0, 38] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a09000800010007 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a09000a000300070000 [2022-06-24 08:29:18][DEBUG] : Read parameter nwk_address response: [0x0000] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a0a000800010005 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a0a000a00030005af4e [2022-06-24 08:29:18][DEBUG] : Read parameter nwk_panid response: [0x4eaf] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a0b000800010008 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a0b001000090008a95d08ffff2e2100 [2022-06-24 08:29:18][DEBUG] : Read parameter nwk_extended_panid response: [00:21:2e:ff:ff:08:5d:a9] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a0c00080001000a [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a0c000c0005000a00800000 [2022-06-24 08:29:18][DEBUG] : Read parameter channel_mask response: [] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a0d00080001000b [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a0d00100009000b0000000000000000 [2022-06-24 08:29:18][DEBUG] : Read parameter aps_extended_panid response: [00:00:00:00:00:00:00:00] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (2, , b'\x00') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a0e00090002001800 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a0e001900120018008f3ff6f33b42724c17915ed243e9bab0 [2022-06-24 08:29:18][DEBUG] : Read parameter network_key response: [0, [143, 63, 246, 243, 59, 66, 114, 76, 23, 145, 94, 210, 67, 233, 186, 176]] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a0f000800010027 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a0f000c0005002779130400 [2022-06-24 08:29:18][DEBUG] : Read parameter nwk_frame_counter response: [267129] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a1000080001000e [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a1000100009000ea95d08ffff2e2100 [2022-06-24 08:29:18][DEBUG] : Read parameter trust_center_address response: [00:21:2e:ff:ff:08:5d:a9] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (9, , b'\xa9]\x08\xff\xff.!\x00') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a11001000090019a95d08ffff2e2100 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a11002000190019a95d08ffff2e21005a6967426565416c6c69616e63653039 [2022-06-24 08:29:18][DEBUG] : Read parameter link_key response: [00:21:2e:ff:ff:08:5d:a9, [90, 105, 103, 66, 101, 101, 65, 108, 108, 105, 97, 110, 99, 101, 48, 57]] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a12000800010010 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a1200090002001003 [2022-06-24 08:29:18][DEBUG] : Read parameter security_mode response: [3] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a1300080001001c [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a1300090002001c0f [2022-06-24 08:29:18][DEBUG] : Read parameter current_channel response: [15] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a14000800010022 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a14000a000300220e01 [2022-06-24 08:29:18][DEBUG] : Read parameter protocol_version response: [270] [2022-06-24 08:29:18][DEBUG] : Command Command.read_parameter (1, , b'') [2022-06-24 08:29:18][DEBUG] : Send: 0x0a15000800010024 [2022-06-24 08:29:18][DEBUG] : Frame received: 0x0a1500090002002400 [2022-06-24 08:29:18][DEBUG] : Read parameter nwk_update_id response: [0] [2022-06-24 08:29:18][INFO] : [00:21:2e:ff:ff:08:5d:a9][listener.device_initialized] new=False [2022-06-24 08:29:18][INFO] : [start_zigbee] Init and start http server : {'database_path': '/var/www/html/plugins/zigbee/data/1/network_deconz.db', 'device': {'path': '/dev/ttyACM1'}, 'network': {'channel': 15}} [2022-06-24 08:29:18][INFO] : [start_zigbee] Start zigbee network