Can't connect to cameras unless SightHound re-installed

[beeftube]

Hey SightHound folks,

I've got a weird issue with my SightHound setup that's confounding me. Currently I'm running on a Win10 VM, 4 x Xeon Cores, 5GB memory, etc. The VM is dedicated to running SightHound and nothing else. Memory footprint rarely exceeds 3GB, and when processing video from my two cameras, it uses around 35% CPU.

In other words, it's not struggling.

However, I've got a weird issue in that if I shut down SightHound for some reason and re-start it (reboot, OS updates, etc), SightHound will NEVER re-connect to the cameras. I can manually turn the cameras off, attempt to Edit their settings, and I see the preview screen show up with a live image -- so in the "test the camera" portion, it works just fine. But, when I save the settings and tell SightHound to connect... nothing.

I've tried specifying the cameras by both IP and DNS hostname. I can use VLC and connect to the camera's ONVIF stream without a problem, so I know the cameras are fine.

So, how do I get them to eventually connect? I have to stop SightHound, completely uninstall it, and then re-install the application. Once I do this, the cameras come up instantly and with no problem... until I have to stop the application again, that is.

As you can imagine, this is pretty inconvenient.

Here is a sample log snippet from one of the camera logs when it attempts to connect:

Code: Select all

2016-10-15 00:13:13,334 - INFO - r16019yW_1002OZS.pyo - __init__ - bitmapWindowMode=MediaCtrl
2016-10-15 00:13:13,334 - INFO - r16019yW_1002OZS.pyo - __init__ - Camera capture initialized, pid: 5764
2016-10-15 00:13:13,334 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> FFmpeg logging active
2016-10-15 00:13:13,334 - INFO - r16019yW_1002OZS.pyo - r16019yW_100l025 - Beginning stream open
2016-10-15 00:13:13,334 - INFO - StreamReader.pyo - open - Attempting to open camera at rtsp://[email protected]/Streaming/Channels/1
2016-10-15 00:13:13,334 - INFO - StreamReader.pyo - open - videolib: Opening rtsp://u:[email protected]/Streaming/Channels/1 using TCP for transport (streamId=0)
2016-10-15 00:13:16,381 - INFO - StreamReader.pyo - open - videolib: Initiate the "video/H264" subsession (client port 55850)
2016-10-15 00:13:16,381 - INFO - StreamReader.pyo - open - videolib: Setting socket buffer to 6291456
2016-10-15 00:13:16,381 - INFO - StreamReader.pyo - open - videolib: Set up the "video/H264" subsession (client port 55850)
2016-10-15 00:13:16,381 - INFO - StreamReader.pyo - open - videolib: Created a data sink for the "video/H264" subsession
2016-10-15 00:13:16,459 - INFO - StreamReader.pyo - open - videolib: Started playback on "[URL:"rtsp://u:[email protected]/Streaming/Channels/1/"]" session
2016-10-15 00:13:16,536 - INFO - StreamReader.pyo - open - Opened stream: uri=rtsp://u:[email protected]/Streaming/Channels/1, w=1920, h=1080, buf=2048
2016-10-15 00:13:16,536 - INFO - StreamReader.pyo - open - Opening local codec libx264 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 (28), 1920x1080
2016-10-15 00:13:16,536 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> using cpu capabilities: MMX2 SSE2Fast SSSE3 Cache64 UnalignedStack
2016-10-15 00:13:16,536 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> profile Constrained Baseline, level 4.0
2016-10-15 00:13:16,536 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> 264 - core 148 r2601 a0cd7d3 - H.264/MPEG-4 AVC codec - Copyright 2003-2015 - http://www.videolan.org/x264.html - options: cabac=0 ref=1 deblock=0:0:0 analyse=0:0 me=dia subme=0 psy=1 psy_rd=1.00:0.00 mixed_ref=0 me_range=16 chroma_me=1 trellis=0 8x8dct=0 cqm=0 deadzone=21,11 fast_pskip=1 chroma_qp_offset=0 threads=6 lookahead_threads=1 sliced_threads=0 nr=0 decimate=1 interlaced=0 bluray_compat=0 constrained_intra=0 bframes=0 weightp=0 keyint=42 keyint_min=10 scenecut=0 intra_refresh=0 rc=crf mbtree=0 crf=23.0 qcomp=0.60 qpmin=0 qpmax=69 qpstep=4 ip_ratio=1.40 aq=0
2016-10-15 00:13:16,536 - ERROR - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> Could not load font "fonts/Inconsolata.otf": cannot open resource
2016-10-15 00:13:16,536 - ERROR - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> Error initializing filter 'drawtext'
2016-10-15 00:13:16,536 - ERROR - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >>  with args 'fontfile=fonts/Inconsolata.otf:textfile=C\:\\Users\\dab\\AppData\\Local\\Sighthound Video\\ts-2fcd9cdcb93cadf80a9fcfaf5d15cea9:reload=1:x=0:y=0:fontsize=28:[email protected]:box=1:[email protected]'
2016-10-15 00:13:16,536 - ERROR - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >>
2016-10-15 00:13:16,536 - ERROR - StreamReader.pyo - open - Graph parse failed - args: drawtext=fontfile=fonts/Inconsolata.otf:textfile=C\\:\\\\Users\\\\dab\\\\AppData\\\\Local\\\\Sighthound Video\\\\ts-2fcd9cdcb93cadf80a9fcfaf5d15cea9:reload=1:x=0:y=0:fontsize=28:[email protected]:box=1:[email protected]
2016-10-15 00:13:16,536 - ERROR - StreamReader.pyo - open - Could not allocate the filter
2016-10-15 00:13:16,536 - INFO - r16019yW_1002OZS.pyo - r16019yW_100l025 - Stream open successful
2016-10-15 00:13:16,552 - WARNING - r16019yW_1002Zll.pyo - r16019yW_1002lO1 - File 'PersonModel_-0.1.mat' does not exist...
2016-10-15 00:13:16,552 - WARNING - r16019yW_1002Zll.pyo - r16019yW_1002lO1 - File 'C:\Program Files (x86)\Sighthound Video\library.zip\analyticsLib\pipelineElements\pipelineUtils\c3\PersonModel_-0.1.mat' does not exist...
2016-10-15 00:13:16,552 - ERROR - r16019yW_1002OZS.pyo - run - Traceback (most recent call last):
  File "backEnd\r16019yW_1002OZS.pyo", line 162, in run
  File "backEnd\r16019yW_1002OZS.pyo", line 179, in r16019yW_100l02O
  File "backEnd\r16019yW_1002OZS.pyo", line 158, in r16019yW_100l025
  File "analyticsLib\r16019yW_1002ZZ0.pyo", line 34, in __init__
  File "analyticsLib\r16019yW_1002ZZ0.pyo", line 153, in r16019yW_1002ZO2
  File "analyticsLib\pipelineElements\pipelineUtils\c3\r16019yW_1002Zll.pyo", line 135, in r16019yW_1002lO1
RuntimeError: Couldn't find or open any of the model files: ['PersonModel_-0.1.mat', 'C:\\Program Files (x86)\\Sighthound Video\\library.zip\\analyticsLib\\pipelineElements\\pipelineUtils\\c3\\PersonModel_-0.1.mat']
2016-10-15 00:13:16,552 - ERROR - r16019yW_1002OZS.pyo - run - Couldn't find or open any of the model files: ['PersonModel_-0.1.mat', 'C:\\Program Files (x86)\\Sighthound Video\\library.zip\\analyticsLib\\pipelineElements\\pipelineUtils\\c3\\PersonModel_-0.1.mat']


So it looks like it's complaining about something called "PersonModel_-0.1.mat" missing.

Once again, I re-install SightHound and everything works like a champ right up until I stop the application again.

Let me know if you have any ideas? I'd be happy to even show you the issue via WebEx, you can click around all you want.

Thanks guys!

[Devin]

Hello beeftube,

I'm sorry to hear you're experiencing this issue. This is the first we've heard of this specific behavior. Please reproduce this, then send us a bug report by going to help > Report a Problem so we can take a look at your logs. Please include a link to this forum post so we know the report is from you.

Regards,

-Devin

[beeftube]

Hi Devin,

Just saw your reply, but I'll do that. Thanks!

[beeftube]

I've opened a bug report as you suggested.

Just for fun, I went through with the whole re-install-to-make-SightHound-connect process again, and here's a log snippet of a FAILED connection, then immediately after a SUCCESSFUL connection (the ~1 minute difference in the log is how long it took me to re-install SightHound, basically -- between 02:10:37 and 02:11:39).

Code: Select all

2016-10-22 02:10:36,601 - INFO - r16019yW_1002OZS.pyo - __init__ - bitmapWindowMode=MediaCtrl
2016-10-22 02:10:36,601 - INFO - r16019yW_1002OZS.pyo - __init__ - Camera capture initialized, pid: 2172
2016-10-22 02:10:36,601 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> FFmpeg logging active
2016-10-22 02:10:36,601 - INFO - r16019yW_1002OZS.pyo - r16019yW_100l025 - Beginning stream open
2016-10-22 02:10:36,601 - INFO - StreamReader.pyo - open - Attempting to open camera at rtsp://[email protected]/Streaming/Channels/1
2016-10-22 02:10:36,601 - INFO - StreamReader.pyo - open - videolib: Opening rtsp://u:[email protected]/Streaming/Channels/1 using TCP for transport (streamId=0)
2016-10-22 02:10:36,615 - INFO - StreamReader.pyo - open - videolib: Initiate the "video/H264" subsession (client port 62388)
2016-10-22 02:10:36,615 - INFO - StreamReader.pyo - open - videolib: Setting socket buffer to 6291456
2016-10-22 02:10:36,631 - INFO - StreamReader.pyo - open - videolib: Set up the "video/H264" subsession (client port 62388)
2016-10-22 02:10:36,631 - INFO - StreamReader.pyo - open - videolib: Created a data sink for the "video/H264" subsession
2016-10-22 02:10:36,756 - INFO - StreamReader.pyo - open - videolib: Started playback on "[URL:"rtsp://u:[email protected]/Streaming/Channels/1/"]" session
2016-10-22 02:10:37,023 - INFO - StreamReader.pyo - open - Opened stream: uri=rtsp://u:[email protected]/Streaming/Channels/1, w=1920, h=1080, buf=2048
2016-10-22 02:10:37,023 - INFO - StreamReader.pyo - open - Opening local codec libx264 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 (28), 1920x1080
2016-10-22 02:10:37,023 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> using cpu capabilities: MMX2 SSE2Fast SSSE3 Cache64 UnalignedStack
2016-10-22 02:10:37,023 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> profile Constrained Baseline, level 4.0
2016-10-22 02:10:37,023 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> 264 - core 148 r2601 a0cd7d3 - H.264/MPEG-4 AVC codec - Copyright 2003-2015 - http://www.videolan.org/x264.html - options: cabac=0 ref=1 deblock=0:0:0 analyse=0:0 me=dia subme=0 psy=1 psy_rd=1.00:0.00 mixed_ref=0 me_range=16 chroma_me=1 trellis=0 8x8dct=0 cqm=0 deadzone=21,11 fast_pskip=1 chroma_qp_offset=0 threads=6 lookahead_threads=1 sliced_threads=0 nr=0 decimate=1 interlaced=0 bluray_compat=0 constrained_intra=0 bframes=0 weightp=0 keyint=42 keyint_min=10 scenecut=0 intra_refresh=0 rc=crf mbtree=0 crf=23.0 qcomp=0.60 qpmin=0 qpmax=69 qpstep=4 ip_ratio=1.40 aq=0
2016-10-22 02:10:37,038 - ERROR - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> Could not load font "fonts/Inconsolata.otf": cannot open resource
2016-10-22 02:10:37,038 - ERROR - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> Error initializing filter 'drawtext'
2016-10-22 02:10:37,038 - ERROR - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >>  with args 'fontfile=fonts/Inconsolata.otf:textfile=C\:\\Users\\dab\\AppData\\Local\\Sighthound Video\\ts-c2f44435668e8b64dffe6aa5f7e00962:reload=1:x=0:y=0:fontsize=28:[email protected]:box=1:[email protected]'
2016-10-22 02:10:37,038 - ERROR - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >>
2016-10-22 02:10:37,038 - ERROR - StreamReader.pyo - open - Graph parse failed - args: drawtext=fontfile=fonts/Inconsolata.otf:textfile=C\\:\\\\Users\\\\dab\\\\AppData\\\\Local\\\\Sighthound Video\\\\ts-c2f44435668e8b64dffe6aa5f7e00962:reload=1:x=0:y=0:fontsize=28:[email protected]:box=1:[email protected]
2016-10-22 02:10:37,038 - ERROR - StreamReader.pyo - open - Could not allocate the filter
2016-10-22 02:10:37,038 - INFO - r16019yW_1002OZS.pyo - r16019yW_100l025 - Stream open successful
2016-10-22 02:10:37,038 - WARNING - r16019yW_1002Zll.pyo - r16019yW_1002lO1 - File 'PersonModel_-0.1.mat' does not exist...
2016-10-22 02:10:37,038 - WARNING - r16019yW_1002Zll.pyo - r16019yW_1002lO1 - File 'C:\Program Files (x86)\Sighthound Video\library.zip\analyticsLib\pipelineElements\pipelineUtils\c3\PersonModel_-0.1.mat' does not exist...
2016-10-22 02:10:37,038 - ERROR - r16019yW_1002OZS.pyo - run - Traceback (most recent call last):
  File "backEnd\r16019yW_1002OZS.pyo", line 162, in run
  File "backEnd\r16019yW_1002OZS.pyo", line 179, in r16019yW_100l02O
  File "backEnd\r16019yW_1002OZS.pyo", line 158, in r16019yW_100l025
  File "analyticsLib\r16019yW_1002ZZ0.pyo", line 34, in __init__
  File "analyticsLib\r16019yW_1002ZZ0.pyo", line 153, in r16019yW_1002ZO2
  File "analyticsLib\pipelineElements\pipelineUtils\c3\r16019yW_1002Zll.pyo", line 135, in r16019yW_1002lO1
RuntimeError: Couldn't find or open any of the model files: ['PersonModel_-0.1.mat', 'C:\\Program Files (x86)\\Sighthound Video\\library.zip\\analyticsLib\\pipelineElements\\pipelineUtils\\c3\\PersonModel_-0.1.mat']
2016-10-22 02:10:37,038 - ERROR - r16019yW_1002OZS.pyo - run - Couldn't find or open any of the model files: ['PersonModel_-0.1.mat', 'C:\\Program Files (x86)\\Sighthound Video\\library.zip\\analyticsLib\\pipelineElements\\pipelineUtils\\c3\\PersonModel_-0.1.mat']
2016-10-22 02:11:39,740 - INFO - r16019yW_1002OZS.pyo - __init__ - bitmapWindowMode=MediaCtrl
2016-10-22 02:11:39,740 - INFO - r16019yW_1002OZS.pyo - __init__ - Camera capture initialized, pid: 4204
2016-10-22 02:11:39,740 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> FFmpeg logging active
2016-10-22 02:11:39,740 - INFO - r16019yW_1002OZS.pyo - r16019yW_100l025 - Beginning stream open
2016-10-22 02:11:39,740 - INFO - StreamReader.pyo - open - Attempting to open camera at rtsp://[email protected]/Streaming/Channels/1
2016-10-22 02:11:39,740 - INFO - StreamReader.pyo - open - videolib: Opening rtsp://u:[email protected]/Streaming/Channels/1 using TCP for transport (streamId=0)
2016-10-22 02:11:40,663 - INFO - StreamReader.pyo - open - videolib: Initiate the "video/H264" subsession (client port 57994)
2016-10-22 02:11:40,663 - INFO - StreamReader.pyo - open - videolib: Setting socket buffer to 6291456
2016-10-22 02:11:40,663 - INFO - StreamReader.pyo - open - videolib: Set up the "video/H264" subsession (client port 57994)
2016-10-22 02:11:40,663 - INFO - StreamReader.pyo - open - videolib: Created a data sink for the "video/H264" subsession
2016-10-22 02:11:40,726 - INFO - StreamReader.pyo - open - videolib: Started playback on "[URL:"rtsp://u:[email protected]/Streaming/Channels/1/"]" session
2016-10-22 02:11:41,023 - INFO - StreamReader.pyo - open - Opened stream: uri=rtsp://u:[email protected]/Streaming/Channels/1, w=1920, h=1080, buf=2048
2016-10-22 02:11:41,023 - INFO - StreamReader.pyo - open - Opening local codec libx264 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 (28), 1920x1080
2016-10-22 02:11:41,023 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> using cpu capabilities: MMX2 SSE2Fast SSSE3 Cache64 UnalignedStack
2016-10-22 02:11:41,038 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> profile Constrained Baseline, level 4.0
2016-10-22 02:11:41,038 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> 264 - core 148 r2601 a0cd7d3 - H.264/MPEG-4 AVC codec - Copyright 2003-2015 - http://www.videolan.org/x264.html - options: cabac=0 ref=1 deblock=0:0:0 analyse=0:0 me=dia subme=0 psy=1 psy_rd=1.00:0.00 mixed_ref=0 me_range=16 chroma_me=1 trellis=0 8x8dct=0 cqm=0 deadzone=21,11 fast_pskip=1 chroma_qp_offset=0 threads=6 lookahead_threads=1 sliced_threads=0 nr=0 decimate=1 interlaced=0 bluray_compat=0 constrained_intra=0 bframes=0 weightp=0 keyint=42 keyint_min=10 scenecut=0 intra_refresh=0 rc=crf mbtree=0 crf=23.0 qcomp=0.60 qpmin=0 qpmax=69 qpstep=4 ip_ratio=1.40 aq=0
2016-10-22 02:11:41,038 - INFO - r16019yW_1002OZS.pyo - r16019yW_100l025 - Stream open successful
2016-10-22 02:11:41,085 - INFO - r16019xW_1001Z1S.pyo - run - launching server ('127.0.0.1', 49192) with 20 request thread(s)...
2016-10-22 02:11:41,085 - INFO - StreamReader.pyo - r16019yW_1001151 - Starting camera read loop...
2016-10-22 02:11:41,085 - INFO - r16019xW_1001Z1S.pyo - run - server running ('127.0.0.1', 49192)
2016-10-22 02:11:41,131 - INFO - r16019yW_1002OZS.pyo - r16019xW_1002O1O - Live view enabled
2016-10-22 02:11:41,131 - INFO - r16019yW_1002OZS.pyo - r16019xW_1002O1O - Live view disabled
2016-10-22 02:11:41,131 - INFO - r16019yW_1002OZS.pyo - r16019xW_1002O1O - Live view enabled
2016-10-22 02:11:41,319 - INFO - StreamReader.pyo - r16019yW_1001151 - Opening local codec libx264 H.264 / AVC / MPEG-4 AVC / MPEG-4 part 10 (28), 1920x1080
2016-10-22 02:11:41,319 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> using cpu capabilities: MMX2 SSE2Fast SSSE3 Cache64 UnalignedStack
2016-10-22 02:11:41,319 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> profile Constrained Baseline, level 4.0
2016-10-22 02:11:41,319 - INFO - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> 264 - core 148 r2601 a0cd7d3 - H.264/MPEG-4 AVC codec - Copyright 2003-2015 - http://www.videolan.org/x264.html - options: cabac=0 ref=1 deblock=0:0:0 analyse=0:0 me=dia subme=0 psy=1 psy_rd=1.00:0.00 mixed_ref=0 me_range=16 chroma_me=1 trellis=0 8x8dct=0 cqm=0 deadzone=21,11 fast_pskip=1 chroma_qp_offset=0 threads=6 lookahead_threads=1 sliced_threads=0 nr=0 decimate=1 interlaced=0 bluray_compat=0 constrained_intra=0 bframes=0 weightp=0 keyint=42 keyint_min=10 scenecut=0 intra_refresh=0 rc=crf mbtree=0 crf=23.0 qcomp=0.60 qpmin=0 qpmax=69 qpstep=4 ip_ratio=1.40 aq=0
2016-10-22 02:11:41,319 - WARNING - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> Using AVStream.codec.time_base as a timebase hint to the muxer is deprecated. Set AVStream.time_base instead.
2016-10-22 02:11:41,319 - WARNING - r16019xW_1002ZZZ.pyo - r16019xW_1002ZZO - FFMPEG >> Warning: data is not aligned! This can lead to a speedloss
2016-10-22 02:11:41,460 - INFO - r16019yW_1002OZS.pyo - r16019yW_100l0ll - Opened shared memory at C:\Users\dab\AppData\Local\Sighthound Video\live\Patio.live
2016-10-22 02:11:41,460 - INFO - r16019yW_1002OZS.pyo - r16019xW_1002O2S - 0.0 : {'priv': 214200}
2016-10-22 02:11:44,476 - INFO - r16019yW_1002OZS.pyo - r16019xW_1002O1O - Live view enabled
2016-10-22 02:11:54,569 - INFO - r16019yW_1002OZS.pyo - r16019xW_1002O1O - Live view disabled
2016-10-22 02:11:59,788 - INFO - r16019yW_1002OZS.pyo - r16019xW_1002O1O - Live view enabled
2016-10-22 02:11:59,881 - INFO - r16019yW_1002OZS.pyo - r16019yW_100l0ll - Opened shared memory at C:\Users\dab\AppData\Local\Sighthound Video\live\Patio.live


[emjay]

I'm having a similar issue - has a solution for this been found?

[Devin]

Hello emjay,

I'm sorry to hear you're also experiencing issues with your camera's connectivity. Please send us a bug report by going to Help > Report a Problem so we can take a look at your logs. Be sure to include a link to this post and a description of the behavior you're seeing so we can determine the cause.

Regards,

-Devin