2014-12-15 00:00:00,860 [THREAD:TimeMinuteUpdater] INFO org.pidome.misc.utils.TimeUtils - Setting timezone data: Europe/Amsterdam, 51.950000, 4.449999 2014-12-15 00:01:02,272 [TriggerTimeRun::00:01] INFO org.pidome.server.services.triggerservice.TriggerEvent - Executing trigger actions for trigger: Set Night 2014-12-15 00:01:02,315 [TriggerTimeRun::00:01] INFO org.pidome.server.system.dayparts.DayPartsService - Set daypart to Night at 15-12-2014 00:01 2014-12-15 06:00:01,364 [TriggerTimeRun::06:00] INFO org.pidome.server.services.triggerservice.TriggerEvent - Executing trigger actions for trigger: Set Morning 2014-12-15 06:00:01,368 [TriggerTimeRun::06:00] INFO org.pidome.server.system.dayparts.DayPartsService - Set daypart to Morning at 15-12-2014 06:00 2014-12-15 12:00:02,146 [TriggerTimeRun::12:00] INFO org.pidome.server.services.triggerservice.TriggerEvent - Executing trigger actions for trigger: Set Afternoon 2014-12-15 12:00:02,149 [TriggerTimeRun::12:00] INFO org.pidome.server.system.dayparts.DayPartsService - Set daypart to Afternoon at 15-12-2014 12:00 2014-12-15 18:00:01,134 [TriggerTimeRun::18:00] INFO org.pidome.server.services.triggerservice.TriggerEvent - Executing trigger actions for trigger: Set Evening 2014-12-15 18:00:01,137 [TriggerTimeRun::18:00] INFO org.pidome.server.system.dayparts.DayPartsService - Set daypart to Evening at 15-12-2014 18:00 2014-12-15 20:42:06,578 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.usb.USBDevices - Removing 'Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC' device, please wait, removing... 2014-12-15 20:42:06,594 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.devices.Devices - Stopping devices for driver org.pidome.driver.driver.nativeMySensorsDriver14 2014-12-15 20:42:06,941 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral stopped. 2014-12-15 20:42:06,943 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.usb.USBDevices - Removed 'Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC' 2014-12-15 20:42:10,331 [Thread-12] ERROR org.pidome.driver.peripherals.pidomeNativeUSBSerial.PidomeNativeUSBSerial - Port reading error (IOError in byte stream), bailing out: null, ({}) 2014-12-15 21:51:24,027 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.usb.USBDevices - New 'Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC' device added, please wait, adding... 2014-12-15 21:51:24,058 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC ready for use 2014-12-15 21:51:24,060 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.drivers.Drivers - Something went wrong width the hardware: MEthod does not support NID to request driver. 2014-12-15 21:51:24,607 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.devices.Devices - Device: Temperature has been loaded 2014-12-15 21:51:24,609 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Loaded and started Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC from saved configuration with: NativeMySensorsDriver14 2014-12-15 21:53:19,927 [Thread-29] INFO Main - Server shutdown instantiated 2014-12-15 21:55:30,415 [main] INFO Main - Starting server with build: 0.1-snapshot-2014-12-08.491 on platform: Linux (arm) 2014-12-15 21:55:30,713 [main] ERROR err - SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder". 2014-12-15 21:55:30,716 [main] ERROR err - SLF4J: Defaulting to no-operation (NOP) logger implementation 2014-12-15 21:55:30,718 [main] ERROR err - SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details. 2014-12-15 21:55:36,503 [main] INFO org.pidome.misc.utils.TimeUtils - Setting timezone data: Europe/Amsterdam, 51.950000, 4.449999 2014-12-15 21:55:37,115 [main] INFO org.pidome.server.system.rpc.PidomeJSONRPC - Initializing RPC 2014-12-15 21:55:40,821 [main] INFO org.pidome.server.system.rpc.PidomeJSONRPC - Done Initializing RPC 2014-12-15 21:55:40,841 [main] INFO org.pidome.server.system.extras.SystemExtras - Initializing system extras 2014-12-15 21:55:40,843 [main] INFO org.pidome.server.system.extras.SystemExtras - LED notifications setting: false 2014-12-15 21:55:40,846 [main] INFO org.pidome.server.system.extras.DataNotificationLeds - Led notification pins are disabled. If you want to enable this got to http://pidome.org on how to enable this. 2014-12-15 21:55:40,847 [main] INFO org.pidome.server.system.extras.SystemExtras - Done initializing extras 2014-12-15 21:55:40,993 [main] INFO org.pidome.server.services.provider.CertGen - Generating certificate(s), please wait...... 2014-12-15 21:55:46,861 [main] INFO org.pidome.server.services.provider.CertGen - Certificate(s) generated. 2014-12-15 21:55:46,868 [main] INFO org.pidome.server.system.network.Network - Network interface loaded 2014-12-15 21:55:47,589 [main] INFO org.pidome.server.services.clients.websockets.WebHttpWSService - Websocket service started: 192.168.1.6 - 8088 2014-12-15 21:55:47,997 [main] INFO org.pidome.server.services.clients.websockets.WebHttpWSService - Websocket ssl service started: 192.168.1.6 - 8089 2014-12-15 21:55:49,431 [HTTP service provider] INFO org.pidome.server.services.clients.http.DefaultHttpServer - HTTP Webservice started at ip: raspi.home/192.168.1.6, on port: 8080, max threads: 50 2014-12-15 21:55:52,247 [main] INFO org.pidome.server.system.hardware.Hardware - Hardware discovery started 2014-12-15 21:55:52,663 [main] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral Server information layer ready for use 2014-12-15 21:55:54,416 [WEBCLIENT:192.168.1.24] ERROR org.pidome.server.services.clients.http.HTTPClientHandler - Not authorized at 192.168.1.24, rewriting request 2014-12-15 21:55:57,092 [HTTPS Service provider] INFO org.pidome.server.services.clients.http.DefaultHttpsServer - HTTPS Webservice started at ip: raspi.home/192.168.1.6, on port: 8443, max threads: 50 2014-12-15 21:55:57,341 [main] INFO org.pidome.server.system.hardware.devices.Devices - Device: The PiDome Server self has been loaded 2014-12-15 21:55:57,698 [USB-discovery] INFO org.pidome.server.system.hardware.Hardware - Started peripherals discovery on USB 2014-12-15 21:55:59,490 [USB-discovery] INFO org.pidome.server.system.hardware.peripherals.usb.USBDevices - New 'Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC' device added, please wait, adding... 2014-12-15 21:55:59,807 [USB-discovery] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC ready for use 2014-12-15 21:55:59,811 [USB-discovery] INFO org.pidome.server.system.hardware.drivers.Drivers - Something went wrong width the hardware: MEthod does not support NID to request driver. 2014-12-15 21:56:00,581 [USB-discovery] INFO org.pidome.server.system.hardware.devices.Devices - Device: Temperature has been loaded 2014-12-15 21:56:00,586 [USB-discovery] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Loaded and started Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC from saved configuration with: NativeMySensorsDriver14 2014-12-15 21:56:03,445 [USB-discovery] INFO org.pidome.server.system.hardware.peripherals.usb.USBDevices - USB listener started 2014-12-15 21:56:03,505 [Serial-discovery] INFO org.pidome.server.system.hardware.Hardware - Started peripherals discovery on Serial GPIO 2014-12-15 21:56:03,797 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Usb listener started 2014-12-15 21:56:03,703 [WEBCLIENT:192.168.1.24] ERROR org.pidome.server.services.clients.http.HTTPClientHandler - Not authorized at 192.168.1.24, rewriting request 2014-12-15 21:56:04,244 [Serial-discovery] ERROR org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral driver PidomeNativeSerial can not be started: Temporary disabled 2014-12-15 21:56:04,310 [I2C-discovery] INFO org.pidome.server.system.hardware.Hardware - Started peripherals discovery on I2C 2014-12-15 21:56:05,578 [WEBCLIENT:192.168.1.24] WARN org.pidome.server.system.webservice.webclient.Webclient_login - Client logged in: admin via 192.168.1.24 2014-12-15 21:56:06,015 [I2C-discovery] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral Raspberry GPIO I2C ready for use 2014-12-15 21:56:06,178 [main] INFO org.pidome.server.system.hardware.peripherals.usb.USBDevices - USB listener started 2014-12-15 21:56:06,207 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Usb listener started 2014-12-15 21:56:06,258 [main] INFO org.pidome.server.system.userstatus.UserStatusService - Set user status to Awake at 15-12-2014 21:56 2014-12-15 21:56:06,352 [main] INFO org.pidome.server.system.presence.PresenceService - Set presence to Home at 15-12-2014 21:56 2014-12-15 21:56:06,486 [main] INFO org.pidome.server.services.clients.socketservice.SocketService - Client display terminal server has started 2014-12-15 21:56:06,499 [main] INFO org.pidome.server.services.clients.socketservice.SocketService - Client display terminal SSL server has started 2014-12-15 21:56:06,493 [Socket] INFO org.pidome.server.services.clients.socketservice.SocketService - Active, waiting for connections on ip: raspi.home/192.168.1.6 and port: 11000 2014-12-15 21:56:06,674 [SocketSSL] INFO org.pidome.server.services.clients.socketservice.SocketService - Active, waiting for connections on ip: raspi.home/192.168.1.6 and port: 11001 2014-12-15 21:56:06,830 [main] INFO org.pidome.server.services.plugins.PluginService - Starting plugin service: Media plugin service 2014-12-15 21:56:07,189 [main] INFO org.pidome.server.services.plugins.PluginService - Starting plugin service: Utility usage plugin service 2014-12-15 21:56:07,312 [main] INFO org.pidome.server.services.plugins.PluginService - Starting plugin service: Messenger plugin service 2014-12-15 21:56:07,473 [main] INFO org.pidome.server.services.plugins.PluginService - Starting plugin service: Remotes plugin service 2014-12-15 21:56:07,768 [main] INFO org.pidome.server.services.plugins.PluginService - Starting plugin service: Devices plugin service 2014-12-15 21:56:07,840 [PluginService::Start:Devices plugin service] INFO org.pidome.server.services.plugins.PluginService - Starting 'MQTT Server hook' (PiDome MQTT Broker) with the 'Devices plugin service' plugin service 2014-12-15 21:56:09,674 [PluginService::Start:Devices plugin service] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral Emulator for: PiDome MQTT Broker ready for use 2014-12-15 21:56:10,790 [main] INFO org.pidome.server.services.network.BroadcastService - Broadcast message: 'DOMCONTROL:192.168.1.6-SCREEN:DOMCONTROL:11000-SCREENSSL:DOMCONTROL:11001-WS:DOMCONTROL:8088' 2014-12-15 21:56:10,820 [SERVICE:BroadcastServer] INFO org.pidome.server.services.network.BroadcastService - Started, sending every 7.5 seconds 2014-12-15 21:56:18,029 [PluginService::Start:Devices plugin service] INFO org.pidome.server.services.plugins.PluginService - Started plugin: MQTT Server hook 2014-12-15 21:56:27,059 [WEBCLIENT:192.168.1.24] INFO org.pidome.server.system.webservice.webclient.desktop.Webclient_utilityedit - Got set: {2={pluginpath=org.pidome.plugins.freeform.utilityMeasurement, pluginname=PiDome Utility Measurements, installed_plugin=2, typeid=2, activated=true}, 10={pluginpath=org.pidome.plugins.freeform.plugwise.plugwiseSmile, pluginname=Plugwise Smile P1, installed_plugin=10, typeid=2, activated=true}} 2014-12-15 21:56:48,142 [Thread-41] INFO Main - Server shutdown instantiated 2014-12-15 21:57:29,280 [main] TRACE org.pidome.server.system.config.SystemConfig - Libraries file paths: [file:/home/pi/pidome-server/packages/system/dep/pi4j-core.jar, file:/home/pi/pidome-server/packages/system/dep/pi4j-service.jar, file:/home/pi/pidome-server/packages/system/dep/native/librxtxSerial.so, file:/home/pi/pidome-server/packages/system/dep/pi4j-gpio-extension.jar, file:/home/pi/pidome-server/packages/system/dep/log4j-api-2.0.jar, file:/home/pi/pidome-server/packages/system/dep/pi4j-device.jar, file:/home/pi/pidome-server/packages/system/dep/fusesource-mqtt-client-1.11-SNAPSHOT-uber.jar, file:/home/pi/pidome-server/packages/system/dep/json-simple-1.1.1.jar, file:/home/pi/pidome-server/packages/system/dep/hidapi-1.1.jar, file:/home/pi/pidome-server/packages/system/dep/jssc.jar, file:/home/pi/pidome-server/packages/system/dep/log4j-core-2.0.jar, file:/home/pi/pidome-server/packages/system/PiDome_Server_Connector_library.jar] 2014-12-15 21:57:29,336 [main] INFO Main - Starting server with build: 0.1-snapshot-2014-12-08.491 on platform: Linux (arm) 2014-12-15 21:57:29,352 [main] DEBUG org.pidome.misc.utils.PidControl - PID location: /var/run/pidome.pid 2014-12-15 21:57:29,357 [main] DEBUG org.pidome.misc.utils.PidControl - Running under PID: 3190 2014-12-15 21:57:29,397 [main] DEBUG org.pidome.server.system.db.DB - Loading all databases 2014-12-15 21:57:29,575 [main] ERROR err - SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder". 2014-12-15 21:57:29,578 [main] ERROR err - SLF4J: Defaulting to no-operation (NOP) logger implementation 2014-12-15 21:57:29,580 [main] ERROR err - SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for further details. 2014-12-15 21:57:32,157 [main] DEBUG org.pidome.server.system.db.DB - Database driver loaded and config and pooling set 2014-12-15 21:57:35,862 [main] INFO org.pidome.misc.utils.TimeUtils - Setting timezone data: Europe/Amsterdam, 51.950000, 4.449999 2014-12-15 21:57:36,402 [main] INFO org.pidome.server.system.rpc.PidomeJSONRPC - Initializing RPC 2014-12-15 21:57:40,068 [main] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - JSON wrapper set. 2014-12-15 21:57:40,070 [main] INFO org.pidome.server.system.rpc.PidomeJSONRPC - Done Initializing RPC 2014-12-15 21:57:40,089 [main] INFO org.pidome.server.system.extras.SystemExtras - Initializing system extras 2014-12-15 21:57:40,092 [main] INFO org.pidome.server.system.extras.SystemExtras - LED notifications setting: false 2014-12-15 21:57:40,094 [main] INFO org.pidome.server.system.extras.DataNotificationLeds - Led notification pins are disabled. If you want to enable this got to http://pidome.org on how to enable this. 2014-12-15 21:57:40,096 [main] INFO org.pidome.server.system.extras.SystemExtras - Done initializing extras 2014-12-15 21:57:40,155 [main] DEBUG org.pidome.server.system.network.Network - Autodiscovery of network interface addresses 2014-12-15 21:57:40,196 [main] DEBUG org.pidome.server.system.network.Network - Found ip address/192.168.1.6/24 [/192.168.1.255] 2014-12-15 21:57:40,199 [main] DEBUG org.pidome.server.system.network.Network - Found broadcast address/192.168.1.255 2014-12-15 21:57:40,204 [main] DEBUG org.pidome.server.system.network.Network - Found subnet /255.255.255.0 2014-12-15 21:57:40,207 [main] DEBUG org.pidome.server.system.network.Network - Event: AVAILABLE 2014-12-15 21:57:40,232 [main] INFO org.pidome.server.services.provider.CertGen - Generating certificate(s), please wait...... 2014-12-15 21:57:45,059 [main] INFO org.pidome.server.services.provider.CertGen - Certificate(s) generated. 2014-12-15 21:57:45,066 [main] INFO org.pidome.server.system.network.Network - Network interface loaded 2014-12-15 21:57:45,318 [main] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - JSON String to parse: {"role":"admin"} 2014-12-15 21:57:45,347 [main] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Parsed JSON Object: {role=admin} 2014-12-15 21:57:45,726 [main] INFO org.pidome.server.services.clients.websockets.WebHttpWSService - Websocket service started: 192.168.1.6 - 8088 2014-12-15 21:57:46,091 [main] INFO org.pidome.server.services.clients.websockets.WebHttpWSService - Websocket ssl service started: 192.168.1.6 - 8089 2014-12-15 21:57:47,416 [main] DEBUG org.pidome.server.services.clients.http.WebHttpService - HTTP service config loaded 2014-12-15 21:57:47,431 [HTTP service provider] INFO org.pidome.server.services.clients.http.DefaultHttpServer - HTTP Webservice started at ip: raspi.home/192.168.1.6, on port: 8080, max threads: 50 2014-12-15 21:57:47,467 [main] DEBUG org.pidome.server.services.clients.http.WebHttpsService - HTTPS service config loaded 2014-12-15 21:57:47,649 [main] DEBUG org.pidome.server.services.macros.MacroDB - Found 4 macros 2014-12-15 21:57:47,839 [main] DEBUG org.pidome.server.system.packages.Packages - Instance request 2014-12-15 21:57:47,841 [main] DEBUG org.pidome.server.system.packages.Packages - Instance initializing 2014-12-15 21:57:48,230 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/PiDome.Peripherals/PiDome_Peripherals.jar added to loader for main package 'PiDome.Peripherals' 2014-12-15 21:57:48,232 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: PiDome.Peripherals 2014-12-15 21:57:48,382 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/PiDome.Drivers/PiDome_Drivers.jar added to loader for main package 'PiDome.Drivers' 2014-12-15 21:57:48,384 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: PiDome.Drivers 2014-12-15 21:57:48,432 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/PiDome.Devices/PiDome_Devices.jar added to loader for main package 'PiDome.Devices' 2014-12-15 21:57:48,440 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: PiDome.Devices 2014-12-15 21:57:48,472 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/Pidome.Plugins/PiDome_Plugins.jar added to loader for main package 'Pidome.Plugins' 2014-12-15 21:57:48,474 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: Pidome.Plugins 2014-12-15 21:57:48,527 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/Pidome.MySensors/Pidome.MySensors.jar added to loader for main package 'Pidome.MySensors' 2014-12-15 21:57:48,529 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: Pidome.MySensors 2014-12-15 21:57:48,603 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/Pidome.PhilipsHue/lib/huesdkresources.jar added to loader for main package 'Pidome.PhilipsHue' 2014-12-15 21:57:48,703 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/Pidome.PhilipsHue/lib/huelocalsdk.jar added to loader for main package 'Pidome.PhilipsHue' 2014-12-15 21:57:48,706 [main] TRACE org.pidome.server.system.packages.PackageLibraryLoader - Library paths for this package: [file:/home/pi/pidome-server/packages/system/dep/pi4j-core.jar, file:/home/pi/pidome-server/packages/system/dep/pi4j-service.jar, file:/home/pi/pidome-server/packages/system/dep/native/librxtxSerial.so, file:/home/pi/pidome-server/packages/system/dep/pi4j-gpio-extension.jar, file:/home/pi/pidome-server/packages/system/dep/log4j-api-2.0.jar, file:/home/pi/pidome-server/packages/system/dep/pi4j-device.jar, file:/home/pi/pidome-server/packages/system/dep/fusesource-mqtt-client-1.11-SNAPSHOT-uber.jar, file:/home/pi/pidome-server/packages/system/dep/json-simple-1.1.1.jar, file:/home/pi/pidome-server/packages/system/dep/hidapi-1.1.jar, file:/home/pi/pidome-server/packages/system/dep/jssc.jar, file:/home/pi/pidome-server/packages/system/dep/log4j-core-2.0.jar, file:/home/pi/pidome-server/packages/system/PiDome_Server_Connector_library.jar, file:/home/pi/pidome-server/packages/user/Pidome.PhilipsHue/lib/huesdkresources.jar, file:/home/pi/pidome-server/packages/user/Pidome.PhilipsHue/lib/huelocalsdk.jar] 2014-12-15 21:57:48,710 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/Pidome.PhilipsHue/Pidome.PhilipsHue.jar added to loader for main package 'Pidome.PhilipsHue' 2014-12-15 21:57:48,712 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: Pidome.PhilipsHue 2014-12-15 21:57:48,752 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/Pidome.Kodi/Pidome.Kodi.jar added to loader for main package 'Pidome.Kodi' 2014-12-15 21:57:48,754 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: Pidome.Kodi 2014-12-15 21:57:48,811 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/PiDome.KlikAanKlikUitArduino/PiDome.KlikAanKlikUitArduino.jar added to loader for main package 'PiDome.KlikAanKlikUitArduino' 2014-12-15 21:57:48,813 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: PiDome.KlikAanKlikUitArduino 2014-12-15 21:57:48,854 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/PiDome.I2C/PiDome.I2C.jar added to loader for main package 'PiDome.I2C' 2014-12-15 21:57:48,856 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: PiDome.I2C 2014-12-15 21:57:48,907 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/PiDome.MQTTBroker/lib/netty-all-4.0.23.Final.jar added to loader for main package 'PiDome.MQTTBroker' 2014-12-15 21:57:48,909 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/PiDome.MQTTBroker/lib/disruptor-3.3.0.jar added to loader for main package 'PiDome.MQTTBroker' 2014-12-15 21:57:48,912 [main] TRACE org.pidome.server.system.packages.PackageLibraryLoader - Library paths for this package: [file:/home/pi/pidome-server/packages/system/dep/pi4j-core.jar, file:/home/pi/pidome-server/packages/system/dep/pi4j-service.jar, file:/home/pi/pidome-server/packages/system/dep/native/librxtxSerial.so, file:/home/pi/pidome-server/packages/system/dep/pi4j-gpio-extension.jar, file:/home/pi/pidome-server/packages/system/dep/log4j-api-2.0.jar, file:/home/pi/pidome-server/packages/system/dep/pi4j-device.jar, file:/home/pi/pidome-server/packages/system/dep/fusesource-mqtt-client-1.11-SNAPSHOT-uber.jar, file:/home/pi/pidome-server/packages/system/dep/json-simple-1.1.1.jar, file:/home/pi/pidome-server/packages/system/dep/hidapi-1.1.jar, file:/home/pi/pidome-server/packages/system/dep/jssc.jar, file:/home/pi/pidome-server/packages/system/dep/log4j-core-2.0.jar, file:/home/pi/pidome-server/packages/system/PiDome_Server_Connector_library.jar, file:/home/pi/pidome-server/packages/user/PiDome.MQTTBroker/lib/netty-all-4.0.23.Final.jar, file:/home/pi/pidome-server/packages/user/PiDome.MQTTBroker/lib/disruptor-3.3.0.jar] 2014-12-15 21:57:48,921 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/PiDome.MQTTBroker/PiDome.MQTTBroker.jar added to loader for main package 'PiDome.MQTTBroker' 2014-12-15 21:57:48,923 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: PiDome.MQTTBroker 2014-12-15 21:57:48,969 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/PiDome.Plugwise/PiDome_Plugwise.jar added to loader for main package 'PiDome.Plugwise' 2014-12-15 21:57:48,971 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: PiDome.Plugwise 2014-12-15 21:57:49,008 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - file:/home/pi/pidome-server/packages/user/PiDome.RFXCom/PiDome.RFXCom.jar added to loader for main package 'PiDome.RFXCom' 2014-12-15 21:57:49,010 [main] DEBUG org.pidome.server.system.packages.PackageLibraryLoader - Loaded package: PiDome.RFXCom 2014-12-15 21:57:50,010 [main] DEBUG org.pidome.server.system.hardware.Hardware - Added listener: org.pidome.server.system.hardware.devices.Devices 2014-12-15 21:57:50,013 [main] DEBUG org.pidome.server.system.hardware.peripherals.Peripherals - Added eventlistener: org.pidome.server.system.hardware.devices.Devices 2014-12-15 21:57:50,076 [main] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Added listener: org.pidome.server.system.hardware.devices.Devices 2014-12-15 21:57:50,210 [main] DEBUG org.pidome.server.system.hardware.peripherals.usb.USBDevices - prepare 2014-12-15 21:57:50,247 [main] DEBUG org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Added listener: org.pidome.server.system.hardware.peripherals.usb.USBDevices 2014-12-15 21:57:50,249 [main] DEBUG org.pidome.server.system.hardware.peripherals.usb.USBDevices - Using linux USB 2014-12-15 21:57:50,291 [main] INFO org.pidome.server.system.hardware.Hardware - Hardware discovery started 2014-12-15 21:57:50,341 [main] DEBUG org.pidome.server.connector.drivers.peripherals.hardware.Peripheral - New peripheral: TYPE_SERVER 2014-12-15 21:57:50,343 [main] DEBUG org.pidome.server.system.hardware.peripherals.server.ServerDevice - The local server "device" 2014-12-15 21:57:50,353 [main] DEBUG org.pidome.server.system.hardware.peripherals.server.ServerDevices - Event: DEVICE_ADDED 2014-12-15 21:57:50,371 [main] DEBUG org.pidome.server.system.hardware.Hardware - New hardware event: HARDWARE_ADDED 2014-12-15 21:57:50,389 [main] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.driver.peripherals.pidomeServerPeripheral from PiDome.Peripherals 2014-12-15 21:57:50,392 [main] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.driver.peripherals.pidomeServerPeripheral.PidomeServerPeripheral from PiDome.Peripherals 2014-12-15 21:57:50,667 [main] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral Server information layer ready for use 2014-12-15 21:57:50,669 [main] DEBUG org.pidome.server.system.hardware.peripherals.Peripherals - Event: DRIVER_LOADED 2014-12-15 21:57:50,693 [main] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Loading peripheral software driver for: Server information layer 2014-12-15 21:57:50,705 [main] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.driver.driver.nativeServerDriver from PiDome.Drivers 2014-12-15 21:57:50,707 [main] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.driver.driver.nativeServerDriver.NativeServerDriver from PiDome.Drivers 2014-12-15 21:57:50,989 [main] DEBUG org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Set peripheral listener: org.pidome.driver.driver.nativeServerDriver.NativeServerDriver 2014-12-15 21:57:50,992 [main] DEBUG org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Added listener: org.pidome.driver.peripherals.pidomeServerPeripheral.PidomeServerPeripheral 2014-12-15 21:57:51,001 [main] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Event: DRIVER_LOADED 2014-12-15 21:57:51,037 [main] DEBUG org.pidome.server.system.hardware.devices.Devices - Found devices: [org.pidome.driver.device.pidomeServerDevice] 2014-12-15 21:57:51,039 [main] DEBUG org.pidome.server.system.hardware.devices.Devices - Loading declared devices for device: org.pidome.driver.device.pidomeServerDevice 2014-12-15 21:57:51,043 [main] DEBUG org.pidome.server.system.hardware.devices.Devices - Found device ids: [1] 2014-12-15 21:57:51,060 [main] DEBUG org.pidome.server.system.hardware.devices.Devices - Loading device instance id: 1 2014-12-15 21:57:51,077 [main] DEBUG org.pidome.server.system.packages.Packages - Found installed device id '1' (The PiDome Server self), trying to retrieve 'org.pidome.driver.device.pidomeServerDevice' from package '3' for loading 2014-12-15 21:57:51,079 [main] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.driver.device.pidomeServerDevice from PiDome.Devices 2014-12-15 21:57:51,081 [main] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice from PiDome.Devices 2014-12-15 21:57:51,772 [main] DEBUG org.pidome.server.system.hardware.devices.Devices - Loaded device data: {friendlyname=The PiDome Server self, settings=, address=null, type=0, driver=org.pidome.driver.driver.nativeServerDriver, xml= PiDome Server Some server data. This data is calculated system wide. Except for the memory usage which is from the PiDome server application , name=Rasp server, location=1, fixed=true, id=1, category=2, device=org.pidome.driver.device.pidomeServerDevice, favorite=true, devicebaseid=1, screenX=725, screenY=392} 2014-12-15 21:57:52,607 [main] DEBUG org.pidome.server.connector.drivers.devices.DeviceStructure - Set canonical device base name: org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice:PiDome Server 2014-12-15 21:57:53,176 [main] DEBUG org.pidome.server.connector.drivers.devices.DeviceStructure - There are no options to set 2014-12-15 21:57:53,178 [main] DEBUG org.pidome.server.connector.drivers.devices.DeviceStructure - Created device options: {} 2014-12-15 21:57:53,262 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Reload categories 2014-12-15 21:57:53,278 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 1:Unknown 2014-12-15 21:57:53,280 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 2:PiDome 2014-12-15 21:57:53,282 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 3:Lighting 2014-12-15 21:57:53,284 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 4:Heating 2014-12-15 21:57:53,297 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 5:Locks 2014-12-15 21:57:53,299 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 6:Media 2014-12-15 21:57:53,301 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 7:Switches 2014-12-15 21:57:53,304 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 8:Remote 2014-12-15 21:57:53,316 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 9:Universal sensor 2014-12-15 21:57:53,318 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 10:Motion 2014-12-15 21:57:53,330 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 11:Display 2014-12-15 21:57:53,333 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 12:Water 2014-12-15 21:57:53,355 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 13:Gas 2014-12-15 21:57:53,358 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 14:Power 2014-12-15 21:57:53,361 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 15:Utilities 2014-12-15 21:57:53,363 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 16:Weather station 2014-12-15 21:57:53,375 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded category: 17:Infrared 2014-12-15 21:57:53,378 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Reload sub categories 2014-12-15 21:57:53,381 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 1:Common 2014-12-15 21:57:53,384 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 2:PiDome Server 2014-12-15 21:57:53,396 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 3:Common 2014-12-15 21:57:53,399 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 4:Common 2014-12-15 21:57:53,401 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 5:Common 2014-12-15 21:57:53,403 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 6:Common 2014-12-15 21:57:53,425 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 7:Common 2014-12-15 21:57:53,427 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 8:Common 2014-12-15 21:57:53,430 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 9:Common 2014-12-15 21:57:53,432 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 10:Common 2014-12-15 21:57:53,434 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 11:Common 2014-12-15 21:57:53,456 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 12:Common 2014-12-15 21:57:53,459 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 13:Common 2014-12-15 21:57:53,461 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 14:Common 2014-12-15 21:57:53,463 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 15:Common 2014-12-15 21:57:53,476 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 16:Common 2014-12-15 21:57:53,478 [main] DEBUG org.pidome.server.system.categories.BaseCategories - Loaded sub category: 17:Common 2014-12-15 21:57:53,607 [main] DEBUG org.pidome.server.system.location.BaseLocations - Reload 2014-12-15 21:57:53,614 [main] DEBUG org.pidome.server.system.location.BaseLocations - Loaded location: {name=Location unknown, screenW=0, fixed=true, id=1, floor=1, floorname=Floor unknown, screenX=0, screenH=0, screenY=0} 2014-12-15 21:57:53,652 [HTTPS Service provider] INFO org.pidome.server.services.clients.http.DefaultHttpsServer - HTTPS Webservice started at ip: raspi.home/192.168.1.6, on port: 8443, max threads: 50 2014-12-15 21:57:53,661 [main] DEBUG org.pidome.server.system.hardware.devices.Devices - Attaching: driver NativeServerDriver to device org.pidome.driver.device.pidomeServerDevice 2014-12-15 21:57:53,663 [main] DEBUG org.pidome.server.system.hardware.devices.DeviceStruct - Added driver listener: org.pidome.driver.driver.nativeServerDriver.NativeServerDriver 2014-12-15 21:57:53,675 [main] DEBUG org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Added listener: org.pidome.server.system.hardware.devices.DeviceStruct 2014-12-15 21:57:53,851 [main] DEBUG org.pidome.server.system.datastorage.RoundRobinDataStorage - Database /home/pi/pidome-server/databases/devices/1.data connected 2014-12-15 21:57:53,988 [main] DEBUG org.pidome.server.system.datastorage.RoundRobinDataStorage - New datatype set for storing: [org.pidome.server.connector.plugins.graphdata.RoundRobinDataGraphItem@92b3b6, org.pidome.server.connector.plugins.graphdata.RoundRobinDataGraphItem@6f2380, org.pidome.server.connector.plugins.graphdata.RoundRobinDataGraphItem@a4ebf2, org.pidome.server.connector.plugins.graphdata.RoundRobinDataGraphItem@8c1c9b] 2014-12-15 21:57:54,007 [main] INFO org.pidome.server.system.hardware.devices.Devices - Device: The PiDome Server self has been loaded 2014-12-15 21:57:54,550 [main] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.addDevice","params": {"id":1} } 2014-12-15 21:57:54,735 [main] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Driver NativeServerDriver on Server information layer on port {Internally used device map} is ready for use 2014-12-15 21:57:54,737 [main] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"SystemService.hardwareAdded","params": {"friendlyname":"Server information layer"} } 2014-12-15 21:57:54,744 [USB-discovery] INFO org.pidome.server.system.hardware.Hardware - Started peripherals discovery on USB 2014-12-15 21:57:54,756 [Thread-10-discovery-timer-60] DEBUG org.pidome.server.system.hardware.Hardware - Started Thread-10 watcher (interrupts after 60 seconds) 2014-12-15 21:57:54,778 [USB-discovery] DEBUG org.pidome.server.system.hardware.peripherals.serial.SerialUtils - Setting new known ports list: /dev/ttyAMA0 2014-12-15 21:57:56,734 [USB-discovery] INFO org.pidome.server.system.hardware.peripherals.usb.USBDevices - USB listener started 2014-12-15 21:57:56,747 [Serial-discovery] INFO org.pidome.server.system.hardware.Hardware - Started peripherals discovery on Serial GPIO 2014-12-15 21:57:56,756 [Thread-13-discovery-timer-60] DEBUG org.pidome.server.system.hardware.Hardware - Started Thread-13 watcher (interrupts after 60 seconds) 2014-12-15 21:57:56,773 [Serial-discovery] DEBUG org.pidome.server.system.hardware.peripherals.serial.SerialUtils - Setting new known ports list: /dev/ttyAMA0 2014-12-15 21:57:56,780 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Usb listener started 2014-12-15 21:57:56,796 [Serial-discovery] DEBUG org.pidome.server.connector.drivers.peripherals.hardware.Peripheral - New peripheral: TYPE_SERIAL 2014-12-15 21:57:56,798 [Serial-discovery] DEBUG org.pidome.server.system.hardware.peripherals.serial.SerialDevice - New GPIO Serial device 2014-12-15 21:57:56,801 [Serial-discovery] DEBUG org.pidome.server.system.hardware.peripherals.serial.SerialDevices - Event: DEVICE_ADDED 2014-12-15 21:57:56,803 [Serial-discovery] DEBUG org.pidome.server.system.hardware.Hardware - New hardware event: HARDWARE_ADDED 2014-12-15 21:57:56,811 [Serial-discovery] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.driver.peripherals.pidomeNativeSerial from PiDome.Peripherals 2014-12-15 21:57:56,813 [Serial-discovery] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.driver.peripherals.pidomeNativeSerial.PidomeNativeSerial from PiDome.Peripherals 2014-12-15 21:57:56,898 [Serial-discovery] ERROR org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral driver PidomeNativeSerial can not be started: Temporary disabled 2014-12-15 21:57:56,900 [Serial-discovery] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"SystemService.hardwareAdded","params": {"friendlyname":"Serial device speed 57600 baud, 8N1"} } 2014-12-15 21:57:56,928 [I2C-discovery] INFO org.pidome.server.system.hardware.Hardware - Started peripherals discovery on I2C 2014-12-15 21:57:56,936 [Thread-15-discovery-timer-60] DEBUG org.pidome.server.system.hardware.Hardware - Started Thread-15 watcher (interrupts after 60 seconds) 2014-12-15 21:57:56,955 [I2C-discovery] DEBUG org.pidome.server.connector.drivers.peripherals.hardware.Peripheral - New peripheral: TYPE_I2C 2014-12-15 21:57:56,957 [I2C-discovery] DEBUG org.pidome.server.system.hardware.peripherals.i2c.I2CDevice - New GPIO I2C device 2014-12-15 21:57:56,960 [I2C-discovery] DEBUG org.pidome.server.system.hardware.peripherals.i2c.I2CDevices - Event: DEVICE_ADDED 2014-12-15 21:57:56,962 [I2C-discovery] DEBUG org.pidome.server.system.hardware.Hardware - New hardware event: HARDWARE_ADDED 2014-12-15 21:57:56,964 [I2C-discovery] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.driver.peripherals.pidomeNativeI2CBus from PiDome.Peripherals 2014-12-15 21:57:56,986 [I2C-discovery] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.driver.peripherals.pidomeNativeI2CBus.PidomeNativeI2CBus from PiDome.Peripherals 2014-12-15 21:57:57,119 [I2C-discovery] DEBUG org.pidome.driver.peripherals.pidomeNativeI2CBus.PidomeNativeI2CBus - Starting peripheral driver for revision: 0010 2014-12-15 21:57:57,122 [I2C-discovery] DEBUG org.pidome.driver.peripherals.pidomeNativeI2CBus.PidomeNativeI2CBus - Going to use bus number: 1 2014-12-15 21:57:57,259 [I2C-discovery] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral Raspberry GPIO I2C ready for use 2014-12-15 21:57:57,261 [I2C-discovery] DEBUG org.pidome.server.system.hardware.peripherals.Peripherals - Event: DRIVER_LOADED 2014-12-15 21:57:57,262 [I2C-discovery] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Loading peripheral software driver for: Raspberry GPIO I2C 2014-12-15 21:57:57,264 [I2C-discovery] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.driver.driver.nativeDefaultI2CDriver from PiDome.I2C 2014-12-15 21:57:57,266 [I2C-discovery] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.driver.driver.nativeDefaultI2CDriver.NativeDefaultI2CDriver from PiDome.I2C 2014-12-15 21:57:57,314 [I2C-discovery] DEBUG org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Set peripheral listener: org.pidome.driver.driver.nativeDefaultI2CDriver.NativeDefaultI2CDriver 2014-12-15 21:57:57,316 [I2C-discovery] DEBUG org.pidome.driver.driver.nativeDefaultI2CDriver.NativeDefaultI2CDriver - Added listener: org.pidome.driver.peripherals.pidomeNativeI2CBus.PidomeNativeI2CBus 2014-12-15 21:57:57,318 [I2C-discovery] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Event: DRIVER_LOADED 2014-12-15 21:57:57,370 [I2C-discovery] DEBUG org.pidome.server.system.hardware.devices.Devices - Found devices: [org.pidome.driver.device.i2cLtsLc, org.pidome.driver.device.bareboneI2CDevice, org.pidome.driver.device.pidomeTrippleReflectorSensorsI2CBoard] 2014-12-15 21:57:57,372 [I2C-discovery] DEBUG org.pidome.server.system.hardware.devices.Devices - Loading declared devices for device: org.pidome.driver.device.i2cLtsLc 2014-12-15 21:57:57,404 [I2C-discovery] DEBUG org.pidome.server.system.hardware.devices.Devices - Found device ids: [] 2014-12-15 21:57:57,416 [I2C-discovery] DEBUG org.pidome.server.system.hardware.devices.Devices - Loading declared devices for device: org.pidome.driver.device.bareboneI2CDevice 2014-12-15 21:57:57,451 [I2C-discovery] DEBUG org.pidome.server.system.hardware.devices.Devices - Found device ids: [] 2014-12-15 21:57:57,453 [I2C-discovery] DEBUG org.pidome.server.system.hardware.devices.Devices - Loading declared devices for device: org.pidome.driver.device.pidomeTrippleReflectorSensorsI2CBoard 2014-12-15 21:57:57,505 [I2C-discovery] DEBUG org.pidome.server.system.hardware.devices.Devices - Found device ids: [] 2014-12-15 21:57:57,507 [I2C-discovery] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Driver NativeDefaultI2CDriver on Raspberry GPIO I2C on port {Auto discovery by driver} is ready for use 2014-12-15 21:57:57,509 [I2C-discovery] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"SystemService.hardwareAdded","params": {"friendlyname":"Raspberry GPIO I2C"} } 2014-12-15 21:57:57,512 [main] INFO org.pidome.server.system.hardware.peripherals.usb.USBDevices - USB listener started 2014-12-15 21:57:57,524 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Usb listener started 2014-12-15 21:57:57,578 [main] DEBUG org.pidome.server.system.userstatus.UserStatusService - Loading user status: 1, name Awake, description: User status awake 2014-12-15 21:57:57,584 [main] DEBUG org.pidome.server.system.userstatus.UserStatusService - Loading user status: 2, name Sleeping, description: User status sleeping 2014-12-15 21:57:57,587 [main] DEBUG org.pidome.server.system.userstatus.UserStatusService - Loading user status: 3, name Unknown/Away, description: When the user is away and status is unknown 2014-12-15 21:57:57,604 [main] INFO org.pidome.server.system.userstatus.UserStatusService - Set user status to Awake at 15-12-2014 21:57 2014-12-15 21:57:57,626 [main] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"UserStatusService.setUserStatus","params": {"name":"Awake","id":1} } 2014-12-15 21:57:57,718 [main] DEBUG org.pidome.server.system.dayparts.DayPartsService - Loading day part: 1, name Morning, description: The morning day part 2014-12-15 21:57:57,725 [main] DEBUG org.pidome.server.system.dayparts.DayPartsService - Loading day part: 2, name Afternoon, description: The Afternoon day part 2014-12-15 21:57:57,727 [main] DEBUG org.pidome.server.system.dayparts.DayPartsService - Loading day part: 3, name Evening, description: The evening day part 2014-12-15 21:57:57,729 [main] DEBUG org.pidome.server.system.dayparts.DayPartsService - Loading day part: 4, name Night, description: The night day part 2014-12-15 21:57:57,735 [main] DEBUG org.pidome.server.system.presence.PresenceService - Loading presence: 1, name Home, description: At Home 2014-12-15 21:57:57,743 [main] DEBUG org.pidome.server.system.presence.PresenceService - Loading presence: 2, name Away, description: Not at Home 2014-12-15 21:57:57,745 [main] DEBUG org.pidome.server.system.presence.PresenceService - Loading presence: 4, name Vacation, description: At Vacation 2014-12-15 21:57:57,747 [main] DEBUG org.pidome.server.system.presence.PresenceService - Loading presence: 5, name At Work, description: At Work. 2014-12-15 21:57:57,751 [main] INFO org.pidome.server.system.presence.PresenceService - Set presence to Home at 15-12-2014 21:57 2014-12-15 21:57:57,763 [main] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"PresenceService.activateGlobalPresence","params": {"name":"Home","id":1} } 2014-12-15 21:57:57,807 [main] INFO org.pidome.server.services.clients.socketservice.SocketService - Client display terminal server has started 2014-12-15 21:57:57,811 [Socket] INFO org.pidome.server.services.clients.socketservice.SocketService - Active, waiting for connections on ip: raspi.home/192.168.1.6 and port: 11000 2014-12-15 21:57:57,813 [main] INFO org.pidome.server.services.clients.socketservice.SocketService - Client display terminal SSL server has started 2014-12-15 21:57:57,861 [SocketSSL] INFO org.pidome.server.services.clients.socketservice.SocketService - Active, waiting for connections on ip: raspi.home/192.168.1.6 and port: 11001 2014-12-15 21:57:57,926 [main] INFO org.pidome.server.services.plugins.PluginService - Starting plugin service: Media plugin service 2014-12-15 21:57:57,962 [main] INFO org.pidome.server.services.plugins.PluginService - Starting plugin service: Utility usage plugin service 2014-12-15 21:57:58,004 [main] INFO org.pidome.server.services.plugins.PluginService - Starting plugin service: Messenger plugin service 2014-12-15 21:57:58,061 [main] INFO org.pidome.server.services.plugins.PluginService - Starting plugin service: Remotes plugin service 2014-12-15 21:57:58,099 [PluginService::Start:Utility usage plugin service] DEBUG org.pidome.server.services.plugins.PluginService - Found plugins: {} 2014-12-15 21:57:58,185 [PluginService::Start:Messenger plugin service] DEBUG org.pidome.server.services.plugins.PluginService - Found plugins: {} 2014-12-15 21:57:58,185 [PluginService::Start:Remotes plugin service] DEBUG org.pidome.server.services.plugins.PluginService - Found plugins: {} 2014-12-15 21:57:58,181 [PluginService::Start:Media plugin service] DEBUG org.pidome.server.services.plugins.PluginService - Found plugins: {} 2014-12-15 21:57:58,174 [main] INFO org.pidome.server.services.plugins.PluginService - Starting plugin service: Devices plugin service 2014-12-15 21:57:58,297 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.services.plugins.PluginService - Found plugins: {4={pluginpath=org.pidome.plugins.mqtt.pidomeMQTTBroker, pluginname=PiDome MQTT Broker, locationid=1, installed_plugin=9, name=MQTT Server hook, description=MQTT Server. Can be used to publish sensor data to. Do not disable if you use mobile devices with the server., location=Location unknown, fixed=true, typeid=5, customdata=null, favorite=false, activated=true}} 2014-12-15 21:57:58,299 [PluginService::Start:Devices plugin service] INFO org.pidome.server.services.plugins.PluginService - Starting 'MQTT Server hook' (PiDome MQTT Broker) with the 'Devices plugin service' plugin service 2014-12-15 21:57:58,321 [TriggerService::TriggersPreLoader] DEBUG org.pidome.server.services.triggerservice.TriggerDB - Found 4 triggers 2014-12-15 21:57:58,329 [main] DEBUG org.pidome.server.services.automations.AutomationRules - Found 1 automation rules 2014-12-15 21:57:58,376 [main] TRACE org.pidome.server.services.automations.AutomationRules - Found automation rule: {name=CPU usage, description=A rule used to send a CPU usage notification. Can be safely deleted, it is an example rule, active=true, rule= cpuloadhigh 75 cpunormal 25 GTE cpuloadhigh ERROR CPU Usage CPU load is very high: AND LT cpuloadhigh GTE cpunormal WARNING CPU Usage CPU load is somewhat high: LT cpunormal OK CPU Usage CPU load is normal: , id=1} 2014-12-15 21:57:58,443 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.plugins.PluginsDB - {pluginpath=org.pidome.plugins.mqtt.pidomeMQTTBroker, pluginname=PiDome MQTT Broker, locationid=1, installed_plugin=9, name=MQTT Server hook, description=MQTT Server. Can be used to publish sensor data to. Do not disable if you use mobile devices with the server., location=Location unknown, fixed=true, typeid=5, customdata=null, favorite=false, activated=true} 2014-12-15 21:57:58,457 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.services.plugins.PluginService - Loading current plugin: {pluginpath=org.pidome.plugins.mqtt.pidomeMQTTBroker, pluginname=PiDome MQTT Broker, locationid=1, installed_plugin=9, name=MQTT Server hook, description=MQTT Server. Can be used to publish sensor data to. Do not disable if you use mobile devices with the server., location=Location unknown, fixed=true, typeid=5, customdata=null, favorite=false, activated=true} 2014-12-15 21:57:58,460 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.plugins.mqtt.pidomeMQTTBroker from PiDome.MQTTBroker 2014-12-15 21:57:58,461 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.plugins.mqtt.pidomeMQTTBroker.PidomeMQTTBroker from PiDome.MQTTBroker 2014-12-15 21:57:58,558 [TriggerService::TriggersPreLoader] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Got 1 parent rules in Set Night 2014-12-15 21:57:58,561 [TriggerService::TriggersPreLoader] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Creating AND rules 2014-12-15 21:57:58,564 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Creating values equation from the following data: [{itemtype=daytime, matchvalue=00:00, matchtype=GREATERTHEN, occurrence=ALL, timetype=FIXED, occurrencename=Every day, timetypename=Fixed time}, {itemtype=daytime, matchvalue=06:00, matchtype=LESSTHEN, occurrence=ALL, timetype=FIXED, occurrencename=Every day, timetypename=Fixed time}] 2014-12-15 21:57:58,603 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Have a time equation with value: 00:00, method: GREATERTHEN, days: ALL 2014-12-15 21:57:58,682 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:57 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 00:00(00:00) 2014-12-15 21:57:58,684 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Have a time equation with value: 06:00, method: LESSTHEN, days: ALL 2014-12-15 21:57:58,707 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:57 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 06:00(06:00) 2014-12-15 21:57:58,715 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Total amount of equations created: 2 2014-12-15 21:57:58,770 [TriggerService::TriggersPreLoader] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Got 1 parent rules in Set Morning 2014-12-15 21:57:58,772 [TriggerService::TriggersPreLoader] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Creating AND rules 2014-12-15 21:57:58,793 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Creating values equation from the following data: [{itemtype=daytime, matchvalue=05:59, matchtype=GREATERTHEN, occurrence=ALL, timetype=FIXED, occurrencename=Every day, timetypename=Fixed time}, {itemtype=daytime, matchvalue=12:00, matchtype=LESSTHEN, occurrence=ALL, timetype=FIXED, occurrencename=Every day, timetypename=Fixed time}] 2014-12-15 21:57:58,795 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Have a time equation with value: 05:59, method: GREATERTHEN, days: ALL 2014-12-15 21:57:58,798 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:57 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 05:59(05:59) 2014-12-15 21:57:58,800 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Have a time equation with value: 12:00, method: LESSTHEN, days: ALL 2014-12-15 21:57:58,802 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:57 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 12:00(12:00) 2014-12-15 21:57:58,803 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Total amount of equations created: 2 2014-12-15 21:57:58,896 [TriggerService::TriggersPreLoader] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Got 1 parent rules in Set Afternoon 2014-12-15 21:57:58,898 [TriggerService::TriggersPreLoader] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Creating AND rules 2014-12-15 21:57:58,901 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Creating values equation from the following data: [{itemtype=daytime, matchvalue=11:59, matchtype=GREATERTHEN, occurrence=ALL, timetype=FIXED, occurrencename=Every day, timetypename=Fixed time}, {itemtype=daytime, matchvalue=18:00, matchtype=LESSTHEN, occurrence=ALL, timetype=FIXED, occurrencename=Every day, timetypename=Fixed time}] 2014-12-15 21:57:58,903 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Have a time equation with value: 11:59, method: GREATERTHEN, days: ALL 2014-12-15 21:57:58,934 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:57 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 11:59(11:59) 2014-12-15 21:57:58,936 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Have a time equation with value: 18:00, method: LESSTHEN, days: ALL 2014-12-15 21:57:58,969 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:57 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 18:00(18:00) 2014-12-15 21:57:58,970 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Total amount of equations created: 2 2014-12-15 21:57:58,972 [TriggerService::TriggersPreLoader] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Got 1 parent rules in Set Evening 2014-12-15 21:57:58,974 [TriggerService::TriggersPreLoader] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Creating AND rules 2014-12-15 21:57:58,996 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Creating values equation from the following data: [{itemtype=daytime, matchvalue=17:59, matchtype=GREATERTHEN, occurrence=ALL, timetype=FIXED, occurrencename=Every day, timetypename=Fixed time}, {itemtype=daytime, matchvalue=23:59, matchtype=LESSTHEN, occurrence=ALL, timetype=FIXED, occurrencename=Every day, timetypename=Fixed time}] 2014-12-15 21:57:58,998 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Have a time equation with value: 17:59, method: GREATERTHEN, days: ALL 2014-12-15 21:57:59,017 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:57 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 17:59(17:59) 2014-12-15 21:57:59,018 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Have a time equation with value: 23:59, method: LESSTHEN, days: ALL 2014-12-15 21:57:59,021 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:57 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 23:59(23:59) 2014-12-15 21:57:59,022 [TriggerService::TriggersPreLoader] TRACE org.pidome.server.services.triggerservice.TriggerEvent - Total amount of equations created: 2 2014-12-15 21:57:59,167 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.connector.drivers.peripherals.hardware.Peripheral - New peripheral: TYPE_PLUGIN 2014-12-15 21:57:59,169 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.peripherals.emulators.HardwarePluginDeviceEmulator - An emulator layer for plugins 2014-12-15 21:57:59,183 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.peripherals.emulators.HardwarePluginDeviceEmulators - Event: DEVICE_ADDED 2014-12-15 21:57:59,195 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.Hardware - New hardware event: HARDWARE_ADDED 2014-12-15 21:57:59,197 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.driver.peripherals.peripheralPluginEmulator from PiDome.Peripherals 2014-12-15 21:57:59,216 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.driver.peripherals.peripheralPluginEmulator.PeripheralPluginEmulator from PiDome.Peripherals 2014-12-15 21:57:59,242 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.peripherals.emulators.HardwarePluginDeviceEmulator - setting custom driver id from plugin 'PiDome MQTT Broker': NATIVE_PIDOMEMQTTBROKER_DRIVER, 0.0.1 2014-12-15 21:57:59,250 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Going to create an if statement based on: controls_if 2014-12-15 21:57:59,261 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Creating if mapping: IF0 2014-12-15 21:57:59,261 [PluginService::Start:Devices plugin service] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral Emulator for: PiDome MQTT Broker ready for use 2014-12-15 21:57:59,265 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.peripherals.Peripherals - Event: DRIVER_LOADED 2014-12-15 21:57:59,267 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Loading peripheral software driver for: Emulator for: PiDome MQTT Broker 2014-12-15 21:57:59,268 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.peripherals.emulators.HardwarePluginDeviceEmulator - setting custom driver id from plugin 'PiDome MQTT Broker': NATIVE_PIDOMEMQTTBROKER_DRIVER, 0.0.1 2014-12-15 21:57:59,270 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.peripherals.emulators.HardwarePluginDeviceEmulator - setting custom driver id from plugin 'PiDome MQTT Broker': NATIVE_PIDOMEMQTTBROKER_DRIVER, 0.0.1 2014-12-15 21:57:59,272 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.drivers.mqtt.pidomeMQTTBrokerDriver from PiDome.MQTTBroker 2014-12-15 21:57:59,278 [main] TRACE org.pidome.server.services.automations.rule.AutomationRule - Creating logic_compare: {block={attributes={inline=true, id=7, type=logic_compare}, childs=[{field={attributes={name=OP}, childs=[], value=GTE}}, {value={attributes={name=A}, childs=[{block={attributes={id=8, type=device_eq:1:values:cpuusage}, childs=[], value=}}]}}, {value={attributes={name=B}, childs=[{block={attributes={id=9, type=variables_get}, childs=[{field={attributes={name=VAR}, childs=[], value=cpuloadhigh}}]}}]}}]}} 2014-12-15 21:57:59,274 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.drivers.mqtt.pidomeMQTTBrokerDriver.PidomeMQTTBrokerDriver from PiDome.MQTTBroker 2014-12-15 21:57:59,317 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.peripherals.emulators.HardwarePluginDeviceEmulator - setting custom driver id from plugin 'PiDome MQTT Broker': NATIVE_PIDOMEMQTTBROKER_DRIVER, 0.0.1 2014-12-15 21:57:59,319 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.peripherals.emulators.HardwarePluginDeviceEmulator - setting custom driver id from plugin 'PiDome MQTT Broker': NATIVE_PIDOMEMQTTBROKER_DRIVER, 0.0.1 2014-12-15 21:57:59,321 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.peripherals.emulators.HardwarePluginDeviceEmulator - setting custom driver id from plugin 'PiDome MQTT Broker': NATIVE_PIDOMEMQTTBROKER_DRIVER, 0.0.1 2014-12-15 21:57:59,322 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.peripherals.emulators.HardwarePluginDeviceEmulator - setting custom driver id from plugin 'PiDome MQTT Broker': NATIVE_PIDOMEMQTTBROKER_DRIVER, 0.0.1 2014-12-15 21:57:59,336 [PluginService::Start:Devices plugin service] TRACE org.pidome.server.system.hardware.drivers.Drivers - Is emulator plugin, setting plugin links: MQTT Server hook 2014-12-15 21:57:59,338 [PluginService::Start:Devices plugin service] TRACE org.pidome.server.system.hardware.drivers.Drivers - Is emulator plugin, setting device instance link 2014-12-15 21:57:59,340 [PluginService::Start:Devices plugin service] TRACE org.pidome.server.system.hardware.drivers.Drivers - Installed devices requested for driver: org.pidome.drivers.mqtt.pidomeMQTTBrokerDriver 2014-12-15 21:57:59,350 [main] TRACE org.pidome.server.services.automations.rule.AutomationRule - Creating in createLogicCompare: [{field={attributes={name=OP}, childs=[], value=GTE}}, {value={attributes={name=A}, childs=[{block={attributes={id=8, type=device_eq:1:values:cpuusage}, childs=[], value=}}]}}, {value={attributes={name=B}, childs=[{block={attributes={id=9, type=variables_get}, childs=[{field={attributes={name=VAR}, childs=[], value=cpuloadhigh}}]}}]}}] 2014-12-15 21:57:59,384 [PluginService::Start:Devices plugin service] TRACE org.pidome.server.system.hardware.drivers.Drivers - Assigning the next installed devices to emulator plugin 'MQTT Server hook': {} 2014-12-15 21:57:59,406 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Set peripheral listener: org.pidome.drivers.mqtt.pidomeMQTTBrokerDriver.PidomeMQTTBrokerDriver 2014-12-15 21:57:59,408 [PluginService::Start:Devices plugin service] DEBUG org.pidome.drivers.mqtt.pidomeMQTTBrokerDriver.PidomeMQTTBrokerDriver - Added listener: org.pidome.driver.peripherals.peripheralPluginEmulator.PeripheralPluginEmulator 2014-12-15 21:57:59,409 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Event: DRIVER_LOADED 2014-12-15 21:57:59,433 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=0, var=75 2014-12-15 21:57:59,468 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:57:59,471 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Adding statements to if mapping: IF0 2014-12-15 21:57:59,486 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.devices.Devices - Found devices: [] 2014-12-15 21:57:59,488 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Driver PidomeMQTTBrokerDriver on Emulator for: PiDome MQTT Broker on port {Plugin handled} is ready for use 2014-12-15 21:57:59,489 [PluginService::Start:Devices plugin service] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"SystemService.hardwareAdded","params": {"friendlyname":"Emulator for: PiDome MQTT Broker"} } 2014-12-15 21:57:59,492 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Adding all devices to org.pidome.plugins.mqtt.pidomeMQTTBroker.PidomeMQTTBroker 2014-12-15 21:57:59,515 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Full hook list after: {org.pidome.plugins.mqtt.pidomeMQTTBroker.PidomeMQTTBroker@d1ee3={0=[]}} 2014-12-15 21:57:59,528 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Added send notification with type: ERROR, subject: CPU Usage, message: [org.pidome.server.services.automations.variables.TextAutomationVariable@188af83, org.pidome.server.services.automations.variables.TextAutomationVariable@1e968ce] in statement list 2014-12-15 21:57:59,545 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Added statements to if mapping: IF0 2014-12-15 21:57:59,547 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Creating if mapping: IF1 2014-12-15 21:57:59,547 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Adding all media to org.pidome.plugins.mqtt.pidomeMQTTBroker.PidomeMQTTBroker 2014-12-15 21:57:59,553 [PluginService::Start:Devices plugin service] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Full hook list after: {org.pidome.plugins.mqtt.pidomeMQTTBroker.PidomeMQTTBroker@d1ee3={0=[]}} 2014-12-15 21:57:59,602 [main] TRACE org.pidome.server.services.automations.rule.AutomationRule - Creating logic_operation: {block={attributes={inline=true, id=14, type=logic_operation}, childs=[{field={attributes={name=OP}, childs=[], value=AND}}, {value={attributes={name=A}, childs=[{block={attributes={inline=true, id=15, type=logic_compare}, childs=[{field={attributes={name=OP}, childs=[], value=LT}}, {value={attributes={name=A}, childs=[{block={attributes={id=16, type=device_eq:1:values:cpuusage}, childs=[], value=}}]}}, {value={attributes={name=B}, childs=[{block={attributes={id=17, type=variables_get}, childs=[{field={attributes={name=VAR}, childs=[], value=cpuloadhigh}}]}}]}}]}}]}}, {value={attributes={name=B}, childs=[{block={attributes={inline=true, id=18, type=logic_compare}, childs=[{field={attributes={name=OP}, childs=[], value=GTE}}, {value={attributes={name=A}, childs=[{block={attributes={id=19, type=device_eq:1:values:cpuusage}, childs=[], value=}}]}}, {value={attributes={name=B}, childs=[{block={attributes={id=20, type=variables_get}, childs=[{field={attributes={name=VAR}, childs=[], value=cpunormal}}]}}]}}]}}]}}]}} 2014-12-15 21:57:59,604 [main] TRACE org.pidome.server.services.automations.rule.AutomationRule - Creating in logic_operation: field 2014-12-15 21:57:59,606 [main] TRACE org.pidome.server.services.automations.rule.AutomationRule - Creating in logic_operation: value 2014-12-15 21:57:59,611 [main] TRACE org.pidome.server.services.automations.rule.AutomationRule - Creating in createLogicCompare: [{field={attributes={name=OP}, childs=[], value=LT}}, {value={attributes={name=A}, childs=[{block={attributes={id=16, type=device_eq:1:values:cpuusage}, childs=[], value=}}]}}, {value={attributes={name=B}, childs=[{block={attributes={id=17, type=variables_get}, childs=[{field={attributes={name=VAR}, childs=[], value=cpuloadhigh}}]}}]}}] 2014-12-15 21:57:59,614 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=0, var=75 2014-12-15 21:57:59,636 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:57:59,638 [main] TRACE org.pidome.server.services.automations.rule.AutomationRule - Creating in logic_operation: value 2014-12-15 21:57:59,658 [main] TRACE org.pidome.server.services.automations.rule.AutomationRule - Creating in createLogicCompare: [{field={attributes={name=OP}, childs=[], value=GTE}}, {value={attributes={name=A}, childs=[{block={attributes={id=19, type=device_eq:1:values:cpuusage}, childs=[], value=}}]}}, {value={attributes={name=B}, childs=[{block={attributes={id=20, type=variables_get}, childs=[{field={attributes={name=VAR}, childs=[], value=cpunormal}}]}}]}}] 2014-12-15 21:57:59,661 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=0, var=25 2014-12-15 21:57:59,663 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:57:59,685 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Adding statements to if mapping: IF1 2014-12-15 21:57:59,688 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Added send notification with type: WARNING, subject: CPU Usage, message: [org.pidome.server.services.automations.variables.TextAutomationVariable@1d7d6d6, org.pidome.server.services.automations.variables.TextAutomationVariable@1f02ef2] in statement list 2014-12-15 21:57:59,689 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Added statements to if mapping: IF1 2014-12-15 21:57:59,691 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Creating if mapping: IF2 2014-12-15 21:57:59,728 [main] TRACE org.pidome.server.services.automations.rule.AutomationRule - Creating logic_compare: {block={attributes={inline=true, id=25, type=logic_compare}, childs=[{field={attributes={name=OP}, childs=[], value=LT}}, {value={attributes={name=A}, childs=[{block={attributes={id=26, type=device_eq:1:values:cpuusage}, childs=[], value=}}]}}, {value={attributes={name=B}, childs=[{block={attributes={id=27, type=variables_get}, childs=[{field={attributes={name=VAR}, childs=[], value=cpunormal}}]}}]}}]}} 2014-12-15 21:57:59,746 [main] TRACE org.pidome.server.services.automations.rule.AutomationRule - Creating in createLogicCompare: [{field={attributes={name=OP}, childs=[], value=LT}}, {value={attributes={name=A}, childs=[{block={attributes={id=26, type=device_eq:1:values:cpuusage}, childs=[], value=}}]}}, {value={attributes={name=B}, childs=[{block={attributes={id=27, type=variables_get}, childs=[{field={attributes={name=VAR}, childs=[], value=cpunormal}}]}}]}}] 2014-12-15 21:57:59,749 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=0, var=25 2014-12-15 21:57:59,751 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:57:59,753 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Adding statements to if mapping: IF2 2014-12-15 21:57:59,777 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Added send notification with type: OK, subject: CPU Usage, message: [org.pidome.server.services.automations.variables.TextAutomationVariable@1b759d6, org.pidome.server.services.automations.variables.TextAutomationVariable@18d604b] in statement list 2014-12-15 21:57:59,779 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Added statements to if mapping: IF2 2014-12-15 21:57:59,780 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Total root rules size: 1 2014-12-15 21:57:59,782 [main] DEBUG org.pidome.server.services.automations.rule.AutomationRule - Running pre-flight, maybe something is already true, you never know 2014-12-15 21:57:59,784 [main] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:57:59,810 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=0, var=75 2014-12-15 21:57:59,828 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:57:59,830 [main] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:57:59,832 [main] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:57:59,833 [main] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:57:59,865 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=0, var=75 2014-12-15 21:57:59,867 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:57:59,869 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=0, var=25 2014-12-15 21:57:59,870 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:57:59,872 [main] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:57:59,874 [main] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:57:59,885 [main] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:57:59,888 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=0, var=25 2014-12-15 21:57:59,889 [main] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:57:59,891 [main] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:57:59,892 [main] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:57:59,948 [main] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"NotificationService.sendNotification","params": {"originates":"EXTERNAL","subject":"CPU Usage","type":"OK","message":"CPU load is normal: 0"} } 2014-12-15 21:58:00,139 [main] INFO org.pidome.server.services.network.BroadcastService - Broadcast message: 'DOMCONTROL:192.168.1.6-SCREEN:DOMCONTROL:11000-SCREENSSL:DOMCONTROL:11001-WS:DOMCONTROL:8088' 2014-12-15 21:58:00,168 [SERVICE:BroadcastServer] INFO org.pidome.server.services.network.BroadcastService - Started, sending every 7.5 seconds 2014-12-15 21:58:00,710 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:58:00,730 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: procheat - 4 bytes 2014-12-15 21:58:00,788 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: procheat - 45.5 2014-12-15 21:58:00,791 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '45.5' to datatype: FLOAT 2014-12-15 21:58:00,805 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, procheat, {} 2014-12-15 21:58:00,876 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: procheat, containing 45.5 2014-12-15 21:58:00,910 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - procheat - 45.5 2014-12-15 21:58:00,928 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:58:00,929 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: cpuusage - 4 bytes 2014-12-15 21:58:00,931 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: cpuusage - 65.85 2014-12-15 21:58:00,934 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '65.85' to datatype: FLOAT 2014-12-15 21:58:01,042 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:01,009 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"procheat","id":1,"value":45.5,"group":"values"} } 2014-12-15 21:58:01,044 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=65.85, var=75 2014-12-15 21:58:01,060 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:01,062 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:01,063 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:01,075 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:01,081 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=65.85, var=75 2014-12-15 21:58:01,083 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:01,084 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=65.85, var=25 2014-12-15 21:58:01,116 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:01,118 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:58:01,119 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:58:01,121 [pool-4-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"NotificationService.sendNotification","params": {"originates":"EXTERNAL","subject":"CPU Usage","type":"WARNING","message":"CPU load is somewhat high: 65.85"} } 2014-12-15 21:58:01,123 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:01,124 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=65.85, var=75 2014-12-15 21:58:01,142 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:01,148 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:01,149 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:01,150 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:01,152 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=65.85, var=75 2014-12-15 21:58:01,154 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:01,196 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=65.85, var=25 2014-12-15 21:58:01,202 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:01,204 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:58:01,228 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:58:01,234 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:01,236 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=65.85, var=75 2014-12-15 21:58:01,237 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:01,239 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:01,241 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:01,242 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:01,273 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=65.85, var=75 2014-12-15 21:58:01,285 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:01,287 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=65.85, var=25 2014-12-15 21:58:01,288 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:01,290 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:58:01,291 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:58:01,293 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:01,294 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=65.85, var=75 2014-12-15 21:58:01,313 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:01,325 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:01,326 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:01,335 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:01,337 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=65.85, var=75 2014-12-15 21:58:01,338 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:01,340 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=65.85, var=25 2014-12-15 21:58:01,342 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:01,343 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:58:01,344 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:58:01,363 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, cpuusage, {} 2014-12-15 21:58:01,385 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: cpuusage, containing 65.85 2014-12-15 21:58:01,387 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"cpuusage","id":1,"value":65.85,"group":"values"} } 2014-12-15 21:58:01,390 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - cpuusage - 65.85 2014-12-15 21:58:01,396 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:58:01,397 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: memusage - 4 bytes 2014-12-15 21:58:01,399 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: memusage - 8.44 2014-12-15 21:58:01,402 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '8.44' to datatype: FLOAT 2014-12-15 21:58:01,403 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, memusage, {} 2014-12-15 21:58:01,426 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: memusage, containing 8.44 2014-12-15 21:58:01,432 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"memusage","id":1,"value":8.44,"group":"values"} } 2014-12-15 21:58:01,452 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:58:01,454 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: diskspace - 4 bytes 2014-12-15 21:58:01,466 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: diskspace - 9592.36 2014-12-15 21:58:01,468 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '9592.36' to datatype: FLOAT 2014-12-15 21:58:01,470 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, diskspace, {} 2014-12-15 21:58:01,524 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: diskspace, containing 9592.36 2014-12-15 21:58:01,537 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"diskspace","id":1,"value":9592.36,"group":"values"} } 2014-12-15 21:58:01,676 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - memusage - 8.44 2014-12-15 21:58:02,006 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - diskspace - 9592.36 2014-12-15 21:58:02,645 [TriggerTimeRun::21:58] DEBUG org.pidome.server.services.triggerservice.TriggerService - Updating Sunset and Sunrise to 16:31, 08:43 2014-12-15 21:58:02,650 [TriggerTimeRun::21:58] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 21:58 in trigger event 'Set Night' 2014-12-15 21:58:02,652 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:58 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 00:00(00:00) 2014-12-15 21:58:02,654 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:58 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 06:00(06:00) 2014-12-15 21:58:02,693 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:58 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 00:00(00:00) 2014-12-15 21:58:02,725 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:58 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 06:00(06:00) 2014-12-15 21:58:02,727 [TriggerTimeRun::21:58] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 21:58 in trigger event 'Set Morning' 2014-12-15 21:58:02,729 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:58 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 05:59(05:59) 2014-12-15 21:58:02,731 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:58 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 12:00(12:00) 2014-12-15 21:58:02,733 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:58 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 05:59(05:59) 2014-12-15 21:58:02,784 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:58 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 12:00(12:00) 2014-12-15 21:58:02,818 [TriggerTimeRun::21:58] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 21:58 in trigger event 'Set Afternoon' 2014-12-15 21:58:02,820 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:58 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 11:59(11:59) 2014-12-15 21:58:02,822 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:58 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 18:00(18:00) 2014-12-15 21:58:02,823 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:58 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 11:59(11:59) 2014-12-15 21:58:02,835 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:58 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 18:00(18:00) 2014-12-15 21:58:02,837 [TriggerTimeRun::21:58] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 21:58 in trigger event 'Set Evening' 2014-12-15 21:58:02,839 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:58 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 17:59(17:59) 2014-12-15 21:58:02,840 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:58 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 23:59(23:59) 2014-12-15 21:58:02,884 [TriggerTimeRun::21:58] INFO org.pidome.server.services.triggerservice.TriggerEvent - Executing trigger actions for trigger: Set Evening 2014-12-15 21:58:02,918 [TriggerTimeRun::21:58] DEBUG org.pidome.server.services.macros.MacroService - MACROSERVICE: Running macro id '3 2014-12-15 21:58:02,924 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"MacroService.runMacro","params": {"id":3} } 2014-12-15 21:58:03,005 [TriggerTimeRun::21:58] INFO org.pidome.server.system.dayparts.DayPartsService - Set daypart to Evening at 15-12-2014 21:58 2014-12-15 21:58:03,037 [TriggerTimeRun::21:58] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DayPartService.setDayPart","params": {"name":"Evening","id":3} } 2014-12-15 21:58:06,932 [PluginService::Start:Devices plugin service] INFO org.pidome.server.services.plugins.PluginService - Started plugin: MQTT Server hook 2014-12-15 21:58:31,810 [Rasp USB Monitor] TRACE org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - USB event subsystem: usb 2014-12-15 21:58:31,828 [Rasp USB Monitor] TRACE org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - USB event subsystem: usb 2014-12-15 21:58:32,117 [Rasp USB Monitor] TRACE org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - USB event subsystem: usb-serial 2014-12-15 21:58:32,146 [Rasp USB Monitor] TRACE org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - USB event subsystem: tty 2014-12-15 21:58:32,150 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - New TTY:'/devices/platform/bcm2708_usb/usb1/1-1/1-1.2/1-1.2:1.0/ttyUSB0/tty/ttyUSB0' device added, please wait 2014-12-15 21:58:32,303 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Path: /devices/platform/bcm2708_usb/usb1/1-1/1-1.2/1-1.2:1.0/ttyUSB0/tty/ttyUSB0 2014-12-15 21:58:32,311 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Device name: FT232 USB-Serial (UART) IC 2014-12-15 21:58:32,313 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Device id: 6001 2014-12-15 21:58:32,314 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Device port: /dev/ttyUSB0 2014-12-15 21:58:32,326 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Device vendor id: 0403 2014-12-15 21:58:32,327 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Device vendor name: Future Technology Devices International, Ltd 2014-12-15 21:58:32,331 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.usb.linux.RaspUsb - Event: DEVICE_ADDED, /devices/platform/bcm2708_usb/usb1/1-1/1-1.2/1-1.2:1.0/ttyUSB0/tty/ttyUSB0 2014-12-15 21:58:32,351 [Rasp USB Monitor] DEBUG org.pidome.server.connector.drivers.peripherals.hardware.Peripheral - New peripheral: TYPE_USB 2014-12-15 21:58:32,353 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.usb.USBDevice - New USB device 2014-12-15 21:58:32,362 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.usb.USBDevices - New 'Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC' device added, please wait, adding... 2014-12-15 21:58:32,364 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.usb.USBDevices - Event: DEVICE_ADDED 2014-12-15 21:58:32,366 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.Hardware - New hardware event: HARDWARE_ADDED 2014-12-15 21:58:32,368 [Rasp USB Monitor] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.driver.peripherals.pidomeNativeUSBSerial from PiDome.Peripherals 2014-12-15 21:58:32,369 [Rasp USB Monitor] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.driver.peripherals.pidomeNativeUSBSerial.PidomeNativeUSBSerial from PiDome.Peripherals 2014-12-15 21:58:32,528 [Rasp USB Monitor] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - JSON String to parse: {"vid":"0403","hardwarePort":"/dev/ttyUSB0","swdriverid":"NATIVE_PIDOMEMYSENSORSDRIVER_1_4","swdriverversion":"0.0.1","pid":"6001","hwdriveroptions":{"portspeed":"115200","stopbits":"1","parity":"none","databits":"8"}} 2014-12-15 21:58:32,545 [Rasp USB Monitor] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Parsed JSON Object: {vid=0403, hardwarePort=/dev/ttyUSB0, swdriverid=NATIVE_PIDOMEMYSENSORSDRIVER_1_4, swdriverversion=0.0.1, pid=6001, hwdriveroptions={portspeed=115200, stopbits=1, parity=none, databits=8}} 2014-12-15 21:58:32,549 [Rasp USB Monitor] DEBUG org.pidome.driver.peripherals.pidomeNativeUSBSerial.PidomeNativeUSBSerial - Got driver option(s) set: {portspeed=115200, stopbits=1, parity=none, databits=8} 2014-12-15 21:58:32,553 [Rasp USB Monitor] DEBUG org.pidome.driver.peripherals.pidomeNativeUSBSerial.PidomeNativeUSBSerial - Port 'null' init 2014-12-15 21:58:32,667 [Rasp USB Monitor] DEBUG org.pidome.driver.peripherals.pidomeNativeUSBSerial.PidomeNativeUSBSerial - Port '/dev/ttyUSB0' ready for data. Started with speed: 115200, data bits: 8, stop bits: 1, parity: 0 2014-12-15 21:58:32,669 [Rasp USB Monitor] DEBUG org.pidome.server.connector.drivers.peripherals.hardware.Peripheral - Problem getting peripheral software id: MEthod does not support NID to request driver. 2014-12-15 21:58:32,677 [Rasp USB Monitor] DEBUG org.pidome.driver.peripherals.pidomeNativeUSBSerial.PidomeNativeUSBSerial - Driver started 2014-12-15 21:58:32,680 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Peripheral Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC ready for use 2014-12-15 21:58:32,681 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.Peripherals - Event: DRIVER_LOADED 2014-12-15 21:58:32,683 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Loading peripheral software driver for: Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC 2014-12-15 21:58:32,688 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.drivers.Drivers - MEthod does not support NID to request driver. 2014-12-15 21:58:32,690 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.drivers.Drivers - Something went wrong width the hardware: MEthod does not support NID to request driver. 2014-12-15 21:58:32,693 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.Peripherals - Trying to start peripheral and driver with: /devices/platform/bcm2708_usb/usb1/1-1/1-1.2/1-1.2:1.0/ttyUSB0/tty/ttyUSB0 and NATIVE_PIDOMEMYSENSORSDRIVER_1_4 version 0.0.1 (save settings?: false) 2014-12-15 21:58:32,695 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.peripherals.Peripherals - Event: DRIVER_LOADED 2014-12-15 21:58:32,697 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Loading peripheral software driver for: Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC 2014-12-15 21:58:32,699 [Rasp USB Monitor] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.driver.driver.nativeMySensorsDriver14 from Pidome.MySensors 2014-12-15 21:58:32,700 [Rasp USB Monitor] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.driver.driver.nativeMySensorsDriver14.NativeMySensorsDriver14 from Pidome.MySensors 2014-12-15 21:58:32,839 [Rasp USB Monitor] DEBUG org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Set peripheral listener: org.pidome.driver.driver.nativeMySensorsDriver14.NativeMySensorsDriver14 2014-12-15 21:58:32,841 [Rasp USB Monitor] DEBUG org.pidome.driver.driver.nativeMySensorsDriver14.NativeMySensorsDriver14 - Added listener: org.pidome.driver.peripherals.pidomeNativeUSBSerial.PidomeNativeUSBSerial 2014-12-15 21:58:32,843 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Event: DRIVER_LOADED 2014-12-15 21:58:32,874 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.devices.Devices - Found devices: [org.pidome.driver.device.pidomeMySensorsLCDTempLuxTimePresence, org.pidome.driver.device.pidomeNativeMySensorsDevice14] 2014-12-15 21:58:32,876 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.devices.Devices - Loading declared devices for device: org.pidome.driver.device.pidomeMySensorsLCDTempLuxTimePresence 2014-12-15 21:58:32,899 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.devices.Devices - Found device ids: [] 2014-12-15 21:58:32,901 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.devices.Devices - Loading declared devices for device: org.pidome.driver.device.pidomeNativeMySensorsDevice14 2014-12-15 21:58:32,924 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.devices.Devices - Found device ids: [17] 2014-12-15 21:58:32,954 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.devices.Devices - Loading device instance id: 17 2014-12-15 21:58:32,958 [Rasp USB Monitor] DEBUG org.pidome.server.system.packages.Packages - Found installed device id '17' (Temperature), trying to retrieve 'org.pidome.driver.device.pidomeNativeMySensorsDevice14' from package '5' for loading 2014-12-15 21:58:32,960 [Rasp USB Monitor] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading package org.pidome.driver.device.pidomeNativeMySensorsDevice14 from Pidome.MySensors 2014-12-15 21:58:32,962 [Rasp USB Monitor] DEBUG org.pidome.server.system.packages.PackageClassLoader - Loading class org.pidome.driver.device.pidomeNativeMySensorsDevice14.PidomeNativeMySensorsDevice14 from Pidome.MySensors 2014-12-15 21:58:32,986 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.devices.Devices - Loaded device data: {friendlyname=Temperature, settings=, address=1, type=1, driver=org.pidome.driver.driver.nativeMySensorsDriver14, xml= Temperature This sensor reads temperature
Blablabla
, name=TEMPLIVINGROOM, location=1, fixed=false, id=17, category=4, device=org.pidome.driver.device.pidomeNativeMySensorsDevice14, favorite=false, devicebaseid=46, screenX=0, screenY=0} 2014-12-15 21:58:33,038 [Rasp USB Monitor] DEBUG org.pidome.server.connector.drivers.devices.DeviceStructure - Set canonical device base name: org.pidome.driver.device.pidomeNativeMySensorsDevice14.PidomeNativeMySensorsDevice14:Temperature 2014-12-15 21:58:33,458 [Rasp USB Monitor] DEBUG org.pidome.server.connector.drivers.devices.DeviceStructure - There are no options to set 2014-12-15 21:58:33,460 [Rasp USB Monitor] DEBUG org.pidome.server.connector.drivers.devices.DeviceStructure - Created device options: {} 2014-12-15 21:58:33,466 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.devices.Devices - Attaching: driver NativeMySensorsDriver14 to device org.pidome.driver.device.pidomeNativeMySensorsDevice14 2014-12-15 21:58:33,468 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.devices.DeviceStruct - Added driver listener: org.pidome.driver.driver.nativeMySensorsDriver14.NativeMySensorsDriver14 2014-12-15 21:58:33,470 [Rasp USB Monitor] DEBUG org.pidome.driver.driver.nativeMySensorsDriver14.NativeMySensorsDriver14 - Added listener: org.pidome.server.system.hardware.devices.DeviceStruct 2014-12-15 21:58:33,472 [Rasp USB Monitor] DEBUG org.pidome.server.system.datastorage.RoundRobinDataStorage - Database /home/pi/pidome-server/databases/devices/17.data connected 2014-12-15 21:58:33,677 [Rasp USB Monitor] DEBUG org.pidome.server.system.datastorage.RoundRobinDataStorage - New datatype set for storing: [org.pidome.server.connector.plugins.graphdata.RoundRobinDataGraphItem@bf6973, org.pidome.server.connector.plugins.graphdata.RoundRobinDataGraphItem@783512] 2014-12-15 21:58:33,680 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.devices.Devices - Device: Temperature has been loaded 2014-12-15 21:58:33,685 [Rasp USB Monitor] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.addDevice","params": {"id":17} } 2014-12-15 21:58:33,687 [Rasp USB Monitor] DEBUG org.pidome.server.system.hardware.drivers.Drivers - Driver NativeMySensorsDriver14 on Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC on port /dev/ttyUSB0 is ready for use 2014-12-15 21:58:33,690 [Rasp USB Monitor] INFO org.pidome.server.system.hardware.peripherals.Peripherals - Loaded and started Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC from saved configuration with: NativeMySensorsDriver14 2014-12-15 21:58:33,692 [Rasp USB Monitor] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"SystemService.hardwareAdded","params": {"friendlyname":"Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC"} } 2014-12-15 21:58:34,520 [Thread-29] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 37 byte(s) 2014-12-15 21:58:34,527 [Thread-29] TRACE org.pidome.driver.driver.nativeMySensorsDriver14.NativeMySensorsDriver14 - Received from hardware driver: 0;0;3;0;14;Gateway startup complete. 2014-12-15 21:58:34,530 [Thread-29] DEBUG org.pidome.driver.driver.nativeMySensorsDriver14.NativeMySensorsDriver14 - Handling internal: 0;0;INTERNAL;14;Gateway startup complete. 2014-12-15 21:58:34,533 [Thread-29] DEBUG org.pidome.driver.driver.nativeMySensorsDriver14.NativeMySensorsDriver14 - Sending internal message to device: '0;0;3;0;2;Get Version' 2014-12-15 21:58:34,575 [pool-15-thread-1] DEBUG org.pidome.driver.driver.nativeMySensorsDriver14.NativeMySensorsDriver14 - sending: [B@13038e1 2014-12-15 21:58:42,334 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - GET /desktop/customdeviceslist.html?requesttype=ajax&_=1418680574325 HTTP/1.1 2014-12-15 21:58:42,340 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Host: 192.168.1.6:8080 2014-12-15 21:58:42,343 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Connection: keep-alive 2014-12-15 21:58:42,346 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept: text/html, */*; q=0.01 2014-12-15 21:58:42,349 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - X-Requested-With: XMLHttpRequest 2014-12-15 21:58:42,356 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/39.0.2171.95 Safari/537.36 2014-12-15 21:58:42,360 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Referer: http://192.168.1.6:8080/desktop/index.html 2014-12-15 21:58:42,364 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Encoding: gzip, deflate, sdch 2014-12-15 21:58:42,371 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Language: en-US,en;q=0.8 2014-12-15 21:58:42,375 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Cookie: key=94cd474f-4e25-4e75-8b6f-c76505372f88 2014-12-15 21:58:42,378 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - 2014-12-15 21:58:42,380 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Having header collection: {REQUEST=/desktop/customdeviceslist.html, PLAINFILE=desktop/customdeviceslist, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=html, QUERYSTRING=requesttype=ajax&_=1418680574325} 2014-12-15 21:58:42,382 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.services.clients.http.HTTPClientHandler - 192.168.1.24 - GET: /desktop/customdeviceslist.html 2014-12-15 21:58:42,385 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Complete constructed from header: {REQUEST=/desktop/customdeviceslist.html, PLAINFILE=desktop/customdeviceslist, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=html, QUERYSTRING=requesttype=ajax&_=1418680574325} 2014-12-15 21:58:42,390 [WEBCLIENT:192.168.1.24] ERROR org.pidome.server.services.clients.http.HTTPClientHandler - Not authorized at 192.168.1.24, rewriting request 2014-12-15 21:58:42,418 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Get query data: {requesttype=ajax, _=1418680574325} 2014-12-15 21:58:48,324 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - POST /login.xhtml HTTP/1.1 2014-12-15 21:58:48,327 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Host: 192.168.1.6:8080 2014-12-15 21:58:48,330 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Connection: keep-alive 2014-12-15 21:58:48,332 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Content-Length: 33 2014-12-15 21:58:48,347 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Origin: http://192.168.1.6:8080 2014-12-15 21:58:48,355 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/39.0.2171.95 Safari/537.36 2014-12-15 21:58:48,359 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Content-type: application/x-www-form-urlencoded 2014-12-15 21:58:48,361 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept: */* 2014-12-15 21:58:48,365 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Referer: http://192.168.1.6:8080/desktop/index.html 2014-12-15 21:58:48,368 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Encoding: gzip, deflate 2014-12-15 21:58:48,371 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Language: en-US,en;q=0.8 2014-12-15 21:58:48,374 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Cookie: key=94cd474f-4e25-4e75-8b6f-c76505372f88 2014-12-15 21:58:48,377 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - 2014-12-15 21:58:48,379 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Having header collection: {REQUEST=/login.xhtml, PLAINFILE=login, METHOD=POST, HOST=192.168.1.6:8080, FILETYPE=xhtml, QUERYSTRING=, CONTENT-LENGTH=33} 2014-12-15 21:58:48,391 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Received post data: {password=allora123, username=admin} 2014-12-15 21:58:48,393 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.services.clients.http.HTTPClientHandler - 192.168.1.24 - POST: /login.xhtml 2014-12-15 21:58:48,399 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Complete constructed from header: {REQUEST=/login.xhtml, PLAINFILE=login, METHOD=POST, HOST=192.168.1.6:8080, FILETYPE=xhtml, QUERYSTRING=, CONTENT-LENGTH=33} 2014-12-15 21:58:48,402 [WEBCLIENT:192.168.1.24] ERROR org.pidome.server.services.clients.http.HTTPClientHandler - Not authorized at 192.168.1.24, rewriting request 2014-12-15 21:58:48,404 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Get query data: {} 2014-12-15 21:58:48,512 [WEBCLIENT:192.168.1.24] WARN org.pidome.server.system.webservice.webclient.Webclient_login - Client logged in: admin via 192.168.1.24 2014-12-15 21:58:50,543 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - GET /desktop/index.html HTTP/1.1 2014-12-15 21:58:50,546 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Host: 192.168.1.6:8080 2014-12-15 21:58:50,549 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Connection: keep-alive 2014-12-15 21:58:50,555 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept: text/html,application/xhtml+xml,application/xml;q=0.9,image/webp,*/*;q=0.8 2014-12-15 21:58:50,561 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/39.0.2171.95 Safari/537.36 2014-12-15 21:58:50,565 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Referer: http://192.168.1.6:8080/desktop/index.html 2014-12-15 21:58:50,576 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Encoding: gzip, deflate, sdch 2014-12-15 21:58:50,579 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Language: en-US,en;q=0.8 2014-12-15 21:58:50,583 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Cookie: key=ecbfc2c4-2420-4019-ba6c-3cd44d4aa577 2014-12-15 21:58:50,587 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - If-Modified-Since: ma, 15 12 2014 21:56:11 GMT 2014-12-15 21:58:50,589 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - 2014-12-15 21:58:50,591 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Having header collection: {REQUEST=/desktop/index.html, PLAINFILE=desktop/index, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=html, QUERYSTRING=} 2014-12-15 21:58:50,593 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.services.clients.http.HTTPClientHandler - 192.168.1.24 - GET: /desktop/index.html 2014-12-15 21:58:50,595 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Complete constructed from header: {REQUEST=/desktop/index.html, PLAINFILE=desktop/index, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=html, QUERYSTRING=} 2014-12-15 21:58:50,606 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Get query data: {} 2014-12-15 21:58:50,736 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:58:50,738 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: procheat - 4 bytes 2014-12-15 21:58:50,740 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: procheat - 44.4 2014-12-15 21:58:50,743 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '44.4' to datatype: FLOAT 2014-12-15 21:58:50,755 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, procheat, {} 2014-12-15 21:58:50,775 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: procheat, containing 44.4 2014-12-15 21:58:50,786 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - procheat - 44.4 2014-12-15 21:58:50,794 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:58:50,796 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: cpuusage - 4 bytes 2014-12-15 21:58:50,803 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: cpuusage - 24.09 2014-12-15 21:58:50,842 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '24.09' to datatype: FLOAT 2014-12-15 21:58:50,846 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:50,871 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=24.09, var=75 2014-12-15 21:58:50,873 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:50,896 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:50,916 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:50,936 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:50,946 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=24.09, var=75 2014-12-15 21:58:50,948 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:50,950 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=24.09, var=25 2014-12-15 21:58:50,952 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:51,006 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:51,026 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:51,016 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"procheat","id":1,"value":44.4,"group":"values"} } 2014-12-15 21:58:51,016 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:51,059 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=24.09, var=25 2014-12-15 21:58:51,076 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:51,082 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:58:51,084 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:58:51,096 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:51,098 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=24.09, var=75 2014-12-15 21:58:51,100 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:51,102 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:51,104 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:51,142 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:51,144 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=24.09, var=75 2014-12-15 21:58:51,157 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:51,159 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=24.09, var=25 2014-12-15 21:58:51,161 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:51,163 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:51,185 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:51,197 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:51,199 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=24.09, var=25 2014-12-15 21:58:51,201 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:51,213 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:58:51,215 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:58:51,217 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:51,225 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=24.09, var=75 2014-12-15 21:58:51,245 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:51,247 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:51,249 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:51,251 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:51,253 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=24.09, var=75 2014-12-15 21:58:51,268 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:51,270 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=24.09, var=25 2014-12-15 21:58:51,272 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:51,285 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:51,287 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:51,288 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:51,290 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=24.09, var=25 2014-12-15 21:58:51,293 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:51,301 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:58:51,302 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:58:51,321 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:51,323 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=24.09, var=75 2014-12-15 21:58:51,330 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:51,331 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:51,333 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:51,345 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:51,347 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=24.09, var=75 2014-12-15 21:58:51,349 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:51,351 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=24.09, var=25 2014-12-15 21:58:51,354 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:58:51,366 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:58:51,367 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:58:51,369 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:58:51,371 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=24.09, var=25 2014-12-15 21:58:51,374 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:58:51,383 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:58:51,384 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:58:51,396 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, cpuusage, {} 2014-12-15 21:58:51,399 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: cpuusage, containing 24.09 2014-12-15 21:58:51,402 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"cpuusage","id":1,"value":24.09,"group":"values"} } 2014-12-15 21:58:51,406 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - cpuusage - 24.09 2014-12-15 21:58:51,412 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:58:51,418 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: memusage - 4 bytes 2014-12-15 21:58:51,427 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: memusage - 14.87 2014-12-15 21:58:51,441 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '14.87' to datatype: FLOAT 2014-12-15 21:58:51,460 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, memusage, {} 2014-12-15 21:58:51,478 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: memusage, containing 14.87 2014-12-15 21:58:51,486 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:58:51,488 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: diskspace - 4 bytes 2014-12-15 21:58:51,491 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: diskspace - 9592.3 2014-12-15 21:58:51,493 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '9592.3' to datatype: FLOAT 2014-12-15 21:58:51,503 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"memusage","id":1,"value":14.87,"group":"values"} } 2014-12-15 21:58:51,520 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, diskspace, {} 2014-12-15 21:58:51,542 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: diskspace, containing 9592.3 2014-12-15 21:58:51,553 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"diskspace","id":1,"value":9592.3,"group":"values"} } 2014-12-15 21:58:51,691 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - memusage - 14.87 2014-12-15 21:58:51,916 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - diskspace - 9592.3 2014-12-15 21:58:54,251 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - GET /jsonrpc.json?rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22DeviceService.getFavoriteDevices%22,%22id%22:%22DeviceService.getFavoriteDevices%22}&_=1418680731519 HTTP/1.1 2014-12-15 21:58:54,261 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - GET /jsonrpc.json?rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22MediaService.getFavorites%22,%22id%22:%22MediaService.getFavorites%22}&_=1418680731520 HTTP/1.1 2014-12-15 21:58:54,276 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - GET /jsonrpc.json?rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22MacroService.getFavoriteMacros%22,%22id%22:%22MacroService.getFavoriteMacros%22}&_=1418680731518 HTTP/1.1 2014-12-15 21:58:54,289 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Host: 192.168.1.6:8080 2014-12-15 21:58:54,292 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Connection: keep-alive 2014-12-15 21:58:54,292 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Host: 192.168.1.6:8080 2014-12-15 21:58:54,296 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Connection: keep-alive 2014-12-15 21:58:54,299 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept: */* 2014-12-15 21:58:54,302 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - X-Requested-With: XMLHttpRequest 2014-12-15 21:58:54,302 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Host: 192.168.1.6:8080 2014-12-15 21:58:54,306 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Connection: keep-alive 2014-12-15 21:58:54,308 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept: */* 2014-12-15 21:58:54,311 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - X-Requested-With: XMLHttpRequest 2014-12-15 21:58:54,335 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept: */* 2014-12-15 21:58:54,341 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - X-Requested-With: XMLHttpRequest 2014-12-15 21:58:54,348 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/39.0.2171.95 Safari/537.36 2014-12-15 21:58:54,360 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Referer: http://192.168.1.6:8080/desktop/index.html 2014-12-15 21:58:54,363 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Encoding: gzip, deflate, sdch 2014-12-15 21:58:54,377 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/39.0.2171.95 Safari/537.36 2014-12-15 21:58:54,381 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/39.0.2171.95 Safari/537.36 2014-12-15 21:58:54,397 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Referer: http://192.168.1.6:8080/desktop/index.html 2014-12-15 21:58:54,400 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Encoding: gzip, deflate, sdch 2014-12-15 21:58:54,403 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Language: en-US,en;q=0.8 2014-12-15 21:58:54,415 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Language: en-US,en;q=0.8 2014-12-15 21:58:54,428 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Cookie: key=ecbfc2c4-2420-4019-ba6c-3cd44d4aa577 2014-12-15 21:58:54,431 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - 2014-12-15 21:58:54,407 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Referer: http://192.168.1.6:8080/desktop/index.html 2014-12-15 21:58:54,438 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Encoding: gzip, deflate, sdch 2014-12-15 21:58:54,441 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Language: en-US,en;q=0.8 2014-12-15 21:58:54,433 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Having header collection: {REQUEST=/jsonrpc.json, PLAINFILE=jsonrpc, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=json, QUERYSTRING=rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22DeviceService.getFavoriteDevices%22,%22id%22:%22DeviceService.getFavoriteDevices%22}&_=1418680731519} 2014-12-15 21:58:54,444 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Cookie: key=ecbfc2c4-2420-4019-ba6c-3cd44d4aa577 2014-12-15 21:58:54,456 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Cookie: key=ecbfc2c4-2420-4019-ba6c-3cd44d4aa577 2014-12-15 21:58:54,468 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - 2014-12-15 21:58:54,471 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Having header collection: {REQUEST=/jsonrpc.json, PLAINFILE=jsonrpc, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=json, QUERYSTRING=rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22MacroService.getFavoriteMacros%22,%22id%22:%22MacroService.getFavoriteMacros%22}&_=1418680731518} 2014-12-15 21:58:54,473 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.services.clients.http.HTTPClientHandler - 192.168.1.24 - GET: /jsonrpc.json 2014-12-15 21:58:54,487 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - 2014-12-15 21:58:54,497 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Having header collection: {REQUEST=/jsonrpc.json, PLAINFILE=jsonrpc, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=json, QUERYSTRING=rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22MediaService.getFavorites%22,%22id%22:%22MediaService.getFavorites%22}&_=1418680731520} 2014-12-15 21:58:54,499 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.services.clients.http.HTTPClientHandler - 192.168.1.24 - GET: /jsonrpc.json 2014-12-15 21:58:54,501 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Complete constructed from header: {REQUEST=/jsonrpc.json, PLAINFILE=jsonrpc, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=json, QUERYSTRING=rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22MediaService.getFavorites%22,%22id%22:%22MediaService.getFavorites%22}&_=1418680731520} 2014-12-15 21:58:54,459 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.services.clients.http.HTTPClientHandler - 192.168.1.24 - GET: /jsonrpc.json 2014-12-15 21:58:54,506 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Complete constructed from header: {REQUEST=/jsonrpc.json, PLAINFILE=jsonrpc, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=json, QUERYSTRING=rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22DeviceService.getFavoriteDevices%22,%22id%22:%22DeviceService.getFavoriteDevices%22}&_=1418680731519} 2014-12-15 21:58:54,510 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Complete constructed from header: {REQUEST=/jsonrpc.json, PLAINFILE=jsonrpc, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=json, QUERYSTRING=rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22MacroService.getFavoriteMacros%22,%22id%22:%22MacroService.getFavoriteMacros%22}&_=1418680731518} 2014-12-15 21:58:54,540 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Get query data: {rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22MacroService.getFavoriteMacros%22,%22id%22:%22MacroService.getFavoriteMacros%22}, _=1418680731518} 2014-12-15 21:58:54,546 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Get query data: {rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22DeviceService.getFavoriteDevices%22,%22id%22:%22DeviceService.getFavoriteDevices%22}, _=1418680731519} 2014-12-15 21:58:54,549 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - JSON String to parse: {"jsonrpc": "2.0", "method": "DeviceService.getFavoriteDevices","id":"DeviceService.getFavoriteDevices"} 2014-12-15 21:58:54,551 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Parsed JSON Object: {method=DeviceService.getFavoriteDevices, id=DeviceService.getFavoriteDevices, jsonrpc=2.0} 2014-12-15 21:58:54,554 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Set request id: DeviceService.getFavoriteDevices 2014-12-15 21:58:54,571 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.AbstractRPCMethodExecutor - Searching without parameter set for getFavoriteDevices in DeviceService 2014-12-15 21:58:54,556 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Get query data: {rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22MediaService.getFavorites%22,%22id%22:%22MediaService.getFavorites%22}, _=1418680731520} 2014-12-15 21:58:54,578 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - JSON String to parse: {"jsonrpc": "2.0", "method": "MediaService.getFavorites","id":"MediaService.getFavorites"} 2014-12-15 21:58:54,580 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Parsed JSON Object: {method=MediaService.getFavorites, id=MediaService.getFavorites, jsonrpc=2.0} 2014-12-15 21:58:54,582 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Set request id: MediaService.getFavorites 2014-12-15 21:58:54,582 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - JSON String to parse: {"jsonrpc": "2.0", "method": "MacroService.getFavoriteMacros","id":"MacroService.getFavoriteMacros"} 2014-12-15 21:58:54,586 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Parsed JSON Object: {method=MacroService.getFavoriteMacros, id=MacroService.getFavoriteMacros, jsonrpc=2.0} 2014-12-15 21:58:54,588 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Set request id: MacroService.getFavoriteMacros 2014-12-15 21:58:54,590 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.AbstractRPCMethodExecutor - Searching without parameter set for getFavoriteMacros in MacroService 2014-12-15 21:58:54,584 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.AbstractRPCMethodExecutor - Searching without parameter set for getFavorites in MediaService 2014-12-15 21:58:54,623 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Response data: {data=[], success=true, message=} 2014-12-15 21:58:54,627 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Response data: {data=[], success=true, message=} 2014-12-15 21:58:54,712 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Response data: {data=[{friendlyname=Rasp server, locationname=Location unknown, categoryconstant=PIDOME, categoryname=PiDome, location=1, id=1, category=2, commandgroups=[{name=Device values, id=values, commands=[{commandtype=data, currentvalue=14.87, typedetails={visualtype=, graphtype=time-series, shortcut=1, datatype=float, prefix=, visual=false, commandset=[], id=memusage, label=Memory usage, deviceCommandValue=14.87, suffix=MB, graph=true}}, {commandtype=data, currentvalue=44.4, typedetails={visualtype=, graphtype=time-series, datatype=float, prefix=, visual=false, commandset=[], id=procheat, label=Pi temperature, deviceCommandValue=44.4, suffix=°C, graph=true}}, {commandtype=data, currentvalue=24.09, typedetails={visualtype=, graphtype=time-series, shortcut=0, datatype=float, prefix=, visual=false, commandset=[], id=cpuusage, label=CPU load, deviceCommandValue=24.09, suffix=%, graph=true}}, {commandtype=data, currentvalue=9592.3, typedetails={visualtype=, graphtype=time-series, datatype=float, prefix=, visual=false, commandset=[], id=diskspace, label=Disk space, deviceCommandValue=9592.3, suffix=MB, graph=true}}]}]}], success=true, message=} 2014-12-15 21:58:54,894 [WebSocketWorker-19] DEBUG org.pidome.server.services.clients.websockets.WebHttpWSService - New connection: 192.168.1.24 - / 2014-12-15 21:58:54,921 [WebSocketWorker-19] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - JSON String to parse: {"jsonrpc":"2.0", "id":"ClientService.resume", "method":"ClientService.resume", "params": {"key":"ecbfc2c4-2420-4019-ba6c-3cd44d4aa577"}} 2014-12-15 21:58:54,924 [WebSocketWorker-19] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Parsed JSON Object: {method=ClientService.resume, id=ClientService.resume, jsonrpc=2.0, params={key=ecbfc2c4-2420-4019-ba6c-3cd44d4aa577}} 2014-12-15 21:58:54,926 [WebSocketWorker-19] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Set request id: ClientService.resume 2014-12-15 21:58:54,938 [WebSocketWorker-19] DEBUG org.pidome.server.services.clients.websockets.WebHttpWSService - Client at 192.168.1.24 is authorized as client for web interface 2014-12-15 21:58:55,141 [WebSocketWorker-19] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Response data: {data={code=200, auth=true, message=Authorized by legal web user., key=}, success=true, message=} 2014-12-15 21:58:55,145 [WebSocketWorker-19] DEBUG org.pidome.server.services.clients.websockets.WebHttpWSService - Sending auth result {"jsonrpc":"2.0", "id": "ClientService.resume","result":{"data":{"code":200,"auth":true,"message":"Authorized by legal web user.","key":""},"success":true,"message":""}} to /192.168.1.24:64039 2014-12-15 21:58:55,149 [WebSocketWorker-19] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Response data: {data={code=200, auth=true, message=Authorized by legal web user., key=}, success=true, message=} 2014-12-15 21:58:59,825 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - GET /desktop/driversedit.html?requesttype=ajax&_=1418680731521 HTTP/1.1 2014-12-15 21:58:59,828 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Host: 192.168.1.6:8080 2014-12-15 21:58:59,829 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Connection: keep-alive 2014-12-15 21:58:59,831 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept: text/html, */*; q=0.01 2014-12-15 21:58:59,839 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - X-Requested-With: XMLHttpRequest 2014-12-15 21:58:59,842 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/39.0.2171.95 Safari/537.36 2014-12-15 21:58:59,845 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Referer: http://192.168.1.6:8080/desktop/index.html 2014-12-15 21:58:59,846 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Encoding: gzip, deflate, sdch 2014-12-15 21:58:59,849 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Language: en-US,en;q=0.8 2014-12-15 21:58:59,851 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Cookie: key=ecbfc2c4-2420-4019-ba6c-3cd44d4aa577 2014-12-15 21:58:59,853 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - 2014-12-15 21:58:59,859 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Having header collection: {REQUEST=/desktop/driversedit.html, PLAINFILE=desktop/driversedit, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=html, QUERYSTRING=requesttype=ajax&_=1418680731521} 2014-12-15 21:58:59,862 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.services.clients.http.HTTPClientHandler - 192.168.1.24 - GET: /desktop/driversedit.html 2014-12-15 21:58:59,866 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Complete constructed from header: {REQUEST=/desktop/driversedit.html, PLAINFILE=desktop/driversedit, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=html, QUERYSTRING=requesttype=ajax&_=1418680731521} 2014-12-15 21:58:59,894 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Get query data: {requesttype=ajax, _=1418680731521} 2014-12-15 21:59:00,707 [TriggerTimeRun::21:59] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 21:59 in trigger event 'Set Night' 2014-12-15 21:59:00,710 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:59 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 00:00(00:00) 2014-12-15 21:59:00,712 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:59 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 06:00(06:00) 2014-12-15 21:59:00,725 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:59 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 00:00(00:00) 2014-12-15 21:59:00,727 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:59 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 06:00(06:00) 2014-12-15 21:59:00,729 [TriggerTimeRun::21:59] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 21:59 in trigger event 'Set Morning' 2014-12-15 21:59:00,731 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:59 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 05:59(05:59) 2014-12-15 21:59:00,733 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:59 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 12:00(12:00) 2014-12-15 21:59:00,746 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:59 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 05:59(05:59) 2014-12-15 21:59:00,747 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:59 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 12:00(12:00) 2014-12-15 21:59:00,749 [TriggerTimeRun::21:59] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 21:59 in trigger event 'Set Afternoon' 2014-12-15 21:59:00,757 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:59 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 11:59(11:59) 2014-12-15 21:59:00,759 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:59 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 18:00(18:00) 2014-12-15 21:59:00,761 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:59 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 11:59(11:59) 2014-12-15 21:59:00,763 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 21:59 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 18:00(18:00) 2014-12-15 21:59:00,764 [TriggerTimeRun::21:59] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 21:59 in trigger event 'Set Evening' 2014-12-15 21:59:00,778 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:59 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 17:59(17:59) 2014-12-15 21:59:00,785 [TriggerTimeRun::21:59] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 21:59 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 23:59(23:59) 2014-12-15 21:59:03,364 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - GET /jsonrpc.json?rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22HardwareService.getSoftwareDriverPresentation%22,%20%22params%22:%20{%22port%22:%22/dev/ttyUSB0%22}%20%22id%22:%22HardwareService.getSoftwareDriverPresentation%22}&_=1418680731522 HTTP/1.1 2014-12-15 21:59:03,376 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Host: 192.168.1.6:8080 2014-12-15 21:59:03,378 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Connection: keep-alive 2014-12-15 21:59:03,380 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept: */* 2014-12-15 21:59:03,382 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - X-Requested-With: XMLHttpRequest 2014-12-15 21:59:03,396 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - User-Agent: Mozilla/5.0 (Windows NT 6.1; WOW64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/39.0.2171.95 Safari/537.36 2014-12-15 21:59:03,398 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Referer: http://192.168.1.6:8080/desktop/index.html 2014-12-15 21:59:03,400 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Encoding: gzip, deflate, sdch 2014-12-15 21:59:03,402 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Accept-Language: en-US,en;q=0.8 2014-12-15 21:59:03,404 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Cookie: key=ecbfc2c4-2420-4019-ba6c-3cd44d4aa577 2014-12-15 21:59:03,417 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - 2014-12-15 21:59:03,419 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Having header collection: {REQUEST=/jsonrpc.json, PLAINFILE=jsonrpc, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=json, QUERYSTRING=rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22HardwareService.getSoftwareDriverPresentation%22,%20%22params%22:%20{%22port%22:%22/dev/ttyUSB0%22}%20%22id%22:%22HardwareService.getSoftwareDriverPresentation%22}&_=1418680731522} 2014-12-15 21:59:03,421 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.services.clients.http.HTTPClientHandler - 192.168.1.24 - GET: /jsonrpc.json 2014-12-15 21:59:03,423 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Complete constructed from header: {REQUEST=/jsonrpc.json, PLAINFILE=jsonrpc, METHOD=GET, HOST=192.168.1.6:8080, FILETYPE=json, QUERYSTRING=rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22HardwareService.getSoftwareDriverPresentation%22,%20%22params%22:%20{%22port%22:%22/dev/ttyUSB0%22}%20%22id%22:%22HardwareService.getSoftwareDriverPresentation%22}&_=1418680731522} 2014-12-15 21:59:03,439 [WEBCLIENT:192.168.1.24] TRACE org.pidome.server.services.clients.http.HTTPClientHandler - Get query data: {rpc={%22jsonrpc%22:%20%222.0%22,%20%22method%22:%20%22HardwareService.getSoftwareDriverPresentation%22,%20%22params%22:%20{%22port%22:%22/dev/ttyUSB0%22}%20%22id%22:%22HardwareService.getSoftwareDriverPresentation%22}, _=1418680731522} 2014-12-15 21:59:03,442 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - JSON String to parse: {"jsonrpc": "2.0", "method": "HardwareService.getSoftwareDriverPresentation", "params": {"port":"/dev/ttyUSB0"} "id":"HardwareService.getSoftwareDriverPresentation"} 2014-12-15 21:59:03,456 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Parsed JSON Object: {method=HardwareService.getSoftwareDriverPresentation, id=HardwareService.getSoftwareDriverPresentation, jsonrpc=2.0, params={port=/dev/ttyUSB0}} 2014-12-15 21:59:03,457 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Set request id: HardwareService.getSoftwareDriverPresentation 2014-12-15 21:59:03,460 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.AbstractRPCMethodExecutor - Searching named parameter set for getSoftwareDriverPresentation in HardwareService 2014-12-15 21:59:03,462 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.AbstractRPCMethodExecutor - Found param key: port 2014-12-15 21:59:03,464 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.AbstractRPCMethodExecutor - searching for getSoftwareDriverPresentation in HardwareService 2014-12-15 21:59:03,478 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.AbstractRPCMethodExecutor - Declared params for getSoftwareDriverPresentation : [class java.lang.String] 2014-12-15 21:59:03,480 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.AbstractRPCMethodExecutor - Passed in params for 'getSoftwareDriverPresentation': [/dev/ttyUSB0] 2014-12-15 21:59:03,516 [WEBCLIENT:192.168.1.24] DEBUG org.pidome.server.system.rpc.PidomeJSONRPC - Response data: {data={presentation=[{description=Information about the hardware used by this driver, title=Hardware link, content=[{label=Hardware, type=SIMPLE_NVP, content=Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC}, {label=Hardware port, type=SIMPLE_NVP, content=/dev/ttyUSB0}]}, {description=Gateway information, title=Gateway info, content=[{label=Version, type=SIMPLE_NVP, content=Waiting for gateway}, {label=Last receive time, type=SIMPLE_NVP, content=15-12-2014 22:58:34}, {label=Last send time, type=SIMPLE_NVP, content=15-12-2014 22:58:34}]}, {description=When a new node is added it will be displayed below. You will then have the option to add the node to the server. When in AUTO mode you can only add one sensor at a time. When using fixed addresses you can add multiple at the same time. Also, if you mix AUTO and fixed, always, but always add the fixed first otherwise the address allocations of the AUTO node can allocate a fixed one. It is required for the nodes to use presentation., title=New nodes presentation, content=[{label=Address request presentation, type=LIST_NVP, content=[]}, {label=Presentation, type=COMPLEX_NVP, content={}}]}, {description=Below is a list of last known 20 messages, title=Last known messages, content=[{label=Messages list, type=LIST_NVP, content=[{custom_driver_function={identifier=clearLogList, function_label=Clear log list, function_id=customFunction}}]}]}], driver=MySensors USB (serial) driver API 1.4, port=/dev/ttyUSB0, hardware=Future Technology Devices International, Ltd, FT232 USB-Serial (UART) IC}, success=true, message=} 2014-12-15 21:59:51,570 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:59:51,572 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: procheat - 4 bytes 2014-12-15 21:59:51,577 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: procheat - 43.3 2014-12-15 21:59:51,580 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '43.3' to datatype: FLOAT 2014-12-15 21:59:51,582 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, procheat, {} 2014-12-15 21:59:51,584 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: procheat, containing 43.3 2014-12-15 21:59:51,588 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"procheat","id":1,"value":43.3,"group":"values"} } 2014-12-15 21:59:51,596 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - procheat - 43.3 2014-12-15 21:59:51,608 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:59:51,610 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: cpuusage - 4 bytes 2014-12-15 21:59:51,612 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: cpuusage - 19.25 2014-12-15 21:59:51,621 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '19.25' to datatype: FLOAT 2014-12-15 21:59:51,641 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,646 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=19.25, var=75 2014-12-15 21:59:51,648 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:59:51,650 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:59:51,661 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:59:51,666 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,668 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=19.25, var=75 2014-12-15 21:59:51,669 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:59:51,671 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=19.25, var=25 2014-12-15 21:59:51,673 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:59:51,676 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:59:51,678 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:59:51,679 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,685 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=19.25, var=25 2014-12-15 21:59:51,687 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:59:51,689 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:59:51,690 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:59:51,692 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,694 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=19.25, var=75 2014-12-15 21:59:51,699 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:59:51,709 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:59:51,711 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:59:51,712 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,714 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=19.25, var=75 2014-12-15 21:59:51,721 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:59:51,723 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=19.25, var=25 2014-12-15 21:59:51,736 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:59:51,738 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:59:51,739 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:59:51,741 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,768 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=19.25, var=25 2014-12-15 21:59:51,771 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:59:51,772 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:59:51,774 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:59:51,780 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,785 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=19.25, var=75 2014-12-15 21:59:51,787 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:59:51,795 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:59:51,797 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:59:51,805 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,807 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=19.25, var=75 2014-12-15 21:59:51,809 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:59:51,811 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=19.25, var=25 2014-12-15 21:59:51,813 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:59:51,814 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:59:51,825 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:59:51,826 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,828 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=19.25, var=25 2014-12-15 21:59:51,830 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:59:51,832 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:59:51,833 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:59:51,842 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,844 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=19.25, var=75 2014-12-15 21:59:51,851 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:59:51,852 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:59:51,854 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:59:51,861 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,863 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=19.25, var=75 2014-12-15 21:59:51,865 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:59:51,872 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: EQUAL_MORE, subject=19.25, var=25 2014-12-15 21:59:51,873 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: false 2014-12-15 21:59:51,882 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: false 2014-12-15 21:59:51,883 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was false 2014-12-15 21:59:51,890 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Parent rule was null/true 2014-12-15 21:59:51,892 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Having new subject data checking as FLOAT with check type: LESS, subject=19.25, var=25 2014-12-15 21:59:51,894 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.compare.AutomationComparison - Comparison result: true 2014-12-15 21:59:51,896 [pool-4-thread-1] DEBUG org.pidome.server.services.automations.rule.logic.compare.AutomationCompareList - Rule compare list result with check type AND: true 2014-12-15 21:59:51,897 [pool-4-thread-1] TRACE org.pidome.server.services.automations.rule.logic.AutomationIf - Last if rule was true 2014-12-15 21:59:51,899 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, cpuusage, {} 2014-12-15 21:59:51,901 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: cpuusage, containing 19.25 2014-12-15 21:59:51,906 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - cpuusage - 19.25 2014-12-15 21:59:51,911 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:59:51,913 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: memusage - 4 bytes 2014-12-15 21:59:51,904 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"cpuusage","id":1,"value":19.25,"group":"values"} } 2014-12-15 21:59:51,926 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: memusage - 12.89 2014-12-15 21:59:51,929 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '12.89' to datatype: FLOAT 2014-12-15 21:59:51,931 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, memusage, {} 2014-12-15 21:59:51,934 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: memusage, containing 12.89 2014-12-15 21:59:51,946 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"memusage","id":1,"value":12.89,"group":"values"} } 2014-12-15 21:59:51,943 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.peripherals.hardware.PeripheralHardwareDriver - Data received from device: 4 byte(s) 2014-12-15 21:59:51,974 [pool-4-thread-1] TRACE org.pidome.driver.driver.nativeServerDriver.NativeServerDriver - Got from hardware driver: diskspace - 4 bytes 2014-12-15 21:59:51,977 [pool-4-thread-1] DEBUG org.pidome.driver.device.pidomeServerDevice.PidomeServerDevice - Handling: diskspace - 9592.26 2014-12-15 21:59:51,979 [pool-4-thread-1] TRACE org.pidome.server.connector.drivers.devices.devicestructure.DeviceControl - Converting '9592.26' to datatype: FLOAT 2014-12-15 21:59:51,981 [pool-4-thread-1] TRACE org.pidome.server.system.hardware.devices.DeviceStruct - Called dispatchClientData: values, diskspace, {} 2014-12-15 21:59:51,985 [pool-6-thread-1] DEBUG org.pidome.server.connector.plugins.hooks.DeviceHook - Handling for device org.pidome.driver.device.pidomeServerDevice with group values, control: diskspace, containing 9592.26 2014-12-15 21:59:52,012 [pool-6-thread-1] TRACE org.pidome.server.services.clients.RemoteClients.RemoteClientsConnectionPool - BROADCAST_ALL: {"jsonrpc":"2.0","method":"DeviceService.sendDevice","params": {"control":"diskspace","id":1,"value":9592.26,"group":"values"} } 2014-12-15 21:59:52,117 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - memusage - 12.89 2014-12-15 21:59:52,287 [pool-7-thread-1] DEBUG org.pidome.server.system.hardware.devices.Devices - Got storage data: 1 - values - diskspace - 9592.26 2014-12-15 22:00:00,719 [THREAD:TimeMinuteUpdater] DEBUG org.pidome.server.system.datastorage.RoundRobinDataStorage - Hourly update of field: values_memusage 2014-12-15 22:00:00,856 [THREAD:TimeMinuteUpdater] DEBUG org.pidome.server.system.datastorage.RoundRobinDataStorage - Hourly update of field: values_procheat 2014-12-15 22:00:00,979 [THREAD:TimeMinuteUpdater] DEBUG org.pidome.server.system.datastorage.RoundRobinDataStorage - Hourly update of field: values_cpuusage 2014-12-15 22:00:01,139 [THREAD:TimeMinuteUpdater] DEBUG org.pidome.server.system.datastorage.RoundRobinDataStorage - Hourly update of field: values_diskspace 2014-12-15 22:00:01,407 [THREAD:TimeMinuteUpdater] DEBUG org.pidome.server.system.datastorage.RoundRobinDataStorage - Hourly update of field: 0_V_TEMP 2014-12-15 22:00:01,416 [TriggerTimeRun::22:00] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 22:00 in trigger event 'Set Night' 2014-12-15 22:00:01,418 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 22:00 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 00:00(00:00) 2014-12-15 22:00:01,420 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 22:00 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 06:00(06:00) 2014-12-15 22:00:01,422 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 22:00 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 00:00(00:00) 2014-12-15 22:00:01,477 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 22:00 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 06:00(06:00) 2014-12-15 22:00:01,478 [TriggerTimeRun::22:00] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 22:00 in trigger event 'Set Morning' 2014-12-15 22:00:01,480 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 22:00 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 05:59(05:59) 2014-12-15 22:00:01,483 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 22:00 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 12:00(12:00) 2014-12-15 22:00:01,506 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 22:00 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 05:59(05:59) 2014-12-15 22:00:01,508 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 22:00 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 12:00(12:00) 2014-12-15 22:00:01,509 [TriggerTimeRun::22:00] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 22:00 in trigger event 'Set Afternoon' 2014-12-15 22:00:01,511 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 22:00 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 11:59(11:59) 2014-12-15 22:00:01,513 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 22:00 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 18:00(18:00) 2014-12-15 22:00:01,516 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 22:00 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 11:59(11:59) 2014-12-15 22:00:01,534 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: false for value 22:00 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 18:00(18:00) 2014-12-15 22:00:01,536 [TriggerTimeRun::22:00] DEBUG org.pidome.server.services.triggerservice.TriggerEvent - Checking for value match: daytime_FIXED_ALL - 22:00 in trigger event 'Set Evening' 2014-12-15 22:00:01,538 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 22:00 in equation daytime_FIXED_ALL with matchtype GREATERTHEN with matchsubject 17:59(17:59) 2014-12-15 22:00:01,540 [TriggerTimeRun::22:00] TRACE org.pidome.server.services.triggerservice.rules.RuleSubject - Returning new result: true for value 22:00 in equation daytime_FIXED_ALL with matchtype LESSTHEN with matchsubject 23:59(23:59) 2014-12-15 22:00:01,706 [THREAD:TimeMinuteUpdater] DEBUG org.pidome.server.system.datastorage.RoundRobinDataStorage - Hourly update of field: INTERNAL_I_BATTERY_LEVEL