Camera captures only a few of seconds

Forum for questions and support relating to the 1.32.x releases only.
Post Reply
fotoclaes
Posts: 1
Joined: Thu Jun 27, 2019 7:29 pm

Camera captures only a few of seconds

Post by fotoclaes »

I have recently installed zoneminder and added my first camera but it fails miserably. It captures just for a few of seconds and then restarts the capture service. Here is my log:

Code: Select all

2019-06-27 19:26:39.839870 zmwatch[64120].ERR-zmwatch.pl [Last analyse time for 2 Kamera0 was zero.]
2019-06-27 19:26:39.483432 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:1300 - Capturing at 2.86 fps, capturing bandwidth 22272bytes/sec]
2019-06-27 19:26:36.541509 zmc_m2[101448].INF-zm_ffmpeg_camera.cpp/378 [Stream open rtsp://admin:XXXXXXXXXXXX@192.168.1.80:554/ch1/main/av_stream, parsing streams...]
2019-06-27 19:26:33.495559 zmc_m2[101448].INF-zm_ffmpeg_camera.cpp/163 [Priming capture from rtsp://admin:XXXXXXXXXXXX@192.168.1.80:554/ch1/main/av_stream]
2019-06-27 19:26:29.569079 zmc_m2[101448].INF-zmc.cpp/311 [Failed to capture image from monitor 2 Kamera0 (1/1)]
2019-06-27 19:26:29.376542 zmc_m2[101448].INF-zm_monitor.cpp/2391 [Return from Capture (-1), signal loss]
2019-06-27 19:26:29.322840 zmdc[64047].INF-zmdc.pl [Command 'zma -m 2' removed from pending list at 19/06/27 21:26:29]
2019-06-27 19:26:29.154571 zmc_m2[101448].INF-zm_ffmpeg_camera.cpp/710 [Unable to read packet from stream 0: error -541478725 "End of file".]
2019-06-27 19:26:29.089403 web_php[67603].ERR-includes/functions.php/2048 [Socket /var/run/zm/zms-688488s.sock does not exist.  This file is created by zms, and since it does not exist, either zms did not run, or zms exited early.  Please check your zms logs and ensure that CGI is enabled in apache and check that the PATH_ZMS is set correctly.  Make sure that ZM is actually recording.  If you are trying to view a live stream and the capture process (zmc) is not running then zms will exit. Please go to http://zoneminder.readthedocs.io/en/latest/faq.html#why-can-t-i-see-streamed-images-when-i-can-see-stills-in-the-zone-window-etc for more information.]
2019-06-27 19:26:29.077393 web_js[67899].ERR-?view=watch [getStreamCmdResponse stream error: No data to read from socket - checkStreamForErrors()]
2019-06-27 19:26:28.972420 zmwatch[64120].INF-zmwatch.pl [Restarting analysis daemon for 2 Kamera0]
2019-06-27 19:26:28.892834 web_php[67036].ERR-includes/functions.php/2048 [No data to read from socket]
2019-06-27 19:26:28.862191 zmc_m2[101448].WAR-zm_ffmpeg_camera.cpp/900 [Unable to receive frame 1235: Resource temporarily unavailable, continuing]
2019-06-27 19:26:27.704024 zmc_m2[101448].WAR-zm_ffmpeg_camera.cpp/900 [Unable to receive frame 1235: Resource temporarily unavailable, continuing]
2019-06-27 19:26:25.976195 web_php[67036].ERR-ajax/stream.php/90 [Timed out waiting for msg /var/run/zm/zms-688488s.sock]
2019-06-27 19:26:24.511800 zmdc[64047].INF-zmdc.pl ['zma -m 2' exited normally]
2019-06-27 19:26:24.441850 zmwatch[64120].ERR-zmwatch.pl [Last analyse time for 2 Kamera0 was zero.]
2019-06-27 19:26:14.107232 zms_m2[100935].ERR-zm_monitorstream.cpp/713 [Terminating, last frame sent time 10.003382 secs more than maximum of 10.000000]
2019-06-27 19:26:04.070381 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:1200 - Capturing at 20.00 fps, capturing bandwidth 144270bytes/sec]
2019-06-27 19:25:59.185331 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:1100 - Capturing at 5.88 fps, capturing bandwidth 64965bytes/sec]
2019-06-27 19:25:58.383586 zms_m2[101204].WAR-zm_monitorstream.cpp/410 [Unable to send stream frame: Broken pipe]
2019-06-27 19:25:58.149655 web_js[67603].ERR-?view=watch [getStreamCmdResponse stream error: No data to read from socket - checkStreamForErrors()]
2019-06-27 19:25:58.139638 zma_m2[102347].INF-zm_signal.cpp/40 [Got signal 15 (Terminated), exiting]
2019-06-27 19:25:57.443510 web_php[67036].ERR-includes/functions.php/2048 [No data to read from socket]
2019-06-27 19:25:54.735873 web_php[67036].ERR-ajax/stream.php/90 [Timed out waiting for msg /var/run/zm/zms-585958s.sock]
2019-06-27 19:25:54.393790 zmdc[64047].INF-zmdc.pl ['zma -m 2' sending stop to pid 67749 at 19/06/27 21:25:54]
2019-06-27 19:25:52.335884 zms_m2[102258].ERR-zm_monitorstream.cpp/713 [Terminating, last frame sent time 10.010509 secs more than maximum of 10.000000]
2019-06-27 19:25:52.009510 zmfilter_1[64100].INF-zmfilter.pl [Checking filter PurgeWhenFull delete returned 0 events ]
2019-06-27 19:25:51.955420 zmfilter_2[64104].INF-zmfilter.pl [Checking filter Update DiskSpace update disk space returned 0 events ]
2019-06-27 19:25:51.835540 zmwatch[64120].INF-zmwatch.pl [Restarting analysis daemon for 2 Kamera0]
2019-06-27 19:25:47.991130 zmwatch[64120].INF-zmwatch.pl [Analysis daemon for 2 Kamera0 needs restarting, time since last analysis 7 seconds (1561663547-1561663540)]
2019-06-27 19:25:42.279923 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:1000 - Capturing at 25.00 fps, capturing bandwidth 146437bytes/sec]
2019-06-27 19:25:41.007399 zma_m2[102347].INF-zm_monitor.cpp/1247 [Kamera0: 500 - Analysing at 12.50 fps]
2019-06-27 19:25:38.891739 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:900 - Capturing at 25.00 fps, capturing bandwidth 145668bytes/sec]
2019-06-27 19:25:34.234333 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:800 - Capturing at 16.67 fps, capturing bandwidth 98112bytes/sec]
2019-06-27 19:25:33.038865 zma_m2[102347].INF-zm_monitor.cpp/1247 [Kamera0: 400 - Analysing at 9.09 fps]
2019-06-27 19:25:28.326437 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:700 - Capturing at 20.00 fps, capturing bandwidth 117503bytes/sec]
2019-06-27 19:25:23.715197 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:600 - Capturing at 20.00 fps, capturing bandwidth 117366bytes/sec]
2019-06-27 19:25:22.541975 zma_m2[102347].INF-zm_monitor.cpp/1247 [Kamera0: 300 - Analysing at 7.69 fps]
2019-06-27 19:25:18.145790 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:500 - Capturing at 14.29 fps, capturing bandwidth 83526bytes/sec]
2019-06-27 19:25:11.117059 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:400 - Capturing at 20.00 fps, capturing bandwidth 115933bytes/sec]
2019-06-27 19:25:09.954960 zma_m2[102347].INF-zm_monitor.cpp/1247 [Kamera0: 200 - Analysing at 10.00 fps]
2019-06-27 19:25:06.190096 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:300 - Capturing at 16.67 fps, capturing bandwidth 98670bytes/sec]
2019-06-27 19:25:00.479563 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:200 - Capturing at 25.00 fps, capturing bandwidth 146155bytes/sec]
2019-06-27 19:24:59.111547 zma_m2[102347].INF-zm_monitor.cpp/1247 [Kamera0: 100 - Analysing at 14.29 fps]
2019-06-27 19:24:56.479649 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:100 - Capturing at 33.33 fps, capturing bandwidth 190545bytes/sec]
2019-06-27 19:24:53.846318 zma_m2[102347].INF-zma.cpp/134 [In mode 3/1, warming up]
2019-06-27 19:24:53.645413 zmc_m2[101448].INF-zm_monitor.cpp/2477 [Kamera0: images:1 - Capturing at 25.00 fps, capturing bandwidth 9699bytes/sec]
2019-06-27 19:24:52.438672 zmc_m2[101448].INF-zm_ffmpeg_camera.cpp/378 [Stream open rtsp://admin:XXXXXXXXXXXX@192.168.1.80:554/ch1/main/av_stream, parsing streams...]
2019-06-27 19:24:52.103661 zmc_m2[101448].INF-zm_ffmpeg_camera.cpp/163 [Priming capture from rtsp://admin:XXXXXXXXXXXX@192.168.1.80:554/ch1/main/av_stream]
2019-06-27 19:24:52.001970 zmdc[67749].INF-zmdc.pl ['zma -m 2' started at 19/06/27 21:24:52]
2019-06-27 19:24:52.001840 zmdc[64047].INF-zmdc.pl ['zma -m 2' starting at 19/06/27 21:24:52, pid = 67749]
2019-06-27 19:24:50.317020 zmfilter_1[64100].INF-zmfilter.pl [Checking filter PurgeWhenFull delete returned 0 events ]
2019-06-27 19:24:49.551050 zmfilter_2[64104].INF-zmfilter.pl [Checking filter Update DiskSpace update disk space returned 0 events ]
2019-06-27 19:24:49.489620 zmdc[64047].INF-zmdc.pl [Starting pending process, zma -m 2]
2019-06-27 19:24:49.131563 zmc_m2[101448].INF-zmc.cpp/223 [Starting Capture version 1.32.3]
2019-06-27 19:24:48.436170 zmdc[64047].ERR-zmdc.pl ['zma -m 2' exited abnormally, exit status 255]
2019-06-27 19:24:48.318334 zma_m2[100543].ERR-zm_monitor.cpp/477 [Shared data not initialised by capture daemon for monitor Kamera0]
2019-06-27 19:24:47.661570 zmdc[67741].INF-zmdc.pl ['zma -m 2' started at 19/06/27 21:24:47]
2019-06-27 19:24:47.661280 zmdc[64047].INF-zmdc.pl ['zma -m 2' starting at 19/06/27 21:24:47, pid = 67741]
2019-06-27 19:24:45.090110 zmdc[64047].INF-zmdc.pl ['zmc -m 2' starting at 19/06/27 21:24:45, pid = 67738]
2019-06-27 19:24:45.089990 zmdc[67738].INF-zmdc.pl ['zmc -m 2' started at 19/06/27 21:24:45]
2019-06-27 19:24:42.870790 zmdc[64047].WAR-zmdc.pl [Can't find process with command of 'zmc -m 2']
2019-06-27 19:24:39.524750 zmdc[64047].INF-zmdc.pl ['zma -m 2' exited, signal 14]
2019-06-27 19:24:38.240469 zma_m2[102268].ERR-zm_monitor.cpp/538 [Got empty memory map file size 0, is the zmc process for this monitor running?]
2019-06-27 19:24:37.739850 zmdc[64047].INF-zmdc.pl ['zma -m 2' sending stop to pid 67725 at 19/06/27 21:24:37]
2019-06-27 19:24:36.776070 zmdc[67725].INF-zmdc.pl ['zma -m 2' started at 19/06/27 21:24:36]
2019-06-27 19:24:36.775960 zmdc[64047].INF-zmdc.pl ['zma -m 2' starting at 19/06/27 21:24:36, pid = 67725]
2019-06-27 19:24:33.270950 zmdc[64047].INF-zmdc.pl [Starting pending process, zma -m 2]
2019-06-27 19:24:33.019910 zmwatch[64120].INF-zmwatch.pl [Restarting capture daemon for Kamera0, shared data not valid]
2019-06-27 19:24:31.262200 zmwatch[64120].ERR-zmwatch.pl [Memory map file '/tmp/zm.mmap.2' should have been 1160 but was instead 0]
2019-06-27 19:24:28.530640 zmdc[64047].ERR-zmdc.pl ['zma -m 2' exited abnormally, exit status 255]
2019-06-27 19:24:26.986528 zma_m2[102258].ERR-zm_monitor.cpp/538 [Got empty memory map file size 0, is the zmc process for this monitor running?]
2019-06-27 19:24:26.016230 zmdc[67707].INF-zmdc.pl ['zma -m 2' started at 19/06/27 21:24:26]
2019-06-27 19:24:26.016130 zmdc[64047].INF-zmdc.pl ['zma -m 2' starting at 19/06/27 21:24:26, pid = 67707]
2019-06-27 19:24:24.968900 zmdc[64047].INF-zmdc.pl [Starting pending process, zma -m 2]
2019-06-27 19:24:22.326210 zmdc[64047].ERR-zmdc.pl ['zma -m 2' exited abnormally, exit status 255]
2019-06-27 19:24:21.462689 zma_m2[102258].ERR-zm_monitor.cpp/538 [Got empty memory map file size 0, is the zmc process for this monitor running?]
2019-06-27 19:24:20.259100 zmdc[67696].INF-zmdc.pl ['zma -m 2' started at 19/06/27 21:24:20]
2019-06-27 19:24:20.258970 zmdc[64047].INF-zmdc.pl ['zma -m 2' starting at 19/06/27 21:24:20, pid = 67696]
2019-06-27 19:24:20.053510 zmdc[64047].INF-zmdc.pl ['zma -m 2' exited, signal 14]
2019-06-27 19:24:15.216180 zmdc[64047].INF-zmdc.pl [Command 'zmc -m 2' removed from pending list at 19/06/27 21:24:15]
2019-06-27 19:24:12.833500 zmdc[64047].INF-zmdc.pl ['zmc -m 2' exited normally]
2019-06-27 19:24:10.285494 zma_m2[100708].INF-zma.cpp/134 [In mode 3/1, warming up]
2019-06-27 19:24:09.605200 zmdc[64047].INF-zmdc.pl ['zma -m 2' sending stop to pid 67638 at 19/06/27 21:24:09]
2019-06-27 19:24:08.678940 zmwatch[64120].INF-zmwatch.pl [Restarting capture daemon for Kamera0, no image since startup. Startup time was 1561663433 - now 1561663448 > 5]
2019-06-27 19:23:54.771546 zmc_m2[100697].ERR-zmc.cpp/253 [Failed to prime capture of initial monitor]
2019-06-27 19:23:53.838680 zmdc[67638].INF-zmdc.pl ['zma -m 2' started at 19/06/27 21:23:53]
2019-06-27 19:23:53.838540 zmdc[64047].INF-zmdc.pl ['zma -m 2' starting at 19/06/27 21:23:53, pid = 67638]
2019-06-27 19:23:53.836069 zmc_m2[100697].ERR-zm_ffmpeg_camera.cpp/357 [Unable to open input rtsp://admin:XXXXXXXXXXXX@192.168.1.80:554/ch1/main/av_stream due to: Operation now in progress]
2019-06-27 19:23:53.592636 zmc_m2[100697].INF-zm_ffmpeg_camera.cpp/163 [Priming capture from rtsp://admin:XXXXXXXXXXXX@192.168.1.80:554/ch1/main/av_stream]
2019-06-27 19:23:52.685740 zmdc[64047].INF-zmdc.pl ['zmc -m 2' sending stop to pid 67619 at 19/06/27 21:23:52]
2019-06-27 19:23:51.231177 zmc_m2[100697].INF-zmc.cpp/223 [Starting Capture version 1.32.3]
I am running zoneminder 1.32.3 as a plugin in freenas 11.2_U4
Zoneminder is using between 50 & 75% of the cpu power!

Where goes everything wrong? I have been following the hikvision guide when adding the camera.
https://wiki.zoneminder.com/Hikvision


Camera:
Hikvision DS-2CD2543G0-IW, cable connected

HW:
AMD Phenom II x6 1090T
16GB Ram
Post Reply