Unwanted triggers.

Discussions related to the 1.36.x series of ZoneMinder
Post Reply
User6677
Posts: 17
Joined: Sat Dec 24, 2022 9:32 am

Unwanted triggers.

Post by User6677 »

Does anyone have any idea how to troubleshoot unwanted triggers that most likely are coming from zmtrigger.pl or some mechanism in ZM that receives these triggers? Is there some extra debugging I can enable? Logs have no info beyond the triggers they should have.

All my cameras are set to Mocord and no detection.

But starting from beginning. I'm using a couple of triggering scripts that talk to zmtrigger. My triggering scripts work fine triggering lets say at 9:21 and cancelling at 9:23 putting a note of "Cam Event" in the info field - this is logged by the script as well as by zmtrigger like this:

Code: Select all

04/10/24 09:21:37.654457 zmtrigger[170].INF [main:418] [Trigger 'on' 'Cam Event']
04/10/24 09:23:01.657856 zmtrigger[170].INF [main:445] [Cancelled event]
However, from then on I'm getting a series of triggers at random every few seconds or up to every minute. The time span between them is random. They all have my info field "Cam Event". Sometimes these will stop on their own. Sometimes they will go on until I restart zonemider service.

What I checked:
- Logs - obviously (both my scripts, ZM and zmtrigger)
- I restarted my scripts during the unwanted triggering string - it made no difference
- I restarted ZM service, this stopped the issue
- I checked the cameras, I have them configured to upload to FTP on every alert - only the correct alert photos are present (anyway my scripts and zmtrigger would log if this was caused by cameras).

Is there a bug like this in 1.36.33? Has anyone seen this? Is there a fix?

Edit: The only indication of this event is in the zmc_mX.log, but there it it not really saying where the event came from. It says:

Code: Select all

04/10/24 11:01:57.172765 zmc_m5[261].INF-zm_monitor.cpp/1933 [PodworkoPrawo: 3741746 - Opened new event 30512, section start]
04/10/24 11:11:56.218796 zmc_m5[261].INF-zm_monitor.cpp/1907 [PodworkoPrawo: 3747745 - Closing event 30512, section end forced 1712740316 - 1712739716 = 600 >= 600]
04/10/24 11:11:56.223351 zmc_m5[261].INF-zm_monitor.cpp/1933 [PodworkoPrawo: 3747743 - Opened new event 30522, section start]
Edit2: In addition, I'm not sure if this is the same problem or another, trigger cancellations sent through zmtrigger.pl sometimes don't work. For example:

this is just a moment ago a log from zmtrigger.pl

Code: Select all

04/10/24 11:14:14.605316 zmtrigger[162607].INF [main:98] [Trigger daemon starting]
04/10/24 11:14:14.606402 zmtrigger[162607].INF [main:104] [Opening connection 'Chan1 TCP on port 6802']
04/10/24 11:14:14.608124 zmtrigger[162607].INF [main:104] [Opening connection 'Chan2 Unix Socket at /run/zm/zmtrigger.sock']
04/10/24 11:39:26.080088 zmtrigger[162607].INF [main:418] [Trigger 'on' 'Cam Event']
04/10/24 11:40:44.517801 zmtrigger[162607].INF [main:445] [Cancelled event]
04/10/24 12:13:30.514629 zmtrigger[162607].INF [main:418] [Trigger 'on' 'Cam Event']
04/10/24 12:15:54.475687 zmtrigger[162607].INF [main:445] [Cancelled event]
04/10/24 12:19:49.887764 zmtrigger[162607].INF [main:418] [Trigger 'on' 'Cam Event']
04/10/24 12:21:14.543929 zmtrigger[162607].INF [main:445] [Cancelled event]
04/10/24 12:24:33.017334 zmtrigger[162607].INF [main:418] [Trigger 'on' 'Cam Event']
04/10/24 12:24:43.739606 zmtrigger[162607].INF [main:418] [Trigger 'on' 'Cam Event']
04/10/24 12:24:58.670570 zmtrigger[162607].INF [main:418] [Trigger 'on' 'Cam Event']
04/10/24 12:25:54.472597 zmtrigger[162607].INF [main:445] [Cancelled event]
04/10/24 12:26:24.535562 zmtrigger[162607].INF [main:445] [Cancelled event]
04/10/24 12:29:14.552125 zmtrigger[162607].INF [main:445] [Cancelled event]
One of these cameras is called "Wejscie", monitor3, its zmc log looks like this:

Code: Select all

04/10/24 12:23:46.994719 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 41800 - Capturing at 10.00 fps, capturing bandwidth 463349bytes/sec Analysing at 0.00 fps]
04/10/24 12:23:56.990690 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 41900 - Capturing at 10.00 fps, capturing bandwidth 476077bytes/sec Analysing at 0.00 fps]
04/10/24 12:24:07.044671 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 42000 - Capturing at 9.95 fps, capturing bandwidth 473156bytes/sec Analysing at 0.00 fps]
04/10/24 12:24:10.084607 zmc_m3[162655].INF-zm_monitor.cpp/1907 [Wejscie: 42030 - Closing event 30589, section end forced 1712744650 - 1712744050 = 600 >= 600]
04/10/24 12:24:10.089867 zmc_m3[162655].INF-zm_monitor.cpp/1933 [Wejscie: 42029 - Opened new event 30598, section start]
04/10/24 12:24:10.091457 zmc_m3[164600].INF-zm_videostore.cpp/532 [some options not used, turn on debugging for a list.]
04/10/24 12:24:17.053110 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 42100 - Capturing at 9.99 fps, capturing bandwidth 494534bytes/sec Analysing at 0.00 fps]
04/10/24 12:24:27.048655 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 42200 - Capturing at 10.00 fps, capturing bandwidth 473884bytes/sec Analysing at 0.00 fps]
04/10/24 12:24:37.052131 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 42300 - Capturing at 10.00 fps, capturing bandwidth 499361bytes/sec Analysing at 0.00 fps]
04/10/24 12:24:43.999760 zmc_m3[162655].INF-zm_monitor.cpp/1976 [Wejscie: 42369 - Gone into alarm state PreAlarmCount: 0 > AlarmFrameCount:1 Cause:]
04/10/24 12:24:47.054321 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 42400 - Capturing at 10.00 fps, capturing bandwidth 471963bytes/sec Analysing at 0.00 fps]
04/10/24 12:24:57.010516 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 42500 - Capturing at 10.04 fps, capturing bandwidth 463076bytes/sec Analysing at 0.00 fps]
04/10/24 12:25:07.057790 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 42600 - Capturing at 9.95 fps, capturing bandwidth 441374bytes/sec Analysing at 0.00 fps]
04/10/24 12:25:16.960972 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 42700 - Capturing at 10.10 fps, capturing bandwidth 450992bytes/sec Analysing at 0.00 fps]
04/10/24 12:25:26.965061 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 42800 - Capturing at 10.00 fps, capturing bandwidth 418579bytes/sec Analysing at 0.00 fps]
04/10/24 12:25:36.971204 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 42900 - Capturing at 9.99 fps, capturing bandwidth 422580bytes/sec Analysing at 0.00 fps]
04/10/24 12:25:46.971913 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 43000 - Capturing at 10.00 fps, capturing bandwidth 408466bytes/sec Analysing at 0.00 fps]
04/10/24 12:25:56.967215 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 43100 - Capturing at 10.00 fps, capturing bandwidth 415853bytes/sec Analysing at 0.00 fps]
04/10/24 12:26:06.969747 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 43200 - Capturing at 10.00 fps, capturing bandwidth 443784bytes/sec Analysing at 0.00 fps]
04/10/24 12:26:16.977174 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 43300 - Capturing at 9.99 fps, capturing bandwidth 432042bytes/sec Analysing at 0.00 fps]
04/10/24 12:26:26.974645 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 43400 - Capturing at 10.00 fps, capturing bandwidth 430330bytes/sec Analysing at 0.00 fps]
04/10/24 12:26:36.973916 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 43500 - Capturing at 10.00 fps, capturing bandwidth 413658bytes/sec Analysing at 0.00 fps]
04/10/24 12:26:46.982732 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 43600 - Capturing at 9.99 fps, capturing bandwidth 399753bytes/sec Analysing at 0.00 fps]
04/10/24 12:26:56.994032 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 43700 - Capturing at 9.99 fps, capturing bandwidth 406706bytes/sec Analysing at 0.00 fps]
04/10/24 12:27:06.931637 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 43800 - Capturing at 10.06 fps, capturing bandwidth 412469bytes/sec Analysing at 0.00 fps]
04/10/24 12:27:16.935562 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 43900 - Capturing at 10.00 fps, capturing bandwidth 399433bytes/sec Analysing at 0.00 fps]
04/10/24 12:27:26.930648 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 44000 - Capturing at 10.00 fps, capturing bandwidth 408325bytes/sec Analysing at 0.00 fps]
04/10/24 12:27:36.938546 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 44100 - Capturing at 9.99 fps, capturing bandwidth 428502bytes/sec Analysing at 0.00 fps]
04/10/24 12:27:46.937808 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 44200 - Capturing at 10.00 fps, capturing bandwidth 426929bytes/sec Analysing at 0.00 fps]
04/10/24 12:27:56.939696 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 44300 - Capturing at 10.00 fps, capturing bandwidth 476221bytes/sec Analysing at 0.00 fps]
04/10/24 12:28:06.939882 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 44400 - Capturing at 10.00 fps, capturing bandwidth 473538bytes/sec Analysing at 0.00 fps]
04/10/24 12:28:16.943280 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 44500 - Capturing at 10.00 fps, capturing bandwidth 455004bytes/sec Analysing at 0.00 fps]
04/10/24 12:28:26.946372 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 44600 - Capturing at 10.00 fps, capturing bandwidth 447910bytes/sec Analysing at 0.00 fps]
04/10/24 12:28:36.946323 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 44700 - Capturing at 10.00 fps, capturing bandwidth 445802bytes/sec Analysing at 0.00 fps]
04/10/24 12:28:46.952690 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 44800 - Capturing at 9.99 fps, capturing bandwidth 430524bytes/sec Analysing at 0.00 fps]
04/10/24 12:28:56.954659 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 44900 - Capturing at 10.00 fps, capturing bandwidth 423163bytes/sec Analysing at 0.00 fps]
04/10/24 12:29:06.953295 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 45000 - Capturing at 10.00 fps, capturing bandwidth 414598bytes/sec Analysing at 0.00 fps]
04/10/24 12:29:16.954500 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 45100 - Capturing at 10.00 fps, capturing bandwidth 416453bytes/sec Analysing at 0.00 fps]
04/10/24 12:29:26.958408 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 45200 - Capturing at 10.00 fps, capturing bandwidth 424283bytes/sec Analysing at 0.00 fps]
04/10/24 12:29:36.958192 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 45300 - Capturing at 10.00 fps, capturing bandwidth 432080bytes/sec Analysing at 0.00 fps]
04/10/24 12:29:46.969216 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 45400 - Capturing at 9.99 fps, capturing bandwidth 440923bytes/sec Analysing at 0.00 fps]
04/10/24 12:29:56.963425 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 45500 - Capturing at 10.01 fps, capturing bandwidth 435107bytes/sec Analysing at 0.00 fps]
04/10/24 12:30:06.964306 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 45600 - Capturing at 10.00 fps, capturing bandwidth 429137bytes/sec Analysing at 0.00 fps]
04/10/24 12:30:16.967402 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 45700 - Capturing at 10.00 fps, capturing bandwidth 431407bytes/sec Analysing at 0.00 fps]
04/10/24 12:30:26.971501 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 45800 - Capturing at 10.00 fps, capturing bandwidth 442417bytes/sec Analysing at 0.00 fps]
04/10/24 12:30:36.975581 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 45900 - Capturing at 10.00 fps, capturing bandwidth 422636bytes/sec Analysing at 0.00 fps]
04/10/24 12:30:46.972482 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 46000 - Capturing at 10.00 fps, capturing bandwidth 417719bytes/sec Analysing at 0.00 fps]
04/10/24 12:30:56.976661 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 46100 - Capturing at 10.00 fps, capturing bandwidth 414952bytes/sec Analysing at 0.00 fps]
04/10/24 12:31:06.975908 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 46200 - Capturing at 10.00 fps, capturing bandwidth 413523bytes/sec Analysing at 0.00 fps]
04/10/24 12:31:16.978601 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 46300 - Capturing at 10.00 fps, capturing bandwidth 418619bytes/sec Analysing at 0.00 fps]
04/10/24 12:31:26.976896 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 46400 - Capturing at 10.00 fps, capturing bandwidth 415243bytes/sec Analysing at 0.00 fps]
04/10/24 12:31:36.984773 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 46500 - Capturing at 9.99 fps, capturing bandwidth 423868bytes/sec Analysing at 0.00 fps]
04/10/24 12:31:46.983014 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 46600 - Capturing at 10.00 fps, capturing bandwidth 431719bytes/sec Analysing at 0.00 fps]
04/10/24 12:31:56.985497 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 46700 - Capturing at 10.00 fps, capturing bandwidth 440742bytes/sec Analysing at 0.00 fps]
04/10/24 12:32:06.984269 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 46800 - Capturing at 10.00 fps, capturing bandwidth 429096bytes/sec Analysing at 0.00 fps]
04/10/24 12:32:16.992139 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 46900 - Capturing at 9.99 fps, capturing bandwidth 427587bytes/sec Analysing at 0.00 fps]
04/10/24 12:32:26.997775 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 47000 - Capturing at 9.99 fps, capturing bandwidth 444036bytes/sec Analysing at 0.00 fps]
04/10/24 12:32:36.993268 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 47100 - Capturing at 10.00 fps, capturing bandwidth 445125bytes/sec Analysing at 0.00 fps]
04/10/24 12:32:46.997862 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 47200 - Capturing at 10.00 fps, capturing bandwidth 426286bytes/sec Analysing at 0.00 fps]
04/10/24 12:32:56.996295 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 47300 - Capturing at 10.00 fps, capturing bandwidth 443242bytes/sec Analysing at 0.00 fps]
04/10/24 12:33:07.000409 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 47400 - Capturing at 10.00 fps, capturing bandwidth 435698bytes/sec Analysing at 0.00 fps]
04/10/24 12:33:17.000919 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 47500 - Capturing at 10.00 fps, capturing bandwidth 411413bytes/sec Analysing at 0.00 fps]
04/10/24 12:33:27.003161 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 47600 - Capturing at 10.00 fps, capturing bandwidth 404925bytes/sec Analysing at 0.00 fps]
04/10/24 12:33:37.004598 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 47700 - Capturing at 10.00 fps, capturing bandwidth 416775bytes/sec Analysing at 0.00 fps]
04/10/24 12:33:47.007225 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 47800 - Capturing at 10.00 fps, capturing bandwidth 418650bytes/sec Analysing at 0.00 fps]
04/10/24 12:33:57.010579 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 47900 - Capturing at 10.00 fps, capturing bandwidth 487886bytes/sec Analysing at 0.00 fps]
04/10/24 12:34:07.011552 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 48000 - Capturing at 10.00 fps, capturing bandwidth 493565bytes/sec Analysing at 0.00 fps]
04/10/24 12:34:09.163019 zmc_m3[162655].INF-zm_monitor.cpp/1907 [Wejscie: 48021 - Closing event 30598, section end forced 1712745249 - 1712744649 = 600 >= 600]
04/10/24 12:34:09.165996 zmc_m3[162655].INF-zm_monitor.cpp/1933 [Wejscie: 48019 - Opened new event 30608, section start]
04/10/24 12:34:09.166789 zmc_m3[164982].INF-zm_videostore.cpp/532 [some options not used, turn on debugging for a list.]
04/10/24 12:34:17.012119 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 48100 - Capturing at 10.00 fps, capturing bandwidth 458479bytes/sec Analysing at 0.00 fps]
04/10/24 12:34:27.014665 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 48200 - Capturing at 10.00 fps, capturing bandwidth 451634bytes/sec Analysing at 0.00 fps]
04/10/24 12:34:37.017860 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 48300 - Capturing at 10.00 fps, capturing bandwidth 468823bytes/sec Analysing at 0.00 fps]
04/10/24 12:34:47.017188 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 48400 - Capturing at 10.00 fps, capturing bandwidth 463529bytes/sec Analysing at 0.00 fps]
04/10/24 12:34:57.020805 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 48500 - Capturing at 10.00 fps, capturing bandwidth 466594bytes/sec Analysing at 0.00 fps]
04/10/24 12:35:07.021358 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 48600 - Capturing at 10.00 fps, capturing bandwidth 465406bytes/sec Analysing at 0.00 fps]
04/10/24 12:35:17.030135 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 48700 - Capturing at 9.99 fps, capturing bandwidth 468497bytes/sec Analysing at 0.00 fps]
04/10/24 12:35:27.023981 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 48800 - Capturing at 10.01 fps, capturing bandwidth 496202bytes/sec Analysing at 0.00 fps]
04/10/24 12:35:37.030720 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 48900 - Capturing at 9.99 fps, capturing bandwidth 470391bytes/sec Analysing at 0.00 fps]
04/10/24 12:35:47.027988 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 49000 - Capturing at 10.00 fps, capturing bandwidth 450385bytes/sec Analysing at 0.00 fps]
04/10/24 12:35:57.029875 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 49100 - Capturing at 10.00 fps, capturing bandwidth 476151bytes/sec Analysing at 0.00 fps]
04/10/24 12:36:07.031157 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 49200 - Capturing at 10.00 fps, capturing bandwidth 470182bytes/sec Analysing at 0.00 fps]
04/10/24 12:36:17.033219 zmc_m3[162514].INF-zm_monitor.cpp/1680 [Wejscie: 49300 - Capturing at 10.00 fps, capturing bandwidth 529332bytes/sec Analysing at 0.00 fps]
It never cancels the event. This is not happening consistently. Most of the time it works fine.

Any ideas how I can troubleshoot it?

I enabled debug logging for zmtrigger level 6. We'll see if it shows anything interesting.
Top
Post Reply

Return to “ZoneMinder 1.36.x”