random ending of events

jameswilson · Post by **jameswilson** » Tue Mar 28, 2006 3:59 pm

not on mine but i have yet to see one of these events anyway. Mine are just restarting between 0.5 and 4 seconds.

wmoore · Post by **wmoore** » Tue Mar 28, 2006 5:38 pm

Can you check to see if the event names have an (r) appended?

Nigitive on the (r) append. I just looked at about 500 events... No such animal. I have seen this before, but not under my current settings..which ARE producing the garbled images AND the signal events.... Again, don't know why, but only on the Axis camera.

What does the (r) mean?

-WAM

jameswilson · Post by **jameswilson** » Tue Mar 28, 2006 5:48 pm

i think the r means something crashed and zmaudit recovered it

jameswilson · Post by **jameswilson** » Wed Mar 29, 2006 11:01 am

Mar 29 11:30:00 localhost zma_m18[2996]: INF [Cam_17: 183419 - Starting new event 2332412]
Mar 29 11:30:29 localhost zma_m18[2996]: INF [Cam_17: 183475 - Gone into alarm state]
Mar 29 11:30:30 localhost zma_m18[2996]: INF [Cam_17: 183477 - Gone into alert state]
Mar 29 11:30:31 localhost zma_m18[2996]: INF [Cam_17: 183479 - Left alarm state (2332412) - 17(2) images]
Mar 29 11:30:52 localhost zma_m18[2996]: INF [Cam_17: 183519 - Gone into alarm state]
Mar 29 11:30:53 localhost zma_m18[2996]: INF [Cam_17: 183520 - Gone into alert state]
Mar 29 11:30:55 localhost zma_m18[2996]: INF [Cam_17: 183522 - Left alarm state (2332412) - 28(3) images]
Mar 29 11:31:17 localhost zma_m18[2996]: INF [Ended event]
Mar 29 11:31:17 localhost zma_m18[2996]: INF [Cam_17: 183565 - Starting new event 2332417]
Mar 29 11:31:44 localhost zma_m18[2996]: INF [Ended event]
Mar 29 11:31:44 localhost zma_m18[2996]: INF [Cam_17: 183616 - Starting new event 2332418]
Mar 29 11:32:40 localhost zma_m18[2996]: INF [Cam_17: 183723 - Gone into alarm state]
Mar 29 11:32:41 localhost zma_m18[2996]: INF [Cam_17: 183725 - Gone into alert state]
Mar 29 11:32:42 localhost zma_m18[2996]: INF [Cam_17: 183727 - Left alarm state (2332418) - 27(2) images]
Mar 29 11:33:07 localhost zma_m18[2996]: INF [Cam_17: 183776 - Gone into alarm state]
Mar 29 11:33:08 localhost zma_m18[2996]: INF [Cam_17: 183777 - Gone into alert state]
Mar 29 11:33:09 localhost zma_m18[2996]: INF [Cam_17: 183779 - Gone back into alarm state]
Mar 29 11:33:22 localhost zma_m18[2996]: INF [Cam_17: 183804 - Gone into alert state]
Mar 29 11:33:23 localhost zma_m18[2996]: INF [Cam_17: 183806 - Left alarm state (2332418) - 67(28) images]
Mar 29 11:34:16 localhost zmc_m18[2991]: INF [Cam_17: 187000 - Capturing at 1.90 fps]
Mar 29 11:35:03 localhost zma_m18[2996]: INF [Cam_17: 184000 - Processing at 1.91 fps]
Mar 29 11:35:57 localhost zma_m18[2996]: INF [Cam_17: 184107 - Gone into alarm state]
Mar 29 11:36:00 localhost zma_m18[2996]: INF [Cam_17: 184111 - Gone into alert state]
Mar 29 11:36:01 localhost zma_m18[2996]: INF [Cam_17: 184113 - Left alarm state (2332418) - 133(32) images]
Mar 29 11:36:52 localhost zma_m18[2996]: INF [Cam_17: 184215 - Gone into alarm state]
Mar 29 11:36:54 localhost zma_m18[2996]: INF [Cam_17: 184219 - Gone into alert state]
Mar 29 11:36:55 localhost zma_m18[2996]: INF [Cam_17: 184221 - Left alarm state (2332418) - 159(36) images]
Mar 29 11:37:42 localhost zma_m18[2996]: INF [Cam_17: 184313 - Gone into alarm state]
Mar 29 11:37:57 localhost zma_m18[2996]: INF [Cam_17: 184342 - Gone into alert state]
Mar 29 11:37:58 localhost zma_m18[2996]: INF [Cam_17: 184344 - Left alarm state (2332418) - 208(65) images]
Mar 29 11:40:00 localhost zma_m18[2996]: INF [Ended event]
Mar 29 11:40:00 localhost zma_m18[2996]: INF [Cam_17: 184577 - Starting new event 2332429]
Mar 29 11:40:04 localhost zma_m18[2996]: INF [Cam_17: 184585 - Gone into alarm state]
Mar 29 11:40:06 localhost zma_m18[2996]: INF [Cam_17: 184588 - Gone into alert state]
Mar 29 11:40:06 localhost zma_m18[2996]: INF [Cam_17: 184589 - Gone back into alarm state]
Mar 29 11:40:07 localhost zma_m18[2996]: INF [Cam_17: 184590 - Gone into alert state]
Mar 29 11:40:08 localhost zma_m18[2996]: INF [Cam_17: 184592 - Left alarm state (2332429) - 10(4) images]
Mar 29 11:40:30 localhost zma_m18[2996]: INF [Ended event]
Mar 29 11:40:30 localhost zma_m18[2996]: INF [Cam_17: 184636 - Starting new event 2332440]
Mar 29 11:42:48 localhost zmc_m18[2991]: INF [Cam_17: 188000 - Capturing at 1.95 fps]
Mar 29 11:43:31 localhost zma_m18[2996]: INF [Ended event]
Mar 29 11:43:31 localhost zma_m18[2996]: INF [Cam_17: 184990 - Starting new event 2332441]
Mar 29 11:43:31 localhost zma_m18[2996]: INF [Cam_17: 184990 - Gone into alarm state]
Mar 29 11:43:33 localhost zma_m18[2996]: INF [Cam_17: 184994 - Gone into alert state]
Mar 29 11:43:34 localhost zma_m18[2996]: INF [Cam_17: 184996 - Left alarm state (2332441) - 8(4) images]
Mar 29 11:43:36 localhost zma_m18[2996]: INF [Cam_17: 185000 - Processing at 1.95 fps]
Mar 29 11:44:14 localhost zma_m18[2996]: INF [Ended event]
Mar 29 11:44:14 localhost zma_m18[2996]: INF [Cam_17: 185074 - Starting new event 2332442]
Mar 29 11:45:51 localhost zma_m18[2996]: INF [Cam_17: 185267 - Gone into alarm state]
Mar 29 11:45:53 localhost zma_m18[2996]: INF [Cam_17: 185269 - Gone into alert state]
Mar 29 11:45:54 localhost zma_m18[2996]: INF [Cam_17: 185271 - Left alarm state (2332442) - 45(2) images]
Mar 29 11:45:58 localhost zma_m18[2996]: INF [Cam_17: 185279 - Gone into alarm state]
Mar 29 11:46:07 localhost zma_m18[2996]: INF [Cam_17: 185297 - Gone into alert state]
Mar 29 11:46:07 localhost zma_m18[2996]: INF [Cam_17: 185299 - Left alarm state (2332442) - 66(20) images]
Mar 29 11:47:24 localhost zma_m18[2996]: INF [Cam_17: 185445 - Gone into alarm state]
Mar 29 11:47:26 localhost zma_m18[2996]: INF [Cam_17: 185449 - Gone into alert state]
Mar 29 11:47:27 localhost zma_m18[2996]: INF [Cam_17: 185451 - Left alarm state (2332442) - 101(24) images]
Mar 29 11:47:36 localhost zma_m18[2996]: INF [Cam_17: 185469 - Gone into alarm state]
Mar 29 11:47:53 localhost zma_m18[2996]: INF [Cam_17: 185502 - Gone into alert state]
Mar 29 11:47:54 localhost zma_m18[2996]: INF [Cam_17: 185504 - Left alarm state (2332442) - 139(57) images]
Mar 29 11:48:09 localhost zma_m18[2996]: INF [Ended event]
Mar 29 11:48:10 localhost zma_m18[2996]: INF [Cam_17: 185535 - Starting new event 2332443]
Mar 29 11:49:39 localhost zma_m18[2996]: INF [Ended event]
Mar 29 11:49:41 localhost zma_m18[2996]: INF [Cam_17: 185704 - Starting new event 2332444]
Mar 29 11:50:00 localhost zma_m18[2996]: INF [Ended event]
Mar 29 11:50:04 localhost zma_m18[2996]: INF [Cam_17: 185744 - Starting new event 2332454]
Mar 29 11:50:25 localhost zma_m18[2996]: INF [Ended event]

I have really been checkin this and i have the disk full purge set at 70% now and am not getting the cannot wqrite error so it looks like the last disk in my LVM has a problem. But im still getting the above in my messages loga nd loads of events but currently only on the ipcams. The system is fine on its local cams. Now i will leave it running as i expect the same to start happening on my locals too.
Note not all ip cams are as badly affected and they are all 206's running in jpeg mode. Mjpeg seems worse.

Also note that the times when the events end and restsrt are not connected and 2 of the cams are right next to each other so it cant be network outage power issue etc.

WM Moore what firmware is in your cams as i have another 1.22.0 system without 206's without problems (pana blc10's and a 206m). Im wondering if the problem are an incompatability between the new 1.22.0 and 206's.

wmoore · Post by **wmoore** » Wed Mar 29, 2006 11:35 am

Products involved: AXIS 2420IR Network Camera
Release date: 2004-10-28
Release type: Production
Software version: 2.43

This is the latest for that camera.

jameswilson · Post by **jameswilson** » Wed Mar 29, 2006 12:27 pm

ah well jusr a thought

jameswilson · Post by **jameswilson** » Wed Oct 11, 2006 7:45 pm

Well im back to this again
I have had the machine back replced my own flavour of linux with a brand new 2006 non live ross, mandrake install and bang

Code: Select all

Oct 11 15:46:21 id1461 zma_m15[17364]: INF [Cam_15: 13000 - Processing at 2.17 fps]
Oct 11 15:50:00 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 15:50:00 id1461 zma_m15[17364]: INF [Cam_15: 13479 - Starting new event 450]
Oct 11 15:53:59 id1461 zma_m15[17364]: INF [Cam_15: 14000 - Processing at 2.18 fps]
Oct 11 16:00:00 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:00:00 id1461 zma_m15[17364]: INF [Cam_15: 14791 - Starting new event 474]
Oct 11 16:01:36 id1461 zma_m15[17364]: INF [Cam_15: 15000 - Processing at 2.19 fps]
Oct 11 16:09:13 id1461 zma_m15[17364]: INF [Cam_15: 16000 - Processing at 2.19 fps]
Oct 11 16:10:00 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:10:00 id1461 zma_m15[17364]: INF [Cam_15: 16097 - Starting new event 506]
Oct 11 16:16:54 id1461 zma_m15[17364]: INF [Cam_15: 17000 - Processing at 2.17 fps]
Oct 11 16:20:00 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:20:00 id1461 zma_m15[17364]: INF [Cam_15: 17405 - Starting new event 518]
Oct 11 16:24:32 id1461 zma_m15[17364]: INF [Cam_15: 18000 - Processing at 2.18 fps]
Oct 11 16:30:00 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:30:00 id1461 zma_m15[17364]: INF [Cam_15: 18719 - Starting new event 546]
Oct 11 16:32:11 id1461 zma_m15[17364]: INF [Cam_15: 19000 - Processing at 2.18 fps]
Oct 11 16:39:51 id1461 zma_m15[17364]: INF [Cam_15: 20000 - Processing at 2.17 fps]
Oct 11 16:40:00 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:40:00 id1461 zma_m15[17364]: INF [Cam_15: 20020 - Starting new event 567]
Oct 11 16:47:31 id1461 zma_m15[17364]: INF [Cam_15: 21000 - Processing at 2.17 fps]
Oct 11 16:50:00 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:50:00 id1461 zma_m15[17364]: INF [Cam_15: 21326 - Starting new event 576]
Oct 11 16:55:09 id1461 zma_m15[17364]: INF [Cam_15: 22000 - Processing at 2.18 fps]
Oct 11 16:56:38 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:56:38 id1461 zma_m15[17364]: INF [Cam_15: 22191 - Starting new event 631]
Oct 11 16:56:39 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:56:39 id1461 zma_m15[17364]: INF [Cam_15: 22196 - Starting new event 651]
Oct 11 16:56:46 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:56:44 id1461 zma_m15[17364]: INF [Cam_15: 22207 - Starting new event 700]
Oct 11 16:56:50 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:56:50 id1461 zma_m15[17364]: INF [Cam_15: 22219 - Starting new event 748]
Oct 11 16:56:52 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:56:52 id1461 zma_m15[17364]: INF [Cam_15: 22224 - Starting new event 766]
Oct 11 16:56:54 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:56:54 id1461 zma_m15[17364]: INF [Cam_15: 22229 - Starting new event 786]
Oct 11 16:56:56 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:56:56 id1461 zma_m15[17364]: INF [Cam_15: 22232 - Starting new event 803]
Oct 11 16:57:04 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:57:04 id1461 zma_m15[17364]: INF [Cam_15: 22246 - Starting new event 861]
Oct 11 16:57:03 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:57:03 id1461 zma_m15[17364]: INF [Cam_15: 22248 - Starting new event 870]
Oct 11 16:57:06 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:57:06 id1461 zma_m15[17364]: INF [Cam_15: 22253 - Starting new event 890]
Oct 11 16:57:09 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:57:09 id1461 zma_m15[17364]: INF [Cam_15: 22255 - Starting new event 899]
Oct 11 16:57:11 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:57:11 id1461 zma_m15[17364]: INF [Cam_15: 22264 - Starting new event 941]
Oct 11 16:57:25 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:57:25 id1461 zma_m15[17364]: INF [Cam_15: 22290 - Starting new event 1041]
Oct 11 16:57:26 id1461 zma_m15[17364]: INF [Ended event]
Oct 11 16:57:26 id1461 zma_m15[17364]: INF [Cam_15: 22294 - Starting new event 1057]

after 16:47 it started again. wtf
I need to get to the bottom of this. I have no clues. I think its some sort of clock issue as a restart fixes it for a while and it appears zm is ending the events. I had force end enabled and you can see it forcing the end of some events. I have disabled this now. Its on a amd x2 4200 via chipset board. Maybe a downgrade to 1.21.4? can i do that?

syslog detail

Code: Select all

Oct 11 16:56:11 id1461 zma_m10[17332]: INF [Cam_10: 22140 - Gone into alert state]
Oct 11 16:56:11 id1461 zma_m19[17390]: INF [Cam_19: 25345 - Gone back into alarm state]
Oct 11 16:56:12 id1461 zma_m10[17332]: INF [Cam_10: 22142 - Gone back into alarm state]
Oct 11 16:56:13 id1461 zma_m18[17382]: INF [Cam_18: 21810 - Gone into alarm state]
Oct 11 16:56:13 id1461 zma_m10[17332]: INF [Cam_10: 22145 - Gone into alert state]
Oct 11 16:56:14 id1461 zma_m18[17382]: INF [Cam_18: 21813 - Gone into alert state]
Oct 11 16:56:15 id1461 zma_m18[17382]: INF [Cam_18: 21815 - Gone back into alarm state]
Oct 11 16:56:16 id1461 zma_m9[17326]: INF [Cam_9: 22150 - Gone into alarm state]
Oct 11 16:56:16 id1461 zma_m21[17406]: INF [Cam_21: 20198 - Gone into alarm state]
Oct 11 16:56:17 id1461 zma_m21[17406]: INF [Cam_21: 20199 - Gone into alert state]
Oct 11 16:56:18 id1461 zma_m10[17332]: INF [Cam_10: 22155 - Left alarm state (571) - 245(40) images]
Oct 11 16:56:19 id1461 zma_m23[17422]: INF [Cam_23: 25073 - Gone into alarm state]
Oct 11 16:56:20 id1461 zma_m22[17414]: INF [Cam_22: 25151 - Gone into alarm state]
Oct 11 16:56:21 id1461 zma_m21[17406]: INF [Cam_21: 20209 - Left alarm state (581) - 178(2) images]
Oct 11 16:56:22 id1461 zma_m20[17398]: INF [Cam_20: 16429 - Gone into alarm state]
Oct 11 16:56:23 id1461 zma_m20[17398]: INF [Cam_20: 16430 - Gone into alert state]
Oct 11 16:56:23 id1461 zma_m18[17382]: INF [Cam_18: 21853 - Gone into alert state]
Oct 11 16:56:23 id1461 zma_m18[17382]: INF [Cam_18: 21854 - Gone back into alarm state]
Oct 11 16:56:24 id1461 zma_m20[17398]: INF [Cam_20: 16434 - Gone back into alarm state]
Oct 11 16:56:24 id1461 zma_m21[17406]: INF [Cam_21: 20215 - Gone into alarm state]
Oct 11 16:56:25 id1461 zma_m21[17406]: INF [Cam_21: 20216 - Gone into alert state]
Oct 11 16:56:25 id1461 zma_m20[17398]: INF [Cam_20: 16435 - Gone into alert state]
Oct 11 16:56:25 id1461 zma_m18[17382]: INF [Cam_18: 21863 - Gone into alert state]
Oct 11 16:56:25 id1461 zma_m21[17406]: INF [Cam_21: 20218 - Gone back into alarm state]
Oct 11 16:56:26 id1461 zma_m19[17390]: INF [Cam_19: 25411 - Gone into alert state]
Oct 11 16:56:26 id1461 zma_m21[17406]: INF [Cam_21: 20219 - Gone into alert state]
Oct 11 16:56:27 id1461 zma_m22[17414]: INF [Cam_22: 25182 - Gone into alert state]
Oct 11 16:56:27 id1461 zma_m22[17414]: INF [Cam_22: 25183 - Gone back into alarm state]
Oct 11 16:56:27 id1461 zma_m18[17382]: INF [Cam_18: 21867 - Gone back into alarm state]
Oct 11 16:56:28 id1461 zma_m19[17390]: INF [Cam_19: 25416 - Gone back into alarm state]
Oct 11 16:56:28 id1461 zma_m23[17422]: INF [Cam_23: 25115 - Gone into alert state]
Oct 11 16:56:28 id1461 zma_m9[17326]: INF [Cam_9: 22177 - Gone into alert state]
Oct 11 16:56:28 id1461 zma_m23[17422]: INF [Cam_23: 25116 - Gone back into alarm state]
Oct 11 16:56:29 id1461 zma_m20[17398]: INF [Cam_20: 16443 - Gone back into alarm state]
Oct 11 16:56:29 id1461 zma_m23[17422]: INF [Cam_23: 25119 - Gone into alert state]
Oct 11 16:56:29 id1461 zma_m20[17398]: INF [Cam_20: 16444 - Gone into alert state]
Oct 11 16:56:29 id1461 zma_m23[17422]: INF [Cam_23: 25121 - Gone back into alarm state]
Oct 11 16:56:30 id1461 zma_m20[17398]: INF [Cam_20: 16446 - Gone back into alarm state]
Oct 11 16:56:30 id1461 zma_m23[17422]: INF [Cam_23: 25125 - Gone into alert state]
Oct 11 16:56:30 id1461 zma_m18[17382]: INF [Cam_18: 21879 - Gone into alert state]
Oct 11 16:56:31 id1461 zma_m20[17398]: INF [Cam_20: 16449 - Gone into alert state]
Oct 11 16:56:31 id1461 zma_m21[17406]: INF [Cam_21: 20229 - Left alarm state (581) - 193(4) images]
Oct 11 16:56:31 id1461 zma_m22[17414]: INF [Cam_22: 25200 - Gone into alert state]
Oct 11 16:56:31 id1461 zma_m20[17398]: INF [Cam_20: 16450 - Gone back into alarm state]
Oct 11 16:56:33 id1461 zma_m23[17422]: INF [Cam_23: 25127 - Gone back into alarm state]
Oct 11 16:56:31 id1461 zma_m22[17414]: INF [Cam_22: 25202 - Gone back into alarm state]
Oct 11 16:56:31 id1461 zma_m4[17292]: INF [Ended event]
Oct 11 16:56:33 id1461 zma_m4[17292]: INF [Cam_4: 21889 - Starting new event 592]
Oct 11 16:56:31 id1461 zma_m18[17382]: INF [Force closed event]
Oct 11 16:56:31 id1461 zma_m18[17382]: INF [Cam_18: 21882 - Starting new event 593]
Oct 11 16:56:32 id1461 zma_m23[17422]: INF [Force closed event]
Oct 11 16:56:32 id1461 zma_m23[17422]: INF [Cam_23: 25129 - Starting new event 594]
Oct 11 16:56:32 id1461 zma_m23[17422]: INF [Cam_23: 25129 - Gone into alarm state]
Oct 11 16:56:34 id1461 zma_m20[17398]: INF [Force closed event]
Oct 11 16:56:34 id1461 zma_m20[17398]: INF [Cam_20: 16454 - Starting new event 595]
Oct 11 16:56:32 id1461 zma_m10[17332]: INF [Ended event]
Oct 11 16:56:34 id1461 zma_m17[17374]: INF [Ended event]
Oct 11 16:56:34 id1461 zma_m10[17332]: INF [Cam_10: 22186 - Starting new event 596]
Oct 11 16:56:34 id1461 zma_m19[17390]: INF [Force closed event]
Oct 11 16:56:32 id1461 zma_m19[17390]: INF [Cam_19: 25437 - Starting new event 597]
Oct 11 16:56:34 id1461 zma_m17[17374]: INF [Cam_17: 23316 - Starting new event 598]
Oct 11 16:56:32 id1461 zma_m21[17406]: INF [Ended event]
Oct 11 16:56:32 id1461 zma_m21[17406]: INF [Cam_21: 20233 - Starting new event 599]
Oct 11 16:56:34 id1461 zma_m9[17326]: INF [Cam_9: 22187 - Left alarm state (588) - 279(79) images]
Oct 11 16:56:32 id1461 zma_m19[17390]: INF [Cam_19: 25437 - Gone into alarm state]
Oct 11 16:56:34 id1461 zma_m17[17374]: INF [Ended event]
Oct 11 16:56:34 id1461 zma_m17[17374]: INF [Cam_17: 23318 - Starting new event 600]
Oct 11 16:56:35 id1461 zma_m12[17344]: INF [Ended event]
Oct 11 16:56:35 id1461 zma_m12[17344]: INF [Cam_12: 22188 - Starting new event 601]
Oct 11 16:56:35 id1461 zma_m9[17326]: INF [Ended event]
Oct 11 16:56:35 id1461 zma_m9[17326]: INF [Cam_9: 22188 - Starting new event 602]
Oct 11 16:56:33 id1461 zma_m23[17422]: INF [Force closed event]
Oct 11 16:56:33 id1461 zma_m23[17422]: INF [Cam_23: 25135 - Starting new event 603]
Oct 11 16:56:35 id1461 zma_m21[17406]: INF [Ended event]
Oct 11 16:56:35 id1461 zma_m21[17406]: INF [Cam_21: 20236 - Starting new event 604]
Oct 11 16:56:33 id1461 zma_m23[17422]: INF [Cam_23: 25135 - Gone into alarm state]
Oct 11 16:56:33 id1461 zma_m6[17306]: INF [Ended event]
Oct 11 16:56:35 id1461 zma_m6[17306]: INF [Cam_6: 22185 - Starting new event 605]
Oct 11 16:56:33 id1461 zma_m22[17414]: INF [Force closed event]

as you can see 16:56:31 before all is fine after it goes mental!!

jameswilson · Post by **jameswilson** » Wed Oct 11, 2006 8:57 pm

this is the only other thing that happens near the problem event?

Code: Select all

10/11/06 14:07:07.294512 zmdc[17238].INF ['zmaudit.pl -c' starting at 06/10/11 14:07:07, pid = 17438]
10/11/06 14:07:07.525811 zmdc[17444].INF ['zmwatch.pl' started at 06/10/11 14:07:07]
10/11/06 14:07:07.526710 zmdc[17238].INF ['zmwatch.pl' starting at 06/10/11 14:07:07, pid = 17444]
10/11/06 14:07:07.658762 zmdc[17449].INF ['zmupdate.pl -c' started at 06/10/11 14:07:07]
10/11/06 14:07:07.659634 zmdc[17238].INF ['zmupdate.pl -c' starting at 06/10/11 14:07:07, pid = 17449]
10/11/06 16:18:14.101311 zmdc[17238].INF ['zmc -m 20' stopping at 06/10/11 16:18:14]
10/11/06 16:18:14.138345 zmdc[17238].ERR ['zmc -m 20' exited abnormally, exit status 255]
10/11/06 16:18:14.268935 zmdc[17238].INF [Starting pending process, zmc -m 20]
10/11/06 16:18:14.270545 zmdc[17032].INF ['zmc -m 20' started at 06/10/11 16:18:14]
10/11/06 16:18:14.271444 zmdc[17238].INF ['zmc -m 20' starting at 06/10/11 16:18:14, pid = 17032]
10/11/06 16:18:38.382049 zmdc[17238].ERR ['zmc -m 20' exited abnormally, exit status 255]
10/11/06 16:18:43.008531 zmdc[17238].INF [Starting pending process, zmc -m 20]
10/11/06 16:18:43.009714 zmdc[17148].INF ['zmc -m 20' started at 06/10/11 16:18:43]
10/11/06 16:18:43.010633 zmdc[17238].INF ['zmc -m 20' starting at 06/10/11 16:18:43, pid = 17148]
10/11/06 16:18:46.103330 zmdc[17238].ERR ['zmc -m 20' exited abnormally, exit status 255]
10/11/06 16:18:56.071877 zmdc[17238].INF [Starting pending process, zmc -m 20]
10/11/06 16:18:56.073032 zmdc[17202].INF ['zmc -m 20' started at 06/10/11 16:18:56]
10/11/06 16:18:56.073883 zmdc[17238].INF ['zmc -m 20' starting at 06/10/11 16:18:56, pid = 17202]
10/11/06 16:18:57.281904 zmdc[17238].ERR ['zmc -m 20' exited abnormally, exit status 255]
10/11/06 16:19:17.080055 zmdc[17238].INF [Starting pending process, zmc -m 20]
10/11/06 16:19:17.081172 zmdc[17301].INF ['zmc -m 20' started at 06/10/11 16:19:17]
10/11/06 16:19:17.082037 zmdc[17238].INF ['zmc -m 20' starting at 06/10/11 16:19:17, pid = 17301]
10/11/06 16:19:29.164811 zmdc[17238].ERR ['zmc -m 20' exited abnormally, exit status 255]
10/11/06 16:20:09.039692 zmdc[17238].INF [Starting pending process, zmc -m 20]
10/11/06 16:20:09.040957 zmdc[17570].INF ['zmc -m 20' started at 06/10/11 16:20:09]
10/11/06 16:20:09.041897 zmdc[17238].INF ['zmc -m 20' starting at 06/10/11 16:20:09, pid = 17570]
10/11/06 16:20:12.097035 zmdc[17238].ERR ['zmc -m 20' exited abnormally, exit status 255]
10/11/06 16:21:32.090788 zmdc[17238].INF [Starting pending process, zmc -m 20]
10/11/06 16:21:32.091904 zmdc[17915].INF ['zmc -m 20' started at 06/10/11 16:21:32]
10/11/06 16:21:32.092776 zmdc[17238].INF ['zmc -m 20' starting at 06/10/11 16:21:32, pid = 17915]
10/11/06 16:21:35.147128 zmdc[17238].ERR ['zmc -m 20' exited abnormally, exit status 255]
10/11/06 16:24:15.014031 zmdc[17238].INF [Starting pending process, zmc -m 20]
10/11/06 16:24:15.015477 zmdc[18576].INF ['zmc -m 20' started at 06/10/11 16:24:15]
10/11/06 16:24:15.016371 zmdc[17238].INF ['zmc -m 20' starting at 06/10/11 16:24:15, pid = 18576]
10/11/06 16:24:18.070645 zmdc[17238].ERR ['zmc -m 20' exited abnormally, exit status 255]
10/11/06 16:29:38.099755 zmdc[17238].INF [Starting pending process, zmc -m 20]
10/11/06 16:29:38.100865 zmdc[19877].INF ['zmc -m 20' started at 06/10/11 16:29:38]
10/11/06 16:29:38.101718 zmdc[17238].INF ['zmc -m 20' starting at 06/10/11 16:29:38, pid = 19877]
10/11/06 16:29:41.205689 zmdc[17238].ERR ['zmc -m 20' exited abnormally, exit status 255]
10/11/06 16:39:41.077791 zmdc[17238].INF [Starting pending process, zmc -m 20]
10/11/06 16:39:41.078978 zmdc[22306].INF ['zmc -m 20' started at 06/10/11 16:39:41]
10/11/06 16:39:41.079883 zmdc[17238].INF ['zmc -m 20' starting at 06/10/11 16:39:41, pid = 22306]
10/11/06 16:39:44.195469 zmdc[17238].ERR ['zmc -m 20' exited abnormally, exit status 255]
10/11/06 16:49:44.051723 zmdc[17238].INF [Starting pending process, zmc -m 20]
10/11/06 16:49:44.131824 zmdc[24738].INF ['zmc -m 20' started at 06/10/11 16:49:44]
10/11/06 16:49:44.132667 zmdc[17238].INF ['zmc -m 20' starting at 06/10/11 16:49:44, pid = 24738]
/bin/rm: cannot remove directory `/var/www/html/zm/events/21/5617': Directory not empty
10/11/06 20:34:29.964859 zmdc[17238].INF ['zma -m 8' stopping at 06/10/11 20:34:29]
10/11/06 20:34:31.916861 zmdc[17238].INF ['zma -m 8' exited normally]
10/11/06 20:34:31.917153 zmdc[17238].INF ['zmc -m 22' stopping at 06/10/11 20:34:31]
10/11/06 20:34:30.060458 zmdc[17238].INF ['zmc -m 22' exited normally]
10/11/06 20:34:30.060790 zmdc[17238].INF ['zma -m 2' stopping at 06/10/11 20:34:30]
10/11/06 20:34:30.062300 zmdc[17238].INF ['zma -m 2' exited normally]
10/11/06 20:34:30.062579 zmdc[17238].INF ['zma -m 11' stopping at 06/10/11 20:34:30]
10/11/06 20:34:30.064515 zmdc[17238].INF ['zma -m 11' exited normally]
10/11/06 20:34:30.064846 zmdc[17238].INF ['zma -m 1' stopping at 06/10/11 20:34:30]
10/11/06 20:34:32.019522 zmdc[17238].INF ['zma -m 1' exited normally]
10/11/06 20:34:32.019880 zmdc[17238].INF ['zmc -m 19' stopping at 06/10/11 20:34:32]
10/11/06 20:34:32.024357 zmdc[17238].ERR ['zmc -m 19' exited abnormally, exit status 255]
10/11/06 20:34:32.024725 zmdc[17238].INF ['zma -m 23' stopping at 06/10/11 20:34:32]
10/11/06 20:34:32.028284 zmdc[17238].INF ['zma -m 23' exited normally]
10/11/06 20:34:32.028589 zmdc[17238].INF ['zma -m 17' stopping at 06/10/11 20:34:32]
10/11/06 20:34:32.034010 zmdc[17238].INF ['zma -m 17' exited normally]
10/11/06 20:34:32.034520 zmdc[17238].INF ['zma -m 22' stopping at 06/10/11

Totally stumped here guys any pointers at all??

Post by **zoneminder** » Thu Oct 12, 2006 12:24 pm

It's odd that a couple of messages up, the syslog entries are not in time order. I've never seen that before.

I will put a patch on here in a sec with some extra debug in it that might shed a bit of light on what is happening.

jameswilson · Post by **jameswilson** » Thu Oct 12, 2006 12:30 pm

I have notied that but assumed noting of it as therer were out of sync when it was working fine, maybe turn syslog off?

Post by **zoneminder** » Thu Oct 12, 2006 12:33 pm

Here is the patch, all it will do is add a bit of extra info in the info lines.

I am more concerned though by the random time warps that appear in the logs. If your system time is warping like that then it would definately explain the behaviour of the events. I wonder if you can set up a simple script to just write the time every second or so to a file and then we can see if that does the same when your system goes wonky. Something like

Code: Select all

while [ 1 ]
do
date >> date.log
sleep 1
done

in bash should do it.

jameswilson · Post by **jameswilson** » Thu Oct 12, 2006 12:36 pm

whoa there boy!
patchs??? how lol
ive never done that before how do i aplly them and what do you want me to do with the other thng as i dont have ssh access to this only webmin and http

Post by **zoneminder** » Thu Oct 12, 2006 12:45 pm

Ahh, you will need command line access to do a patch and rebuild or to run the script I suspect. I don't know whether webmin will grant you this kind of privilege or not if you don't have ssh running. I would always recommend leaving ssh going on a box if possible as you can run everything else over it, though make sure it is secured. if you have webmin, can you not start ssh?

If you are not using a source build of ZM then forget the patch and we will just run the script. To do this just copy the commands into a file, say timecheck.sh and then set it off in the background

Code: Select all

sh timecheck.sh &

Do it somewhere like /tmp though.

jameswilson · Post by **jameswilson** » Thu Oct 12, 2006 12:53 pm

well i have had 3 ports forwarded by IT
http, https and webmin
i could chnage https and ssh to use that port and then would have ssh access. SHall i send you the details as im not 100% sure i can do this lol

jameswilson · Post by **jameswilson** » Thu Oct 12, 2006 12:57 pm

ok then i know have ssh access