Broken events

Forum for questions and support relating to the 1.24.x releases only.
Locked
oma
Posts: 2
Joined: Wed Aug 19, 2009 1:26 pm

Broken events

Post by oma »

Hello,

I've some trouble wirh events starting at unusual times with unusual duration:
Btw. Hof is an ip-cam, therefore link-interruptions may occur
Image
Zoneminder loggs:

Code: Select all

#Last correct event:
ec 28 16:34:09 server zma_m1[28950]: INF [Einfahrt: 51924 - Gone into alarm state]
Dec 28 16:34:09 server zma_m1[28950]: INF [Einfahrt: 51924 - Opening new event 3735, alarm start]
Dec 28 16:34:14 server zma_m2[29843]: INF [Hof: 21474 - Gone into alert state]
Dec 28 16:34:17 server zma_m1[28950]: INF [Einfahrt: 51929 - Gone into alert state]
Dec 28 16:34:19 server zma_m2[29843]: INF [Hof: 21484 - Left alarm state (3734) - 35(12) images]
Dec 28 16:34:19 server zma_m2[29843]: INF [Hof: 21484 - Closing event 3734, alarm end]

#Ok, there is some regular stuff from other monitors:
Dec 28 16:34:56 server zmc_m1[30153]: INF [Einfahrt: 14000 - Capturing at 3.02 fps] 
Dec 28 16:37:17 server zma_m2[29843]: INF [Hof: 22000 - Processing at 2.83 fps]
Dec 28 16:39:17 server zmc_m2[30515]: INF [Hof: 3000 - Capturing at 2.92 fps]  
Dec 28 16:40:14 server zma_m1[28950]: INF [Einfahrt: 53000 - Processing at 3.00 fps]
Dec 28 16:40:29 server zmc_m1[30153]: INF [Einfahrt: 15000 - Capturing at 2.99 fps] 
## continues ###
Alarm of second monitor:
Dec 28 16:51:22 server zma_m1[28950]: INF [Einfahrt: 55000 - Processing at 2.99 fps]
Dec 28 16:51:36 server zmc_m1[30153]: INF [Einfahrt: 17000 - Capturing at 3.00 fps] 
Dec 28 16:52:36 server zma_m1[28950]: INF [Einfahrt: 55222 - Gone into alarm state] 
Dec 28 16:52:36 server zma_m1[28950]: INF [Einfahrt: 55222 - Opening new event 3736, alarm start]
Dec 28 16:52:49 server zma_m1[28950]: INF [Einfahrt: 55232 - Gone into alert state]
Dec 28 16:52:53 server zma_m1[28950]: INF [Einfahrt: 55242 - Left alarm state (3736) - 30(10) images]
Dec 28 16:52:53 server zma_m1[28950]: INF [Einfahrt: 55242 - Closing event 3736, alarm end]
#Debug continues...
#At once, something is wrong:
Dec 28 18:17:26 server zmwatch[4750]: INF [Restarting capture daemon for Einfahrt, time since last capture 13 seconds (1262020646-1262020633)]
Dec 28 18:17:28 server zmdc[4716]: INF ['zmc -m 1' stopping at 09/12/28 18:17:28]
Dec 28 18:17:28 server zmc_m1[30153]: INF [Got signal 15 (Terminated), exiting]  
Dec 28 18:17:28 server zmwatch[4750]: INF ['zmc -m 1' stopping at 09/12/28 18:17:28]
Dec 28 18:17:28 server zmdc[4716]: INF [Starting pending process, zmc -m 1]
Dec 28 18:17:28 server zmdc[4716]: INF ['zmc -m 1' starting at 09/12/28 18:17:28, pid = 31184]
Dec 28 18:17:28 server zmdc[31184]: INF ['zmc -m 1' started at 09/12/28 18:17:28]
Dec 28 18:17:29 server zmc_m1[31184]: INF [Debug Level = 0, Debug Log = <none>]  
Dec 28 18:17:30 server zmc_m1[31184]: INF [Starting Capture]
#Debugging continues ...
Dec 28 18:17:43 server zma_m2[29843]: INF [Hof: 39000 - Processing at 2.92 fps]
Dec 28 18:19:40 server zmc_m2[30515]: INF [Hof: 20000 - Capturing at 2.92 fps]
#Again ...
ec 28 20:56:32 server zmwatch[4750]: INF [Restarting capture daemon for Einfahrt, time since last capture 8 seconds (1262030192-1262030184)]
Dec 28 20:56:34 server zmdc[4716]: INF ['zmc -m 1' stopping at 09/12/28 20:56:34]
Dec 28 20:56:34 server zmc_m1[31184]: INF [Got signal 15 (Terminated), exiting]
Dec 28 20:56:34 server zmwatch[4750]: INF ['zmc -m 1' stopping at 09/12/28 20:56:34]
Dec 28 20:56:35 server zmdc[4716]: INF [Starting pending process, zmc -m 1]
Dec 28 20:56:35 server zmdc[32097]: INF ['zmc -m 1' started at 09/12/28 20:56:35]
Dec 28 20:56:35 server zmdc[4716]: INF ['zmc -m 1' starting at 09/12/28 20:56:35, pid = 32097]
#Other monitors alarms, debug continues as usual...
...
#Some unsual loggs again:
Dec 28 23:00:21 server zms[338]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:00:40 server zms[338]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:00:42 server zms[343]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:01:16 server zms[343]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:01:17 server zms[352]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:01:36 server zms[352]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:01:37 server zms[355]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:01:55 server zms[355]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:01:57 server zms[359]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:01:58 server zmc_m2[30515]: INF [Hof: 68000 - Capturing at 2.89 fps]
Dec 28 23:04:05 server zms[382]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:04:12 server zms[382]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:04:15 server zms[386]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:04:22 server zmc_m1[32097]: INF [Einfahrt: 23000 - Capturing at 2.99 fps]
Dec 28 23:04:31 server zms[388]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:04:35 server zms[386]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:04:57 server zma_m1[28950]: INF [Einfahrt: 122000 - Processing at 2.86 fps]
Dec 28 23:05:04 server zms[388]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:05:04 server zms[394]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:05:18 server zms[394]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:05:24 server zms[396]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:05:26 server zms[396]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:05:29 server zms[399]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:05:36 server zms[399]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:05:52 server zma_m2[29843]: INF [Hof: 88000 - Processing at 2.87 fps]
Dec 28 23:06:40 server zms[405]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:06:54 server zms[405]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:07:10 server zms[409]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:07:47 server zmc_m2[30515]: INF [Hof: 69000 - Capturing at 2.87 fps]
Dec 28 23:09:56 server zmc_m1[32097]: INF [Einfahrt: 24000 - Capturing at 2.99 fps]
Dec 28 23:10:26 server zms[455]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:11:01 server zms[467]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:11:32 server zms[471]: INF [Debug Level = 0, Debug Log = <none>]
Dec 28 23:11:35 server zms[467]: INF [Got signal 15 (Terminated), exiting]
Dec 28 23:12:05 server zma_m1[28950]: INF [Einfahrt: 123000 - Processing at 2.34 fps]
Dec 28 23:12:30 server zmaudit[4748]: INF [Filesystem event '2/3670' does not exist in database]
Dec 28 23:12:30 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:30 server zmaudit[4748]: INF [Filesystem event '2/3671' does not exist in database]
Dec 28 23:12:30 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:30 server zmaudit[4748]: INF [Filesystem event '2/3668' does not exist in database]
Dec 28 23:12:31 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:31 server zmaudit[4748]: INF [Filesystem event '2/3721' does not exist in database]
Dec 28 23:12:31 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:31 server zmaudit[4748]: INF [Filesystem event '2/3669' does not exist in database]
Dec 28 23:12:31 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:31 server zmaudit[4748]: INF [Found orphaned frame records for event '3668']
Dec 28 23:12:31 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:31 server zmaudit[4748]: INF [Found orphaned frame records for event '3669']
Dec 28 23:12:31 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:31 server zmaudit[4748]: INF [Found orphaned frame records for event '3670']
Dec 28 23:12:31 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:31 server zmaudit[4748]: INF [Found orphaned frame records for event '3671']
Dec 28 23:12:31 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:31 server zmaudit[4748]: INF [Found orphaned frame records for event '3721']
Dec 28 23:12:31 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:32 server zmaudit[4748]: INF [Found orphaned statistic records for event '3668']
Dec 28 23:12:32 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:32 server zmaudit[4748]: INF [Found orphaned statistic records for event '3669']
Dec 28 23:12:32 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:32 server zmaudit[4748]: INF [Found orphaned statistic records for event '3670']
Dec 28 23:12:32 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:32 server zmaudit[4748]: INF [Found orphaned statistic records for event '3671']
Dec 28 23:12:32 server zmaudit[4748]: INF [deleting]
Dec 28 23:12:32 server zmaudit[4748]: INF [Found orphaned statistic records for event '3721']
#Other orphaned data is found...
...
#demons are killed and started again
#after some hours: Everything is back to normal
...
System is Zoneminder 1.24.2, CPU load is 50%.

What might be wrong here?
Thanks in advance,
Keep smiling
yanosz
tmpp
Posts: 2
Joined: Wed Dec 30, 2009 2:46 pm

Post by tmpp »

I have the same issues with weird event durations. ZM 1.24.x
There are various anomalies such as

Id Name Time Secs Frames Score
648 Event-648(r) 1969-12-31 18:00:00 99999999.99 12/2 77/93 X
631 Event-631 1969-12-31 18:00:00 16627927.71 25/4 16/36 X
624 Event-624 2009-12-29 21:59:01 6818.79 75/55 36/65 X
623 Event-623 2009-12-29 21:30:28 19.88 21/1 8/8 X

Also this list is from one of the cameras which occasionally goes 'red' for Source.

For me I get a few each day.

Is the timestamp coming from the camera or the application?
tmpp
Posts: 2
Joined: Wed Dec 30, 2009 2:46 pm

Post by tmpp »

see other topic for resolution of dates

http://www.zoneminder.com/forums/viewtopic.php?t=15075

For 1969 and 1970 timestamps in your events, install mysqltuner as per miket's guide and set parameters

http://www.zoneminder.com/forums/viewtopic.php?t=14281
Locked