kylejohnson / puppet-zoneminder

A puppet module to completely install ZoneMinder from source
8 stars 4 forks source link

resulting Zm system non-existant image streaming when user auth enabled #4

Closed gwenhastings closed 11 years ago

gwenhastings commented 11 years ago

This is specific to the branch pulled by this puppet script it does NOT occur in stock 1.25.0(at least the one distributed as a vm for vmware).

When User authentication is enabled then monitor images except for stored frames are broken.. no broken image icon just foreshortend screens with text only no images.. clicking on frames and then to alarm frames gives what is expected but clicking on a monitor/cam link gives no image as it normally would

gwenhastings commented 11 years ago

I see about 10 x Got signal 6 (Aborted), exiting and forcing backtrace line after turning on authentication and attempting to view a monitor these do NOT occur without authentication on..

line 65 in zm_signal.cpp

the view errors come right after this...

gwenhastings commented 11 years ago

also see

2013-07-08 13:16:10.266830  web_php 1498    ERR socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory includes/functions.php  2322
2013-07-08 13:16:04.798686  web_js  1498    ERR getStreamCmdResponse stream error: socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory - checkStreamForErrors() ?view=watch 
2013-07-08 13:16:04.007328  web_php 1498    ERR socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory includes/functions.php  2322
2013-07-08 13:15:58.575938  web_js  1498    ERR getStreamCmdResponse stream error: socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory - checkStreamForErrors() ?view=watch 
2013-07-08 13:15:57.762607  web_php 1498    ERR socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory includes/functions.php  2322
2013-07-08 13:15:52.298930  web_js  1498    ERR getStreamCmdResponse stream error: socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory - checkStreamForErrors() ?view=watch 
2013-07-08 13:15:51.513978  web_php 1498    ERR socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory includes/functions.php  2322
2013-07-08 13:15:46.224347  web_js  1498    ERR getStreamCmdResponse stream error: socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory - checkStreamForErrors() ?view=watch 
2013-07-08 13:15:45.451180  web_php 1498    ERR socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory includes/functions.php  2322
2013-07-08 13:15:40.139411  web_js  1498    ERR getStreamCmdResponse stream error: socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory - checkStreamForErrors() ?view=watch 
2013-07-08 13:15:39.353144  web_php 1498    ERR socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory includes/functions.php  2322
2013-07-08 13:15:33.868418  web_js  1498    ERR getStreamCmdResponse stream error: socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory - checkStreamForErrors() ?view=watch 
2013-07-08 13:15:33.085373  web_php 1498    ERR socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory includes/functions.php  2322
2013-07-08 13:15:26.867323  zms 1591    INF Got signal 6 (Aborted), exiting and forcing backtrace   zm_signal.cpp   65
2013-07-08 13:15:26.833113  zms 1589    INF Got signal 6 (Aborted), exiting and forcing backtrace   zm_signal.cpp   65
2013-07-08 13:15:26.797631  zms 1587    INF Got signal 6 (Aborted), exiting and forcing backtrace   zm_signal.cpp   65
2013-07-08 13:15:26.748621  zms 1585    INF Got signal 6 (Aborted), exiting and forcing backtrace   zm_signal.cpp   65
2013-07-08 13:15:26.709614  zms 1583    INF Got signal 6 (Aborted), exiting and forcing backtrace   zm_signal.cpp   65
2013-07-08 13:15:26.679679  zms 1581    INF Got signal 6 (Aborted), exiting and forcing backtrace   zm_signal.cpp   65
2013-07-08 13:15:26.640837  zms 1579    INF Got signal 6 (Aborted), exiting and forcing backtrace   zm_signal.cpp   65
2013-07-08 13:15:26.598876  zms 1577    INF Got signal 6 (Aborted), exiting and forcing backtrace   zm_signal.cpp   65
2013-07-08 13:15:26.557046  zms 1575    INF Got signal 6 (Aborted), exiting and forcing backtrace   zm_signal.cpp   65
2
gwenhastings commented 11 years ago

2013-07-08 13:15:33.085373 web_php 1498 ERR socket_sendto( /tmp/zm/zms-956556s.sock ) failed: No such file or directory includes/functions.php 2322

hmm this is a result of an ajaxerror i believe function ajaxError( $message, $code=HTTP_STATUS_OK ) { Error( $message ); /line 2322/. if ( function_exists( 'ajaxCleanup' ) ) now have to find how we got here!! more to come

gwenhastings commented 11 years ago

cool looks like its someplace in zms

Jul 8 20:29:00 zm-meta zms[5121]: DB1 [LogOpts: level=DB1/DB1, screen=OFF, database=DB9, logfile=DB1->/tmp/zm/zm_debug.log.05121, syslog=DB9] Jul 8 20:29:00 zm-meta zma_m5[4978]: DB1 [Writing capture frame 166] Jul 8 20:29:00 zm-meta zma_m3[4957]: DB1 [Writing capture frame 158] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Detected a x86\x86-64 processor with SSE3] Jul 8 20:29:00 zm-meta zma_m1[5048]: DB1 [Writing capture frame 174] Jul 8 20:29:00 zm-meta zma_m2[5052]: DB1 [Writing capture frame 195] Jul 8 20:29:00 zm-meta zma_m4[4967]: DB1 [Writing capture frame 160] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Query: mode=jpeg&monitor=1&scale=100&maxfps=15&buffer=1000&auth=3f59b38792d18e617e9f20360e1ad610&connkey=386609&rand=1373340538] Jul 8 20:29:00 zm-meta zma_m5[4978]: DB1 [Writing capture frame 167] Jul 8 20:29:00 zm-meta zma_m3[4957]: DB1 [Writing capture frame 159] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Attempting to authenticate user from auth string '3f59b38792d18e617e9f20360e1ad610'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...admin_6D04956F04B71849478CA303973C3A04FEDE5738192.168.221.1172086113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...admin_6D04956F04B71849478CA303973C3A04FEDE5738192.168.221.1171986113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zma_m2[5052]: DB1 [Writing capture frame 196] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...gwen_C8088B24104B746EB32C50A7E6B571F72401AEC9192.168.221.1172086113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...gwen_C8088B24104B746EB32C50A7E6B571F72401AEC9192.168.221.1171986113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...jeff_90F4E97CF604E9A6E930E5B893BB98346B637AFF192.168.221.1172086113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...jeff_90F4E97CF604E9A6E930E5B893BB98346B637AFF192.168.221.1171986113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...rudy_AD6EE72BDB2EAED179F67C6CC0FAFE0D4C16FAF0192.168.221.1172086113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...rudy_AD6EE72BDB2EAED179F67C6CC0FAFE0D4C16FAF0192.168.221.1171986113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...OPD-kris_AB8AA2AE92D34791B01FE58BD9D2202467CAC79C192.168.221.1172086113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...OPD-kris_AB8AA2AE92D34791B01FE58BD9D2202467CAC79C192.168.221.1171986113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...OPD-Marie_A93EFFAE2433396B1115DB6F9092ADE2F1CEEBBD192.168.221.1172086113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...OPD-Marie_A93EFFAE2433396B1115DB6F9092ADE2F1CEEBBD192.168.221.1171986113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...bette_C9D6235F66664547F97CE3EA0AF8CA3EA5B490CE192.168.221.1172086113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:00 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...bette_C9D6235F66664547F97CE3EA0AF8CA3EA5B490CE192.168.221.1171986113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] ..kevin_39EC02C30810A402EC01AB065ADD9728D69B2F7A192.168.221.1172086113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:01 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...kevin_39EC02C30810A402EC01AB065ADD9728D69B2F7A192.168.221.1171986113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:01 zm-meta zma_m1[5048]: DB1 [Writing capture frame 176] Jul 8 20:29:01 zm-meta zma_m5[4978]: DB1 [Writing capture frame 169] Jul 8 20:29:01 zm-meta zma_m4[4967]: DB1 [Writing capture frame 162] Jul 8 20:29:01 zm-meta zma_m3[4957]: DB1 [Writing capture frame 161] Jul 8 20:29:01 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...gweni_9FB34A0165F2943AC2EA4051056A8BC0A953DEE9192.168.221.1172086113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:01 zm-meta zma_m2[5052]: DB1 [Writing capture frame 198] Jul 8 20:29:01 zm-meta zms[5121]: DB1 [Checking auth_key '...Change me to something unique...gweni_9FB34A0165F2943AC2EA4051056A8BC0A953DEE9192.168.221.1171986113' -> auth_md5 '20ef31eaff7f0000207693c5eb7f0000d0c831eaff7f0000633eb46400000000'] Jul 8 20:29:01 zm-meta zma_m1[5048]: DB1 [Writing capture frame 177] Jul 8 20:29:01 zm-meta zma_m5[4978]: DB1 [Writing capture frame 170] Jul 8 20:29:01 zm-meta zma_m3[4957]: DB1 [Writing capture frame 162] Jul 8 20:29:01 zm-meta zma_m2[5052]: DB1 [Writing capture frame 199] Jul 8 20:29:01 zm-meta zms[5121]: INF [Got signal 6 (Aborted), exiting and forcing backtrace

cool its failing authentication for some reason... :)

never seeing the error of !allowed in the log however..but user->getStream failing while user->getEvents passing or !userEvents failing...

gwenhastings commented 11 years ago

hmm User zmLoadAuthUser( const char auth, bool use_remote_addr ) is returning zero instead of a User object after dropping off end and not matching authentication strings(loaded from a mysqldump) will try fresh install strings saved them

gwenhastings commented 11 years ago

fresh authentication strings not matter still failing... codewalkthrought with cscope especially of the zm_user.cpp and zms.cpp(not a c++ programmer (not what I call a programmer at least not yet)) but having loads of fun tracking this sigh

gwenhastings commented 11 years ago

ok added an else message to the routine I suspected was failing hash authentication and its getting hit continually.. so suspicions of where we come to this sequence are correct.. now have to figure out why?

gwenhastings commented 11 years ago

hmm when none selected for auth_relay then user object is returned from permission stream and all works... plain and auth hash broken after line 204 in zms.cpp

gwenhastings commented 11 years ago

only difference in source on zms.cpp is ssedetect();.. looking over and dont see how the pooch is getting screwed...

gwenhastings commented 11 years ago

ok ssedetect(); at line 92 in zms.cpp is breaking hashed authentication(or it may be broken all on its own(but no changes from stock where it works) when this call ssedetect(); commented out of zms.cpp and plain auth_relay then authentication succeeds and monitor stream generated resulting in picture still does not work with auth_relay is set to hashed.. but thats a problem for kyle if he wants to look into it..suspect strongly that sse version level breaking rest of code somehow for this case...

kylejohnson commented 11 years ago

I'll follow up in IRC with you when you get online - thanks for the work!

gwenhastings commented 11 years ago

closing and pulling nextime/zum branch where this derived from to file report there