[2020-12-07 17:19:24][INFO] : Start zigbeed [2020-12-07 17:19:24][INFO] : Log level : debug [2020-12-07 17:19:24][INFO] : PID file : /tmp/jeedom/zigbee/deamon_1.pid [2020-12-07 17:19:24][INFO] : Device : /dev/ttyACM0 [2020-12-07 17:19:24][INFO] : Apikey : FO1uWWKTsbVCL11Bjg9A6ky1V3aRPuMQ [2020-12-07 17:19:24][INFO] : Callback : http://127.0.0.1:80/plugins/zigbee/core/php/jeeZigbee.php [2020-12-07 17:19:24][INFO] : Cycle : 0.3 [2020-12-07 17:19:24][INFO] : Controller : cc [2020-12-07 17:19:24][INFO] : Channel : 15 [2020-12-07 17:19:24][INFO] : Data folder : /var/www/html/plugins/zigbee/data/1 [2020-12-07 17:19:25][INFO] : Find device : /dev/ttyACM0 [2020-12-07 17:19:25][INFO] : LOADER------Import de la configuration specifics.danfoss [2020-12-07 17:19:25][INFO] : LOADER------Import de la configuration specifics.danfoss.details [2020-12-07 17:19:25][DEBUG] : Writing PID 10102 to /tmp/jeedom/zigbee/deamon_1.pid [2020-12-07 17:19:25][DEBUG] : Init request module v2.21.0 [2020-12-07 17:19:25][DEBUG] : Starting new HTTP connection (1): 127.0.0.1:80 [2020-12-07 17:19:25][DEBUG] : http://127.0.0.1:80 "GET /plugins/zigbee/core/php/jeeZigbee.php?apikey=FO1uWWKTsbVCL11Bjg9A6ky1V3aRPuMQ HTTP/1.1" 200 0 [2020-12-07 17:19:25][DEBUG] : Using selector: EpollSelector [2020-12-07 17:19:25][DEBUG] : [start_zigbee] Init zigbee network with config : {'database_path': '/var/www/html/plugins/zigbee/data/1/network_cc.db', 'device': {'path': '/dev/ttyACM0'}, 'network': {'channel': 15}} [2020-12-07 17:19:25][DEBUG] : executing functools.partial(.connector at 0x75225540>) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA foreign_keys = ON', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE TABLE IF NOT EXISTS devices (ieee ieee, nwk, status)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA user_version = 3', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE UNIQUE INDEX IF NOT EXISTS ieee_idx ON devices(ieee)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE TABLE IF NOT EXISTS endpoints (ieee ieee, endpoint_id, profile_id, device_type device_type, status, FOREIGN KEY(ieee) REFERENCES devices(ieee) ON DELETE CASCADE)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA user_version = 3', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE UNIQUE INDEX IF NOT EXISTS endpoint_idx ON endpoints(ieee, endpoint_id)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE TABLE IF NOT EXISTS clusters (ieee ieee, endpoint_id, cluster, FOREIGN KEY(ieee, endpoint_id) REFERENCES endpoints(ieee, endpoint_id) ON DELETE CASCADE)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA user_version = 3', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE UNIQUE INDEX IF NOT EXISTS cluster_idx ON clusters(ieee, endpoint_id, cluster)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE TABLE IF NOT EXISTS neighbors (device_ieee ieee NOT NULL, extended_pan_id ieee NOT NULL,ieee ieee NOT NULL, nwk INTEGER NOT NULL, struct INTEGER NOT NULL, permit_joining INTEGER NOT NULL, depth INTEGER NOT NULL, lqi INTEGER NOT NULL, FOREIGN KEY(device_ieee) REFERENCES devices(ieee) ON DELETE CASCADE)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA user_version = 3', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE INDEX IF NOT EXISTS neighbors_idx ON neighbors(device_ieee)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE TABLE IF NOT EXISTS node_descriptors (ieee ieee, value, FOREIGN KEY(ieee) REFERENCES devices(ieee) ON DELETE CASCADE)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA user_version = 3', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE UNIQUE INDEX IF NOT EXISTS node_descriptors_idx ON node_descriptors(ieee)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE TABLE IF NOT EXISTS output_clusters (ieee ieee, endpoint_id, cluster, FOREIGN KEY(ieee, endpoint_id) REFERENCES endpoints(ieee, endpoint_id) ON DELETE CASCADE)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA user_version = 3', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE UNIQUE INDEX IF NOT EXISTS output_cluster_idx ON output_clusters(ieee, endpoint_id, cluster)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE TABLE IF NOT EXISTS attributes (ieee ieee, endpoint_id, cluster, attrid, value, FOREIGN KEY(ieee) REFERENCES devices(ieee) ON DELETE CASCADE)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA user_version = 3', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE UNIQUE INDEX IF NOT EXISTS attribute_idx ON attributes(ieee, endpoint_id, cluster, attrid)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE TABLE IF NOT EXISTS groups (group_id, name)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA user_version = 3', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE UNIQUE INDEX IF NOT EXISTS group_idx ON groups(group_id)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE TABLE IF NOT EXISTS group_members (group_id, ieee ieee, endpoint_id, FOREIGN KEY(group_id) REFERENCES groups(group_id) ON DELETE CASCADE, FOREIGN KEY(ieee, endpoint_id) REFERENCES endpoints(ieee, endpoint_id) ON DELETE CASCADE)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA user_version = 3', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE UNIQUE INDEX IF NOT EXISTS group_members_idx ON group_members(group_id, ieee, endpoint_id)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE TABLE IF NOT EXISTS relays (ieee ieee, relays, FOREIGN KEY(ieee) REFERENCES devices(ieee) ON DELETE CASCADE)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'PRAGMA user_version = 3', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'CREATE UNIQUE INDEX IF NOT EXISTS relays_idx ON relays(ieee)', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial() [2020-12-07 17:19:25][DEBUG] : returning None [2020-12-07 17:19:25][DEBUG] : Loading application state from %s [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 'SELECT * FROM devices', []) [2020-12-07 17:19:25][DEBUG] : returning [2020-12-07 17:19:25][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:25][DEBUG] : returning [] [2020-12-07 17:19:25][DEBUG] : executing functools.partial() [2020-12-07 17:19:25][DEBUG] : returning None [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 'SELECT * FROM node_descriptors', []) [2020-12-07 17:19:26][DEBUG] : returning [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:26][DEBUG] : returning [] [2020-12-07 17:19:26][DEBUG] : executing functools.partial() [2020-12-07 17:19:26][DEBUG] : returning None [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 'SELECT * FROM endpoints', []) [2020-12-07 17:19:26][DEBUG] : returning [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:26][DEBUG] : returning [] [2020-12-07 17:19:26][DEBUG] : executing functools.partial() [2020-12-07 17:19:26][DEBUG] : returning None [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 'SELECT * FROM clusters', []) [2020-12-07 17:19:26][DEBUG] : returning [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:26][DEBUG] : returning [] [2020-12-07 17:19:26][DEBUG] : executing functools.partial() [2020-12-07 17:19:26][DEBUG] : returning None [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 'SELECT * FROM output_clusters', []) [2020-12-07 17:19:26][DEBUG] : returning [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:26][DEBUG] : returning [] [2020-12-07 17:19:26][DEBUG] : executing functools.partial() [2020-12-07 17:19:26][DEBUG] : returning None [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 'SELECT * FROM attributes WHERE attrid=4 OR attrid=5', []) [2020-12-07 17:19:26][DEBUG] : returning [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:26][DEBUG] : returning [] [2020-12-07 17:19:26][DEBUG] : executing functools.partial() [2020-12-07 17:19:26][DEBUG] : returning None [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 'SELECT * FROM attributes', []) [2020-12-07 17:19:26][DEBUG] : returning [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:26][DEBUG] : returning [] [2020-12-07 17:19:26][DEBUG] : executing functools.partial() [2020-12-07 17:19:26][DEBUG] : returning None [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 'SELECT * FROM groups', []) [2020-12-07 17:19:26][DEBUG] : returning [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:26][DEBUG] : returning [] [2020-12-07 17:19:26][DEBUG] : executing functools.partial() [2020-12-07 17:19:26][DEBUG] : returning None [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 'SELECT * FROM group_members', []) [2020-12-07 17:19:26][DEBUG] : returning [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:26][DEBUG] : returning [] [2020-12-07 17:19:26][DEBUG] : executing functools.partial() [2020-12-07 17:19:26][DEBUG] : returning None [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 'SELECT * FROM relays', []) [2020-12-07 17:19:26][DEBUG] : returning [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:26][DEBUG] : returning [] [2020-12-07 17:19:26][DEBUG] : executing functools.partial() [2020-12-07 17:19:26][DEBUG] : returning None [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 'SELECT * FROM neighbors', []) [2020-12-07 17:19:26][DEBUG] : returning [2020-12-07 17:19:26][DEBUG] : executing functools.partial(, 64) [2020-12-07 17:19:26][DEBUG] : returning [] [2020-12-07 17:19:26][DEBUG] : executing functools.partial() [2020-12-07 17:19:26][DEBUG] : returning None [2020-12-07 17:19:26][INFO] : Starting zigpy-cc version: 0.5.2 [2020-12-07 17:19:26][DEBUG] : Connecting on port /dev/ttyACM0 with boudrate 115200 [2020-12-07 17:19:26][DEBUG] : Connection made [2020-12-07 17:19:27][DEBUG] : --> SREQ SYS ping tsn: None {'capabilities': 1} [2020-12-07 17:19:27][DEBUG] : Send: b'\xfe\x00!\x01 ' [2020-12-07 17:19:27][ERROR] : Serial port closed unexpectedly: device reports readiness to read but returned no data (device disconnected or multiple access on port?) [2020-12-07 17:19:32][INFO] : Starting zigpy-cc version: 0.5.2 [2020-12-07 17:19:32][DEBUG] : Connecting on port /dev/ttyACM0 with boudrate 115200 [2020-12-07 17:19:32][INFO] : Failed to reconnect: [Errno 16] could not open port /dev/ttyACM0: [Errno 16] Device or resource busy: '/dev/ttyACM0' [2020-12-07 17:19:33][ERROR] : Couldn't start application [2020-12-07 17:19:33][DEBUG] : executing functools.partial() [2020-12-07 17:19:33][DEBUG] : returning None [2020-12-07 17:19:33][ERROR] : [start_zigbee] Fatal error : [2020-12-07 17:19:33][DEBUG] : Traceback (most recent call last): File "/var/www/html/plugins/zigbee/resources/zigbeed/zigbeed.py", line 71, in start_zigbee start_radio=True, File "/usr/local/lib/python3.7/dist-packages/zigpy/application.py", line 68, in new await app.startup(auto_form) File "/usr/local/lib/python3.7/dist-packages/zigpy_cc/zigbee/application.py", line 95, in startup await self._api.request(Subsystem.SYS, "ping", {"capabilities": 1}) File "/usr/local/lib/python3.7/dist-packages/zigpy_cc/api.py", line 117, in request return await self.request_raw(obj, waiter_id, expected_status) File "/usr/local/lib/python3.7/dist-packages/zigpy_cc/api.py", line 121, in request_raw return await self._request_raw(obj, waiter_id, expected_status) File "/usr/local/lib/python3.7/dist-packages/zigpy_cc/api.py", line 141, in _request_raw result = await waiter.wait() File "/usr/local/lib/python3.7/dist-packages/zigpy_cc/api.py", line 47, in wait return await asyncio.wait_for(self.future, self.timeout / 1000) File "/usr/lib/python3.7/asyncio/tasks.py", line 423, in wait_for raise futures.TimeoutError() concurrent.futures._base.TimeoutError [2020-12-07 17:19:33][DEBUG] : Shutdown [2020-12-07 17:19:33][DEBUG] : Removing PID file /tmp/jeedom/zigbee/deamon_1.pid [2020-12-07 17:19:33][DEBUG] : Exit 0