==> /var/log/openhab/events.log <== 2022-09-20 22:23:20.763 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.229 to 1.226 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:20.833 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 114 fps=0.5 q=2.0 size=N/A time=00:03:43.40 bitrate=N/A speed=0.993x 2022-09-20 22:23:21.352 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 114 fps=0.5 q=2.0 size=N/A time=00:03:43.40 bitrate=N/A speed=0.991x ==> /var/log/openhab/events.log <== 2022-09-20 22:23:21.464 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Linh_Lastseen' changed from 2022-09-20T22:22:51.345+0700 to 2022-09-20T22:23:21.417+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:21.878 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 114 fps=0.5 q=2.0 size=N/A time=00:03:43.40 bitrate=N/A speed=0.989x 2022-09-20 22:23:22.430 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 114 fps=0.5 q=2.0 size=N/A time=00:03:43.40 bitrate=N/A speed=0.986x 2022-09-20 22:23:22.943 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 115 fps=0.5 q=2.0 size=N/A time=00:03:45.40 bitrate=N/A speed=0.993x 2022-09-20 22:23:23.464 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 115 fps=0.5 q=2.0 size=N/A time=00:03:45.40 bitrate=N/A speed=0.991x 2022-09-20 22:23:23.952 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 115 fps=0.5 q=2.0 size=N/A time=00:03:45.40 bitrate=N/A speed=0.989x 2022-09-20 22:23:24.670 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 116 fps=0.5 q=2.0 size=N/A time=00:03:47.40 bitrate=N/A speed=0.994x ==> /var/log/openhab/events.log <== 2022-09-20 22:23:24.842 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from ONLINE to UNINITIALIZED ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:24.853 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Stopping ffmpeg SNAPSHOT now when keepalive is:8 2022-09-20 22:23:24.858 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Unsubscribe 2022-09-20 22:23:24.902 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:s:Senderter:ActionNotSupportedter:NotImplementedThis optional method is not implemented ==> /var/log/openhab/events.log <== 2022-09-20 22:23:24.905 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from UNINITIALIZED to UNINITIALIZED (DISABLED) ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:26.924 [DEBUG] [amera.internal.onvif.OnvifConnection] - Eventloop is shutdown:true ==> /var/log/openhab/events.log <== 2022-09-20 22:23:28.907 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from UNINITIALIZED (DISABLED) to INITIALIZING ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:28.928 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:23:28.930 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:23:28.988 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:ManualfalseGMT+07:001523282022920 2022-09-20 22:23:28.990 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetCapabilities 2022-09-20 22:23:28.998 [DEBUG] [amera.internal.onvif.OnvifConnection] - Cameras UTC dateTime is:2022-9-20T15:23:28 2022-09-20 22:23:29.006 [DEBUG] [amera.internal.onvif.OnvifConnection] - Openhabs UTC dateTime is:2022-09-20T15:23:29.003Z 2022-09-20 22:23:29.051 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://192.168.0.214/onvif/device_servicefalsefalsefalsefalsefalsetruefalsefalsefalsefalse200210220230240242161218061812falsefalsefalsefalse00falsefalsefalsefalsefalsefalsefalsefalsefalsefalse0falsehttp://192.168.0.214/onvif/event_servicetruetruefalsehttp://192.168.0.214/onvif/imaging_servicehttp://192.168.0.214/onvif/media_servicefalsetruetrue6http://192.168.0.214/onvif/deviceIO_service1000000 2022-09-20 22:23:29.053 [DEBUG] [amera.internal.onvif.OnvifConnection] - deviceXAddr:http://192.168.0.214/onvif/device_service 2022-09-20 22:23:29.055 [DEBUG] [amera.internal.onvif.OnvifConnection] - eventsXAddr:http://192.168.0.214/onvif/event_service 2022-09-20 22:23:29.057 [DEBUG] [amera.internal.onvif.OnvifConnection] - mediaXAddr:http://192.168.0.214/onvif/media_service 2022-09-20 22:23:29.059 [TRACE] [amera.internal.onvif.OnvifConnection] - Camera must not support PTZ, it failed to give a :http://192.168.0.214/onvif/device_servicefalsefalsefalsefalsefalsetruefalsefalsefalsefalse200210220230240242161218061812falsefalsefalsefalse00falsefalsefalsefalsefalsefalsefalsefalsefalsefalse0falsehttp://192.168.0.214/onvif/event_servicetruetruefalsehttp://192.168.0.214/onvif/imaging_servicehttp://192.168.0.214/onvif/media_servicefalsetruetrue6http://192.168.0.214/onvif/deviceIO_service1000000 2022-09-20 22:23:29.061 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetProfiles 2022-09-20 22:23:29.120 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:Profile000VideoSource0002VideoSource000VideoEncoder0001H265192010806.000000251409650MainIPv4224.1.2.44000064falsePT60SMetadata0001falsefalsetns1:Media/ConfigurationChangedtrueIPv4224.1.2.44000064falsePT60SProfile001VideoSource0002VideoSource000VideoEncoder0011H2646404804.00000010164020MainIPv4224.1.2.44001664falsePT60SMetadata0011falsefalsetns1:Media/ConfigurationChangedtrueIPv4224.1.2.44001664falsePT60S 2022-09-20 22:23:29.124 [TRACE] [amera.internal.onvif.OnvifConnection] - String was found:Profile000 2022-09-20 22:23:29.126 [TRACE] [amera.internal.onvif.OnvifConnection] - String was found:Profile001 2022-09-20 22:23:29.129 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSnapshotUri 2022-09-20 22:23:29.135 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetStreamUri 2022-09-20 22:23:29.143 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetEventProperties 2022-09-20 22:23:29.150 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetServiceCapabilities 2022-09-20 22:23:29.178 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:s:Senderter:ActionNotSupportedter:NotImplementedThis optional method is not implemented 2022-09-20 22:23:29.214 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/EventPortType/GetEventPropertiesResponsehttp://www.onvif.org/onvif/ver10/topics/topicns.xmltruehttp://docs.oasis-open.org/wsn/t-1/TopicExpression/Concretehttp://www.onvif.org/ver10/tev/topicExpression/ConcreteSethttp://www.onvif.org/ver10/tev/messageContentFilter/ItemFilterhttp://www.onvif.org/onvif/ver10/schema/onvif.xsd 2022-09-20 22:23:29.216 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:CreatePullPointSubscription 2022-09-20 22:23:29.249 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:s:Senderter:ActionNotSupportedter:NotImplementedThis optional method is not implemented 2022-09-20 22:23:29.337 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/EventPortType/CreatePullPointSubscriptionResponsehttp://192.168.0.214/onvif/Subscription?Idx=32022-09-20T15:23:29Z2022-09-20T15:33:29Z 2022-09-20 22:23:29.339 [DEBUG] [amera.internal.onvif.OnvifConnection] - subscriptionXAddr=http://192.168.0.214/onvif/Subscription?Idx=3 2022-09-20 22:23:29.341 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:PullMessages 2022-09-20 22:23:29.352 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:rtsp://192.168.0.214:554/cam/realmonitor?channel=1&subtype=1&unicast=true&proto=OnviftruetruePT0S 2022-09-20 22:23:29.355 [DEBUG] [amera.internal.onvif.OnvifConnection] - GetStreamUri:rtsp://192.168.0.214:554/cam/realmonitor?channel=1&subtype=1&unicast=true&proto=Onvif 2022-09-20 22:23:29.428 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/PullPointSubscription/PullMessagesResponse2022-09-20T15:23:29Z2022-09-20T15:33:29Ztns1:VideoSource/MotionAlarm 2022-09-20 22:23:29.430 [DEBUG] [amera.internal.onvif.OnvifConnection] - Onvif Event Topic:VideoSource/MotionAlarm, Data:State, Value:false 2022-09-20 22:23:29.435 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Renew ==> /var/log/openhab/events.log <== 2022-09-20 22:23:29.437 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'CameraMotionAlarm' changed from ON to OFF ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:29.476 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://docs.oasis-open.org/wsn/bw-2/SubscriptionManager/RenewResponse2022-09-20T15:24:29Z2022-09-20T15:23:29Z 2022-09-20 22:23:29.478 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:PullMessages 2022-09-20 22:23:30.442 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/PullPointSubscription/PullMessagesResponse2022-09-20T15:23:30Z2022-09-20T15:24:29Ztns1:VideoSource/GlobalSceneChange/ImagingService 2022-09-20 22:23:30.445 [DEBUG] [amera.internal.onvif.OnvifConnection] - Onvif Event Topic:VideoSource/GlobalSceneChange/ImagingService, Data:State, Value:false 2022-09-20 22:23:30.447 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Renew 2022-09-20 22:23:30.504 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://docs.oasis-open.org/wsn/bw-2/SubscriptionManager/RenewResponse2022-09-20T15:24:30Z2022-09-20T15:23:30Z 2022-09-20 22:23:30.506 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:PullMessages ==> /var/log/openhab/events.log <== 2022-09-20 22:23:30.775 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Voltage' changed from 224 to 225 2022-09-20 22:23:30.785 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 199 to 198 2022-09-20 22:23:30.788 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.226 to 1.223 2022-09-20 22:23:32.670 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'LivingroomLightsSwitch_RSSI' changed from 94 to 92 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:32.936 [DEBUG] [era.internal.handler.IpCameraHandler] - Binding has no snapshot url. Will use your CPU and FFmpeg to create snapshots from the cameras RTSP. 2022-09-20 22:23:32.940 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Starting ffmpeg with this command now:-rtsp_transport tcp -threads 1 -skip_frame nokey -hide_banner -i rtsp://admin:********@192.168.0.214:554/cam/realmonitor?channel=1&subtype=0&unicast=true&proto=Onvif -an -vsync vfr -q:v 2 -update 1 http://127.0.0.1:8080/ipcamera/Livingroom_Imou/snapshot.jpg ==> /var/log/openhab/events.log <== 2022-09-20 22:23:32.943 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from INITIALIZING to ONLINE ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:34.471 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Input #0, rtsp, from 'rtsp://admin:secret@192.168.0.214:554/cam/realmonitor?channel=1&subtype=0&unicast=true&proto=Onvif': 2022-09-20 22:23:34.475 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Metadata: 2022-09-20 22:23:34.478 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - title : Media Server 2022-09-20 22:23:34.480 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Duration: N/A, start: 0.000000, bitrate: N/A 2022-09-20 22:23:34.482 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream #0:0: Video: hevc (Main), yuvj420p(pc, bt470bg/bt470bg/smpte170m), 1920x1080, 25 fps, 25 tbr, 90k tbn, 90k tbc 2022-09-20 22:23:34.484 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream #0:1: Audio: aac (LC), 16000 Hz, mono, fltp 2022-09-20 22:23:34.486 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream #0:2: Data: none 2022-09-20 22:23:34.488 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream mapping: 2022-09-20 22:23:34.490 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream #0:0 -> #0:0 (hevc (native) -> mjpeg (native)) 2022-09-20 22:23:34.492 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Press [q] to stop, [?] for help 2022-09-20 22:23:34.747 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Output #0, image2, to 'http://127.0.0.1:8080/ipcamera/Livingroom_Imou/snapshot.jpg': 2022-09-20 22:23:34.750 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Metadata: 2022-09-20 22:23:34.754 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - title : Media Server 2022-09-20 22:23:34.758 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - encoder : Lavf58.20.100 2022-09-20 22:23:34.762 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream #0:0: Video: mjpeg, yuvj420p(pc), 1920x1080, q=2-31, 200 kb/s, 25 fps, 25 tbn, 25 tbc 2022-09-20 22:23:34.765 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Metadata: 2022-09-20 22:23:34.769 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - encoder : Lavc58.35.100 mjpeg 2022-09-20 22:23:34.772 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Side data: 2022-09-20 22:23:34.777 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - cpb: bitrate max/min/avg: 0/0/200000 buffer size: 0 vbv_delay: -1 2022-09-20 22:23:34.991 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 1 fps=0.0 q=0.0 size=N/A time=00:00:00.00 bitrate=N/A speed= 0x 2022-09-20 22:23:35.508 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 1 fps=1.0 q=0.0 size=N/A time=00:00:00.00 bitrate=N/A speed= 0x 2022-09-20 22:23:35.992 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 2 fps=1.3 q=2.0 size=N/A time=00:00:00.04 bitrate=N/A speed=0.0264x 2022-09-20 22:23:36.512 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 2 fps=1.0 q=2.0 size=N/A time=00:00:00.04 bitrate=N/A speed=0.0197x ==> /var/log/openhab/events.log <== 2022-09-20 22:23:36.647 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Nam_Lastseen' changed from 2022-09-20T22:23:06.431+0700 to 2022-09-20T22:23:36.639+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:37.032 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 2 fps=0.8 q=2.0 size=N/A time=00:00:00.04 bitrate=N/A speed=0.0157x 2022-09-20 22:23:37.553 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 2 fps=0.7 q=2.0 size=N/A time=00:00:00.04 bitrate=N/A speed=0.013x 2022-09-20 22:23:38.108 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 3 fps=0.8 q=2.0 size=N/A time=00:00:02.00 bitrate=N/A speed=0.557x 2022-09-20 22:23:38.527 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/PullPointSubscription/PullMessagesResponse2022-09-20T15:23:38Z2022-09-20T15:24:30Z 2022-09-20 22:23:38.530 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Renew 2022-09-20 22:23:38.585 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://docs.oasis-open.org/wsn/bw-2/SubscriptionManager/RenewResponse2022-09-20T15:24:38Z2022-09-20T15:23:38Z 2022-09-20 22:23:38.587 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:PullMessages 2022-09-20 22:23:38.626 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 3 fps=0.7 q=2.0 size=N/A time=00:00:02.00 bitrate=N/A speed=0.487x 2022-09-20 22:23:39.144 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 3 fps=0.6 q=2.0 size=N/A time=00:00:02.00 bitrate=N/A speed=0.432x ==> /var/log/openhab/events.log <== 2022-09-20 22:23:39.250 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Binh_Lastseen' changed from 2022-09-20T22:23:08.936+0700 to 2022-09-20T22:23:39.241+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:39.830 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 4 fps=0.7 q=2.0 size=N/A time=00:00:04.00 bitrate=N/A speed=0.747x 2022-09-20 22:23:40.352 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 4 fps=0.7 q=2.0 size=N/A time=00:00:04.00 bitrate=N/A speed=0.681x ==> /var/log/openhab/events.log <== 2022-09-20 22:23:40.777 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 198 to 200 2022-09-20 22:23:40.784 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Total_Consumption' changed from 78.635 to 78.637 2022-09-20 22:23:40.788 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.223 to 1.229 2022-09-20 22:23:40.792 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Today_Consumption' changed from 7.014 to 7.016 2022-09-20 22:23:40.817 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'This_Month_Power_Cost' changed from 144237.33720 to 144241.08264 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:40.872 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 4 fps=0.6 q=2.0 size=N/A time=00:00:04.00 bitrate=N/A speed=0.626x 2022-09-20 22:23:41.391 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 4 fps=0.6 q=2.0 size=N/A time=00:00:04.00 bitrate=N/A speed=0.579x 2022-09-20 22:23:41.952 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 5 fps=0.7 q=2.0 size=N/A time=00:00:06.00 bitrate=N/A speed=0.805x 2022-09-20 22:23:42.473 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 5 fps=0.6 q=2.0 size=N/A time=00:00:06.00 bitrate=N/A speed=0.752x 2022-09-20 22:23:42.992 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 5 fps=0.6 q=2.0 size=N/A time=00:00:06.00 bitrate=N/A speed=0.707x 2022-09-20 22:23:43.489 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 5 fps=0.6 q=2.0 size=N/A time=00:00:06.00 bitrate=N/A speed=0.667x 2022-09-20 22:23:44.005 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 6 fps=0.6 q=2.0 size=N/A time=00:00:08.04 bitrate=N/A speed=0.845x 2022-09-20 22:23:44.525 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 6 fps=0.6 q=2.0 size=N/A time=00:00:08.04 bitrate=N/A speed=0.801x 2022-09-20 22:23:45.045 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 6 fps=0.6 q=2.0 size=N/A time=00:00:08.04 bitrate=N/A speed=0.761x 2022-09-20 22:23:45.563 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 6 fps=0.5 q=2.0 size=N/A time=00:00:08.04 bitrate=N/A speed=0.726x 2022-09-20 22:23:46.113 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 7 fps=0.6 q=2.0 size=N/A time=00:00:10.04 bitrate=N/A speed=0.865x 2022-09-20 22:23:46.601 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/PullPointSubscription/PullMessagesResponse2022-09-20T15:23:46Z2022-09-20T15:24:38Ztns1:VideoSource/MotionAlarm 2022-09-20 22:23:46.603 [DEBUG] [amera.internal.onvif.OnvifConnection] - Onvif Event Topic:VideoSource/MotionAlarm, Data:State, Value:true 2022-09-20 22:23:46.607 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Renew ==> /var/log/openhab/events.log <== 2022-09-20 22:23:46.610 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'CameraMotionAlarm' changed from OFF to ON ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:46.624 [DEBUG] [ng.ipcamera.internal.IpCameraActions] - Recording ipcamera.gif for 5 seconds. 2022-09-20 22:23:46.630 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Starting ffmpeg with this command now:-y -t 5 -hide_banner -loglevel warning -rtsp_transport tcp -i rtsp://admin:********@192.168.0.214:554/cam/realmonitor?channel=1&subtype=0&unicast=true&proto=Onvif -r 2 -filter_complex scale=-2:360:flags=lanczos,setpts=0.5*PTS,split[o1][o2];[o1]palettegen[p];[o2]fifo[o3];[o3][p]paletteuse /var/lib/openhab/ipcamera/Livingroom_Imou/ipcamera.gif ==> /var/log/openhab/events.log <== 2022-09-20 22:23:46.646 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'CameraRecordingGif' changed from 0 to 5 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:46.721 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 8 fps=0.7 q=2.0 size=N/A time=00:00:12.04 bitrate=N/A speed=0.983x 2022-09-20 22:23:46.724 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://docs.oasis-open.org/wsn/bw-2/SubscriptionManager/RenewResponse2022-09-20T15:24:46Z2022-09-20T15:23:46Z 2022-09-20 22:23:46.727 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:PullMessages 2022-09-20 22:23:47.440 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 8 fps=0.6 q=2.0 size=N/A time=00:00:12.04 bitrate=N/A speed=0.929x 2022-09-20 22:23:47.965 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 9 fps=0.7 q=2.0 size=N/A time=00:00:12.88 bitrate=N/A speed=0.955x 2022-09-20 22:23:48.486 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 9 fps=0.6 q=2.0 size=N/A time=00:00:12.88 bitrate=N/A speed=0.92x 2022-09-20 22:23:48.764 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - [swscaler @ 0x18b9a70] deprecated pixel format used, make sure you did set range correctly 2022-09-20 22:23:49.015 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 9 fps=0.6 q=2.0 size=N/A time=00:00:12.88 bitrate=N/A speed=0.886x 2022-09-20 22:23:49.533 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 9 fps=0.6 q=2.0 size=N/A time=00:00:12.88 bitrate=N/A speed=0.856x 2022-09-20 22:23:50.064 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 10 fps=0.6 q=2.0 size=N/A time=00:00:14.00 bitrate=N/A speed=0.899x 2022-09-20 22:23:50.603 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 10 fps=0.6 q=2.0 size=N/A time=00:00:14.00 bitrate=N/A speed=0.87x ==> /var/log/openhab/events.log <== 2022-09-20 22:23:50.793 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.229 to 1.232 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:51.119 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 10 fps=0.6 q=2.0 size=N/A time=00:00:14.00 bitrate=N/A speed=0.843x ==> /var/log/openhab/events.log <== 2022-09-20 22:23:51.609 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Linh_Lastseen' changed from 2022-09-20T22:23:21.417+0700 to 2022-09-20T22:23:51.600+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:51.850 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 11 fps=0.6 q=2.0 size=N/A time=00:00:16.00 bitrate=N/A speed=0.934x 2022-09-20 22:23:52.154 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 11 fps=0.6 q=2.0 size=N/A time=00:00:16.00 bitrate=N/A speed=0.907x 2022-09-20 22:23:52.639 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 11 fps=0.6 q=2.0 size=N/A time=00:00:16.00 bitrate=N/A speed=0.881x ==> /var/log/openhab/events.log <== 2022-09-20 22:23:52.785 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Bathroom_Humidity' changed from 69 to 70 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:23:53.161 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 11 fps=0.6 q=2.0 size=N/A time=00:00:16.00 bitrate=N/A speed=0.856x 2022-09-20 22:23:53.848 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 12 fps=0.6 q=2.0 size=N/A time=00:00:18.00 bitrate=N/A speed=0.929x 2022-09-20 22:23:54.365 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 12 fps=0.6 q=2.0 size=N/A time=00:00:18.00 bitrate=N/A speed=0.905x 2022-09-20 22:23:54.687 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/PullPointSubscription/PullMessagesResponse2022-09-20T15:23:54Z2022-09-20T15:24:46Z 2022-09-20 22:23:54.692 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Renew 2022-09-20 22:23:54.751 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://docs.oasis-open.org/wsn/bw-2/SubscriptionManager/RenewResponse2022-09-20T15:24:54Z2022-09-20T15:23:54Z 2022-09-20 22:23:54.753 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:PullMessages 2022-09-20 22:23:54.916 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 12 fps=0.6 q=2.0 size=N/A time=00:00:18.00 bitrate=N/A speed=0.882x 2022-09-20 22:23:55.393 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 12 fps=0.6 q=2.0 size=N/A time=00:00:18.00 bitrate=N/A speed=0.861x 2022-09-20 22:23:55.895 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 13 fps=0.6 q=2.0 size=N/A time=00:00:20.00 bitrate=N/A speed=0.934x 2022-09-20 22:23:56.429 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 13 fps=0.6 q=2.0 size=N/A time=00:00:20.00 bitrate=N/A speed=0.911x 2022-09-20 22:23:56.938 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 13 fps=0.6 q=2.0 size=N/A time=00:00:20.00 bitrate=N/A speed=0.891x 2022-09-20 22:23:57.465 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 13 fps=0.6 q=2.0 size=N/A time=00:00:20.00 bitrate=N/A speed=0.871x 2022-09-20 22:23:57.945 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 14 fps=0.6 q=2.0 size=N/A time=00:00:22.04 bitrate=N/A speed=0.939x 2022-09-20 22:23:58.465 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 14 fps=0.6 q=2.0 size=N/A time=00:00:22.04 bitrate=N/A speed=0.919x 2022-09-20 22:23:58.986 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 14 fps=0.6 q=2.0 size=N/A time=00:00:22.04 bitrate=N/A speed=0.899x 2022-09-20 22:23:59.538 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 14 fps=0.6 q=2.0 size=N/A time=00:00:22.04 bitrate=N/A speed=0.881x 2022-09-20 22:24:00.063 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 15 fps=0.6 q=2.0 size=N/A time=00:00:24.04 bitrate=N/A speed=0.941x 2022-09-20 22:24:00.580 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 15 fps=0.6 q=2.0 size=N/A time=00:00:24.04 bitrate=N/A speed=0.922x ==> /var/log/openhab/events.log <== 2022-09-20 22:24:00.825 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 200 to 208 2022-09-20 22:24:00.828 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.232 to 1.283 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:01.065 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 15 fps=0.6 q=2.0 size=N/A time=00:00:24.04 bitrate=N/A speed=0.904x 2022-09-20 22:24:01.585 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 15 fps=0.6 q=2.0 size=N/A time=00:00:24.04 bitrate=N/A speed=0.887x 2022-09-20 22:24:02.107 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 16 fps=0.6 q=2.0 size=N/A time=00:00:26.04 bitrate=N/A speed=0.943x 2022-09-20 22:24:02.625 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 16 fps=0.6 q=2.0 size=N/A time=00:00:26.04 bitrate=N/A speed=0.925x 2022-09-20 22:24:02.783 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/PullPointSubscription/PullMessagesResponse2022-09-20T15:24:02Z2022-09-20T15:24:54Z 2022-09-20 22:24:02.785 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Renew 2022-09-20 22:24:02.834 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://docs.oasis-open.org/wsn/bw-2/SubscriptionManager/RenewResponse2022-09-20T15:25:02Z2022-09-20T15:24:02Z 2022-09-20 22:24:02.837 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:PullMessages 2022-09-20 22:24:03.143 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 16 fps=0.6 q=2.0 size=N/A time=00:00:26.04 bitrate=N/A speed=0.908x 2022-09-20 22:24:03.888 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 17 fps=0.6 q=2.0 size=N/A time=00:00:28.04 bitrate=N/A speed=0.961x 2022-09-20 22:24:04.143 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 17 fps=0.6 q=2.0 size=N/A time=00:00:28.04 bitrate=N/A speed=0.945x 2022-09-20 22:24:04.663 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 17 fps=0.6 q=2.0 size=N/A time=00:00:28.04 bitrate=N/A speed=0.929x 2022-09-20 22:24:05.196 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 17 fps=0.6 q=2.0 size=N/A time=00:00:28.04 bitrate=N/A speed=0.913x 2022-09-20 22:24:05.895 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 18 fps=0.6 q=2.0 size=N/A time=00:00:30.04 bitrate=N/A speed=0.956x 2022-09-20 22:24:06.457 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 18 fps=0.6 q=2.0 size=N/A time=00:00:30.04 bitrate=N/A speed=0.94x ==> /var/log/openhab/events.log <== 2022-09-20 22:24:06.935 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Nam_Lastseen' changed from 2022-09-20T22:23:36.639+0700 to 2022-09-20T22:24:06.925+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:06.975 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 18 fps=0.6 q=2.0 size=N/A time=00:00:30.04 bitrate=N/A speed=0.925x 2022-09-20 22:24:07.463 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 18 fps=0.5 q=2.0 size=N/A time=00:00:30.04 bitrate=N/A speed=0.911x 2022-09-20 22:24:07.984 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 19 fps=0.6 q=2.0 size=N/A time=00:00:32.04 bitrate=N/A speed=0.956x 2022-09-20 22:24:08.505 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 19 fps=0.6 q=2.0 size=N/A time=00:00:32.04 bitrate=N/A speed=0.942x 2022-09-20 22:24:09.024 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 19 fps=0.6 q=2.0 size=N/A time=00:00:32.04 bitrate=N/A speed=0.928x 2022-09-20 22:24:09.544 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 19 fps=0.5 q=2.0 size=N/A time=00:00:32.04 bitrate=N/A speed=0.914x ==> /var/log/openhab/events.log <== 2022-09-20 22:24:10.017 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Binh_Lastseen' changed from 2022-09-20T22:23:39.241+0700 to 2022-09-20T22:24:10.006+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:10.096 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 20 fps=0.6 q=2.0 size=N/A time=00:00:34.04 bitrate=N/A speed=0.957x 2022-09-20 22:24:10.402 [DEBUG] [amera.internal.servlet.CameraServlet] - GET:/ipcamera.gif, received from 192.168.0.206 2022-09-20 22:24:10.617 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 20 fps=0.6 q=2.0 size=N/A time=00:00:34.04 bitrate=N/A speed=0.943x ==> /var/log/openhab/events.log <== 2022-09-20 22:24:10.792 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Total_Consumption' changed from 78.637 to 78.638 2022-09-20 22:24:10.824 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.283 to 1.227 2022-09-20 22:24:10.828 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Voltage' changed from 225 to 224 2022-09-20 22:24:10.832 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 208 to 199 2022-09-20 22:24:10.836 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Today_Consumption' changed from 7.016 to 7.017 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:10.878 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/PullPointSubscription/PullMessagesResponse2022-09-20T15:24:10Z2022-09-20T15:25:02Z 2022-09-20 22:24:10.883 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Renew 2022-09-20 22:24:10.953 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://docs.oasis-open.org/wsn/bw-2/SubscriptionManager/RenewResponse2022-09-20T15:25:10Z2022-09-20T15:24:10Z 2022-09-20 22:24:10.956 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:PullMessages 2022-09-20 22:24:11.137 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 20 fps=0.5 q=2.0 size=N/A time=00:00:34.04 bitrate=N/A speed=0.929x 2022-09-20 22:24:11.640 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 20 fps=0.5 q=2.0 size=N/A time=00:00:34.04 bitrate=N/A speed=0.916x 2022-09-20 22:24:12.145 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 21 fps=0.6 q=2.0 size=N/A time=00:00:36.04 bitrate=N/A speed=0.957x 2022-09-20 22:24:12.663 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 21 fps=0.5 q=2.0 size=N/A time=00:00:36.04 bitrate=N/A speed=0.944x 2022-09-20 22:24:13.183 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 21 fps=0.5 q=2.0 size=N/A time=00:00:36.04 bitrate=N/A speed=0.931x 2022-09-20 22:24:13.883 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 22 fps=0.6 q=2.0 size=N/A time=00:00:38.04 bitrate=N/A speed=0.965x 2022-09-20 22:24:14.416 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 22 fps=0.6 q=2.0 size=N/A time=00:00:38.04 bitrate=N/A speed=0.953x 2022-09-20 22:24:14.906 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 22 fps=0.5 q=2.0 size=N/A time=00:00:38.04 bitrate=N/A speed=0.941x 2022-09-20 22:24:15.431 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 22 fps=0.5 q=2.0 size=N/A time=00:00:38.04 bitrate=N/A speed=0.929x 2022-09-20 22:24:15.924 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 23 fps=0.6 q=2.0 size=N/A time=00:00:40.04 bitrate=N/A speed=0.966x 2022-09-20 22:24:16.428 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 23 fps=0.5 q=2.0 size=N/A time=00:00:40.04 bitrate=N/A speed=0.954x 2022-09-20 22:24:16.943 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 23 fps=0.5 q=2.0 size=N/A time=00:00:40.04 bitrate=N/A speed=0.943x 2022-09-20 22:24:17.464 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 23 fps=0.5 q=2.0 size=N/A time=00:00:40.04 bitrate=N/A speed=0.931x 2022-09-20 22:24:17.984 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 24 fps=0.6 q=2.0 size=N/A time=00:00:42.04 bitrate=N/A speed=0.966x 2022-09-20 22:24:18.504 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 24 fps=0.5 q=2.0 size=N/A time=00:00:42.04 bitrate=N/A speed=0.955x ==> /var/log/openhab/events.log <== 2022-09-20 22:24:18.609 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'CameraRecordingGif' changed from 5 to 0 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:18.961 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/PullPointSubscription/PullMessagesResponse2022-09-20T15:24:18Z2022-09-20T15:25:10Ztns1:VideoSource/MotionAlarm 2022-09-20 22:24:18.963 [DEBUG] [amera.internal.onvif.OnvifConnection] - Onvif Event Topic:VideoSource/MotionAlarm, Data:State, Value:false 2022-09-20 22:24:18.967 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Renew ==> /var/log/openhab/events.log <== 2022-09-20 22:24:18.971 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'CameraMotionAlarm' changed from ON to OFF ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:19.020 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://docs.oasis-open.org/wsn/bw-2/SubscriptionManager/RenewResponse2022-09-20T15:25:18Z2022-09-20T15:24:18Z 2022-09-20 22:24:19.023 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:PullMessages 2022-09-20 22:24:19.057 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 24 fps=0.5 q=2.0 size=N/A time=00:00:42.04 bitrate=N/A speed=0.944x 2022-09-20 22:24:19.576 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 24 fps=0.5 q=2.0 size=N/A time=00:00:42.04 bitrate=N/A speed=0.933x 2022-09-20 22:24:20.097 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 25 fps=0.5 q=2.0 size=N/A time=00:00:44.04 bitrate=N/A speed=0.966x 2022-09-20 22:24:20.577 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 25 fps=0.5 q=2.0 size=N/A time=00:00:44.04 bitrate=N/A speed=0.955x ==> /var/log/openhab/events.log <== 2022-09-20 22:24:20.749 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.227 to 1.23 2022-09-20 22:24:20.760 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 199 to 200 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:21.103 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 25 fps=0.5 q=2.0 size=N/A time=00:00:44.04 bitrate=N/A speed=0.945x 2022-09-20 22:24:21.688 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 25 fps=0.5 q=2.0 size=N/A time=00:00:44.04 bitrate=N/A speed=0.934x ==> /var/log/openhab/events.log <== 2022-09-20 22:24:21.736 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Linh_Lastseen' changed from 2022-09-20T22:23:51.600+0700 to 2022-09-20T22:24:21.636+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:22.158 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 26 fps=0.5 q=2.0 size=N/A time=00:00:46.04 bitrate=N/A speed=0.966x 2022-09-20 22:24:22.677 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 26 fps=0.5 q=2.0 size=N/A time=00:00:46.04 bitrate=N/A speed=0.955x ==> /var/log/openhab/events.log <== 2022-09-20 22:24:30.756 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.23 to 1.22 2022-09-20 22:24:30.785 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 200 to 198 2022-09-20 22:24:30.787 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Today_Consumption' changed from 7.017 to 7.018 2022-09-20 22:24:30.790 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Total_Consumption' changed from 78.638 to 78.639 2022-09-20 22:24:32.657 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'LivingroomLightsSwitch_RSSI' changed from 92 to 90 2022-09-20 22:24:32.693 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'LivingroomLightsSwitch_Humidity' changed from 65.1 to 65 2022-09-20 22:24:32.696 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Livingroom_Humidity' changed from 65.1 to 65 2022-09-20 22:24:37.682 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Nam_Lastseen' changed from 2022-09-20T22:24:06.925+0700 to 2022-09-20T22:24:37.674+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:37.942 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Stopping ffmpeg SNAPSHOT now when keepalive is:8 ==> /var/log/openhab/events.log <== 2022-09-20 22:24:37.943 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): FFmpeg Snapshots Stopped: Check your camera can be reached. ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:37.945 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Unsubscribe 2022-09-20 22:24:37.960 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:24:37.963 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:24:37.969 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:24:37.978 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:24:38.002 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:24:40.038 [DEBUG] [amera.internal.onvif.OnvifConnection] - Eventloop is shutdown:true ==> /var/log/openhab/events.log <== 2022-09-20 22:24:40.681 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Binh_Lastseen' changed from 2022-09-20T22:24:10.006+0700 to 2022-09-20T22:24:40.672+0700 2022-09-20 22:24:40.803 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Today_Consumption' changed from 7.018 to 7.019 2022-09-20 22:24:40.807 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Total_Consumption' changed from 78.639 to 78.64 2022-09-20 22:24:40.811 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.22 to 1.221 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:41.969 [DEBUG] [era.internal.handler.IpCameraHandler] - About to connect to the IP Camera using the ONVIF PORT at IP:192.168.0.214:80 2022-09-20 22:24:41.971 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:24:41.973 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:24:41.998 [DEBUG] [era.internal.handler.IpCameraHandler] - Binding has no snapshot url. Will use your CPU and FFmpeg to create snapshots from the cameras RTSP. 2022-09-20 22:24:42.005 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Starting ffmpeg with this command now:-rtsp_transport tcp -threads 1 -skip_frame nokey -hide_banner -i rtsp://admin:********@192.168.0.214:554/cam/realmonitor?channel=1&subtype=0&unicast=true&proto=Onvif -an -vsync vfr -q:v 2 -update 1 http://127.0.0.1:8080/ipcamera/Livingroom_Imou/snapshot.jpg ==> /var/log/openhab/events.log <== 2022-09-20 22:24:42.007 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from OFFLINE (COMMUNICATION_ERROR): FFmpeg Snapshots Stopped: Check your camera can be reached. to ONLINE 2022-09-20 22:24:42.344 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'This_Month_Power_Cost' changed from 144241.08264 to 144246.7008 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:43.002 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:24:43.004 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime ==> /var/log/openhab/events.log <== 2022-09-20 22:24:47.435 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Kitchen_Humidity' changed from 65 to 65.1 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:47.986 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:24:48.002 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. ==> /var/log/openhab/events.log <== 2022-09-20 22:24:50.776 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power_Factor' changed from 0.72 to 0.73 2022-09-20 22:24:50.779 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.221 to 1.237 2022-09-20 22:24:50.786 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 198 to 202 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:51.011 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Stopping ffmpeg SNAPSHOT now when keepalive is:8 ==> /var/log/openhab/events.log <== 2022-09-20 22:24:51.012 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): FFmpeg Snapshots Stopped: Check your camera can be reached. ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:51.015 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Unsubscribe 2022-09-20 22:24:51.024 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:24:51.031 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:24:51.041 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:24:51.052 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:24:51.071 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:24:51.071 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:24:51.074 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. ==> /var/log/openhab/events.log <== 2022-09-20 22:24:51.814 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Linh_Lastseen' changed from 2022-09-20T22:24:21.636+0700 to 2022-09-20T22:24:51.795+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:53.081 [DEBUG] [amera.internal.onvif.OnvifConnection] - Eventloop is shutdown:true 2022-09-20 22:24:55.041 [DEBUG] [era.internal.handler.IpCameraHandler] - About to connect to the IP Camera using the ONVIF PORT at IP:192.168.0.214:80 2022-09-20 22:24:55.043 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:24:55.046 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:24:55.051 [DEBUG] [era.internal.handler.IpCameraHandler] - Binding has no snapshot url. Will use your CPU and FFmpeg to create snapshots from the cameras RTSP. ==> /var/log/openhab/events.log <== 2022-09-20 22:24:55.060 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from OFFLINE (COMMUNICATION_ERROR): FFmpeg Snapshots Stopped: Check your camera can be reached. to ONLINE ==> /var/log/openhab/openhab.log <== 2022-09-20 22:24:55.063 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Starting ffmpeg with this command now:-rtsp_transport tcp -threads 1 -skip_frame nokey -hide_banner -i rtsp://admin:********@192.168.0.214:554/cam/realmonitor?channel=1&subtype=0&unicast=true&proto=Onvif -an -vsync vfr -q:v 2 -update 1 http://127.0.0.1:8080/ipcamera/Livingroom_Imou/snapshot.jpg 2022-09-20 22:24:56.060 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:24:56.062 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime ==> /var/log/openhab/events.log <== 2022-09-20 22:25:00.747 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power_Factor' changed from 0.73 to 0.72 2022-09-20 22:25:00.751 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.237 to 1.22 2022-09-20 22:25:00.755 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 202 to 197 2022-09-20 22:25:00.758 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Total_Consumption' changed from 78.64 to 78.641 2022-09-20 22:25:00.760 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Today_Consumption' changed from 7.019 to 7.02 2022-09-20 22:25:00.783 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'This_Month_Power_Cost' changed from 144246.7008 to 144248.57352 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:01.057 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:25:01.069 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:25:04.068 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Stopping ffmpeg SNAPSHOT now when keepalive is:8 ==> /var/log/openhab/events.log <== 2022-09-20 22:25:04.070 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): FFmpeg Snapshots Stopped: Check your camera can be reached. ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:04.071 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Unsubscribe 2022-09-20 22:25:04.084 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:25:04.087 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:25:04.094 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:25:04.113 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:25:04.130 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:25:04.130 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:25:04.134 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:25:06.142 [DEBUG] [amera.internal.onvif.OnvifConnection] - Eventloop is shutdown:true ==> /var/log/openhab/events.log <== 2022-09-20 22:25:08.093 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Nam_Lastseen' changed from 2022-09-20T22:24:37.674+0700 to 2022-09-20T22:25:08.085+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:08.094 [DEBUG] [era.internal.handler.IpCameraHandler] - About to connect to the IP Camera using the ONVIF PORT at IP:192.168.0.214:80 2022-09-20 22:25:08.097 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:25:08.098 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:25:08.103 [DEBUG] [era.internal.handler.IpCameraHandler] - Binding has no snapshot url. Will use your CPU and FFmpeg to create snapshots from the cameras RTSP. ==> /var/log/openhab/events.log <== 2022-09-20 22:25:08.112 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from OFFLINE (COMMUNICATION_ERROR): FFmpeg Snapshots Stopped: Check your camera can be reached. to ONLINE ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:08.114 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Starting ffmpeg with this command now:-rtsp_transport tcp -threads 1 -skip_frame nokey -hide_banner -i rtsp://admin:********@192.168.0.214:554/cam/realmonitor?channel=1&subtype=0&unicast=true&proto=Onvif -an -vsync vfr -q:v 2 -update 1 http://127.0.0.1:8080/ipcamera/Livingroom_Imou/snapshot.jpg 2022-09-20 22:25:09.112 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:25:09.114 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime ==> /var/log/openhab/events.log <== 2022-09-20 22:25:10.767 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power_Factor' changed from 0.72 to 0.73 2022-09-20 22:25:10.772 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.22 to 1.263 2022-09-20 22:25:10.783 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 197 to 206 2022-09-20 22:25:10.901 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Binh_Lastseen' changed from 2022-09-20T22:24:40.672+0700 to 2022-09-20T22:25:10.890+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:14.120 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:25:14.136 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:25:17.120 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Stopping ffmpeg SNAPSHOT now when keepalive is:8 ==> /var/log/openhab/events.log <== 2022-09-20 22:25:17.121 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from ONLINE to OFFLINE (COMMUNICATION_ERROR): FFmpeg Snapshots Stopped: Check your camera can be reached. ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:17.122 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:Unsubscribe 2022-09-20 22:25:17.137 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:25:17.139 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:25:17.147 [DEBUG] [amera.internal.onvif.OnvifConnection] - Connecting 192.168.0.214 to ONVIF 2022-09-20 22:25:17.151 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSystemDateAndTime 2022-09-20 22:25:17.179 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:25:17.179 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:25:17.181 [DEBUG] [amera.internal.onvif.OnvifConnection] - Camera is not reachable on ONVIF port:80 or the port may be wrong. 2022-09-20 22:25:17.964 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:ManualfalseGMT+07:000015200011 2022-09-20 22:25:17.966 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetCapabilities 2022-09-20 22:25:17.974 [DEBUG] [amera.internal.onvif.OnvifConnection] - Cameras UTC dateTime is:2000-1-1T0:0:15 2022-09-20 22:25:17.980 [DEBUG] [amera.internal.onvif.OnvifConnection] - Openhabs UTC dateTime is:2022-09-20T15:25:17.980Z 2022-09-20 22:25:17.984 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:ManualfalseGMT+07:000015200011 2022-09-20 22:25:17.986 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetCapabilities 2022-09-20 22:25:17.992 [DEBUG] [amera.internal.onvif.OnvifConnection] - Cameras UTC dateTime is:2000-1-1T0:0:15 2022-09-20 22:25:18.000 [DEBUG] [amera.internal.onvif.OnvifConnection] - Openhabs UTC dateTime is:2022-09-20T15:25:17.999Z 2022-09-20 22:25:18.044 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://192.168.0.214/onvif/device_servicefalsefalsefalsefalsefalsetruefalsefalsefalsefalse200210220230240242161218061812falsefalsefalsefalse00falsefalsefalsefalsefalsefalsefalsefalsefalsefalse0falsehttp://192.168.0.214/onvif/event_servicetruetruefalsehttp://192.168.0.214/onvif/imaging_servicehttp://192.168.0.214/onvif/media_servicefalsetruetrue6http://192.168.0.214/onvif/deviceIO_service1000000 2022-09-20 22:25:18.047 [DEBUG] [amera.internal.onvif.OnvifConnection] - deviceXAddr:http://192.168.0.214/onvif/device_service 2022-09-20 22:25:18.049 [DEBUG] [amera.internal.onvif.OnvifConnection] - eventsXAddr:http://192.168.0.214/onvif/event_service 2022-09-20 22:25:18.051 [DEBUG] [amera.internal.onvif.OnvifConnection] - mediaXAddr:http://192.168.0.214/onvif/media_service 2022-09-20 22:25:18.054 [TRACE] [amera.internal.onvif.OnvifConnection] - Camera must not support PTZ, it failed to give a :http://192.168.0.214/onvif/device_servicefalsefalsefalsefalsefalsetruefalsefalsefalsefalse200210220230240242161218061812falsefalsefalsefalse00falsefalsefalsefalsefalsefalsefalsefalsefalsefalse0falsehttp://192.168.0.214/onvif/event_servicetruetruefalsehttp://192.168.0.214/onvif/imaging_servicehttp://192.168.0.214/onvif/media_servicefalsetruetrue6http://192.168.0.214/onvif/deviceIO_service1000000 2022-09-20 22:25:18.056 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetProfiles 2022-09-20 22:25:18.090 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://192.168.0.214/onvif/device_servicefalsefalsefalsefalsefalsetruefalsefalsefalsefalse200210220230240242161218061812falsefalsefalsefalse00falsefalsefalsefalsefalsefalsefalsefalsefalsefalse0falsehttp://192.168.0.214/onvif/event_servicetruetruefalsehttp://192.168.0.214/onvif/imaging_servicehttp://192.168.0.214/onvif/media_servicefalsetruetrue6http://192.168.0.214/onvif/deviceIO_service1000000 2022-09-20 22:25:18.092 [DEBUG] [amera.internal.onvif.OnvifConnection] - deviceXAddr:http://192.168.0.214/onvif/device_service 2022-09-20 22:25:18.094 [DEBUG] [amera.internal.onvif.OnvifConnection] - eventsXAddr:http://192.168.0.214/onvif/event_service 2022-09-20 22:25:18.096 [DEBUG] [amera.internal.onvif.OnvifConnection] - mediaXAddr:http://192.168.0.214/onvif/media_service 2022-09-20 22:25:18.098 [TRACE] [amera.internal.onvif.OnvifConnection] - Camera must not support PTZ, it failed to give a :http://192.168.0.214/onvif/device_servicefalsefalsefalsefalsefalsetruefalsefalsefalsefalse200210220230240242161218061812falsefalsefalsefalse00falsefalsefalsefalsefalsefalsefalsefalsefalsefalse0falsehttp://192.168.0.214/onvif/event_servicetruetruefalsehttp://192.168.0.214/onvif/imaging_servicehttp://192.168.0.214/onvif/media_servicefalsetruetrue6http://192.168.0.214/onvif/deviceIO_service1000000 2022-09-20 22:25:18.099 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetProfiles 2022-09-20 22:25:18.133 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:Profile000VideoSource0002VideoSource000VideoEncoder0001H265192010806.000000251409650MainIPv4224.1.2.44000064falsePT60SMetadata0001falsefalsetns1:Media/ConfigurationChangedtrueIPv4224.1.2.44000064falsePT60SProfile001VideoSource0002VideoSource000VideoEncoder0011H2646404804.00000010164020MainIPv4224.1.2.44001664falsePT60SMetadata0011falsefalsetns1:Media/ConfigurationChangedtrueIPv4224.1.2.44001664falsePT60S 2022-09-20 22:25:18.135 [TRACE] [amera.internal.onvif.OnvifConnection] - String was found:Profile000 2022-09-20 22:25:18.138 [TRACE] [amera.internal.onvif.OnvifConnection] - String was found:Profile001 2022-09-20 22:25:18.139 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSnapshotUri 2022-09-20 22:25:18.144 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetStreamUri 2022-09-20 22:25:18.150 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetEventProperties 2022-09-20 22:25:18.158 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetServiceCapabilities 2022-09-20 22:25:18.180 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:Profile000VideoSource0002VideoSource000VideoEncoder0001H265192010806.000000251409650MainIPv4224.1.2.44000064falsePT60SMetadata0001falsefalsetns1:Media/ConfigurationChangedtrueIPv4224.1.2.44000064falsePT60SProfile001VideoSource0002VideoSource000VideoEncoder0011H2646404804.00000010164020MainIPv4224.1.2.44001664falsePT60SMetadata0011falsefalsetns1:Media/ConfigurationChangedtrueIPv4224.1.2.44001664falsePT60S 2022-09-20 22:25:18.182 [TRACE] [amera.internal.onvif.OnvifConnection] - String was found:Profile000 2022-09-20 22:25:18.185 [TRACE] [amera.internal.onvif.OnvifConnection] - String was found:Profile001 2022-09-20 22:25:18.186 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetSnapshotUri 2022-09-20 22:25:18.191 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetStreamUri 2022-09-20 22:25:18.201 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetEventProperties 2022-09-20 22:25:18.205 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:GetServiceCapabilities 2022-09-20 22:25:18.519 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:s:Senderter:ActionNotSupportedter:NotImplementedThis optional method is not implemented 2022-09-20 22:25:18.540 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:s:Senderter:ActionNotSupportedter:NotImplementedThis optional method is not implemented 2022-09-20 22:25:18.578 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/EventPortType/GetEventPropertiesResponsehttp://www.onvif.org/onvif/ver10/topics/topicns.xmltruehttp://docs.oasis-open.org/wsn/t-1/TopicExpression/Concretehttp://www.onvif.org/ver10/tev/topicExpression/ConcreteSethttp://www.onvif.org/ver10/tev/messageContentFilter/ItemFilterhttp://www.onvif.org/onvif/ver10/schema/onvif.xsd 2022-09-20 22:25:18.582 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:CreatePullPointSubscription 2022-09-20 22:25:18.591 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:s:Senderter:ActionNotSupportedter:NotImplementedThis optional method is not implemented 2022-09-20 22:25:18.718 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:s:Senderter:ActionNotSupportedter:NotImplementedThis optional method is not implemented 2022-09-20 22:25:18.761 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/EventPortType/GetEventPropertiesResponsehttp://www.onvif.org/onvif/ver10/topics/topicns.xmltruehttp://docs.oasis-open.org/wsn/t-1/TopicExpression/Concretehttp://www.onvif.org/ver10/tev/topicExpression/ConcreteSethttp://www.onvif.org/ver10/tev/messageContentFilter/ItemFilterhttp://www.onvif.org/onvif/ver10/schema/onvif.xsd 2022-09-20 22:25:18.763 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:CreatePullPointSubscription 2022-09-20 22:25:18.776 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:rtsp://192.168.0.214:554/cam/realmonitor?channel=1&subtype=1&unicast=true&proto=OnviftruetruePT0S 2022-09-20 22:25:18.778 [DEBUG] [amera.internal.onvif.OnvifConnection] - GetStreamUri:rtsp://192.168.0.214:554/cam/realmonitor?channel=1&subtype=1&unicast=true&proto=Onvif 2022-09-20 22:25:18.892 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:http://www.onvif.org/ver10/events/wsdl/EventPortType/CreatePullPointSubscriptionResponsehttp://192.168.0.214/onvif/Subscription?Idx=12000-01-01T00:00:16Z2000-01-01T00:10:16Z 2022-09-20 22:25:18.894 [DEBUG] [amera.internal.onvif.OnvifConnection] - subscriptionXAddr=http://192.168.0.214/onvif/Subscription?Idx=1 2022-09-20 22:25:18.897 [TRACE] [amera.internal.onvif.OnvifConnection] - Sending ONVIF request:PullMessages 2022-09-20 22:25:18.911 [TRACE] [amera.internal.onvif.OnvifConnection] - Onvif reply is:rtsp://192.168.0.214:554/cam/realmonitor?channel=1&subtype=1&unicast=true&proto=OnviftruetruePT0S 2022-09-20 22:25:18.913 [DEBUG] [amera.internal.onvif.OnvifConnection] - GetStreamUri:rtsp://192.168.0.214:554/cam/realmonitor?channel=1&subtype=1&unicast=true&proto=Onvif 2022-09-20 22:25:19.183 [DEBUG] [g.ipcamera.internal.onvif.OnvifCodec] - Exception on ONVIF connection: Connection reset by peer 2022-09-20 22:25:19.186 [DEBUG] [g.ipcamera.internal.onvif.OnvifCodec] - Exception on ONVIF connection: Connection reset by peer 2022-09-20 22:25:19.194 [DEBUG] [amera.internal.onvif.OnvifConnection] - Eventloop is shutdown:true ==> /var/log/openhab/events.log <== 2022-09-20 22:25:20.777 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power_Factor' changed from 0.73 to 0.72 2022-09-20 22:25:20.792 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 206 to 199 2022-09-20 22:25:20.794 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.263 to 1.226 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:21.147 [DEBUG] [era.internal.handler.IpCameraHandler] - Binding has no snapshot url. Will use your CPU and FFmpeg to create snapshots from the cameras RTSP. ==> /var/log/openhab/events.log <== 2022-09-20 22:25:21.152 [INFO ] [ab.event.ThingStatusInfoChangedEvent] - Thing 'ipcamera:onvif:Livingroom_Imou' changed from OFFLINE (COMMUNICATION_ERROR): FFmpeg Snapshots Stopped: Check your camera can be reached. to ONLINE ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:21.151 [DEBUG] [hab.binding.ipcamera.internal.Ffmpeg] - Starting ffmpeg with this command now:-rtsp_transport tcp -threads 1 -skip_frame nokey -hide_banner -i rtsp://admin:********@192.168.0.214:554/cam/realmonitor?channel=1&subtype=0&unicast=true&proto=Onvif -an -vsync vfr -q:v 2 -update 1 http://127.0.0.1:8080/ipcamera/Livingroom_Imou/snapshot.jpg ==> /var/log/openhab/events.log <== 2022-09-20 22:25:21.913 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Linh_Lastseen' changed from 2022-09-20T22:24:51.795+0700 to 2022-09-20T22:25:21.906+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:22.687 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Input #0, rtsp, from 'rtsp://admin:secret@192.168.0.214:554/cam/realmonitor?channel=1&subtype=0&unicast=true&proto=Onvif': 2022-09-20 22:25:22.689 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Metadata: 2022-09-20 22:25:22.691 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - title : Media Server 2022-09-20 22:25:22.692 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Duration: N/A, start: 0.000000, bitrate: N/A 2022-09-20 22:25:22.694 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream #0:0: Video: hevc (Main), yuvj420p(pc, bt470bg/bt470bg/smpte170m), 1920x1080, 25 fps, 25 tbr, 90k tbn, 90k tbc 2022-09-20 22:25:22.696 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream #0:1: Audio: aac (LC), 16000 Hz, mono, fltp 2022-09-20 22:25:22.698 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream #0:2: Data: none 2022-09-20 22:25:22.700 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream mapping: 2022-09-20 22:25:22.702 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream #0:0 -> #0:0 (hevc (native) -> mjpeg (native)) 2022-09-20 22:25:22.703 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Press [q] to stop, [?] for help 2022-09-20 22:25:22.950 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Output #0, image2, to 'http://127.0.0.1:8080/ipcamera/Livingroom_Imou/snapshot.jpg': 2022-09-20 22:25:22.953 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Metadata: 2022-09-20 22:25:22.956 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - title : Media Server 2022-09-20 22:25:22.959 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - encoder : Lavf58.20.100 2022-09-20 22:25:22.977 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Stream #0:0: Video: mjpeg, yuvj420p(pc), 1920x1080, q=2-31, 200 kb/s, 25 fps, 25 tbn, 25 tbc 2022-09-20 22:25:22.979 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Metadata: 2022-09-20 22:25:22.982 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - encoder : Lavc58.35.100 mjpeg 2022-09-20 22:25:22.985 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - Side data: 2022-09-20 22:25:22.988 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - cpb: bitrate max/min/avg: 0/0/200000 buffer size: 0 vbv_delay: -1 2022-09-20 22:25:23.249 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 1 fps=0.0 q=0.0 size=N/A time=00:00:00.00 bitrate=N/A speed= 0x 2022-09-20 22:25:23.768 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 1 fps=1.0 q=0.0 size=N/A time=00:00:00.00 bitrate=N/A speed= 0x 2022-09-20 22:25:24.253 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 2 fps=1.3 q=2.0 size=N/A time=00:00:00.04 bitrate=N/A speed=0.0256x 2022-09-20 22:25:24.790 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 2 fps=1.0 q=2.0 size=N/A time=00:00:00.04 bitrate=N/A speed=0.0193x 2022-09-20 22:25:25.285 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 2 fps=0.8 q=2.0 size=N/A time=00:00:00.04 bitrate=N/A speed=0.0155x 2022-09-20 22:25:25.805 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 2 fps=0.6 q=2.0 size=N/A time=00:00:00.04 bitrate=N/A speed=0.0129x 2022-09-20 22:25:26.498 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 3 fps=0.8 q=2.0 size=N/A time=00:00:02.04 bitrate=N/A speed=0.536x 2022-09-20 22:25:27.069 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 3 fps=0.7 q=2.0 size=N/A time=00:00:02.04 bitrate=N/A speed=0.47x 2022-09-20 22:25:27.550 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 3 fps=0.6 q=2.0 size=N/A time=00:00:02.04 bitrate=N/A speed=0.42x 2022-09-20 22:25:28.089 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 3 fps=0.6 q=2.0 size=N/A time=00:00:02.04 bitrate=N/A speed=0.379x 2022-09-20 22:25:28.596 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 4 fps=0.7 q=2.0 size=N/A time=00:00:04.04 bitrate=N/A speed=0.684x 2022-09-20 22:25:29.107 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 4 fps=0.6 q=2.0 size=N/A time=00:00:04.04 bitrate=N/A speed=0.63x 2022-09-20 22:25:29.626 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 4 fps=0.6 q=2.0 size=N/A time=00:00:04.04 bitrate=N/A speed=0.583x 2022-09-20 22:25:30.326 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 5 fps=0.7 q=2.0 size=N/A time=00:00:06.28 bitrate=N/A speed=0.823x ==> /var/log/openhab/events.log <== 2022-09-20 22:25:30.862 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.226 to 1.233 2022-09-20 22:25:30.864 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 199 to 200 2022-09-20 22:25:30.866 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Total_Consumption' changed from 78.641 to 78.643 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:30.868 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 5 fps=0.6 q=2.0 size=N/A time=00:00:06.28 bitrate=N/A speed=0.772x ==> /var/log/openhab/events.log <== 2022-09-20 22:25:30.869 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Today_Consumption' changed from 7.02 to 7.022 2022-09-20 22:25:30.896 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'This_Month_Power_Cost' changed from 144248.57352 to 144252.31896 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:31.347 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 5 fps=0.6 q=2.0 size=N/A time=00:00:06.28 bitrate=N/A speed=0.726x 2022-09-20 22:25:31.867 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 5 fps=0.5 q=2.0 size=N/A time=00:00:06.28 bitrate=N/A speed=0.685x 2022-09-20 22:25:32.415 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 6 fps=0.6 q=2.0 size=N/A time=00:00:08.28 bitrate=N/A speed=0.854x ==> /var/log/openhab/events.log <== 2022-09-20 22:25:32.653 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'LivingroomLightsSwitch_RSSI' changed from 90 to 92 2022-09-20 22:25:32.661 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'LivingroomLightsSwitch_Humidity' changed from 65 to 64.9 2022-09-20 22:25:32.663 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Livingroom_Humidity' changed from 65 to 64.9 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:32.942 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 6 fps=0.6 q=2.0 size=N/A time=00:00:08.28 bitrate=N/A speed=0.81x 2022-09-20 22:25:33.455 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 6 fps=0.6 q=2.0 size=N/A time=00:00:08.28 bitrate=N/A speed=0.771x 2022-09-20 22:25:33.946 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 6 fps=0.5 q=2.0 size=N/A time=00:00:08.28 bitrate=N/A speed=0.736x 2022-09-20 22:25:34.467 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 7 fps=0.6 q=2.0 size=N/A time=00:00:10.28 bitrate=N/A speed=0.874x 2022-09-20 22:25:34.988 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 7 fps=0.6 q=2.0 size=N/A time=00:00:10.28 bitrate=N/A speed=0.836x 2022-09-20 22:25:35.506 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 8 fps=0.6 q=2.0 size=N/A time=00:00:12.28 bitrate=N/A speed=0.959x 2022-09-20 22:25:36.026 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 8 fps=0.6 q=2.0 size=N/A time=00:00:12.28 bitrate=N/A speed=0.922x 2022-09-20 22:25:36.574 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 8 fps=0.6 q=2.0 size=N/A time=00:00:12.28 bitrate=N/A speed=0.886x 2022-09-20 22:25:37.277 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 9 fps=0.6 q=2.0 size=N/A time=00:00:13.24 bitrate=N/A speed=0.908x 2022-09-20 22:25:37.786 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 9 fps=0.6 q=2.0 size=N/A time=00:00:13.24 bitrate=N/A speed=0.878x 2022-09-20 22:25:38.307 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 9 fps=0.6 q=2.0 size=N/A time=00:00:13.24 bitrate=N/A speed=0.848x ==> /var/log/openhab/events.log <== 2022-09-20 22:25:38.713 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Nam_Lastseen' changed from 2022-09-20T22:25:08.085+0700 to 2022-09-20T22:25:38.704+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:38.828 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 9 fps=0.6 q=2.0 size=N/A time=00:00:13.24 bitrate=N/A speed=0.821x 2022-09-20 22:25:39.347 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 10 fps=0.6 q=2.0 size=N/A time=00:00:15.24 bitrate=N/A speed=0.916x 2022-09-20 22:25:39.868 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 10 fps=0.6 q=2.0 size=N/A time=00:00:15.24 bitrate=N/A speed=0.887x 2022-09-20 22:25:40.415 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 10 fps=0.6 q=2.0 size=N/A time=00:00:15.24 bitrate=N/A speed=0.861x ==> /var/log/openhab/events.log <== 2022-09-20 22:25:40.773 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.233 to 1.227 2022-09-20 22:25:40.791 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 200 to 199 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:40.944 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 10 fps=0.5 q=2.0 size=N/A time=00:00:15.24 bitrate=N/A speed=0.837x ==> /var/log/openhab/events.log <== 2022-09-20 22:25:41.305 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Binh_Lastseen' changed from 2022-09-20T22:25:10.890+0700 to 2022-09-20T22:25:41.297+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:41.456 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 11 fps=0.6 q=2.0 size=N/A time=00:00:17.24 bitrate=N/A speed=0.92x 2022-09-20 22:25:41.988 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 12 fps=0.6 q=2.0 size=N/A time=00:00:19.24 bitrate=N/A speed=0.999x 2022-09-20 22:25:42.469 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 12 fps=0.6 q=2.0 size=N/A time=00:00:19.24 bitrate=N/A speed=0.973x 2022-09-20 22:25:42.995 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 12 fps=0.6 q=2.0 size=N/A time=00:00:19.24 bitrate=N/A speed=0.948x 2022-09-20 22:25:43.507 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 12 fps=0.6 q=2.0 size=N/A time=00:00:19.24 bitrate=N/A speed=0.925x 2022-09-20 22:25:44.027 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 13 fps=0.6 q=2.0 size=N/A time=00:00:19.84 bitrate=N/A speed=0.93x 2022-09-20 22:25:44.575 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 13 fps=0.6 q=2.0 size=N/A time=00:00:19.84 bitrate=N/A speed=0.907x 2022-09-20 22:25:45.095 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 13 fps=0.6 q=2.0 size=N/A time=00:00:19.84 bitrate=N/A speed=0.887x 2022-09-20 22:25:45.616 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 13 fps=0.6 q=2.0 size=N/A time=00:00:19.84 bitrate=N/A speed=0.866x 2022-09-20 22:25:46.108 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 14 fps=0.6 q=2.0 size=N/A time=00:00:21.84 bitrate=N/A speed=0.933x 2022-09-20 22:25:46.627 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 14 fps=0.6 q=2.0 size=N/A time=00:00:21.84 bitrate=N/A speed=0.913x 2022-09-20 22:25:47.148 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 14 fps=0.6 q=2.0 size=N/A time=00:00:21.84 bitrate=N/A speed=0.893x 2022-09-20 22:25:47.360 [DEBUG] [amera.internal.servlet.CameraServlet] - GET:/ipcamera.gif, received from 192.168.0.206 ==> /var/log/openhab/events.log <== 2022-09-20 22:25:47.460 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Kitchen_Humidity' changed from 65.1 to 65 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:47.879 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 15 fps=0.6 q=2.0 size=N/A time=00:00:23.84 bitrate=N/A speed=0.955x 2022-09-20 22:25:48.177 [DEBUG] [amera.internal.servlet.CameraServlet] - GET:/ipcamera.gif, received from 192.168.0.206 2022-09-20 22:25:48.196 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 15 fps=0.6 q=2.0 size=N/A time=00:00:23.84 bitrate=N/A speed=0.935x 2022-09-20 22:25:48.746 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 15 fps=0.6 q=2.0 size=N/A time=00:00:23.84 bitrate=N/A speed=0.916x 2022-09-20 22:25:49.255 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 15 fps=0.6 q=2.0 size=N/A time=00:00:23.84 bitrate=N/A speed=0.898x 2022-09-20 22:25:49.883 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 16 fps=0.6 q=2.0 size=N/A time=00:00:25.84 bitrate=N/A speed=0.95x 2022-09-20 22:25:50.416 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 16 fps=0.6 q=2.0 size=N/A time=00:00:25.84 bitrate=N/A speed=0.933x ==> /var/log/openhab/events.log <== 2022-09-20 22:25:50.755 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.227 to 1.231 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:50.908 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 16 fps=0.6 q=2.0 size=N/A time=00:00:25.84 bitrate=N/A speed=0.916x 2022-09-20 22:25:51.418 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 16 fps=0.6 q=2.0 size=N/A time=00:00:25.84 bitrate=N/A speed= 0.9x 2022-09-20 22:25:51.911 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 17 fps=0.6 q=2.0 size=N/A time=00:00:27.84 bitrate=N/A speed=0.953x ==> /var/log/openhab/events.log <== 2022-09-20 22:25:51.992 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Linh_Lastseen' changed from 2022-09-20T22:25:21.906+0700 to 2022-09-20T22:25:51.957+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:25:52.451 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 17 fps=0.6 q=2.0 size=N/A time=00:00:27.84 bitrate=N/A speed=0.937x 2022-09-20 22:25:52.970 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 17 fps=0.6 q=2.0 size=N/A time=00:00:27.84 bitrate=N/A speed=0.921x 2022-09-20 22:25:53.457 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 17 fps=0.6 q=2.0 size=N/A time=00:00:27.84 bitrate=N/A speed=0.905x 2022-09-20 22:25:53.977 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 18 fps=0.6 q=2.0 size=N/A time=00:00:29.84 bitrate=N/A speed=0.954x 2022-09-20 22:25:54.502 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 18 fps=0.6 q=2.0 size=N/A time=00:00:29.84 bitrate=N/A speed=0.938x 2022-09-20 22:25:55.016 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 18 fps=0.6 q=2.0 size=N/A time=00:00:29.84 bitrate=N/A speed=0.923x 2022-09-20 22:25:55.538 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 18 fps=0.5 q=2.0 size=N/A time=00:00:29.84 bitrate=N/A speed=0.909x 2022-09-20 22:25:56.091 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 19 fps=0.6 q=2.0 size=N/A time=00:00:31.84 bitrate=N/A speed=0.954x 2022-09-20 22:25:56.610 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 19 fps=0.6 q=2.0 size=N/A time=00:00:31.84 bitrate=N/A speed=0.94x 2022-09-20 22:25:57.130 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 19 fps=0.6 q=2.0 size=N/A time=00:00:31.84 bitrate=N/A speed=0.926x 2022-09-20 22:25:57.620 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 19 fps=0.5 q=2.0 size=N/A time=00:00:31.84 bitrate=N/A speed=0.912x 2022-09-20 22:25:58.140 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 20 fps=0.6 q=2.0 size=N/A time=00:00:33.84 bitrate=N/A speed=0.955x 2022-09-20 22:25:58.655 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 20 fps=0.6 q=2.0 size=N/A time=00:00:33.84 bitrate=N/A speed=0.941x 2022-09-20 22:25:59.178 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 20 fps=0.5 q=2.0 size=N/A time=00:00:33.84 bitrate=N/A speed=0.928x 2022-09-20 22:25:59.887 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 21 fps=0.6 q=2.0 size=N/A time=00:00:35.84 bitrate=N/A speed=0.964x 2022-09-20 22:26:00.450 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 21 fps=0.6 q=2.0 size=N/A time=00:00:35.84 bitrate=N/A speed=0.95x ==> /var/log/openhab/events.log <== 2022-09-20 22:26:00.758 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.231 to 1.238 2022-09-20 22:26:00.769 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 199 to 200 2022-09-20 22:26:00.772 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Today_Consumption' changed from 7.022 to 7.023 2022-09-20 22:26:00.775 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Total_Consumption' changed from 78.643 to 78.644 2022-09-20 22:26:00.799 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'This_Month_Power_Cost' changed from 144252.31896 to 144254.19168 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:26:00.969 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 21 fps=0.5 q=2.0 size=N/A time=00:00:35.84 bitrate=N/A speed=0.937x 2022-09-20 22:26:01.456 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 21 fps=0.5 q=2.0 size=N/A time=00:00:35.84 bitrate=N/A speed=0.925x 2022-09-20 22:26:01.976 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 22 fps=0.6 q=2.0 size=N/A time=00:00:37.84 bitrate=N/A speed=0.963x 2022-09-20 22:26:02.495 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 22 fps=0.6 q=2.0 size=N/A time=00:00:37.84 bitrate=N/A speed=0.951x 2022-09-20 22:26:03.016 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 22 fps=0.5 q=2.0 size=N/A time=00:00:37.84 bitrate=N/A speed=0.938x 2022-09-20 22:26:03.536 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 22 fps=0.5 q=2.0 size=N/A time=00:00:37.84 bitrate=N/A speed=0.927x 2022-09-20 22:26:04.089 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 23 fps=0.6 q=2.0 size=N/A time=00:00:39.84 bitrate=N/A speed=0.963x 2022-09-20 22:26:04.609 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 23 fps=0.5 q=2.0 size=N/A time=00:00:39.84 bitrate=N/A speed=0.951x 2022-09-20 22:26:05.128 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 23 fps=0.5 q=2.0 size=N/A time=00:00:39.84 bitrate=N/A speed=0.94x 2022-09-20 22:26:05.617 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 23 fps=0.5 q=2.0 size=N/A time=00:00:39.84 bitrate=N/A speed=0.928x 2022-09-20 22:26:06.137 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 24 fps=0.6 q=2.0 size=N/A time=00:00:41.84 bitrate=N/A speed=0.963x 2022-09-20 22:26:06.656 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 24 fps=0.5 q=2.0 size=N/A time=00:00:41.84 bitrate=N/A speed=0.952x 2022-09-20 22:26:07.177 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 24 fps=0.5 q=2.0 size=N/A time=00:00:41.84 bitrate=N/A speed=0.941x 2022-09-20 22:26:07.897 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 25 fps=0.6 q=2.0 size=N/A time=00:00:43.84 bitrate=N/A speed=0.97x 2022-09-20 22:26:08.449 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 25 fps=0.5 q=2.0 size=N/A time=00:00:43.84 bitrate=N/A speed=0.959x 2022-09-20 22:26:08.969 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 25 fps=0.5 q=2.0 size=N/A time=00:00:43.84 bitrate=N/A speed=0.948x ==> /var/log/openhab/events.log <== 2022-09-20 22:26:09.121 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Nam_Lastseen' changed from 2022-09-20T22:25:38.704+0700 to 2022-09-20T22:26:09.113+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:26:09.456 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 25 fps=0.5 q=2.0 size=N/A time=00:00:43.84 bitrate=N/A speed=0.938x 2022-09-20 22:26:09.987 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 26 fps=0.5 q=2.0 size=N/A time=00:00:45.84 bitrate=N/A speed=0.97x 2022-09-20 22:26:10.500 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 26 fps=0.5 q=2.0 size=N/A time=00:00:45.84 bitrate=N/A speed=0.959x ==> /var/log/openhab/events.log <== 2022-09-20 22:26:10.782 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power_Factor' changed from 0.72 to 0.73 2022-09-20 22:26:10.787 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Current' changed from 1.238 to 1.259 2022-09-20 22:26:10.796 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Power' changed from 200 to 205 2022-09-20 22:26:10.799 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Today_Consumption' changed from 7.023 to 7.024 2022-09-20 22:26:10.801 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'PZEM_Total_Consumption' changed from 78.644 to 78.645 2022-09-20 22:26:10.831 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'This_Month_Power_Cost' changed from 144254.19168 to 144256.06440 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:26:11.016 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 26 fps=0.5 q=2.0 size=N/A time=00:00:45.84 bitrate=N/A speed=0.949x 2022-09-20 22:26:11.535 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 26 fps=0.5 q=2.0 size=N/A time=00:00:45.84 bitrate=N/A speed=0.939x ==> /var/log/openhab/events.log <== 2022-09-20 22:26:11.724 [INFO ] [openhab.event.ItemStateChangedEvent ] - Item 'Binh_Lastseen' changed from 2022-09-20T22:25:41.297+0700 to 2022-09-20T22:26:11.715+0700 ==> /var/log/openhab/openhab.log <== 2022-09-20 22:26:12.096 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 27 fps=0.5 q=2.0 size=N/A time=00:00:47.84 bitrate=N/A speed=0.969x 2022-09-20 22:26:12.609 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 27 fps=0.5 q=2.0 size=N/A time=00:00:47.84 bitrate=N/A speed=0.959x 2022-09-20 22:26:13.130 [TRACE] [hab.binding.ipcamera.internal.Ffmpeg] - frame= 27 fps=0.5 q=2.0 size=N/A time=00:00:47.84 bitrate=N/A speed=0.949x ^C