Page 1 of 1

Foscam C2 zmc not stable

Posted: Thu Oct 12, 2017 1:19 am
by duke1swd
Newbie to Zoneminder, trying to set up my first camera.
I have a clean install of Debian 9.2 on an old PC, and a clean install of Zoneminder 1.30.4.
My camera is a Foscam C2.
Source Type Remote
Function Modect
Remote Protocol HTTP
Remote Method Simple
Remote Host Name [IP addr]
Remote Host Port 88
Remote Host Path: cgi-bin/CGIProxy.fcgi?cmd=snapPicture2&usr=XXX&pwd=XXX
Target Colorspace: 32 bit
Capture Width: 1920
Capture Height: 1080

Symptoms. I can monitor this camera perfectly. If I click on the monitor I get stable images at almost 7 fps. Motion events mostly don't work. There are many errors in the log suggesting difficulty talking to the camera. I don't understand why I can stream from the camera but cannot capture reliably from it. My load factor is typically under .25, my shm is 44%, and my disk is 6%. This is the only monitor enabled.

Here are a few minutes of log, starting with a zoneminder start:

Code: Select all

2017-10-11 21:08:45.685125 zma_m3[15814].INF-zma.cpp/142 [In mode 3/1, warming up]
2017-10-11 21:08:45.359030 zmdc[15814].INF-zmdc.pl ['zma -m 3' started at 17/10/11 21:08:45]
2017-10-11 21:08:45.355720 zmdc[15651].INF-zmdc.pl ['zma -m 3' starting at 17/10/11 21:08:45, pid = 15814]
2017-10-11 21:08:45.111260 zmwatch[15716].INF-zmwatch.pl [Restarting analysis daemon for  LRtSnap]
2017-10-11 21:08:45.048970 zmwatch[15716].ERR-zmwatch.pl [Error getting last capture time for  LRtSnap]
2017-10-11 21:08:35.733494 zmc_m3[15801].INF-zmc.cpp/247 [Starting Capture version 1.30.4]
2017-10-11 21:08:34.944440 zmdc[15801].INF-zmdc.pl ['zmc -m 3' started at 17/10/11 21:08:34]
2017-10-11 21:08:34.944430 zmdc[15651].INF-zmdc.pl ['zmc -m 3' starting at 17/10/11 21:08:34, pid = 15801]
2017-10-11 21:08:34.697160 zmwatch[15716].INF-zmwatch.pl [Restarting capture daemon for LRtSnap, shared data not valid]
2017-10-11 21:08:24.818570 zmdc[15651].ERR-zmdc.pl ['zmc -m 3' exited abnormally, exit status 255]
2017-10-11 21:08:24.603650 zmdc[15798].INF-zmdc.pl ['zmc -m 3' started at 17/10/11 21:08:24]
2017-10-11 21:08:24.603640 zmdc[15651].INF-zmdc.pl ['zmc -m 3' starting at 17/10/11 21:08:24, pid = 15798]
2017-10-11 21:08:24.367270 zmwatch[15716].INF-zmwatch.pl [Restarting capture daemon for LRtSnap, shared data not valid]
2017-10-11 21:08:24.329940 zmwatch[15716].ERR-zmwatch.pl [Memory map file '/dev/shm/zm.mmap.3' should have been 896 but was instead 0]
2017-10-11 21:08:23.433550 zmdc[15651].ERR-zmdc.pl ['zma -m 3' exited abnormally, exit status 255]
2017-10-11 21:08:23.383637 zma_m3[15795].ERR-zm_monitor.cpp/533 [Got empty memory map file size 0, is the zmc process for this monitor running?]
2017-10-11 21:08:23.135790 zmdc[15795].INF-zmdc.pl ['zma -m 3' started at 17/10/11 21:08:23]
2017-10-11 21:08:23.135780 zmdc[15651].INF-zmdc.pl ['zma -m 3' starting at 17/10/11 21:08:23, pid = 15795]
2017-10-11 21:08:23.079020 zmdc[15651].INF-zmdc.pl [Starting pending process, zma -m 3]
2017-10-11 21:08:14.228440 zmdc[15651].INF-zmdc.pl ['zmc -m 3' exited normally]
2017-10-11 21:08:14.040732 zmc_m3[15783].ERR-zm_remote_camera_http.cpp/1141 [Unable to get response, disconnecting]
2017-10-11 21:08:13.998916 zmc_m3[15783].ERR-zm_remote_camera_http.cpp/1026 [Unable to read content]
2017-10-11 21:08:13.957095 zmc_m3[15783].ERR-zm_remote_camera_http.cpp/175 [Select error: Interrupted system call]
2017-10-11 21:08:13.915357 zmc_m3[15783].INF-zm_signal.cpp/40 [Got signal 15 (Terminated), exiting]
2017-10-11 21:08:13.872300 zmdc[15651].INF-zmdc.pl ['zmc -m 3' sending stop to pid 15783 at 17/10/11 21:08:13]
2017-10-11 21:08:13.626930 zmwatch[15716].INF-zmwatch.pl [Restarting capture daemon for LRtSnap, time since last capture 13 seconds (1507770493-1507770480)]
2017-10-11 21:08:03.584150 zmdc[15651].INF-zmdc.pl ['zma -m 3' exited normally]
2017-10-11 21:08:03.472258 zma_m3[15774].INF-zm_signal.cpp/40 [Got signal 15 (Terminated), exiting]
2017-10-11 21:08:03.432370 zmdc[15651].INF-zmdc.pl ['zma -m 3' sending stop to pid 15774 at 17/10/11 21:08:03]
2017-10-11 21:08:03.196820 zmwatch[15716].INF-zmwatch.pl [Restarting analysis daemon for  LRtSnap]
2017-10-11 21:08:03.158560 zmwatch[15716].ERR-zmwatch.pl [Error getting last capture time for  LRtSnap]
2017-10-11 21:07:53.894244 zmc_m3[15783].INF-zmc.cpp/247 [Starting Capture version 1.30.4]
2017-10-11 21:07:53.052600 zmdc[15783].INF-zmdc.pl ['zmc -m 3' started at 17/10/11 21:07:53]
2017-10-11 21:07:53.051170 zmdc[15651].INF-zmdc.pl ['zmc -m 3' starting at 17/10/11 21:07:53, pid = 15783]
2017-10-11 21:07:52.793960 zmwatch[15716].INF-zmwatch.pl [Restarting capture daemon for LRtSnap, shared data not valid]
2017-10-11 21:07:42.959300 zmdc[15651].ERR-zmdc.pl ['zmc -m 3' exited abnormally, exit status 255]
2017-10-11 21:07:42.687380 zmdc[15651].INF-zmdc.pl ['zmc -m 3' starting at 17/10/11 21:07:42, pid = 15779]
2017-10-11 21:07:42.687380 zmdc[15779].INF-zmdc.pl ['zmc -m 3' started at 17/10/11 21:07:42]
2017-10-11 21:07:42.443300 zmwatch[15716].INF-zmwatch.pl [Restarting capture daemon for LRtSnap, shared data not valid]
2017-10-11 21:07:42.396750 zmwatch[15716].ERR-zmwatch.pl [Memory map file '/dev/shm/zm.mmap.3' does not exist.  zmc might not be running.]
2017-10-11 21:07:32.354420 zmdc[15651].INF-zmdc.pl ['zmc -m 3' exited normally]
2017-10-11 21:07:32.158820 zmc_m3[15762].ERR-zm_remote_camera_http.cpp/1141 [Unable to get response, disconnecting]
2017-10-11 21:07:32.117002 zmc_m3[15762].ERR-zm_remote_camera_http.cpp/1026 [Unable to read content]
2017-10-11 21:07:32.075183 zmc_m3[15762].ERR-zm_remote_camera_http.cpp/175 [Select error: Interrupted system call]
2017-10-11 21:07:32.033473 zmc_m3[15762].INF-zm_signal.cpp/40 [Got signal 15 (Terminated), exiting]
2017-10-11 21:07:31.990390 zmdc[15651].INF-zmdc.pl ['zmc -m 3' sending stop to pid 15762 at 17/10/11 21:07:31]
2017-10-11 21:07:31.745290 zmwatch[15716].INF-zmwatch.pl [Restarting capture daemon for LRtSnap, time since last capture 10 seconds (1507770451-1507770441)]
2017-10-11 21:07:21.423990 zma_m3[15774].INF-zma.cpp/142 [In mode 3/1, warming up]
2017-10-11 21:07:21.103460 zmdc[15774].INF-zmdc.pl ['zma -m 3' started at 17/10/11 21:07:21]
2017-10-11 21:07:21.101280 zmdc[15651].INF-zmdc.pl ['zma -m 3' starting at 17/10/11 21:07:21, pid = 15774]
2017-10-11 21:07:21.054100 zmdc[15651].INF-zmdc.pl [Starting pending process, zma -m 3]
2017-10-11 21:07:11.698480 zmdc[15651].INF-zmdc.pl ['zma -m 3' exited normally]
2017-10-11 21:07:11.547475 zma_m3[15730].INF-zm_signal.cpp/40 [Got signal 15 (Terminated), exiting]
2017-10-11 21:07:11.509030 zmdc[15651].INF-zmdc.pl ['zma -m 3' sending stop to pid 15730 at 17/10/11 21:07:11]
2017-10-11 21:07:11.263730 zmwatch[15716].INF-zmwatch.pl [Restarting analysis daemon for  LRtSnap]
2017-10-11 21:07:11.217330 zmwatch[15716].ERR-zmwatch.pl [Error getting last capture time for  LRtSnap]
2017-10-11 21:07:01.894728 zmc_m3[15762].INF-zmc.cpp/247 [Starting Capture version 1.30.4]
2017-10-11 21:07:01.111380 zmdc[15762].INF-zmdc.pl ['zmc -m 3' started at 17/10/11 21:07:01]
2017-10-11 21:07:01.111370 zmdc[15651].INF-zmdc.pl ['zmc -m 3' starting at 17/10/11 21:07:01, pid = 15762]
2017-10-11 21:07:00.879990 zmwatch[15716].INF-zmwatch.pl [Restarting capture daemon for LRtSnap, shared data not valid]
2017-10-11 21:06:55.381060 zmdc[15651].ERR-zmdc.pl ['zmc -m 3' exited abnormally, exit status 255]
2017-10-11 21:06:55.129260 zmdc[15759].INF-zmdc.pl ['zmc -m 3' started at 17/10/11 21:06:55]
2017-10-11 21:06:55.129250 zmdc[15651].INF-zmdc.pl ['zmc -m 3' starting at 17/10/11 21:06:55, pid = 15759]
2017-10-11 21:06:55.082040 zmdc[15651].INF-zmdc.pl [Starting pending process, zmc -m 3]
2017-10-11 21:06:50.838060 zmdc[15651].INF-zmdc.pl ['zmc -m 3' exited normally]
2017-10-11 21:06:50.650387 zmc_m3[15687].ERR-zm_remote_camera_http.cpp/1141 [Unable to get response, disconnecting]
2017-10-11 21:06:50.608569 zmc_m3[15687].ERR-zm_remote_camera_http.cpp/1026 [Unable to read content]
2017-10-11 21:06:50.566727 zmc_m3[15687].ERR-zm_remote_camera_http.cpp/175 [Select error: Interrupted system call]
2017-10-11 21:06:50.525001 zmc_m3[15687].INF-zm_signal.cpp/40 [Got signal 15 (Terminated), exiting]
2017-10-11 21:06:50.482070 zmdc[15651].INF-zmdc.pl ['zmc -m 3' sending stop to pid 15687 at 17/10/11 21:06:50]
2017-10-11 21:06:50.256100 zmwatch[15716].INF-zmwatch.pl [Restarting capture daemon for LRtSnap, time since last capture 10 seconds (1507770410-1507770400)]
2017-10-11 21:06:31.256464 zma_m3[15730].INF-zm_monitor.cpp/1716 [LRtSnap: 1060 - Closing event 105, alarm end]
2017-10-11 21:06:31.215757 zma_m3[15730].INF-zm_monitor.cpp/1711 [LRtSnap: 1060 - Left alarm state (105) - 79(5) images]
2017-10-11 21:06:26.220435 zma_m3[15730].INF-zm_monitor.cpp/1704 [LRtSnap: 1035 - Gone into alert state]
2017-10-11 21:06:25.965633 zma_m3[15730].INF-zm_monitor.cpp/1695 [LRtSnap: 1034 - Gone back into alarm state]
2017-10-11 21:06:25.776601 zma_m3[15730].INF-zm_monitor.cpp/1704 [LRtSnap: 1033 - Gone into alert state]
2017-10-11 21:06:25.329949 zma_m3[15730].INF-zm_monitor.cpp/1695 [LRtSnap: 1031 - Gone back into alarm state]
2017-10-11 21:06:21.065517 zma_m3[15730].INF-zm_monitor.cpp/1704 [LRtSnap: 1008 - Gone into alert state]
2017-10-11 21:06:19.906226 zma_m3[15730].INF-zm_monitor.cpp/1660 [LRtSnap: 1006 - Opening new event 105, alarm start]
2017-10-11 21:06:19.812871 zma_m3[15730].INF-zm_monitor.cpp/1614 [LRtSnap: 1006 - Gone into alarm state]
2017-10-11 21:06:19.005944 zma_m3[15730].INF-zm_monitor.cpp/1296 [LRtSnap: 1000 - Analysing at 6.45 fps]
2017-10-11 21:06:16.125945 zmc_m3[15687].INF-zm_monitor.cpp/3125 [LRtSnap: 1000 - Capturing at 6.37 fps]
2017-10-11 21:03:44.437569 zma_m3[15730].INF-zma.cpp/142 [In mode 3/1, warming up]
2017-10-11 21:03:44.134260 zmdc[15730].INF-zmdc.pl ['zma -m 3' started at 17/10/11 21:03:44]
2017-10-11 21:03:44.131480 zmdc[15651].INF-zmdc.pl ['zma -m 3' starting at 17/10/11 21:03:44, pid = 15730]
2017-10-11 21:03:44.088670 zmdc[15651].INF-zmdc.pl [Starting pending process, zma -m 3]
2017-10-11 21:03:40.194620 zmwatch[15716].INF-zmwatch.pl [Watchdog pausing for 30 seconds]
2017-10-11 21:03:40.152880 zmwatch[15716].INF-zmwatch.pl [Watchdog starting]
2017-10-11 21:03:39.840080 zmdc[15651].INF-zmdc.pl ['zmwatch.pl' starting at 17/10/11 21:03:39, pid = 15716]
2017-10-11 21:03:39.840080 zmdc[15716].INF-zmdc.pl ['zmwatch.pl' started at 17/10/11 21:03:39]
2017-10-11 21:03:39.593300 zmfilter[15698].INF-zmfilter.pl [Scanning for events]
2017-10-11 21:03:39.492400 zmdc[15706].INF-zmdc.pl ['zmaudit.pl -c' started at 17/10/11 21:03:39]
2017-10-11 21:03:39.489890 zmdc[15651].INF-zmdc.pl ['zmaudit.pl -c' starting at 17/10/11 21:03:39, pid = 15706]
2017-10-11 21:03:39.464308 zmc_m3[15687].INF-zmc.cpp/247 [Starting Capture version 1.30.4]
2017-10-11 21:03:39.359780 zmdc[15651].ERR-zmdc.pl ['zma -m 3' exited abnormally, exit status 255]
2017-10-11 21:03:39.310237 zma_m3[15697].ERR-zm_monitor.cpp/442 [Shared data not initialised by capture daemon for monitor LRtSnap]
2017-10-11 21:03:38.924060 zmdc[15698].INF-zmdc.pl ['zmfilter.pl' started at 17/10/11 21:03:38]
2017-10-11 21:03:38.920980 zmdc[15651].INF-zmdc.pl ['zmfilter.pl' starting at 17/10/11 21:03:38, pid = 15698]
2017-10-11 21:03:38.881830 zmdc[15697].INF-zmdc.pl ['zma -m 3' started at 17/10/11 21:03:38]
2017-10-11 21:03:38.878430 zmdc[15651].INF-zmdc.pl ['zma -m 3' starting at 17/10/11 21:03:38, pid = 15697]
2017-10-11 21:03:38.824760 zmdc[15651].INF-zmdc.pl [Starting pending process, zma -m 3]
2017-10-11 21:03:38.777440 zmdc[15651].ERR-zmdc.pl ['zma -m 3' exited abnormally, exit status 255]
2017-10-11 21:03:38.716707 zma_m3[15688].ERR-zm_monitor.cpp/442 [Shared data not initialised by capture daemon for monitor LRtSnap]
2017-10-11 21:03:38.443400 zmdc[15688].INF-zmdc.pl ['zma -m 3' started at 17/10/11 21:03:38]
2017-10-11 21:03:38.443390 zmdc[15651].INF-zmdc.pl ['zma -m 3' starting at 17/10/11 21:03:38, pid = 15688]
2017-10-11 21:03:38.342990 zmdc[15687].INF-zmdc.pl ['zmc -m 3' started at 17/10/11 21:03:38]
2017-10-11 21:03:38.342980 zmdc[15651].INF-zmdc.pl ['zmc -m 3' starting at 17/10/11 21:03:38, pid = 15687]
2017-10-11 21:03:38.290260 zmdc[15651].INF-zmdc.pl [Starting pending process, zmc -m 3]
2017-10-11 21:03:38.240110 zmdc[15651].ERR-zmdc.pl ['zmc -m 3' exited abnormally, exit status 255]
2017-10-11 21:03:37.994980 zmdc[15679].INF-zmdc.pl ['zmc -m 3' started at 17/10/11 21:03:37]
2017-10-11 21:03:37.994980 zmdc[15651].INF-zmdc.pl ['zmc -m 3' starting at 17/10/11 21:03:37, pid = 15679]
2017-10-11 21:03:37.739520 zmpkg[15609].INF-zmpkg.pl [Single server configuration detected. Starting up services.]
2017-10-11 21:03:34.729970 zmdc[15651].INF-zmdc.pl [Server starting at 17/10/11 21:03:34]
2017-10-11 21:03:34.072460 zmpkg[15609].INF-zmpkg.pl [Command: start]
2017-10-11 21:03:34.002700 zmpkg[15609].INF-zmpkg.pl [Sanity checking States table...]
2017-10-11 21:03:33.760760 zmsystemctl[15605].INF-zmsystemctl.pl [Redirecting command through systemctl]
2017-10-11 21:03:33.530070 zmpkg[15599].INF-zmpkg.pl [Command: start]
2017-10-11 21:03:33.475830 zmpkg[15599].INF-zmpkg.pl [Sanity checking States table...]
Any suggestions?

Thanks very much.

Re: Foscam C2 zmc not stable

Posted: Thu Oct 12, 2017 1:21 am
by duke1swd
Forgot to mention. In order to resolve a problem with private /tmp, I changed PATH_SWAP from /tmp/zm to /dev/shm.
Other than that, Zoneminder is running as set up from the zoneminder on debian quickstart guide.

Re: Foscam C2 zmc not stable

Posted: Sat Oct 14, 2017 12:32 pm
by duke1swd
Update on this issue. I moved the camera from a WiFi connection to a hardwired Ethernet connection and the problem went away.
Not sure if this is a problem with the camera or my WiFi.

Re: Foscam C2 zmc not stable

Posted: Sun Oct 15, 2017 5:23 pm
by duke1swd
Upgraded my C2 firmware from

1.11.1.5/2.72.1.21
to
1.11.1.10/2.72.1.49.

This appears to have reduced the problem. Not gone, but better.