Unexpected stop of openLuup
-
Crillereplied to akbooer on Aug 20, 2021, 4:30 PM last edited by Crille Aug 20, 2021, 12:31 PM
-
That rather looks as though it has run out of file handles (which are used for sockets as well.)
- what machine is this running on?
- can I see the complete Startup Log?
- also, when running, the openLuup console Servers page.
-
Crillereplied to akbooer on Aug 20, 2021, 6:17 PM last edited by Crille Aug 20, 2021, 2:27 PM
@akbooer It's running on a virtual Ubuntu 18.04 LTS server that also run Homebridge and MSR, therefore a lot of calls from 127.0.0.1.
Startup log:
2021-08-03 13:01:53.798 :: openLuup STARTUP :: /home/username/cmh-ludl 2021-08-03 13:01:53.798 openLuup.init:: version 2021.06.14 @akbooer 2021-08-03 13:01:53.822 openLuup.scheduler:: version 2021.03.19 @akbooer 2021-08-03 13:01:53.852 openLuup.io:: version 2021.03.27 @akbooer 2021-08-03 13:01:53.852 openLuup.mqtt:: version 2021.06.08 @akbooer 2021-08-03 13:01:53.853 openLuup.wsapi:: version 2019.08.12 @akbooer 2021-08-03 13:01:53.854 openLuup.servlet:: version 2021.04.30 @akbooer 2021-08-03 13:01:53.854 openLuup.client:: version 2019.10.14 @akbooer 2021-08-03 13:01:53.854 openLuup.server:: version 2020.03.26 @akbooer 2021-08-03 13:01:53.857 openLuup.scenes:: version 2021.06.02 @akbooer 2021-08-03 13:01:53.863 openLuup.chdev:: version 2021.05.04 @akbooer 2021-08-03 13:01:53.863 openLuup.userdata:: version 2021.04.30 @akbooer 2021-08-03 13:01:53.863 openLuup.requests:: version 2021.02.20 @akbooer 2021-08-03 13:01:53.863 openLuup.gateway:: version 2021.05.08 @akbooer 2021-08-03 13:01:53.866 openLuup.smtp:: version 2018.04.12 @akbooer 2021-08-03 13:01:53.893 openLuup.historian:: version 2021.06.12 @akbooer 2021-08-03 13:01:53.893 openLuup.luup:: version 2021.05.14 @akbooer 2021-08-03 13:01:53.894 openLuup.pop3:: version 2018.04.23 @akbooer 2021-08-03 13:01:53.895 openLuup.compression:: version 2016.06.30 @akbooer 2021-08-03 13:01:53.895 openLuup.timers:: version 2021.05.23 @akbooer 2021-08-03 13:01:53.895 openLuup.logs:: version 2018.03.25 @akbooer 2021-08-03 13:01:53.895 openLuup.json:: version Cjson (2.1.0) + openLuup (2021.05.01) @akbooer 2021-08-03 13:01:53.929 luup.create_device:: [1] D_ZWaveNetwork.xml / I_ZWave.xml / (urn:schemas-micasaverde-com:device:ZWaveNetwork:1) 2021-08-03 13:01:53.935 luup.create_device:: [2] D_openLuup.xml / I_openLuup.xml / D_openLuup.json (openLuup) 2021-08-03 13:01:53.935 openLuup.init:: loading configuration user_data.json 2021-08-03 13:01:53.942 openLuup.userdata:: loading user_data json... 2021-08-03 13:01:53.951 luup.variable_set:: 2.openLuup.HouseMode was: EMPTY now: 1 #hooks:0 2021-08-03 13:01:53.951 openLuup.userdata:: loading rooms... 2021-08-03 13:01:53.951 openLuup.userdata:: room#1 'MiOS-XXXXXX' 2021-08-03 13:01:53.951 openLuup.userdata:: room#4 'Källaren' 2021-08-03 13:01:53.951 openLuup.userdata:: room#5 'Sovrummet' 2021-08-03 13:01:53.951 openLuup.userdata:: room#6 'Vera sensorer' 2021-08-03 13:01:53.951 openLuup.userdata:: room#7 'Datarummet' 2021-08-03 13:01:53.951 openLuup.userdata:: room#8 'Z - Virtual' 2021-08-03 13:01:53.951 openLuup.userdata:: room#9 'Hela huset' 2021-08-03 13:01:53.951 openLuup.userdata:: room#10 'Köket' 2021-08-03 13:01:53.951 openLuup.userdata:: room#11 'Vardagsrummet' 2021-08-03 13:01:53.951 openLuup.userdata:: room#12 'Milias rum' 2021-08-03 13:01:53.951 openLuup.userdata:: room#13 'Hallen' 2021-08-03 13:01:53.951 openLuup.userdata:: room#14 'Ezlo-90000XXX' 2021-08-03 13:01:53.951 openLuup.userdata:: room#15 'Baksidan (Ute)' 2021-08-03 13:01:53.951 openLuup.userdata:: room#16 'Tasmota' 2021-08-03 13:01:53.951 openLuup.userdata:: room#101 'Room 101' 2021-08-03 13:01:53.951 openLuup.userdata:: room#17 'Växthuset' 2021-08-03 13:01:53.951 openLuup.userdata:: ...room loading completed 2021-08-03 13:01:53.951 openLuup.userdata:: loading devices... 2021-08-03 13:01:53.952 luup.create_device:: [1] D_ZWaveNetwork.xml / X / (urn:schemas-micasaverde-com:device:ZWaveNetwork:1) 2021-08-03 13:01:54.100 openLuup.scheduler.sandbox:: device 3 defined 'string.starts' (a function value) 2021-08-03 13:01:54.100 openLuup.scheduler.sandbox:: device 3 defined 'string.altui_split' (a function value) 2021-08-03 13:01:54.100 openLuup.scheduler.sandbox:: device 3 defined 'string.template' (a function value) 2021-08-03 13:01:54.100 openLuup.scheduler.sandbox:: device 3 defined 'string.trim' (a function value) 2021-08-03 13:01:54.100 luup.create_device:: [3] D_ALTUI.xml / I_ALTUI.xml / D_ALTUI_UI7.json (urn:schemas-upnp-org:device:altui:1) 2021-08-03 13:01:54.104 luup.create_device:: [4] D_AltAppStore.xml / I_AltAppStore.xml / D_AltAppStore.json (urn:schemas-upnp-org:device:AltAppStore:1) 2021-08-03 13:01:54.110 luup.create_device:: [5] D_VeraBridge.xml / I_VeraBridge.xml / D_VeraBridge.json (VeraBridge) 2021-08-03 13:01:54.119 luup.create_device:: [9] D_EzloBridge.xml / I_EzloBridge.xml / D_EzloBridge.json (urn:schemas-rboer-com:device:EzloBridge:1) 2021-08-03 13:01:54.130 luup.create_device:: [10] D_VirtualBinaryLight1.xml / I_VirtualBinaryLight1.xml / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.221 luup.create_device:: [23] D_Homebridge2openluup1.xml / I_Homebridge2openluup1.xml / D_Homebridge2openluup1.json (urn:schemas-ctrlable-com:device:Homebridge2openluup1:1) 2021-08-03 13:01:54.223 luup.create_device:: [28] D_VirtualBinaryLight1.xml / I_VirtualBinaryLight1.xml / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.225 luup.create_device:: [29] D_VirtualBinaryLight1.xml / I_VirtualBinaryLight1.xml / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.310 luup.create_device:: [33] D_HVAC_ZoneThermostat1.xml / / D_HVAC_ZoneThermostat1.json (urn:schemas-upnp-org:device:HVAC_ZoneThermostat:1) 2021-08-03 13:01:54.312 luup.create_device:: [34] D_HVAC_ZoneThermostat1.xml / / D_HVAC_ZoneThermostat1.json (urn:schemas-upnp-org:device:HVAC_ZoneThermostat:1) 2021-08-03 13:01:54.315 luup.create_device:: [35] D_TasmotaBridge.xml / I_TasmotaBridge.xml / D_TasmotaBridge.json (TasmotaBridge) 2021-08-03 13:01:54.332 luup.create_device:: [37] D_VirtualSensor1.xml / I_VirtualSensor1.xml / D_VirtualSensor1.json (urn:schemas-toggledbits-com:device:VirtualSensor:1) 2021-08-03 13:01:54.334 luup.create_device:: [38] D_TemperatureSensor1.xml / / D_TemperatureSensor1.json (urn:schemas-micasaverde-com:device:TemperatureSensor:1) 2021-08-03 13:01:54.335 luup.create_device:: [39] D_TemperatureSensor1.xml / / D_TemperatureSensor1.json (urn:schemas-micasaverde-com:device:TemperatureSensor:1) 2021-08-03 13:01:54.336 luup.create_device:: [40] D_HumiditySensor1.xml / / D_HumiditySensor1.json (urn:schemas-micasaverde-com:device:HumiditySensor:1) 2021-08-03 13:01:54.338 luup.create_device:: [42] D_VirtualBinaryLight1.xml / I_VirtualBinaryLight1.xml / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.340 luup.create_device:: [43] D_VirtualBinaryLight1.xml / I_VirtualBinaryLight1.xml / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.342 luup.create_device:: [44] D_VirtualBinaryLight1.xml / I_VirtualBinaryLight1.xml / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.344 luup.create_device:: [45] D_VirtualBinaryLight1.xml / I_VirtualBinaryLight1.xml / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.346 luup.create_device:: [46] D_VirtualBinaryLight1.xml / I_VirtualBinaryLight1.xml / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.348 luup.create_device:: [47] D_VirtualBinaryLight1.xml / I_VirtualBinaryLight1.xml / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.374 luup.create_device:: [51] D_SiteSensor1.xml / I_SiteSensor1.xml / D_SiteSensor1.json (urn:schemas-toggledbits-com:device:SiteSensor:1) 2021-08-03 13:01:54.375 luup.create_device:: [52] D_HumiditySensor1.xml / / D_HumiditySensor1.json (urn:schemas-micasaverde-com:device:HumiditySensor:1) 2021-08-03 13:01:54.381 luup.create_device:: [10002] D_ZigbeeNetwork.xml / X / (urn:schemas-micasaverde-com:device:ZigbeeNetwork:1) 2021-08-03 13:01:54.384 luup.create_device:: [10003] D_BluetoothNetwork.xml / X / (urn:schemas-micasaverde-com:device:BluetoothNetwork:1) 2021-08-03 13:01:54.388 luup.create_device:: [10004] D_LPRFNetwork.xml / X / (urn:schemas-micasaverde-com:device:LPRFNetwork:1) 2021-08-03 13:01:54.391 luup.create_device:: [10005] D_SceneController1.xml / X / D_SceneController1.json (urn:schemas-micasaverde-com:device:SceneController:1) 2021-08-03 13:01:54.395 luup.create_device:: [10006] D_G550Siren.xml / X / D_G550Siren1.json (urn:schemas-micasaverde-com:device:G550Siren:1) 2021-08-03 13:01:54.406 luup.create_device:: [10016] D_GarageDoorLock.xml / X / D_DoorLock1.json (urn:schemas-micasaverde-com:device:DoorLock:1) 2021-08-03 13:01:54.413 luup.create_device:: [10027] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.415 luup.create_device:: [10028] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.415 luup.create_device:: [10032] D_GarageDoorLock.xml / X / D_DoorLock1.json (urn:schemas-micasaverde-com:device:DoorLock:1) 2021-08-03 13:01:54.416 luup.create_device:: [10046] D_VirtualBinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.417 luup.create_device:: [10047] D_VirtualBinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.418 luup.create_device:: [10048] D_VirtualBinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.584 luup.create_device:: [10050] D_HouseModes.xml / X / D_HouseModes.json (urn:schemas-micasaverde-com:device:HouseModes:1) 2021-08-03 13:01:54.584 luup.create_device:: [10064] D_VirtualBinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.585 luup.create_device:: [10065] D_VirtualBinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.586 luup.create_device:: [10068] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.588 luup.create_device:: [10069] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.589 luup.create_device:: [10070] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.590 luup.create_device:: [10071] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.591 luup.create_device:: [10076] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.592 luup.create_device:: [10086] D_TemperatureSensor1.xml / X / D_TemperatureSensor1.json (urn:schemas-micasaverde-com:device:TemperatureSensor:1) 2021-08-03 13:01:54.676 luup.create_device:: [10093] D_BinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.678 luup.create_device:: [10094] D_GenericIO1.xml / X / D_GenericIO1.json (urn:schemas-micasaverde-com:device:GenericIO:1) 2021-08-03 13:01:54.680 luup.create_device:: [10095] D_DoorSensor1.xml / X / D_DoorSensor1.json (urn:schemas-micasaverde-com:device:DoorSensor:1) 2021-08-03 13:01:54.681 luup.create_device:: [10096] D_GenericIO1.xml / X / D_GenericIO1.json (urn:schemas-micasaverde-com:device:GenericIO:1) 2021-08-03 13:01:54.682 luup.create_device:: [10097] D_DoorSensor1.xml / X / D_DoorSensor1.json (urn:schemas-micasaverde-com:device:DoorSensor:1) 2021-08-03 13:01:54.683 luup.create_device:: [10098] D_GenericIO1.xml / X / D_GenericIO1.json (urn:schemas-micasaverde-com:device:GenericIO:1) 2021-08-03 13:01:54.684 luup.create_device:: [10099] D_DoorSensor1.xml / X / D_DoorSensor1.json (urn:schemas-micasaverde-com:device:DoorSensor:1) 2021-08-03 13:01:54.685 luup.create_device:: [10100] D_BinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.686 luup.create_device:: [10104] D_GenericIO1.xml / X / D_GenericIO1.json (urn:schemas-micasaverde-com:device:GenericIO:1) 2021-08-03 13:01:54.687 luup.create_device:: [10105] D_DoorSensor1.xml / X / D_DoorSensor1.json (urn:schemas-micasaverde-com:device:DoorSensor:1) 2021-08-03 13:01:54.688 luup.create_device:: [10106] D_GenericIO1.xml / X / D_GenericIO1.json (urn:schemas-micasaverde-com:device:GenericIO:1) 2021-08-03 13:01:54.689 luup.create_device:: [10107] D_DoorSensor1.xml / X / D_DoorSensor1.json (urn:schemas-micasaverde-com:device:DoorSensor:1) 2021-08-03 13:01:54.690 luup.create_device:: [10109] D_GenericIO1.xml / X / D_GenericIO1.json (urn:schemas-micasaverde-com:device:GenericIO:1) 2021-08-03 13:01:54.691 luup.create_device:: [10110] D_DoorSensor1.xml / X / D_DoorSensor1.json (urn:schemas-micasaverde-com:device:DoorSensor:1) 2021-08-03 13:01:54.692 luup.create_device:: [10111] D_BinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.766 luup.create_device:: [10112] D_Keypad1.xml / X / D_Keypad_Wintop.json (urn:schemas-micasaverde-com:device:Keypad:1) 2021-08-03 13:01:54.768 luup.create_device:: [10113] D_VirtualBinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.770 luup.create_device:: [10115] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.771 luup.create_device:: [10116] D_TemperatureSensor1.xml / X / D_TemperatureSensor1.json (urn:schemas-micasaverde-com:device:TemperatureSensor:1) 2021-08-03 13:01:54.772 luup.create_device:: [10127] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.773 luup.create_device:: [10129] D_HumiditySensor1.xml / X / D_HumiditySensor1.json (urn:schemas-micasaverde-com:device:HumiditySensor:1) 2021-08-03 13:01:54.774 luup.create_device:: [10130] D_VirtualBinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.864 luup.create_device:: [10131] D_MotionSensor1.xml / X / D_GlassBreakSensorWithTamper.json (urn:schemas-micasaverde-com:device:MotionSensor:1) 2021-08-03 13:01:54.865 luup.create_device:: [10132] D_MotionSensor1.xml / X / D_GlassBreakSensorWithTamper.json (urn:schemas-micasaverde-com:device:MotionSensor:1) 2021-08-03 13:01:54.865 luup.create_device:: [10133] D_MotionSensor1.xml / X / D_GlassBreakSensorWithTamper.json (urn:schemas-micasaverde-com:device:MotionSensor:1) 2021-08-03 13:01:54.866 luup.create_device:: [10149] D_BinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.868 luup.create_device:: [10162] D_PowerMeter1.xml / X / D_PowerMeter1.json (urn:schemas-micasaverde-com:device:PowerMeter:1) 2021-08-03 13:01:54.870 luup.create_device:: [10163] D_LightSensor1.xml / X / D_LightSensor1.json (urn:schemas-micasaverde-com:device:LightSensor:1) 2021-08-03 13:01:54.872 luup.create_device:: [10165] D_SmokeSensor1.xml / X / D_SmokeSensorWithTamper1.json (urn:schemas-micasaverde-com:device:SmokeSensor:1) 2021-08-03 13:01:54.874 luup.create_device:: [10166] D_TemperatureSensor1.xml / X / D_TemperatureSensor1.json (urn:schemas-micasaverde-com:device:TemperatureSensor:1) 2021-08-03 13:01:54.960 luup.create_device:: [10167] D_DimmableLight1.xml / X / D_DimmableLightQD1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.962 luup.create_device:: [10168] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.963 luup.create_device:: [10184] D_VirtualBinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.964 luup.create_device:: [10185] D_VirtualBinaryLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:BinaryLight:1) 2021-08-03 13:01:54.965 luup.create_device:: [10187] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.967 luup.create_device:: [10188] D_ComboDevice1.xml / X / D_ComboDevice1.json (urn:schemas-micasaverde-com:device:ComboDevice:1) 2021-08-03 13:01:54.968 luup.create_device:: [10189] D_TemperatureSensor1.xml / X / D_TemperatureSensor1.json (urn:schemas-micasaverde-com:device:TemperatureSensor:1) 2021-08-03 13:01:54.969 luup.create_device:: [10190] D_HumiditySensor1.xml / X / D_HumiditySensor1.json (urn:schemas-micasaverde-com:device:HumiditySensor:1) 2021-08-03 13:01:54.970 luup.create_device:: [10191] D_Siren1.xml / X / D_Siren1.json (urn:schemas-micasaverde-com:device:Siren:1) 2021-08-03 13:01:54.971 luup.create_device:: [10192] D_Siren1.xml / X / D_Siren1.json (urn:schemas-micasaverde-com:device:Siren:1) 2021-08-03 13:01:54.973 luup.create_device:: [10199] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.974 luup.create_device:: [10200] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.975 luup.create_device:: [10215] D_HumiditySensor1.xml / X / D_HumiditySensor1.json (urn:schemas-micasaverde-com:device:HumiditySensor:1) 2021-08-03 13:01:54.976 luup.create_device:: [10216] D_TemperatureSensor1.xml / X / D_TemperatureSensor1.json (urn:schemas-micasaverde-com:device:TemperatureSensor:1) 2021-08-03 13:01:54.977 luup.create_device:: [10217] D_VSwitch.xml / X / D_VSwitch_UI7.json (urn:schemas-upnp-org:device:VSwitch:1) 2021-08-03 13:01:54.979 luup.create_device:: [10218] D_VirtualMotionSensor1.xml / X / D_MotionSensor1.json (urn:schemas-micasaverde-com:device:SmokeSensor:1) 2021-08-03 13:01:54.980 luup.create_device:: [10219] D_VirtualMotionSensor1.xml / X / D_MotionSensor1.json (urn:schemas-micasaverde-com:device:SmokeSensor:1) 2021-08-03 13:01:54.981 luup.create_device:: [10220] D_TemperatureSensor1.xml / X / D_TemperatureSensor1.json (urn:schemas-micasaverde-com:device:TemperatureSensor:1) 2021-08-03 13:01:54.981 luup.create_device:: [10221] D_HumiditySensor1.xml / X / D_HumiditySensor1.json (urn:schemas-micasaverde-com:device:HumiditySensor:1) 2021-08-03 13:01:54.982 luup.create_device:: [10222] D_LightSensor1.xml / X / D_LightSensor1.json (urn:schemas-micasaverde-com:device:LightSensor:1) 2021-08-03 13:01:54.983 luup.create_device:: [10223] D_LightSensor1.xml / X / D_LightSensor1.json (urn:schemas-micasaverde-com:device:LightSensor:1) 2021-08-03 13:01:54.984 luup.create_device:: [20004] D_LightSensor1.xml / X / D_LightSensor1.json (urn:schemas-micasaverde-com:device:LightSensor:1) 2021-08-03 13:01:54.985 luup.create_device:: [20005] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.986 luup.create_device:: [20006] D_LightSensor1.xml / X / D_LightSensor1.json (urn:schemas-micasaverde-com:device:LightSensor:1) 2021-08-03 13:01:54.987 luup.create_device:: [20007] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.988 luup.create_device:: [20008] D_HumiditySensor1.xml / X / D_HumiditySensor1.json (urn:schemas-micasaverde-com:device:HumiditySensor:1) 2021-08-03 13:01:54.989 luup.create_device:: [20009] D_DimmableLight1.xml / X / D_BinaryLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.990 luup.create_device:: [20010] D_HumiditySensor1.xml / X / D_HumiditySensor1.json (urn:schemas-micasaverde-com:device:HumiditySensor:1) 2021-08-03 13:01:54.991 luup.create_device:: [20011] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.992 luup.create_device:: [20012] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.993 luup.create_device:: [20013] D_MotionSensor1.xml / X / D_MotionSensor1.json (urn:schemas-micasaverde-com:device:MotionSensor:1) 2021-08-03 13:01:54.994 luup.create_device:: [20014] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.995 luup.create_device:: [20015] D_TemperatureSensor1.xml / X / D_TemperatureSensor1.json (urn:schemas-micasaverde-com:device:TemperatureSensor:1) 2021-08-03 13:01:54.996 luup.create_device:: [20016] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.997 luup.create_device:: [20018] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:54.999 luup.create_device:: [20019] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:55.000 luup.create_device:: [20020] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:55.000 luup.create_device:: [20021] D_TemperatureSensor1.xml / X / D_TemperatureSensor1.json (urn:schemas-micasaverde-com:device:TemperatureSensor:1) 2021-08-03 13:01:55.002 luup.create_device:: [20022] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:55.003 luup.create_device:: [20024] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:55.005 luup.create_device:: [20025] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:55.006 luup.create_device:: [20026] D_MotionSensor1.xml / X / D_MotionSensor1.json (urn:schemas-micasaverde-com:device:MotionSensor:1) 2021-08-03 13:01:55.007 luup.create_device:: [20029] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:55.008 luup.create_device:: [20030] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:55.009 luup.create_device:: [20031] D_DimmableLight1.xml / X / D_DimmableLight1.json (urn:schemas-upnp-org:device:DimmableLight:1) 2021-08-03 13:01:55.010 luup.create_device:: [30001] D_GenericTasmotaDevice.xml / / D_GenericTasmotaDevice.json (GenericTasmotaDevice) 2021-08-03 13:01:55.010 luup.create_device:: [30003] D_GenericTasmotaDevice.xml / / D_GenericTasmotaDevice.json (GenericTasmotaDevice) 2021-08-03 13:01:55.010 luup.create_device:: [30004] D_GenericTasmotaDevice.xml / / D_GenericTasmotaDevice.json (GenericTasmotaDevice) 2021-08-03 13:01:55.011 luup.create_device:: [30005] D_GenericTasmotaDevice.xml / / D_GenericTasmotaDevice.json (GenericTasmotaDevice) 2021-08-03 13:01:55.011 luup.create_device:: [30006] D_GenericTasmotaDevice.xml / / D_GenericTasmotaDevice.json (GenericTasmotaDevice) 2021-08-03 13:01:55.011 luup.create_device:: [30007] D_GenericTasmotaDevice.xml / / D_GenericTasmotaDevice.json (GenericTasmotaDevice) 2021-08-03 13:01:55.012 luup.create_device:: [30008] D_GenericTasmotaDevice.xml / / D_GenericTasmotaDevice.json (GenericTasmotaDevice) 2021-08-03 13:01:55.012 luup.create_device:: [30009] D_GenericTasmotaDevice.xml / / D_GenericTasmotaDevice.json (GenericTasmotaDevice) 2021-08-03 13:01:55.012 openLuup.userdata:: loading scenes... 2021-08-03 13:01:55.012 openLuup.userdata:: [11] Dimma upp Sovrum Taklampa 2021-08-03 13:01:55.012 openLuup.userdata:: [10] Dimma ned Sovrummet 2021-08-03 13:01:55.012 openLuup.userdata:: [9] Dimma upp Milias rum 2021-08-03 13:01:55.012 openLuup.userdata:: number of scenes = 3 2021-08-03 13:01:55.012 openLuup.userdata:: ...scene loading completed 2021-08-03 13:01:55.012 openLuup.userdata:: loading installed plugin info... 2021-08-03 13:01:55.013 openLuup.userdata:: [openLuup] openLuup (21.7.25) 2021-08-03 13:01:55.013 openLuup.userdata:: [AltAppStore] Alternate App Store (20.3.30) 2021-08-03 13:01:55.013 openLuup.userdata:: [VeraBridge] VeraBridge (21.1.3) 2021-08-03 13:01:55.013 openLuup.userdata:: [8246] Alternate UI (2.53c.) 2021-08-03 13:01:55.013 openLuup.userdata:: [Z-Way] Z-Way (not.installed) 2021-08-03 13:01:55.013 openLuup.userdata:: [Arduino] MySensors (not.installed) 2021-08-03 13:01:55.013 openLuup.userdata:: [9314] Ezlo Bridge (GitHub.master) 2021-08-03 13:01:55.013 openLuup.userdata:: [9281] Virtual HTTP Devices (GitHub.master) 2021-08-03 13:01:55.013 openLuup.userdata:: [9031] Virtual Sensor (1.11) 2021-08-03 13:01:55.013 openLuup.userdata:: [8942] SiteSensor (1.15) 2021-08-03 13:01:55.013 openLuup.userdata:: ...user_data loading completed 2021-08-03 13:01:55.013 openLuup.init:: running _openLuup_STARTUP_ 2021-08-03 13:01:55.013 luup_log:0: MagicShowerFan: Function loaded successfully. 2021-08-03 13:01:55.013 luup_log:0: MagicShowerFan: Starting to monitor showers... 2021-08-03 13:01:55.013 luup.variable_watch:: callback=MagicShowerFan, watching=10190.urn:micasaverde-com:serviceId:HumiditySensor1.CurrentLevel 2021-08-03 13:01:55.013 luup.variable_watch:: callback=MagicShowerFan, watching=20008.urn:micasaverde-com:serviceId:HumiditySensor1.CurrentLevel 2021-08-03 13:01:55.013 openLuup.init:: init phase completed 2021-08-03 13:01:55.013 :: openLuup LOG ROTATION :: (runtime 0.0 days)
Server console page:
Server sockets watched for incoming connections # date / time device socket 1 2021-08-20 20:15:52 0 HTTP:3480 tcp{client}: 0x55bab90e01a8 2 2021-08-20 20:15:52 0 HTTP:3480 tcp{client}: 0x55bab9d0b718 3 2021-08-20 20:15:52 0 HTTP:3480 tcp{client}: 0x55bab8de9968 4 2021-08-20 20:15:52 0 HTTP:3480 tcp{client}: 0x55bab9cce768 5 2021-08-20 20:15:52 0 HTTP:3480 tcp{client}: 0x55bab9dda538 6 2021-08-20 20:15:52 0 HTTP:3480 tcp{client}: 0x55bab9856bb8 7 2021-08-20 20:15:43 0 HTTP:3480 tcp{client}: 0x55bab9ecaa58 8 2021-08-20 20:15:21 0 HTTP:3480 tcp{client}: 0x55bab8d74018 9 2021-08-20 20:04:16 0 HTTP:3480 tcp{client}: 0x55bab9aaf008 10 2021-08-20 20:00:15 0 HTTP:3480 tcp{client}: 0x55bab9863d48 11 2021-08-20 17:59:58 0 MQTT:1888 tcp{client}: 0x55bab8c24e48 12 2021-08-20 17:25:37 0 HTTP:3480 tcp{client}: 0x55bab8c3b128 13 2021-08-20 15:13:23 0 MQTT:1888 tcp{client}: 0x55bab90d5438 14 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8bdb198 15 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8f9d898 16 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab86e7f58 17 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8e87328 18 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8c69918 19 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8839b78 20 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8f0fa38 21 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8bc3808 22 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8df8c48 23 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8fe2c88 24 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8fc8938 25 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8fc0fe8 26 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8d39d68 27 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8fd0288 28 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8f20f68 29 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8f52ee8 30 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8f3b908 31 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab7fd7868 32 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab7fdbf88 33 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8d5eb58 34 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8ee8998 35 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8c31438 36 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8fd72b8 37 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8fe6558 38 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8fdec08 39 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8647ca8 40 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8f1da88 41 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8c0a7d8 42 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8d3e718 43 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8f33728 44 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8ec3eb8 45 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8bc9118 46 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8ebc6c8 47 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8f03d38 48 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8f0ad28 49 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8f087d8 50 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8efcd78 51 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8efa858 52 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8fdb8f8 53 2021-08-20 15:12:18 0 MQTT:1888 tcp{client}: 0x55bab8fff8f8 54 2021-08-20 15:12:10 0 MQTT:1888 tcp{server}: 0x55bab8a09878 55 2021-08-20 15:12:10 0 POP3 tcp{server}: 0x55bab89f0b58 56 2021-08-20 15:12:10 0 SMTP tcp{server}: 0x55bab89edbf8 57 2021-08-20 15:12:10 0 HTTP:3480 tcp{server}: 0x55bab89eb0b8 Received connections server date / time #connects from IP HTTP 2021-08-20 20:15:52 22187 127.0.0.1 HTTP 2021-08-20 20:15:21 19 192.168.1.240 HTTP 2021-08-20 20:04:16 4 192.168.1.3 SMTP 0 POP3 0 UDP 0 MQTT 2021-08-20 15:12:18 1 192.168.1.63 MQTT 2021-08-20 15:12:18 1 192.168.1.62 MQTT 2021-08-20 17:59:58 4 192.168.1.66 MQTT 2021-08-20 15:12:18 1 192.168.1.61 MQTT 2021-08-20 15:12:18 35 127.0.0.1 MQTT 2021-08-20 15:13:23 1 192.168.1.65 MQTT 2021-08-20 15:12:18 1 192.168.1.64 MQTT 2021-08-20 15:12:18 1 192.168.1.59
-
@crille said in Unexpected stop of openLuup:
I don't know if VeraBridge is running asynchronous, is that relevant too?
Yes, it's relevant. Synchronous polling takes a lot of time out from other things.
Check the VeraBridge variable AsyncPoll, if it's not set to true then you should try doing so (and reloading.)
-
@akbooer Ok. Thanks ,I changed it to true (was at, I guess default, false) and reloaded. Let’s hope that do good to the system.
I still always get errors after a reload though.
2021-08-20 23:44:09.048 openLuup.mqtt:: RECEIVE ERROR: closed tcp{client}: 0x55b0530b79b8 2021-08-20 23:44:09.049 openLuup.mqtt:: RECEIVE ERROR: closed tcp{client}: 0x55b0533b7bc8 2021-08-20 23:44:09.300 openLuup.server:: error 'socket.select() not ready to send tcp{client}: 0x55b0526b00d8' sending 2 bytes to tcp{client}: 0x55b0526b00d8
-
@akbooer I join in here since I have had some similar problems.
My Zway bridge has been running in asyc mode for long, however I checked my Vera bridge and it was not. I have changed it, but since I have no devices left on the Vera I thought that I just as well should remove it from OpenLuup to unload it a bit.
What is the best way of doing that? Just to delete the brigde device in OpenLuup and reload? -
Yup, just that.
-
Today I got a new crash. This time in the middle of the day. OpenLuup was not doing anything specific, I was not doing anything with it, no irregular cpu load (approx 3.6%). No errors in the log before what is shown below. Mqtt Explorer was not on either, so regular load there as well. (This was also before I tried with Mqtt from Home Assistant to OpenLuup, as described in another thread.)
I discovered a few hours later that the server had crashed. When checking the logs this is what I could see:
2021-09-17 11:04:36.136 openLuup.io.server:: MQTT:1883 connection from 192.168.1.144 tcp{client}: 0x29b5f80 2021-09-17 11:04:36.136 openLuup.io.server:: MQTT:1883 connection from 192.168.1.66 tcp{client}: 0x3136a28 2021-09-17 11:04:36.136 openLuup.io.server:: MQTT:1883 connection from 192.168.1.59 tcp{client}: 0x30932b0 2021-09-17 11:04:36.137 openLuup.io.server:: MQTT:1883 connection from 192.168.1.52 tcp{client}: 0x3671eb8 2021-09-17 11:04:36.137 openLuup.io.server:: MQTT:1883 connection from 192.168.1.51 tcp{client}: 0x3506688 2021-09-17 11:04:36.137 openLuup.io.server:: MQTT:1883 connection from 192.168.1.58 tcp{client}: 0x3005fa8 2021-09-17 11:04:36.182 luup.variable_set:: 144.urn:toggledbits-com:serviceId:ReactorValues.SpabadCut was: 349 now: 345 #hooks:1 2021-09-17 11:04:36.190 luup.variable_set:: 144.urn:toggledbits-com:serviceId:ReactorSensor.cstate was: {"cond0":{"evaledge":[],"stateedge":[],"valuestamp":1631631832,"id":"cond0","statestamp":0,"lastvalue":0},"root":{"... now: {"cond0":{"evaledge":[],"stateedge":[],"valuestamp":1631631832,"id":"cond0","statestamp":0,"lastvalue":0},"root":{"... #hooks:0 2021-09-17 11:04:36.191 luup.variable_set:: 144.urn:toggledbits-com:serviceId:ReactorSensor.lastacc was: 1631869442 now: 1631869476 #hooks:0 2021-09-17 11:04:36.191 luup.variable_set:: 144.urn:toggledbits-com:serviceId:ReactorGroup.GroupStatus_grp1b0eboj1 was: 1 now: 0 #hooks:0 2021-09-17 11:04:36.191 luup.variable_set:: 144.urn:toggledbits-com:serviceId:ReactorSensor.Message was: Not tripped now: Not tripped #hooks:0 2021-09-17 11:04:36.194 openLuup.io.server:: MQTT:1883 connection closed tcp{client}: 0x2a6a020 2021-09-17 11:04:36.195 openLuup.mqtt:: RECEIVE ERROR: closed tcp{client}: 0x2a6a020 2021-09-17 11:04:36.195 openLuup.mqtt:: TasmotaFriggebod UNSUBSCRIBE from cmnd/TasmotaFriggebod_fb/# tcp{client}: 0x2a6a020 2021-09-17 11:04:36.195 openLuup.mqtt:: TasmotaFriggebod UNSUBSCRIBE from cmnd/TasmotaFriggebod/# tcp{client}: 0x2a6a020 2021-09-17 11:04:36.195 openLuup.mqtt:: TasmotaFriggebod UNSUBSCRIBE from cmnd/tasmotas/# tcp{client}: 0x2a6a020 2021-09-17 11:04:36.195 openLuup.io.server:: MQTT:1883 connection closed tcp{client}: 0x2978900 2021-09-17 11:04:36.195 openLuup.mqtt:: RECEIVE ERROR: closed tcp{client}: 0x2978900 2021-09-17 11:04:36.195 openLuup.mqtt:: TasmotaSjo UNSUBSCRIBE from cmnd/TasmotaSjo_fb/# tcp{client}: 0x2978900 2021-09-17 11:04:36.195 openLuup.mqtt:: TasmotaSjo UNSUBSCRIBE from cmnd/tasmotas/# tcp{client}: 0x2978900 2021-09-17 11:04:36.195 openLuup.mqtt:: TasmotaSjo UNSUBSCRIBE from cmnd/Tasmota_Sjo/# tcp{client}: 0x2978900 2021-09-17 11:04:36.195 openLuup.io.server:: MQTT:1883 connection closed tcp{client}: 0x2c12be0 2021-09-17 11:04:36.195 openLuup.mqtt:: RECEIVE ERROR: closed tcp{client}: 0x2c12be0 2021-09-17 11:04:36.195 openLuup.mqtt:: TasmotaIR UNSUBSCRIBE from cmnd/tasmotas/# tcp{client}: 0x2c12be0 2021-09-17 11:04:36.195 openLuup.mqtt:: TasmotaIR UNSUBSCRIBE from cmnd/TasmotaIR_fb/# tcp{client}: 0x2c12be0 2021-09-17 11:04:36.195 openLuup.mqtt:: TasmotaIR UNSUBSCRIBE from cmnd/TasmotaIR/# tcp{client}: 0x2c12be0 2021-09-17 11:04:36.210 openLuup.io.server:: MQTT:1883 connection closed tcp{client}: 0x30c6558 2021-09-17 11:04:36.210 openLuup.mqtt:: RECEIVE ERROR: closed tcp{client}: 0x30c6558 2021-09-17 11:04:36.210 openLuup.io.server:: MQTT:1883 connection closed tcp{client}: 0x395fb70 2021-09-17 11:04:36.210 openLuup.mqtt:: RECEIVE ERROR: closed tcp{client}: 0x395fb70 2021-09-17 11:04:36.210 openLuup.mqtt:: TasmotaGarage UNSUBSCRIBE from cmnd/TasmotaGarage_fb/# tcp{client}: 0x395fb70 2021-09-17 11:04:36.210 openLuup.mqtt:: TasmotaGarage UNSUBSCRIBE from cmnd/tasmotas/# tcp{client}: 0x395fb70 2021-09-17 11:04:36.210 openLuup.mqtt:: TasmotaGarage UNSUBSCRIBE from cmnd/TasmotaGarage/# tcp{client}: 0x395fb70 ... 2021-09-17 11:04:36.219 openLuup.io.server:: MQTT:1883 connection closed tcp{client}: 0x29b5f80 2021-09-17 11:04:36.219 openLuup.mqtt:: RECEIVE ERROR: closed tcp{client}: 0x29b5f80 2021-09-17 11:04:36.219 openLuup.io.server:: MQTT:1883 connection closed tcp{client}: 0x3136a28 2021-09-17 11:04:36.219 openLuup.mqtt:: RECEIVE ERROR: closed tcp{client}: 0x3136a28 2021-09-17 11:04:36.223 luup.watch_callback:: 20013.MHZ19B.CarbonDioxide called [9]virtualSensorWatchCallback() function: 0x263bea8 ... 2021-09-17 11:04:36.243 openLuup.io.server:: MQTT:1883 connection closed tcp{client}: 0x2b7aff8 2021-09-17 11:04:36.243 openLuup.mqtt:: closed tcp{client}: 0x2b7aff8 2021-09-17 11:04:36.243 openLuup.mqtt:: TasmotaCO2Brandv UNSUBSCRIBE from cmnd/TasmotaCO2Brandv/# tcp{client}: 0x2b7aff8 2021-09-17 11:04:36.243 openLuup.mqtt:: TasmotaCO2Brandv UNSUBSCRIBE from cmnd/tasmotas/# tcp{client}: 0x2b7aff8 2021-09-17 11:04:36.243 openLuup.mqtt:: TasmotaCO2Brandv UNSUBSCRIBE from cmnd/TasmotaCO2Brandv_fb/# tcp{client}: 0x2b7aff8 2021-09-17 11:04:36.243 openLuup.mqtt:: ERROR publishing application message for mqtt:cmnd/TasmotaCO2Brandv/POWER : closed
I am seeing a number of Mqtt connections almost at the same time and then some unsubscribe and receive errors and then just a crash.
I have had not crashes for >25 days, so a bit strange.
The only change I can think of that I made a day ago was that I added a Reactor that fetches data from a site parses it and sends it to Thingspeak by making two "http get" actions to get data from energyhive.com and then two:
os.execute( "curl -s -i -H 'Accept:application/json' 'https://api.thingspeak.com/update?api_key=key&field1='" .. result)
Both actions were running every minute. I have now removed one of the "http get" and curl commands, and also run this every second minute instead. The Reactor is what is shown in the beginning of the log btw.
Maybe this is something that puts a lot of load on the Lua sockets of something? I will disable it and see.Any ideas around this would be welcome.
-
@akbooer I'm still having a lot of crashes but since I added an autorestart of the service it's not really a major problem anymore.
Even though openLuup is rock solid for most people, may I suggest you add[Service] Restart=on-failure RestartSec=5s
To the documentation for openLuup in the appendix for systemd?
At least it helped me not coming home to a dead house -
Hi akbooer,
randomly openluup hangs but today I noticed in the log (attached) something strange :
2022-08-13 12:54:35.283 openLuup.server:: GET /data_request?id=lr_render&target=Vera-45108342.024.urn:upnp-org:serviceId:VContainer1.Variable3&from=2022-08-13T00:00&format=json HTTP/1.1 tcp{client}: 0x556c471741f8
2022-08-13 12:54:35.286 luup_log:4: DataGraph: Whisper query: CPU = 2.068 mS for 775 points
2022-08-13 12:54:35.289 openLuup.server:: request completed (20282 bytes, 2 chunks, 6 ms) tcp{client}: 0x556c471741f8
2022-08-13 12:54:35.290 openLuup.io.server:: HTTP:3480 connection closed openLuup.server.receive closed tcp{client}: 0x556c471741f8
2022-08-13 12:54:57.889 openLuup.io.server:: HTTP:3480 connection from 92.255.85.183 tcp{client}: 0x556c482cf138
2022-08-13 12:54:57.889 openLuup.server:: /*: mstshash=Administr tcp{client}: 0x556c482cf138
2022-08-13 12:54:57.889 openLuup.context_switch:: ERROR: [dev #0] ./openLuup/server.lua:238: attempt to concatenate local 'method' (a nil value)
2022-08-13 12:54:57.889 luup.incoming_callback:: function: 0x556c4753ff20 ERROR: ./openLuup/server.lua:238: attempt to concatenate local 'method' (a nil value)at 12:54 openluup stopped to write and read the datayours files
Is a possible attack ?
-
Looks like an attack, from what I read online.
-
Hi akbooer,
in order to set firewall rules can you give me some info on the openluup log records ? Following there are few normal log lines of datayours read/write :
2022-08-13 12:52:21.921 luup.variable_set:: 4.urn:akbooer-com:serviceId:DataYours1.AppMemoryUsed was: 6568 now: 6871 #hooks:0
2022-08-13 12:52:26.570 openLuup.io.server:: HTTP:3480 connection from xx.xx.xx.xx tcp{client}: 0x556c474b0348
2022-08-13 12:52:26.571 openLuup.server:: GET /data_request?id=lr_render&target=Vera-yyyyyyyy.024.urn:upnp-org:serviceId:VContainer1.Variable3&from=-2h&format=json HTTP/1.1 tcp{client}: 0x556c474b0348
2022-08-13 12:52:26.571 luup_log:4: DataGraph: Whisper query: CPU = 0.405 mS for 121 points
2022-08-13 12:52:26.572 openLuup.server:: request completed (3359 bytes, 1 chunks, 1 ms) tcp{client}: 0x556c474b0348
2022-08-13 12:52:26.572 openLuup.io.server:: HTTP:3480 connection closed openLuup.server.receive closed tcp{client}: 0x556c474b0348
2022-08-13 12:52:26.574 openLuup.io.server:: HTTP:3480 connection from xx.xx.xx.xx tcp{client}: 0x556c47810548
2022-08-13 12:52:26.574 openLuup.server:: GET /data_request?id=lr_render&target=Vera-yyyyyyyy.024.urn:upnp-org:serviceId:VContainer1.Variable3&from=2022-08-13T00:00&format=json HTTP/1.1 tcp{client}: 0x556c47810548
2022-08-13 12:52:26.576 luup_log:4: DataGraph: Whisper query: CPU = 2.085 mS for 773 points
2022-08-13 12:52:26.580 openLuup.server:: request completed (20228 bytes, 2 chunks, 6 ms) tcp{client}: 0x556c47810548
2022-08-13 12:52:26.581 openLuup.io.server:: HTTP:3480 connection closed openLuup.server.receive closed tcp{client}: 0x556c47810548
2022-08-13 12:52:35.363 openLuup.io.server:: HTTP:3480 connection from xx.xx.xx.xx tcp{client}: 0x556c4756a4b8
2022-08-13 12:52:35.364 openLuup.server:: GET /data_request?id=lr_render&target=Vera-yyyyyyyy.024.urn:upnp-org:serviceId:VContainer1.Variable3&from=-2h&format=json HTTP/1.1 tcp{client}: 0x556c4756a4b8
2022-08-13 12:52:35.364 luup_log:4: DataGraph: Whisper query: CPU = 0.418 mS for 121 points
2022-08-13 12:52:35.366 openLuup.server:: request completed (3359 bytes, 1 chunks, 1 ms) tcp{client}: 0x556c4756a4b8
2022-08-13 12:52:35.366 openLuup.io.server:: HTTP:3480 connection closed openLuup.server.receive closed tcp{client}: 0x556c4756a4b8
2022-08-13 12:52:35.368 openLuup.io.server:: HTTP:3480 connection from xx.xx.xx.xx tcp{client}: 0x556c47294958
2022-08-13 12:52:35.368 openLuup.server:: GET /data_request?id=lr_render&target=Vera-yyyyyyyy.024.urn:upnp-org:serviceId:VContainer1.kwdaily3&from=2016-07-01&format=json HTTP/1.1 tcp{client}: 0x556c47294958
2022-08-13 12:52:35.375 luup_log:4: DataGraph: Whisper query: CPU = 6.521 mS for 2235 points
2022-08-13 12:52:35.392 openLuup.server:: request completed (62445 bytes, 4 chunks, 23 ms) tcp{client}: 0x556c47294958
2022-08-13 12:52:35.397 openLuup.io.server:: HTTP:3480 connection closed openLuup.server.receive closed tcp{client}: 0x556c47294958
2022-08-13 12:52:35.398 openLuup.io.server:: HTTP:3480 connection from xx.xx.xx.xx tcp{client}: 0x556c47158248
2022-08-13 12:52:35.398 openLuup.server:: GET /data_request?id=lr_render&target=Vera-yyyyyyyy.024.urn:upnp-org:serviceId:VContainer1.Variable3&from=2022-08-13T00:00&format=json HTTP/1.1 tcp{client}: 0x556c47158248
2022-08-13 12:52:35.401 luup_log:4: DataGraph: Whisper query: CPU = 2.409 mS for 773 points
2022-08-13 12:52:35.406 openLuup.server:: request completed (20228 bytes, 2 chunks, 7 ms) tcp{client}: 0x556c47158248
2022-08-13 12:52:35.406 openLuup.io.server:: HTTP:3480 connection closed openLuup.server.receive closed tcp{client}: 0x556c47158248
2022-08-13 12:53:26.581 openLuup.io.server:: HTTP:3480 connection from xx.xx.xx.xx tcp{client}: 0x556c4877f9d8
2022-08-13 12:53:26.581 openLuup.server:: GET /data_request?id=lr_render&target=Vera-yyyyyyyy.024.urn:upnp-org:serviceId:VContainer1.Variable3&from=-2h&format=json HTTP/1.1 tcp{client}: 0x556c4877f9d8
2022-08-13 12:53:26.582 luup_log:4: DataGraph: Whisper query: CPU = 0.735 mS for 121 pointsThe read commands of whisper files are all of kind "http://server-ip:3480......."
the following log record :
openLuup.io.server:: HTTP:3480 connection from xx.xx.xx.xx tcp{client}
is from a http read ?Can I see UDP write log record ?
The write commands come from remote datayours through UDP to "server-ip" .
All consolidated whisper files I read/write are on "server-ip".
Is it correct in this scenario that all the regular and normal commands (read/write) must come from "server-ip" ?
tnks
-
If your system is exposed to the internet (which I assume it must be, given that IP address is in HK) have you considered either setting up some port forwarding, or, a VPN and locking it down to internal access only? Would seem simpler than trying to set up firewall rules, assuming your Datayours server is on the same LAN?
I'm sure you have a good reason for your set up, just my $0.0002 worth
C
-
Yes, the server logs the initial HTTP connection, and the hex number at the end of the log line is an internal reference for the client socket. That same socket reference occurs at the end of the actual HTTP request line.
IIRC, DataYours by default does not log UDP writes (because in many instances they would flood the log. I’d have to refer back to the source code to see if debug logging enables that.
Agree with the comment on VPNs.
-
This error:
2022-08-13 12:54:57.889 openLuup.context_switch:: ERROR: [dev #0] ./openLuup/server.lua:238: attempt to concatenate local 'method' (a nil value)
…is an error in my error reporting! I can fix this easily. The message should just report an unsupported HTTP request and then carry on as usual. I’ll post an update shortly.
It still doesn’t address the issue that you’re receiving a request from someone/somewhere that you shouldn’t.
-
OK, latest development version (v220814) should fix the error message.
-
tnks akbooer for your fix.
About VPN, my server is on a cloud hosting and the web app is accessed by authenticated users so I suppose the only solution is to activate some fw rule on the openluup/datayours server.