iobroker-community-adapters / ioBroker.broadlink2

ioBroker adapter for broadlink devices like the RM remote or SP switches
MIT License
41 stars 15 forks source link

V2Beta 1.9.9 iobroker beendet sich.. #49

Closed Ilovegym66 closed 5 years ago

Ilovegym66 commented 5 years ago

mit der aktuellen V2Beta beendet sich iobroker nach einem scan, der broadlink2 Adapter findet auch ganz viele Geraete auf einmal.. 019-03-25 19:26:50.696 - info: host.iobroker instance system.adapter.broadlink2.0 started with pid 26263 2019-03-25 19:26:51.041 - debug: broadlink2.0 objectDB connected 2019-03-25 19:26:51.055 - debug: broadlink2.0 statesDB connected 2019-03-25 19:26:51.068 - info: broadlink2.0 starting. Version 1.9.9 in /opt/iobroker/node_modules/iobroker.broadlink2, node: v8.15.1 2019-03-25 19:26:53.711 - info: broadlink2.0 broadlink2 initialization started... 2019-03-25 19:26:53.711 - info: broadlink2.0 broadlink2 starting main... 2019-03-25 19:26:53.716 - info: broadlink2.0 UDP socket listening on 0.0.0.0:15001 2019-03-25 19:26:53.717 - info: broadlink2.0 Discover Broadlink devices for 10sec on broadlink2.0 2019-03-25 19:26:53.910 - info: broadlink2.0 Device RM:0x272a_34:ea:34:c7:c0:bb dedected: address=192.168.178.87, mac=34:ea:34:c7:c0:bb, typ=rmp, id=0x272a devtype=RM2 Pro Plus 2019-03-25 19:26:54.315 - info: broadlink2.0 Device RM:0x2737_34:ea:34:41:45:14 dedected: address=192.168.178.88, mac=34:ea:34:41:45:14, typ=rm, id=0x2737 devtype=RM Mini 2019-03-25 19:26:54.511 - info: broadlink2.0 Device SP:0x2728_b4:43:0d:f0:d0:67 dedected: address=192.168.178.177, mac=b4:43:0d:f0:d0:67, typ=sp2, id=0x2728 devtype=OEM branded SPMini2 2019-03-25 19:27:08.794 - info: Adapter broadlink2 still running 2019-03-25 19:27:09.956 - info: broadlink2.0 Close all connections... 2019-03-25 19:27:09.957 - info: broadlink2.0 Adapter disconnected and stopped with dostop(false) and callback(true) 2019-03-25 19:27:09.958 - warn: broadlink2.0 Adapter will exit in latest 1 sec with code false! 2019-03-25 19:29:18.014 - info: history.0 enabled logging of broadlink2.0.RM:Broadlink-RMMINI-41-45-14.Temperature (Count=153), Alias=false 2019-03-25 19:29:18.014 - info: history.0 enabled logging of broadlink2.0.RM:Broadlink-RMPLUS.Temperature (Count=154), Alias=false 2019-03-25 19:29:30.132 - info: host.iobroker object change system.adapter.broadlink2.0 2019-03-25 19:29:30.173 - info: host.iobroker instance system.adapter.broadlink2.0 started with pid 27304 2019-03-25 19:29:30.749 - debug: broadlink2.0 objectDB connected 2019-03-25 19:29:30.883 - debug: broadlink2.0 statesDB connected 2019-03-25 19:29:30.923 - info: broadlink2.0 starting. Version 1.9.1 in /opt/iobroker/node_modules/iobroker.broadlink2, node: v8.15.1 2019-03-25 19:29:30.948 - debug: broadlink2.0 Adapter broadlink2.0 starting. 2019-03-25 19:29:35.621 - debug: broadlink2.0 broadlink2 received 13339 objects with config ip,scenes,switches,poll,new,lang,latitude,longitude 2019-03-25 19:29:35.626 - info: broadlink2.0 Discover UDP devices for 10sec on broadlink2.0 2019-03-25 19:29:35.627 - debug: broadlink2.0 Config IP-Address end to remove: .fritz.box 2019-03-25 19:29:35.768 - debug: broadlink2.0 Change _NewDeviceScan to true with ack: true 2019-03-25 19:29:35.887 - info: broadlink2.0 Device SP:BroadLink-SPmini-T1-2 dedected: 192.168.178.178,IPv4,80,128,10024,sp2,SP:BroadLink-SPmini-T1-2,SPMini2,28:27:c0:a8:b2:b2 2019-03-25 19:29:35.898 - info: broadlink2.0 Device RM:Broadlink-RMPLUS dedected: 192.168.178.87,IPv4,80,128,10026,rm,RM:Broadlink-RMPLUS,RM2 Pro Plus,2a:27:57:b2:a8:c0 2019-03-25 19:29:36.300 - info: broadlink2.0 Device RM:Broadlink-RMMINI-41-45-14 dedected: 192.168.178.88,IPv4,80,128,10039,rm,RM:Broadlink-RMMINI-41-45-14,RM Mini,37:27:58:b2:a8:c0 2019-03-25 19:29:41.966 - debug: broadlink2.0 Change _NewDeviceScan to false with ack: true 2019-03-25 19:29:42.041 - debug: broadlink2.0 Adapter has 79 old states! 2019-03-25 19:29:42.047 - warn: broadlink2.0 device SP:BroadLink-SPmini-T1-1 not found, please rescan later again or delete it! It was: 192.168.178.177,IPv4,80,128,10024,sp2,SP:BroadLink-SPmini-T1-1,SPMini2,28:27:c0:a8:b2:b1 2019-03-25 19:29:42.053 - warn: broadlink2.0 device RM:0x272a_34:ea:34:c7:c0:bb not found, please rescan later again or delete it! It was: 192.168.178.87,80,7,10026,[object Object],34:ea:34:c7:c0:bb,rmp,RM:0x272a_34:ea:34:c7:c0:bb,0x272a,RM2 Pro Plus 2019-03-25 19:29:42.054 - warn: broadlink2.0 device RM:0x2737_34:ea:34:41:45:14 not found, please rescan later again or delete it! It was: 192.168.178.88,80,7,10039,[object Object],34:ea:34:41:45:14,rm,RM:0x2737_34:ea:34:41:45:14,0x2737,RM Mini 2019-03-25 19:29:42.066 - debug: broadlink2.0 Change SendScene to ' ' with ack: true 2019-03-25 19:29:42.068 - debug: broadlink2.0 Poll every 30 secods. 2019-03-25 19:29:42.068 - info: broadlink2.0 Adapter broadlink2.0 started and found 3 devices named 'SP:BroadLink-SPmini-T1-2', 'RM:Broadlink-RMPLUS', 'RM:Broadlink-RMMINI-41-45-14'. 2019-03-25 19:29:42.068 - info: broadlink2.0 3 were not found: SP:BroadLink-SPmini-T1-1,RM:0x272a_34:ea:34:c7:c0:bb,RM:0x2737_34:ea:34:41:45:14 2019-03-25 19:29:42.145 - info: history.0 enabled logging of broadlink2.0.RM:Broadlink-RMPLUS.Temperature, Alias=false 2019-03-25 19:29:42.150 - debug: broadlink2.0 Change RM:Broadlink-RMPLUS.Temperature to 21.4 with ack: true 2019-03-25 19:29:42.213 - info: history.0 enabled logging of broadlink2.0.RM:Broadlink-RMMINI-41-45-14.Temperature, Alias=false 2019-03-25 19:29:44.065 - debug: broadlink2.0 Change SP:BroadLink-SPmini-T1-2.notReachable to false with ack: true 2019-03-25 19:29:44.165 - debug: broadlink2.0 Change RM:Broadlink-RMMINI-41-45-14.notReachable to false with ack: true 2019-03-25 19:29:44.215 - debug: broadlink2.0 Change SP:BroadLink-SPmini-T1-1.notReachable to false with ack: true 2019-03-25 19:29:44.265 - debug: broadlink2.0 Change RM:0x272a_34:ea:34:c7:c0:bb.notReachable to false with ack: true 2019-03-25 19:29:44.315 - debug: broadlink2.0 Change RM:0x2737_34:ea:34:41:45:14.notReachable to false with ack: true 2019-03-25 19:30:04.730 - debug: broadlink2.0 system.adapter.admin.0: logging true 2019-03-25 19:30:14.221 - warn: broadlink2.0 Device SP:BroadLink-SPmini-T1-1 not reachable 2019-03-25 19:30:14.234 - debug: broadlink2.0 Change SP:BroadLink-SPmini-T1-1.notReachable to true with ack: true 2019-03-25 19:30:14.276 - warn: broadlink2.0 Device RM:0x272a_34:ea:34:c7:c0:bb not reachable 2019-03-25 19:30:14.278 - debug: broadlink2.0 Change RM:0x272a_34:ea:34:c7:c0:bb.notReachable to true with ack: true 2019-03-25 19:30:14.321 - warn: broadlink2.0 Device RM:0x2737_34:ea:34:41:45:14 not reachable 2019-03-25 19:30:14.323 - debug: broadlink2.0 Change RM:0x2737_34:ea:34:41:45:14.notReachable to true with ack: true 2019-03-25 19:30:16.737 - debug: broadlink2.0 system.adapter.admin.0: logging false 2019-03-25 19:30:16.873 - debug: broadlink2.0 system.adapter.admin.0: logging true 2019-03-25 19:30:27.885 - info: host.iobroker object change system.adapter.broadlink2.0 2019-03-25 19:30:27.887 - debug: broadlink2.0 Adapter disconnected and stopped with dostop(false) and callback(true) 2019-03-25 19:30:27.885 - info: host.iobroker "system.adapter.broadlink2.0" disabled 2019-03-25 19:30:27.885 - info: host.iobroker stopInstance system.adapter.broadlink2.0 2019-03-25 19:30:27.885 - info: host.iobroker stopInstance system.adapter.broadlink2.0 killing pid 27304 2019-03-25 19:30:27.915 - info: host.iobroker instance system.adapter.broadlink2.0 terminated with code 0 (OK)

Ilovegym66 commented 5 years ago

update: 2019-03-29 19:12:27.068 - info: host.iobroker "system.adapter.broadlink2.0" enabled 2019-03-29 19:12:27.089 - info: host.iobroker instance system.adapter.broadlink2.0 started with pid 4724 2019-03-29 19:12:27.523 - info: broadlink2.0 starting. Version 1.9.9 in /opt/iobroker/node_modules/iobroker.broadlink2, node: v8.15.1 2019-03-29 19:12:31.255 - info: broadlink2.0 broadlink2 initialization started... 2019-03-29 19:12:31.256 - info: broadlink2.0 broadlink2 starting main... 2019-03-29 19:12:31.261 - info: broadlink2.0 UDP socket listening on 0.0.0.0:15001 2019-03-29 19:12:31.262 - info: broadlink2.0 Discover Broadlink devices for 10sec on broadlink2.0 2019-03-29 19:12:32.054 - info: broadlink2.0 Device SP:0x2728_b4:43:0d:f0:d0:67 dedected: address=192.168.178.177, mac=b4:43:0d:f0:d0:67, typ=sp2, id=0x2728 devtype=OEM branded SPMini2 2019-03-29 19:12:32.077 - info: broadlink2.0 Device SP:0x2728_34:ea:34:f4:f3:e8 dedected: address=192.168.178.178, mac=34:ea:34:f4:f3:e8, typ=sp2, id=0x2728 devtype=OEM branded SPMini2 2019-03-29 19:12:32.092 - info: broadlink2.0 Device RM:0x2737_34:ea:34:41:45:14 dedected: address=192.168.178.88, mac=34:ea:34:41:45:14, typ=rm, id=0x2737 devtype=RM Mini 2019-03-29 19:12:32.102 - info: broadlink2.0 Device RM:0x272a_34:ea:34:c7:c0:bb dedected: address=192.168.178.87, mac=34:ea:34:c7:c0:bb, typ=rmp, id=0x272a devtype=RM2 Pro Plus 2019-03-29 19:12:46.346 - info: Adapter broadlink2 still running 2019-03-29 19:12:47.568 - info: broadlink2.0 Close all connections... 2019-03-29 19:12:47.570 - info: broadlink2.0 Adapter disconnected and stopped with dostop(false) and callback(true) 2019-03-29 19:12:47.571 - warn: broadlink2.0 Adapter will exit in latest 1 sec with code false!

Ilovegym66 commented 5 years ago

2019-03-29 19:12:27.068 - info: host.iobroker "system.adapter.broadlink2.0" enabled 2019-03-29 19:12:27.089 - info: host.iobroker instance system.adapter.broadlink2.0 started with pid 4724 2019-03-29 19:12:27.523 - info: broadlink2.0 starting. Version 1.9.9 in /opt/iobroker/node_modules/iobroker.broadlink2, node: v8.15.1 at clone (/opt/iobroker/node_modules/iobroker.js-controller/lib/objects/objectsInMemServer.js:1936:24) at clone (/opt/iobroker/node_modules/iobroker.js-controller/lib/objects/objectsInMemServer.js:1940:29) at clone (/opt/iobroker/node_modules/iobroker.js-controller/lib/objects/objectsInMemServer.js:1940:29) at clone (/opt/iobroker/node_modules/iobroker.js-controller/lib/objects/objectsInMemServer.js:1940:29) at _getObjectList (/opt/iobroker/node_modules/iobroker.js-controller/lib/objects/objectsInMemServer.js:2863:39) at checkObjectRights (/opt/iobroker/node_modules/iobroker.js-controller/lib/objects/objectsInMemServer.js:2912:28) at checkObjectRights (/opt/iobroker/node_modules/iobroker.js-controller/lib/objects/objectsInMemServer.js:1869:20) at ObjectsInMemServer.getObjectList (/opt/iobroker/node_modules/iobroker.js-controller/lib/objects/objectsInMemServer.js:2908:13) 2019-03-29 19:12:36.307 - info: iobroker _restart 2019-03-29 19:12:36.499 - info: iobroker Starting node restart.js 2019-03-29 19:12:36.510 - info: iobroker exit 0 2019-03-29 19:12:41.338 - warn: host.iobroker multihost service started on 0.0.0.0:50005 2019-03-29 19:12:46.343 - info: host.iobroker force terminating

frankjoke commented 5 years ago

I have seen it as well on some of my systems and debugged it to a problem in js-controller which kills itself if getObjectList is called more than one time. Restrt adapter, every 2nd or 3rdd time it works then forever because the adapter calls the function only on beginning. It should not happen with new js-controller 2.0 but meanwhile I try to change the broadlink2 code not to use the call too often.

frankjoke commented 5 years ago

It should be corrected with current version on git.

Ilovegym66 commented 5 years ago

Sorry, same again in Version 2.0.0 :-(

frankjoke commented 5 years ago

Just restart adapter. I cannot do anything about is because js-controller from ioBroker is failing on the same call which works all other times. I realized that it happens when you have admin open for a long time. Admin has also a problem, it eats memory from iobroker and the browser! I only raised that to js-controiller guys.

Ilovegym66 commented 5 years ago

ah, thank you for the support, yes, I've the admin in some VM's a long time open ... ok, I check this !