lol! These errors are hilarious. This is after creating a new user
19:28:46.874 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - !!!! Camera has closed the channel URL:/ISAPI/Streaming/channels/101/picture Cause reported is: {}
io.netty.util.concurrent.BlockingOperationException: DefaultChannelPromise@495e3e0a(incomplete)
at io.netty.util.concurrent.DefaultPromise.checkDeadLock(DefaultPromise.java:386) ~[235:io.netty.common:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.checkDeadLock(DefaultChannelPromise.java:159) ~[237:io.netty.transport:4.1.34.Final]
at io.netty.util.concurrent.DefaultPromise.awaitUninterruptibly(DefaultPromise.java:236) ~[235:io.netty.common:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.awaitUninterruptibly(DefaultChannelPromise.java:137) ~[237:io.netty.transport:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.awaitUninterruptibly(DefaultChannelPromise.java:30) ~[237:io.netty.transport:4.1.34.Final]
at org.openhab.binding.ipcamera.handler.IpCameraHandler.sendHttpRequest(IpCameraHandler.java:543) ~[?:?]
at org.openhab.binding.ipcamera.internal.MyNettyAuthHandler.processAuth(MyNettyAuthHandler.java:126) ~[?:?]
at org.openhab.binding.ipcamera.internal.MyNettyAuthHandler.channelRead(MyNettyAuthHandler.java:223) ~[?:?]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:337) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.CombinedChannelDuplexHandler$DelegatingChannelHandlerContext.fireChannelRead(CombinedChannelDuplexHandler.java:438) [237:io.netty.transport:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:323) [233:io.netty.codec:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:310) [233:io.netty.codec:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.callDecode(ByteToMessageDecoder.java:426) [233:io.netty.codec:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:278) [233:io.netty.codec:4.1.34.Final]
at io.netty.channel.CombinedChannelDuplexHandler.channelRead(CombinedChannelDuplexHandler.java:253) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:337) [237:io.netty.transport:4.1.34.Final]
at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:286) [232:io.netty.handler:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:337) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.DefaultChannelPipeline$HeadContext.channelRead(DefaultChannelPipeline.java:1408) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:930) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:163) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:677) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:612) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:529) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:491) [237:io.netty.transport:4.1.34.Final]
at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:905) [235:io.netty.common:4.1.34.Final]
at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) [235:io.netty.common:4.1.34.Final]
at java.lang.Thread.run(Thread.java:748) [?:?]
19:28:51.592 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - The alarm stream was not running for camera 192.168.1.200, re-starting it now
19:28:51.592 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - The alarm stream was not running for camera 192.168.1.201, re-starting it now
19:28:51.595 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - The alarm stream was not running for camera 192.168.1.203, re-starting it now
19:28:51.594 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - The alarm stream was not running for camera 192.168.1.202, re-starting it now
19:28:53.738 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - !!!! Camera has closed the channel URL:/ISAPI/Streaming/channels/101/picture Cause reported is: {}
io.netty.util.concurrent.BlockingOperationException: DefaultChannelPromise@294c34ac(incomplete)
at io.netty.util.concurrent.DefaultPromise.checkDeadLock(DefaultPromise.java:386) ~[235:io.netty.common:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.checkDeadLock(DefaultChannelPromise.java:159) ~[237:io.netty.transport:4.1.34.Final]
at io.netty.util.concurrent.DefaultPromise.awaitUninterruptibly(DefaultPromise.java:236) ~[235:io.netty.common:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.awaitUninterruptibly(DefaultChannelPromise.java:137) ~[237:io.netty.transport:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.awaitUninterruptibly(DefaultChannelPromise.java:30) ~[237:io.netty.transport:4.1.34.Final]
at org.openhab.binding.ipcamera.handler.IpCameraHandler.sendHttpRequest(IpCameraHandler.java:543) ~[?:?]
at org.openhab.binding.ipcamera.internal.MyNettyAuthHandler.processAuth(MyNettyAuthHandler.java:126) ~[?:?]
at org.openhab.binding.ipcamera.internal.MyNettyAuthHandler.channelRead(MyNettyAuthHandler.java:223) ~[?:?]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:337) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.CombinedChannelDuplexHandler$DelegatingChannelHandlerContext.fireChannelRead(CombinedChannelDuplexHandler.java:438) [237:io.netty.transport:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:323) [233:io.netty.codec:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:310) [233:io.netty.codec:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.callDecode(ByteToMessageDecoder.java:426) [233:io.netty.codec:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:278) [233:io.netty.codec:4.1.34.Final]
at io.netty.channel.CombinedChannelDuplexHandler.channelRead(CombinedChannelDuplexHandler.java:253) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:337) [237:io.netty.transport:4.1.34.Final]
at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:286) [232:io.netty.handler:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:337) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.DefaultChannelPipeline$HeadContext.channelRead(DefaultChannelPipeline.java:1408) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:930) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:163) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:677) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:612) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:529) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:491) [237:io.netty.transport:4.1.34.Final]
at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:905) [235:io.netty.common:4.1.34.Final]
at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) [235:io.netty.common:4.1.34.Final]
at java.lang.Thread.run(Thread.java:748) [?:?]
19:28:54.096 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - !!!! Camera has closed the channel URL:/ISAPI/Event/notification/alertStream Cause reported is: {}
io.netty.util.concurrent.BlockingOperationException: DefaultChannelPromise@74014e51(incomplete)
at io.netty.util.concurrent.DefaultPromise.checkDeadLock(DefaultPromise.java:386) ~[235:io.netty.common:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.checkDeadLock(DefaultChannelPromise.java:159) ~[237:io.netty.transport:4.1.34.Final]
at io.netty.util.concurrent.DefaultPromise.awaitUninterruptibly(DefaultPromise.java:236) ~[235:io.netty.common:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.awaitUninterruptibly(DefaultChannelPromise.java:137) ~[237:io.netty.transport:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.awaitUninterruptibly(DefaultChannelPromise.java:30) ~[237:io.netty.transport:4.1.34.Final]
at org.openhab.binding.ipcamera.handler.IpCameraHandler.sendHttpRequest(IpCameraHandler.java:543) ~[?:?]
at org.openhab.binding.ipcamera.internal.MyNettyAuthHandler.processAuth(MyNettyAuthHandler.java:126) ~[?:?]
at org.openhab.binding.ipcamera.internal.MyNettyAuthHandler.channelRead(MyNettyAuthHandler.java:223) ~[?:?]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:337) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.CombinedChannelDuplexHandler$DelegatingChannelHandlerContext.fireChannelRead(CombinedChannelDuplexHandler.java:438) [237:io.netty.transport:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:323) [233:io.netty.codec:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.fireChannelRead(ByteToMessageDecoder.java:310) [233:io.netty.codec:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.callDecode(ByteToMessageDecoder.java:426) [233:io.netty.codec:4.1.34.Final]
at io.netty.handler.codec.ByteToMessageDecoder.channelRead(ByteToMessageDecoder.java:278) [233:io.netty.codec:4.1.34.Final]
at io.netty.channel.CombinedChannelDuplexHandler.channelRead(CombinedChannelDuplexHandler.java:253) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:337) [237:io.netty.transport:4.1.34.Final]
at io.netty.handler.timeout.IdleStateHandler.channelRead(IdleStateHandler.java:286) [232:io.netty.handler:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.fireChannelRead(AbstractChannelHandlerContext.java:337) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.DefaultChannelPipeline$HeadContext.channelRead(DefaultChannelPipeline.java:1408) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:359) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.AbstractChannelHandlerContext.invokeChannelRead(AbstractChannelHandlerContext.java:345) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.DefaultChannelPipeline.fireChannelRead(DefaultChannelPipeline.java:930) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.AbstractNioByteChannel$NioByteUnsafe.read(AbstractNioByteChannel.java:163) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.processSelectedKey(NioEventLoop.java:677) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.processSelectedKeysOptimized(NioEventLoop.java:612) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.processSelectedKeys(NioEventLoop.java:529) [237:io.netty.transport:4.1.34.Final]
at io.netty.channel.nio.NioEventLoop.run(NioEventLoop.java:491) [237:io.netty.transport:4.1.34.Final]
at io.netty.util.concurrent.SingleThreadEventExecutor$5.run(SingleThreadEventExecutor.java:905) [235:io.netty.common:4.1.34.Final]
at io.netty.util.concurrent.FastThreadLocalRunnable.run(FastThreadLocalRunnable.java:30) [235:io.netty.common:4.1.34.Final]
at java.lang.Thread.run(Thread.java:748) [?:?]
19:28:55.582 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:null
19:29:02.588 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:null
19:29:02.589 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:null
@dastrix80
I am 100% sure you are running an old JAR and not the latest, multiple log entries you have posted prove they do not match what the current JAR will insert into the logs.
Re download the latest version and place all files from the zip into the addons folder.
Make sure you only have the 1.4 version of xml SOAP in the addons folder and not two different versions.
Clean cache and temp and REBOOT by using this line in linux…
sudo service openhab2 stop && sudo rm -rf /var/lib/openhab2/cache/* && sudo rm -rf /var/lib/openhab2/tmp/* && sudo reboot
You must use admin rights to talk to your cameras and you must create an ONVIF user and password and also enable the cgi/API features in the cameras control panel.
Try and get 1 single camera working first before trying multiples as often you need to increase the heap size.
Hi Matt
Im using this version now. I am using the admin user / pass
bundle:list | grep Camera
238 x Active x 80 x 2.5.0.201908030247 x openHAB Add-ons :: Bundles :: IpCamera Binding
openhab>
Here shows the soap version
ls /usr/share/openhab2/addons/
doorbird-deps-1.0.0.jar netty-codec-http-4.1.34.Final.jar netty-transport-4.1.34.Final.jar org.openhab.binding.broadlink-2.2.0-BETA2.jar README
javax.xml.soap-api-1.4.0.jar netty-common-4.1.34.Final.jar openhab-addons-2.4.0.kar org.openhab.binding.doorbird-2.5.0-SNAPSHOT.jar
netty-buffer-4.1.34.Final.jar netty-handler-4.1.34.Final.jar org.apache.servicemix.bundles.xstream-1.4.7_1.jar org.openhab.binding.ipcamera-2.5.0-SNAPSHOT.jar
netty-codec-4.1.34.Final.jar netty-resolver-4.1.34.Final.jar org.openhab.binding.amazonechocontrol-2.5.0-SNAPSHOT.jar org.openhab.binding.zwave-2.5.0-SNAPSHOT.jar
and heres another error after a restart
10:29:36.946 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:null
10:29:37.483 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:null
10:29:37.484 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:null
10:29:38.956 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:null
10:29:39.957 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:null
10:29:42.749 [INFO ] [smarthome.event.ItemStateChangedEvent] - Entrance_Motion_Alarm changed from ON to OFF
10:29:46.275 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - ipCamera Dispose() called.
10:29:46.275 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:Driveway' changed from ONLINE to UNINITIALIZED
10:29:46.276 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - ipCamera restarting.
10:29:46.279 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:Driveway' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
10:29:46.280 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:North_Yard' changed from ONLINE to UNINITIALIZED
10:29:46.280 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - ipCamera Dispose() called.
10:29:46.281 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - ipCamera restarting.
10:29:46.284 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - ipCamera Dispose() called.
10:29:46.284 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:North_Yard' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
10:29:46.284 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - ipCamera restarting.
10:29:46.285 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:South_Steps' changed from ONLINE to UNINITIALIZED
10:29:46.288 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:South_Steps' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
10:29:46.288 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - ipCamera Dispose() called.
10:29:46.289 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:Carport' changed from ONLINE to UNINITIALIZED
10:29:46.289 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - ipCamera restarting.
10:29:46.292 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:Carport' changed from UNINITIALIZED to UNINITIALIZED (HANDLER_MISSING_ERROR)
10:29:46.333 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'ipcamera:HIKVISION:North_Yard' has been updated.
10:29:46.334 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'ipcamera:HIKVISION:South_Steps' has been updated.
10:29:46.334 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'ipcamera:HIKVISION:Driveway' has been updated.
10:29:46.335 [INFO ] [smarthome.event.ThingUpdatedEvent ] - Thing 'ipcamera:HIKVISION:Carport' has been updated.
10:29:46.337 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:North_Yard' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:29:46.340 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:South_Steps' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:29:46.342 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:Driveway' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:29:46.344 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:Carport' changed from UNINITIALIZED (HANDLER_MISSING_ERROR) to INITIALIZING
10:29:47.350 [ERROR] [ml.internal.messaging.saaj.client.p2p] - SAAJ0008: Bad Response; Not Found
10:29:47.350 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - SOAP error when trying to connect with ONVIF. This may indicate your camera does not fully support ONVIF, check for an updated firmware for your camera. Will try and connect with HTTP. Camera at IP:192.168.1.203, fault was com.sun.xml.internal.messaging.saaj.SOAPExceptionImpl: com.sun.xml.internal.messaging.saaj.SOAPExceptionImpl: Bad response: (404Not Found
10:29:47.350 [ERROR] [ml.internal.messaging.saaj.client.p2p] - SAAJ0008: Bad Response; Not Found
10:29:47.350 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - SOAP error when trying to connect with ONVIF. This may indicate your camera does not fully support ONVIF, check for an updated firmware for your camera. Will try and connect with HTTP. Camera at IP:192.168.1.200, fault was com.sun.xml.internal.messaging.saaj.SOAPExceptionImpl: com.sun.xml.internal.messaging.saaj.SOAPExceptionImpl: Bad response: (404Not Found
10:29:47.353 [ERROR] [ml.internal.messaging.saaj.client.p2p] - SAAJ0008: Bad Response; Not Found
10:29:47.353 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - SOAP error when trying to connect with ONVIF. This may indicate your camera does not fully support ONVIF, check for an updated firmware for your camera. Will try and connect with HTTP. Camera at IP:192.168.1.202, fault was com.sun.xml.internal.messaging.saaj.SOAPExceptionImpl: com.sun.xml.internal.messaging.saaj.SOAPExceptionImpl: Bad response: (404Not Found
10:29:47.356 [ERROR] [ml.internal.messaging.saaj.client.p2p] - SAAJ0008: Bad Response; Not Found
10:29:47.356 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - SOAP error when trying to connect with ONVIF. This may indicate your camera does not fully support ONVIF, check for an updated firmware for your camera. Will try and connect with HTTP. Camera at IP:192.168.1.201, fault was com.sun.xml.internal.messaging.saaj.SOAPExceptionImpl: com.sun.xml.internal.messaging.saaj.SOAPExceptionImpl: Bad response: (404Not Found
10:29:47.359 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - IpCamera file server for camera 192.168.1.200 has started on port 50001
10:29:47.359 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - IP Camera at 192.168.1.200 is now online.
10:29:47.359 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - IpCamera file server for camera 192.168.1.203 has started on port 50004
10:29:47.359 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - IP Camera at 192.168.1.203 is now online.
10:29:47.359 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:North_Yard' changed from INITIALIZING to ONLINE
10:29:47.360 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - IpCamera file server for camera 192.168.1.202 has started on port 50003
10:29:47.360 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - IP Camera at 192.168.1.202 is now online.
10:29:47.360 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:Carport' changed from INITIALIZING to ONLINE
10:29:47.360 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:Driveway' changed from INITIALIZING to ONLINE
10:29:47.379 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - IpCamera file server for camera 192.168.1.201 has started on port 50002
10:29:47.380 [INFO ] [ding.ipcamera.handler.IpCameraHandler] - IP Camera at 192.168.1.201 is now online.
10:29:47.380 [INFO ] [ome.event.ThingStatusInfoChangedEvent] - 'ipcamera:HIKVISION:South_Steps' changed from INITIALIZING to ONLINE
10:29:49.740 [WARN ] [ding.ipcamera.handler.IpCameraHandler] - !!!! Camera has closed the channel URL:/ISAPI/Streaming/channels/101/picture Cause reported is: {}
io.netty.util.concurrent.BlockingOperationException: DefaultChannelPromise@23b31a3c(incomplete)
at io.netty.util.concurrent.DefaultPromise.checkDeadLock(DefaultPromise.java:386) ~[235:io.netty.common:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.checkDeadLock(DefaultChannelPromise.java:159) ~[237:io.netty.transport:4.1.34.Final]
at io.netty.util.concurrent.DefaultPromise.awaitUninterruptibly(DefaultPromise.java:236) ~[235:io.netty.common:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.awaitUninterruptibly(DefaultChannelPromise.java:137) ~[237:io.netty.transport:4.1.34.Final]
at io.netty.channel.DefaultChannelPromise.awaitUninterruptibly(DefaultChannelPromise.java:30) ~[237:io.netty.transport:4.1.34.Final]
Hi Matt. Great binding. Installed over the weekend and configured a Foscam FI9816P. Seems to be working well (pan, tilt, motion detection, image in PaperUI) Now to start configuring rules.
Hi Everyone. If buying new cameras, what are people recommending to work with the binding? Thanks
This binding is now merged into openHAB 2.5.9 and newer.
See below for more details on what each brand of camera has working as often choosing the right camera will save you from needing to purchase an extra video server (both the cost to purchase the server, plus the ongoing electricity costs) to process the video feeds.
Features for Generic cameras with only RTSP (no snapshot url):
Snapshots (jpg) can be created from RTSP with low CPU overhead but requires non stop network traffic to keep …
Also for camera recommendations best to ask in a camera form like this one, plenty of threads already discussing which camera is best for which application.
Hi Matt
See attached debug, only 1 camera is configured. Latest binding version
It seems authentication related, but ive tried the admin crendentials and an operator user, same issue. Its set to digest/basic, the other option is digest only.
Hopefully this helps:
2019-08-22 15:50:19.832 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Sending camera: GET: http://192.168.1.200/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.832 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Using the already open channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.833 [TRACE] [ipcamera.internal.MyNettyAuthHandler] - MyNettyAuthHandler is now setup for GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.833 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultHttpResponse(decodeResult: success, version: HTTP/1.1)
HTTP/1.1 401 Unauthorized
Date: Thu, 22 Aug 2019 15:50:08 GMT
Server: App-webs/
Content-Length: 178
Content-Type: text/html
Connection: keep-alive
Keep-Alive: timeout=10, max=82
WWW-Authenticate: Digest qop="auth", realm="IP Camera(76898)", nonce="5a44466c5a6d4535597a7069595441314e5749354e773d3d", stale="FALSE"
WWW-Authenticate: Basic realm="IP Camera(76898)"
2019-08-22 15:50:19.834 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultLastHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 178, cap: 178/178, unwrapped: PooledUnsafeDirectByteBuf(ridx: 551, widx: 551, cap: 1024)), decoderResult: success)
2019-08-22 15:50:19.834 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :<!DOCTYPE html>
<html><head><title>Document Error: Unauthorized</title></head>
<body><h2>Access Error: 401 -- Unauthorized</h2>
<p>Authentication Error</p>
</body>
</html>
2019-08-22 15:50:19.836 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - 401: Mark to re-use, the channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.836 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - Setting up the camera to use Basic Auth and resending last request with correct auth.
2019-08-22 15:50:19.837 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Sending camera: GET: http://192.168.1.200/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.837 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Using the already open channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.837 [TRACE] [ipcamera.internal.MyNettyAuthHandler] - MyNettyAuthHandler is now setup for GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.838 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultHttpResponse(decodeResult: success, version: HTTP/1.1)
HTTP/1.1 401 Unauthorized
Date: Thu, 22 Aug 2019 15:50:08 GMT
Server: App-webs/
Content-Length: 178
Content-Type: text/html
Connection: keep-alive
Keep-Alive: timeout=10, max=81
WWW-Authenticate: Digest qop="auth", realm="IP Camera(76898)", nonce="4f5445774e4446694e6a5536596d45774e5456694f57493d", stale="FALSE"
WWW-Authenticate: Basic realm="IP Camera(76898)"
2019-08-22 15:50:19.838 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultLastHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 178, cap: 178/178, unwrapped: PooledUnsafeDirectByteBuf(ridx: 551, widx: 551, cap: 1024)), decoderResult: success)
2019-08-22 15:50:19.839 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :<!DOCTYPE html>
<html><head><title>Document Error: Unauthorized</title></head>
<body><h2>Access Error: 401 -- Unauthorized</h2>
<p>Authentication Error</p>
</body>
</html>
2019-08-22 15:50:19.841 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - 401: Mark to re-use, the channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.841 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - Setting up the camera to use Basic Auth and resending last request with correct auth.
2019-08-22 15:50:19.842 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Sending camera: GET: http://192.168.1.200/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.842 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - 401: Mark to re-use, the channel:1 GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.842 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - Setting up the camera to use Basic Auth and resending last request with correct auth.
2019-08-22 15:50:19.842 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Using the already open channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.843 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Sending camera: GET: http://192.168.1.200/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.843 [TRACE] [ipcamera.internal.MyNettyAuthHandler] - MyNettyAuthHandler is now setup for GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.843 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultHttpResponse(decodeResult: success, version: HTTP/1.1)
HTTP/1.1 401 Unauthorized
Date: Thu, 22 Aug 2019 15:50:08 GMT
Server: App-webs/
Content-Length: 178
Content-Type: text/html
Connection: keep-alive
Keep-Alive: timeout=10, max=80
WWW-Authenticate: Digest qop="auth", realm="IP Camera(76898)", nonce="4d5449354e575a694f575936596d45774e5456695954413d", stale="FALSE"
WWW-Authenticate: Basic realm="IP Camera(76898)"
2019-08-22 15:50:19.843 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Using the already open channel:1 GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.844 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultLastHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 178, cap: 178/178, unwrapped: PooledUnsafeDirectByteBuf(ridx: 551, widx: 551, cap: 1024)), decoderResult: success)
2019-08-22 15:50:19.844 [TRACE] [ipcamera.internal.MyNettyAuthHandler] - MyNettyAuthHandler is now setup for GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.844 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :<!DOCTYPE html>
<html><head><title>Document Error: Unauthorized</title></head>
<body><h2>Access Error: 401 -- Unauthorized</h2>
<p>Authentication Error</p>
</body>
</html>
2019-08-22 15:50:19.844 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultHttpResponse(decodeResult: success, version: HTTP/1.1)
HTTP/1.1 401 Unauthorized
Date: Thu, 22 Aug 2019 15:50:08 GMT
Server: App-webs/
Content-Length: 178
Content-Type: text/html
Connection: keep-alive
Keep-Alive: timeout=10, max=15
WWW-Authenticate: Digest qop="auth", realm="IP Camera(76898)", nonce="4f5745785a5468695a546b36596d45774e5456694f57513d", stale="FALSE"
WWW-Authenticate: Basic realm="IP Camera(76898)"
2019-08-22 15:50:19.845 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultLastHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 178, cap: 178/178, unwrapped: PooledUnsafeDirectByteBuf(ridx: 551, widx: 551, cap: 1024)), decoderResult: success)
2019-08-22 15:50:19.845 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :<!DOCTYPE html>
<html><head><title>Document Error: Unauthorized</title></head>
<body><h2>Access Error: 401 -- Unauthorized</h2>
<p>Authentication Error</p>
</body>
</html>
2019-08-22 15:50:19.848 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - 401: Mark to re-use, the channel:1 GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.849 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - Setting up the camera to use Basic Auth and resending last request with correct auth.
2019-08-22 15:50:19.849 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - 401: Mark to re-use, the channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.849 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Sending camera: GET: http://192.168.1.200/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.849 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - Setting up the camera to use Basic Auth and resending last request with correct auth.
2019-08-22 15:50:19.849 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Using the already open channel:1 GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.850 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Sending camera: GET: http://192.168.1.200/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.850 [TRACE] [ipcamera.internal.MyNettyAuthHandler] - MyNettyAuthHandler is now setup for GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.850 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultHttpResponse(decodeResult: success, version: HTTP/1.1)
HTTP/1.1 401 Unauthorized
Date: Thu, 22 Aug 2019 15:50:08 GMT
Server: App-webs/
Content-Length: 178
Content-Type: text/html
Connection: keep-alive
Keep-Alive: timeout=10, max=14
WWW-Authenticate: Digest qop="auth", realm="IP Camera(76898)", nonce="4d574e6b4e32453559324d36596d45774e5456695954673d", stale="FALSE"
WWW-Authenticate: Basic realm="IP Camera(76898)"
2019-08-22 15:50:19.850 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Using the already open channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.850 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultLastHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 178, cap: 178/178, unwrapped: PooledUnsafeDirectByteBuf(ridx: 551, widx: 551, cap: 1024)), decoderResult: success)
2019-08-22 15:50:19.851 [TRACE] [ipcamera.internal.MyNettyAuthHandler] - MyNettyAuthHandler is now setup for GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.851 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :<!DOCTYPE html>
<html><head><title>Document Error: Unauthorized</title></head>
<body><h2>Access Error: 401 -- Unauthorized</h2>
<p>Authentication Error</p>
</body>
</html>
2019-08-22 15:50:19.851 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultHttpResponse(decodeResult: success, version: HTTP/1.1)
HTTP/1.1 401 Unauthorized
Date: Thu, 22 Aug 2019 15:50:08 GMT
Server: App-webs/
Content-Length: 178
Content-Type: text/html
Connection: keep-alive
Keep-Alive: timeout=10, max=79
WWW-Authenticate: Digest qop="auth", realm="IP Camera(76898)", nonce="4f546c694e446469596d4d36596d45774e5456695954633d", stale="FALSE"
WWW-Authenticate: Basic realm="IP Camera(76898)"
2019-08-22 15:50:19.852 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultLastHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 178, cap: 178/178, unwrapped: PooledUnsafeDirectByteBuf(ridx: 551, widx: 551, cap: 1024)), decoderResult: success)
2019-08-22 15:50:19.852 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :<!DOCTYPE html>
<html><head><title>Document Error: Unauthorized</title></head>
<body><h2>Access Error: 401 -- Unauthorized</h2>
<p>Authentication Error</p>
</body>
</html>
2019-08-22 15:50:19.854 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - 401: Mark to re-use, the channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.854 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - Setting up the camera to use Basic Auth and resending last request with correct auth.
2019-08-22 15:50:19.854 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - 401: Mark to re-use, the channel:1 GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.855 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Sending camera: GET: http://192.168.1.200/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.855 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - Setting up the camera to use Basic Auth and resending last request with correct auth.
2019-08-22 15:50:19.855 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Using the already open channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.855 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Sending camera: GET: http://192.168.1.200/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.855 [TRACE] [ipcamera.internal.MyNettyAuthHandler] - MyNettyAuthHandler is now setup for GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.856 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultHttpResponse(decodeResult: success, version: HTTP/1.1)
HTTP/1.1 401 Unauthorized
Date: Thu, 22 Aug 2019 15:50:08 GMT
Server: App-webs/
Content-Length: 178
Content-Type: text/html
Connection: keep-alive
Keep-Alive: timeout=10, max=78
WWW-Authenticate: Digest qop="auth", realm="IP Camera(76898)", nonce="4e44566a5932493159324536596d45774e5456695957513d", stale="FALSE"
WWW-Authenticate: Basic realm="IP Camera(76898)"
2019-08-22 15:50:19.856 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Using the already open channel:1 GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.856 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultLastHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 178, cap: 178/178, unwrapped: PooledUnsafeDirectByteBuf(ridx: 551, widx: 551, cap: 1024)), decoderResult: success)
2019-08-22 15:50:19.856 [TRACE] [ipcamera.internal.MyNettyAuthHandler] - MyNettyAuthHandler is now setup for GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.856 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :<!DOCTYPE html>
<html><head><title>Document Error: Unauthorized</title></head>
<body><h2>Access Error: 401 -- Unauthorized</h2>
<p>Authentication Error</p>
</body>
</html>
2019-08-22 15:50:19.857 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultHttpResponse(decodeResult: success, version: HTTP/1.1)
HTTP/1.1 401 Unauthorized
Date: Thu, 22 Aug 2019 15:50:08 GMT
Server: App-webs/
Content-Length: 178
Content-Type: text/html
Connection: keep-alive
Keep-Alive: timeout=10, max=13
WWW-Authenticate: Digest qop="auth", realm="SéH", nonce="4f546c6c4f5749354e325936596d45774e54566959574d3d", stale="FALSE"
WWW-Authenticate: Basic realm="IP Camera(76898)"
2019-08-22 15:50:19.857 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultLastHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 178, cap: 178/178, unwrapped: PooledUnsafeDirectByteBuf(ridx: 538, widx: 538, cap: 1024)), decoderResult: success)
2019-08-22 15:50:19.857 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :<!DOCTYPE html>
<html><head><title>Document Error: Unauthorized</title></head>
<body><h2>Access Error: 401 -- Unauthorized</h2>
<p>Authentication Error</p>
</body>
</html>
2019-08-22 15:50:19.859 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - 401: Mark to re-use, the channel:1 GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.859 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - Setting up the camera to use Basic Auth and resending last request with correct auth.
2019-08-22 15:50:19.859 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Sending camera: GET: http://192.168.1.200/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.859 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - 401: Mark to re-use, the channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:50:19.860 [DEBUG] [ipcamera.internal.MyNettyAuthHandler] - Setting up the camera to use Basic Auth and resending last request with correct auth.
2019-08-22 15:50:19.860 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Using the already open channel:1 GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:50:19.860 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Sending camera: GET: http://192.168.1.200/ISAPI/Event/notification/alertStream
2019-08-22 15:50:37.815 [WARN ] [me.core.internal.events.EventHandler] - Dispatching event to subscriber 'org.eclipse.smarthome.io.monitor.internal.EventLogger@5e9d07e0' takes more than 5000ms.
2019-08-22 15:50:32.809 [INFO ] [.smarthome.model.script.system.rules] - Server Uptime updated to 6 Days / 22 Hours / 17 Min.
2019-08-22 15:50:19.860 [TRACE] [ipcamera.internal.MyNettyAuthHandler] - MyNettyAuthHandler is now setup for GET:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:51:19.863 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultHttpResponse(decodeResult: success, version: HTTP/1.1)
HTTP/1.1 401 Unauthorized
Date: Thu, 22 Aug 2019 15:50:08 GMT
Server: App-webs/
Content-Length: 178
Content-Type: text/html
Connection: keep-alive
Keep-Alive: timeout=10, max=12
WWW-Authenticate: Digest qop="auth", realm="IP Camera(76898)", nonce="59574e6c4d7a63794f545136596d45774e545669596a493d", stale="FALSE"
WWW-Authenticate: Basic realm="IP Camera(76898)"
2019-08-22 15:51:19.863 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - commonCameraHandler closed channel:3 URL:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:51:19.863 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultLastHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 178, cap: 178/178, unwrapped: PooledUnsafeDirectByteBuf(ridx: 551, widx: 551, cap: 1024)), decoderResult: success)
2019-08-22 15:51:19.864 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - commonCameraHandler closed channel:4 URL:/ISAPI/Event/notification/alertStream
2019-08-22 15:51:19.864 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :<!DOCTYPE html>
<html><head><title>Document Error: Unauthorized</title></head>
<body><h2>Access Error: 401 -- Unauthorized</h2>
<p>Authentication Error</p>
</body>
</html>
2019-08-22 15:51:19.864 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - Using the already open channel:2 GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:51:19.864 [TRACE] [ipcamera.internal.MyNettyAuthHandler] - MyNettyAuthHandler is now setup for GET:/ISAPI/Event/notification/alertStream
2019-08-22 15:51:19.872 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultHttpResponse(decodeResult: success, version: HTTP/1.1)
HTTP/1.1 401 Unauthorized
Date: Thu, 22 Aug 2019 15:50:08 GMT
Server: App-webs/
Content-Length: 178
Content-Type: text/html
Connection: keep-alive
Keep-Alive: timeout=10, max=77
WWW-Authenticate: Digest qop="auth", realm="IP Camera(76898)", nonce="4e4451304f5463344d546336596d45774e545669596a4d3d", stale="FALSE"
WWW-Authenticate: Basic realm="IP Camera(76898)"
2019-08-22 15:51:19.872 [DEBUG] [ing.ipcamera.handler.IpCameraHandler] - commonCameraHandler closed channel:1 URL:/ISAPI/Streaming/channels/101/picture
2019-08-22 15:51:19.872 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - DefaultLastHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 178, cap: 178/178, unwrapped: PooledUnsafeDirectByteBuf(ridx: 551, widx: 551, cap: 1024)), decoderResult: success)
2019-08-22 15:51:19.872 [TRACE] [ing.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :<!DOCTYPE html>
<html><head><title>Document Error: Unauthorized</title></head>
<body><h2>Access Error: 401 -- Unauthorized</h2>
<p>Authentication Error</p>
</body>
</html>
It did not show any problems so check this…
In cameras settings make sure “Enable Illegal Login Lock” is unticked, save and then reboot the camera. Also make sure the IP filter is not setup.
I have multiple HIk cameras and have one setup for basic and the other for digest and they just work.
I did notice this weird thing in the logs which to my knowledge a camera should not change the realm. It may be a bug in the cameras firmware that has triggered the illegal lock feature.
WWW-Authenticate: Digest qop="auth", realm="SéH",
WWW-Authenticate: Digest qop="auth", realm="IP Camera(76898)",
Also it must be login details for admin rights, user level is not enough.
I unticked the enable illegal login, ip filter was off. Changed to digest for shits and giggles, no joy
19:53:15.842 [ERROR] [ml.internal.messaging.saaj.client.p2p] - SAAJ0008: Bad Response; Not Found
Definitely back onto admin credentials.
Continuing the discussion from IpCamera: New IP Camera Binding:
When i connect my hikvision wifi camera, after some time openhab crashes because of “java.lang.OutOfMemoryError: Java heap space” its the ipcamera:HIKVISION:IpCamHoved that is the problem. When i remove the ipcamera:HIKVISION:IpCamHoved from the things the problem goes away.
Camera info:
DS-2CD2532F-IWS
Firmware V5.4.5 build 170123
2019-08-22 04:05:55.122 [WARN ] [su.litvak.chromecast.api.v2.Channel ] - Error while handling, caused by java.net.SocketException: Kanalen blev brudt (Write failed)
2019-08-22 04:05:55.123 [WARN ] [su.litvak.chromecast.api.v2.Channel ] - Error while reading, caused by javax.net.ssl.SSLException: Connection has been shutdown: javax.net.ssl.SSLException: java.net.SocketException: Kanalen blev brudt (Write failed)
2019-08-22 04:05:55.123 [WARN ] [su.litvak.chromecast.api.v2.Channel ] - <-- null payload in message
2019-08-22 04:05:56.487 [WARN ] [su.litvak.chromecast.api.v2.Channel ] - Error while sending 'PING', caused by java.net.SocketException: Socket is closed
2019-08-22 04:06:12.999 [WARN ] [io.netty.channel.nio.NioEventLoop ] - Unexpected exception in the selector loop.
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:06:30.361 [WARN ] [me.core.internal.events.EventHandler] - Dispatching event to subscriber 'org.eclipse.smarthome.core.internal.items.ItemUpdater@72f37bc7' takes more than 5000ms.
2019-08-22 04:07:03.881 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - !!!! Camera has closed the channel URL:/ISAPI/Streaming/channels/101/picture Cause reported is: {}
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:07:10.697 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - !!!! Camera has closed the channel URL:/ISAPI/Streaming/channels/101/picture Cause reported is: {}
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:07:25.219 [WARN ] [me.core.internal.events.EventHandler] - Dispatching event to subscriber 'org.eclipse.smarthome.core.internal.items.ItemUpdater@72f37bc7' takes more than 5000ms.
2019-08-22 04:07:34.797 [WARN ] [me.core.internal.events.EventHandler] - Dispatching event to subscriber 'org.eclipse.smarthome.core.internal.items.ItemUpdater@72f37bc7' takes more than 5000ms.
2019-08-22 04:07:34.806 [INFO ] [io.openhabcloud.internal.CloudClient] - Disconnected from the openHAB Cloud service (UUID = 205093e4-4f07-4ab3-b3d4-c62db9f28b27, base URL = http://localhost:8080)
2019-08-22 04:10:57.966 [WARN ] [me.core.internal.events.EventHandler] - Dispatching event to subscriber 'org.eclipse.smarthome.core.internal.items.ItemUpdater@72f37bc7' takes more than 5000ms.
2019-08-22 04:10:57.968 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception:
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:10:57.970 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - Unexpected thread death: org.eclipse.jetty.util.thread.QueuedThreadPool$Runner@2601c8f5 in QueuedThreadPool[ServletModel-12]@2dc7e85{STARTED,8<=8<=8,i=6,r=1,q=0}[ReservedThreadExecutor@28c63245{s=0/1,p=0}]
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:18.847 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - !!!! Camera has closed the channel URL:/ISAPI/Streaming/channels/101/picture Cause reported is: {}
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:14.801 [WARN ] [io.netty.channel.nio.NioEventLoop ] - Unexpected exception in the selector loop.
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:10:55.289 [ERROR] [org.quartz.core.JobRunShell ] - Job MapDB_SchedulerGroup.Commit_Transaction threw an unhandled Exception:
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:18.847 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - Unexpected thread death: org.eclipse.jetty.util.thread.QueuedThreadPool$Runner@39ff61d5 in QueuedThreadPool[ESH-httpClient-common]@367224d1{STARTED,10<=10<=40,i=4,r=4,q=0}[ReservedThreadExecutor@8b5bd2b{s=1/4,p=0}]
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:14.801 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - Unexpected thread death: org.eclipse.jetty.util.thread.QueuedThreadPool$Runner@7382b18b in QueuedThreadPool[qtp893194427]@353d10bb{STARTED,2<=8<=50,i=2,r=4,q=0}[ReservedThreadExecutor@7ee5fbeb{s=1/4,p=0}]
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:14.801 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - Unexpected thread death: org.eclipse.jetty.util.thread.QueuedThreadPool$Runner@2f1ae739 in QueuedThreadPool[HttpClient@178df92c]@311a5c0e{STARTED,8<=8<=200,i=4,r=4,q=0}[ReservedThreadExecutor@ab181ec{s=1/4,p=0}]
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:14.800 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - Unexpected thread death: org.eclipse.jetty.util.thread.QueuedThreadPool$Runner@2601c8f5 in QueuedThreadPool[ServletModel-12]@2dc7e85{STARTED,8<=8<=8,i=6,r=1,q=0}[ReservedThreadExecutor@28c63245{s=0/1,p=0}]
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:10:59.423 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception:
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:14.801 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - Unexpected thread death: org.eclipse.jetty.util.thread.QueuedThreadPool$Runner@2f1ae739 in QueuedThreadPool[HttpClient@178df92c]@311a5c0e{STARTED,8<=8<=200,i=4,r=4,q=0}[ReservedThreadExecutor@ab181ec{s=1/4,p=0}]
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:37.481 [ERROR] [org.quartz.core.ErrorLogger ] - Job (MapDB_SchedulerGroup.Commit_Transaction threw an exception.
org.quartz.SchedulerException: Job threw an unhandled exception.
at org.quartz.core.JobRunShell.run(JobRunShell.java:213) [181:org.openhab.core.scheduler:2.5.0.201908180304]
at org.quartz.simpl.SimpleThreadPool$WorkerThread.run(SimpleThreadPool.java:573) [181:org.openhab.core.scheduler:2.5.0.201908180304]
Caused by: java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:14.802 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - Unexpected thread death: org.eclipse.jetty.util.thread.QueuedThreadPool$Runner@2f1ae739 in QueuedThreadPool[HttpClient@178df92c]@311a5c0e{STARTED,8<=8<=200,i=4,r=4,q=0}[ReservedThreadExecutor@ab181ec{s=1/4,p=0}]
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:14.802 [WARN ] [mmon.WrappedScheduledExecutorService] - Scheduled runnable ended with an exception:
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:36.113 [ERROR] [org.apache.felix.fileinstall ] - In main loop, we have serious trouble
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:36.112 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - Unexpected thread death: org.eclipse.jetty.util.thread.QueuedThreadPool$Runner@32cf7812 in QueuedThreadPool[HttpClient@3a58bca]@42ccd0e7{STARTED,8<=8<=200,i=6,r=4,q=0}[ReservedThreadExecutor@3c08803b{s=0/4,p=0}]
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:36.112 [ERROR] [org.apache.felix.fileinstall ] - In main loop, we have serious trouble
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:34.764 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - !!!! Camera has closed the channel URL:/ISAPI/Streaming/channels/101/picture Cause reported is: {}
java.lang.OutOfMemoryError: Java heap space
2019-08-22 04:12:56.738 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - The alarm stream was not running for camera 10.0.0.91, re-starting it now
2019-08-22 04:12:59.502 [WARN ] [WaveSerialHandler$ZWaveReceiveThread] - Exception during ZWave thread.
java.lang.IllegalStateException: Queue full
at java.util.AbstractQueue.add(AbstractQueue.java:98) ~[?:?]
at java.util.concurrent.ArrayBlockingQueue.add(ArrayBlockingQueue.java:312) ~[?:?]
at org.openhab.binding.zwave.internal.protocol.ZWaveTransactionManager.processReceiveMessage(ZWaveTransactionManager.java:410) ~[271:org.openhab.binding.zwave:2.5.0.201908182309]
at org.openhab.binding.zwave.internal.protocol.ZWaveController.incomingPacket(ZWaveController.java:1064) ~[271:org.openhab.binding.zwave:2.5.0.201908182309]
at org.openhab.binding.zwave.handler.ZWaveControllerHandler.incomingMessage(ZWaveControllerHandler.java:411) ~[271:org.openhab.binding.zwave:2.5.0.201908182309]
at org.openhab.binding.zwave.handler.ZWaveSerialHandler$ZWaveReceiveThread.run(ZWaveSerialHandler.java:331) [271:org.openhab.binding.zwave:2.5.0.201908182309]
2019-08-22 04:13:00.016 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:00.017 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - Cleaning the channels has just found a connection with wrong open state.
2019-08-22 04:13:00.019 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:/ISAPI/System/IO/inputs/1/status
2019-08-22 04:13:00.175 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 14 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:00.254 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 14 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:00.331 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 15 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:00.332 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - Cleaning the channels has just found a connection with wrong open state.
2019-08-22 04:13:00.332 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:/ISAPI/System/IO/inputs/1/status
2019-08-22 04:13:00.418 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:03.717 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:03.954 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:04.698 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:05.162 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:07.521 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:08.643 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:09.121 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:11.925 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:15.242 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:15.464 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:15.545 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:15.620 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 14 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:15.621 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - Cleaning the channels has just found a connection with wrong open state.
2019-08-22 04:13:15.622 [WARN ] [ing.ipcamera.handler.IpCameraHandler] - Can't find ch when removing handler URL:/ISAPI/System/IO/inputs/1/status
2019-08-22 04:13:17.140 [INFO ] [ing.ipcamera.handler.IpCameraHandler] - There are 13 channels being tracked, cleaning out old channels now to try and reduce this to 12 or below.
2019-08-22 04:13:37.480 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{FAILED,8<=0<=200,i=0,r=-1,q=6}[NO_TRY] rejected org.eclipse.jetty.io.ManagedSelector$$Lambda$166/2135414754@3f6d1e1a
2019-08-22 04:15:07.672 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=7<=200,i=0,r=-1,q=9}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19380,5,main]
2019-08-22 04:15:07.677 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=7<=200,i=0,r=-1,q=9}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19369,5,main]
2019-08-22 04:15:07.678 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=7<=200,i=0,r=-1,q=9}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19372,5,main]
2019-08-22 04:15:07.678 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=7<=200,i=0,r=-1,q=9}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19382,5,main]
2019-08-22 04:15:07.679 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=7<=200,i=0,r=-1,q=9}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19373,5,main]
2019-08-22 04:15:07.682 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=7<=200,i=0,r=-1,q=9}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19374,5,main]
2019-08-22 04:15:07.683 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=7<=200,i=0,r=-1,q=9}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19379,5,main]
2019-08-22 04:16:07.694 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPED,8<=0<=200,i=0,r=-1,q=0}[NO_TRY] rejected org.eclipse.jetty.io.ManagedSelector$$Lambda$166/2135414754@359a795d
2019-08-22 04:38:25.819 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{FAILED,8<=0<=200,i=0,r=-1,q=27}[NO_TRY] rejected org.eclipse.jetty.io.ManagedSelector$$Lambda$166/2135414754@3537bb5f
2019-08-22 04:39:56.121 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19624,5,main]
2019-08-22 04:39:56.122 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19620,5,main]
2019-08-22 04:39:56.122 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19621,5,main]
2019-08-22 04:39:56.124 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19616,5,main]
2019-08-22 04:39:56.125 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19618,5,main]
2019-08-22 04:39:56.126 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19626,5,main]
2019-08-22 04:39:56.126 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19628,5,main]
2019-08-22 04:39:56.128 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19632,5,main]
2019-08-22 04:39:56.128 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19615,5,main]
2019-08-22 04:39:56.129 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19630,5,main]
2019-08-22 04:39:56.130 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19629,5,main]
2019-08-22 04:39:56.132 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19619,5,main]
2019-08-22 04:39:56.133 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19631,5,main]
2019-08-22 04:39:56.134 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19617,5,main]
2019-08-22 04:39:56.135 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19623,5,main]
2019-08-22 04:39:56.136 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19627,5,main]
2019-08-22 04:39:56.137 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19625,5,main]
2019-08-22 04:39:56.138 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPING,8<=18<=200,i=0,r=-1,q=21}[NO_TRY] Couldn't stop Thread[HttpClient@366630bb-19622,5,main]
2019-08-22 04:40:56.150 [WARN ] [e.jetty.util.thread.QueuedThreadPool] - QueuedThreadPool[HttpClient@366630bb]@32c5ac30{STOPPED,8<=0<=200,i=0,r=-1,q=0}[NO_TRY] rejected org.eclipse.jetty.io.ManagedSelector$$Lambda$166/2135414754@52ab0045
Thing file:
Thing ipcamera:HIKVISION:IpCamGarage "IpCam Garage" @ "Cameras"
IPADDRESS="10.0.0.90",
PORT=80,
PASSWORD="",
USERNAME="admin",
POLL_CAMERA_MS=2000,
SERVER_PORT=50001,
ONVIF_PORT=9999,
IP_WHITELIST="DISABLE",
IMAGE_UPDATE_EVENTS=1,
UPDATE_IMAGE=true,
GIF_PREROLL=20,
GIF_POSTROLL=40,
FFMPEG_OUTPUT="/tmp/IpCamGarage/",
FFMPEG_INPUT="rtsp://10.0.0.90:554/Streaming/Channels/102/"
Thing ipcamera:HIKVISION:IpCamHoved "IpCam Hoveddør" @ "Cameras"
IPADDRESS="10.0.0.91",
PORT=80,
PASSWORD="",
USERNAME="admin",
POLL_CAMERA_MS=2000,
SERVER_PORT=50002,
ONVIF_PORT=9999,
IP_WHITELIST="DISABLE",
IMAGE_UPDATE_EVENTS=1,
UPDATE_IMAGE=true,
GIF_PREROLL=20,
GIF_POSTROLL=40,
FFMPEG_OUTPUT="/tmp/IpCamHoved/",
FFMPEG_INPUT="rtsp://10.0.0.91:554/Streaming/Channels/102/"
Item file:
Image IpCamGarageImage "Garage" (gCamera) { channel="ipcamera:HIKVISION:IpCamGarage:image" }
Switch IpCamGarageUpdateImage "Garage" { channel="ipcamera:HIKVISION:IpCamGarage:updateImageNow" }
Switch IpCamGarageCreateGif "Garage" (gCameraGif) { channel="ipcamera:HIKVISION:IpCamGarage:updateGif" }
String IpCamGarageStreamUrl "Garage" { channel="ipcamera:HIKVISION:IpCamGarage:streamUrl" }
Image IpCamHovedImage "Hoveddør" (gCamera) { channel="ipcamera:HIKVISION:IpCamHoved:image" }
Switch IpCamHovedUpdateImage "Hoveddør" { channel="ipcamera:HIKVISION:IpCamHoved:updateImageNow" }
Switch IpCamHovedCreateGif "Hoveddør" (gCameraGif) { channel="ipcamera:HIKVISION:IpCamHoved:updateGif" }
String IpCamHovedStreamUrl "Hoveddør" { channel="ipcamera:HIKVISION:IpCamHoved:streamUrl" }```
Thanks, no change, errors persist
And the URL for the camera should be http://192.168.1.3:50001/Streaming/channels/102/httppreview right?
Thats my OH2 IP
some of the latest debug:
07:16:31.680 [TRACE] [ding.ipcamera.handler.IpCameraHandler] - DefaultHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 603, cap: 603/603, unwrapped: PooledUnsafeDirectByteBuf(ridx: 603, widx: 603, cap: 2048)), decoderResult: success)
07:16:31.682 [TRACE] [ding.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :--boundary
Content-Type: application/xml; charset="UTF-8"
Content-Length: 520
<EventNotificationAlert version="2.0" xmlns="http://www.hikvision.com/ver20/XMLSchema">
<ipAddress>192.168.1.200</ipAddress>
<portNo>80</portNo>
<protocol>HTTP</protocol>
<macAddress>18:68:cb:b4:13:92</macAddress>
<channelID>1</channelID>
<dateTime>2019-08-23T07:16:19+09:00</dateTime>
<activePostCount>0</activePostCount>
<eventType>videoloss</eventType>
<eventState>inactive</eventState>
<eventDescription>videoloss alarm</eventDescription>
<channelName>North Yard</channelName>
</EventNotificationAlert>
07:16:41.589 [TRACE] [ding.ipcamera.handler.IpCameraHandler] - DefaultHttpContent(data: PooledSlicedByteBuf(ridx: 0, widx: 603, cap: 603/603, unwrapped: PooledUnsafeDirectByteBuf(ridx: 603, widx: 603, cap: 2048)), decoderResult: success)
07:16:41.590 [TRACE] [ding.ipcamera.handler.IpCameraHandler] - HTTP Result back from camera is :--boundary
Content-Type: application/xml; charset="UTF-8"
Content-Length: 520
<EventNotificationAlert version="2.0" xmlns="http://www.hikvision.com/ver20/XMLSchema">
<ipAddress>192.168.1.200</ipAddress>
<portNo>80</portNo>
<protocol>HTTP</protocol>
<macAddress>18:68:cb:b4:13:92</macAddress>
<channelID>1</channelID>
<dateTime>2019-08-23T07:16:29+09:00</dateTime>
<activePostCount>0</activePostCount>
<eventType>videoloss</eventType>
<eventState>inactive</eventState>
<eventDescription>videoloss alarm</eventDescription>
<channelName>North Yard</channelName>
</EventNotificationAlert>
dastrix80:
And the URL for the camera should be http://192.168.1.3:50001/Streaming/channels/102/httppreview right?
No, try http://192.168.1.3:50001/ipcamera.jpg
The readme file covers this in depth, does it need changing/updating? If so which part is in need of reworking?
@dezito
Try searching the forum before posting, this thread should go into detail as will searching this thread…
I had a recent/same problem when I went from only one camera to four. One big change you can make is turning off the image channel from updating. My guess is the binding can send data faster then what your Pi and openhab can process when you have more then 3 cameras. Openhab seems to send the picture data down the event bus and this is the bottleneck which is not my coding. Also it appears to leak memory. Good news is I added a feature to turn off sending the data to openhabs frame work and the…