[Ace-users] Re: [ace-bugs] ACE 5.6 on Fedora Core 6 fails MEM_Stream_Test; Multicast_Test, Proactor_Test, Process_Semaphore_Test

Steve Huston shuston at riverace.com
Thu Sep 6 12:23:28 CDT 2007


Hi Rick,

> Thanks for the good advice

You're welcome.

> I'll certainly try running the proactor test by itself.

Good - there are conditions where the proactor can get into trouble
with multiple threads; -n 1 runs with one thread to narrow down the
causes.

> Any idea where I can grab the patches - along with
> instructions for applying them?

No - I forgot you are running FC... I assumed you were running RHEL
and could get updates from RHN. Sorry...

-Steve

> Regards
> Rick Hess
> 
> -----Original Message-----
> From: Steve Huston [mailto:shuston at riverace.com] 
> Sent: Thursday, September 06, 2007 9:57 AM
> To: Hess, Richard T. Jr; schmidt at dre.vanderbilt.edu
> Cc: ace-bugs at cs.wustl.edu
> Subject: RE: [ace-bugs] ACE 5.6 on Fedora Core 6 fails
> MEM_Stream_Test;Multicast_Test, Proactor_Test,
Process_Semaphore_Test
> 
> Hi Rick,
> 
> > Nope I'm stuck using this mandated O.S.  What is the classic
> > configuration?
> 
> It looks as though you used the traditional build method (your own
> config.h and platform_macros.GNU files as opposed to using
> ./configure).
> 
> You might make sure you've got the latest ip-related patches. I see
> the Multicast_Test failing similarly on RHEL 4, only on x64.
> 
> For Proactor_Test, try running it by hand with ./Proactor_Test -n 1
> And see if that does better.
> 
> I don't have any quick ideas on the other two.
> 
> -Steve
> 
> > Rick
> > 
> > -----Original Message-----
> > From: schmidt at dre.vanderbilt.edu
[mailto:schmidt at dre.vanderbilt.edu]
> 
> > Sent: Wednesday, September 05, 2007 9:07 PM
> > To: Hess, Richard T. Jr
> > Cc: ace-bugs at cs.wustl.edu
> > Subject: Re: [ace-bugs] ACE 5.6 on Fedora Core 6 fails 
> > MEM_Stream_Test;
> > Multicast_Test, Proactor_Test, Process_Semaphore_Test 
> > 
> > 
> > Hi Rick,
> > 
> > > Has anyone seen something like this - advice would be
appreciated
> in
> > either tracking this down or providing some
> > > explanation like didn't set an option to something in config.h.
> > 
> > I recommend you try using the "classic" configuration rather than
> the
> > auto-conf configuration.  That might make a difference.  It looks
> like
> > the tests are timing out, so there may be an issue with your OS.
> Have
> > you tried using a different OS?
> > 
> > Thanks,
> > 
> >      Doug
> > 
> > > ACE 5.6
> > > 
> > > ----------------------------------
> > > 
> > > HOST MACHINE and OPERATING SYSTEM:
> > > 
> > > Linux dragon 2.6.22.2-42.fc6 #1 SMP
> > > 
> > > EDT 2007 i686 i686 i386 GNU/Linux
> > > 
> > > RedHat Linux Version
> > > 
> > > Fedora Core release 6 (Zod)
> > > 
> > > Linux Kernel Version
> > > 
> > > Linux version 2.6.22.2-42.fc6
> > (brewbuilder at hs20-bc1-5.build.redhat.com)
> > > 
> > > (gcc version 4.1.2 20070626 (Red Hat 4.1.2-13)) #1 SMP Wed Aug
15
> > > 
> > > 11:32:12 EDT 2007
> > > 
> > > -----------------------------------
> > > 
> > > THE $ACE_ROOT/ace/config.h
> > > 
> > > #define ACE_GCC_HAS_TEMPLATE_INSTANTIATION_VISIBILITY_ATTRS 1
> > > 
> > > #define ACE_NDEBUG 0
> > > 
> > >  #define ACE_NTRACE 1
> > > 
> > >  #include <ace/config-linux.h>
> > > 
> > > ------------------------------------
> > > 
> > > THE $ACE_ROOT/include/makeinclude/platform_macros.GNU FILE
> > > 
> > > exceptions=1
> > > 
> > > inline=1
> > > 
> > > ami=1
> > > 
> > > rt_corba=1
> > > 
> > > smart_proxies=1
> > > 
> > > interceptors=1
> > > 
> > > interface_repo=1
> > > 
> > > corba_messaging=1
> > > 
> > > probe=0
> > > 
> > > profile=0
> > > 
> > > fakesvcconf=0
> > > 
> > > shared_libs_only=1
> > > 
> > > debug=1
> > > 
> > > optimize=0
> > > 
> > > include $(ACE_ROOT)/include/makeinclude/platform_linux.GNU
> > > 
> > > ------------------------------------
> > > 
> > > CONTENTS OF
> $ACE_ROOT/bin/MakeProjectCreator/config/default.features
> > > 
> > > (used by MPC when you generate your own makefiles):
> > > 
> > > Not Applicable
> > > 
> > > ------------------------------------
> > > 
> > > Compiler Version
> > > 
> > > Using built-in specs.
> > > 
> > > Target: i386-redhat-linux
> > > 
> > > Configured with: ../configure --prefix=/usr
> --mandir=/usr/share/man
> > > 
> > > --infodir=/usr/share/info --enable-shared --enable-threads=posix
> > > 
> > > --enable-checking=release --with-system-zlib
--enable-__cxa_atexit
> > > 
> > > --disable-libunwind-exceptions --enable-libgcj-multifile
> > > 
> > > --enable-languages=c,c++,objc,obj-c++,java,fortran,ada
> > --enable-java-awt=gtk
> > > 
> > > --disable-dssi --enable-plugin
> > > 
> > > --with-java-home=/usr/lib/jvm/java-1.4.2-gcj-1.4.2.0/jre
> > --with-cpu=generic
> > > 
> > > --host=i386-redhat-linux
> > > 
> > > Thread model: posix
> > > 
> > > gcc version 4.1.2 20070626 (Red Hat 4.1.2-13)
> > > 
> > >
> > --------------------------------------------------------------
> > ----------
> > ----------
> > > 
> > > AREA/CLASS/EXAMPLE AFFECTED:
> > > 
> > > [What example failed?  What module failed to compile?]
> > > 
> > >     DOES THE PROBLEM AFFECT:
> > > 
> > >         COMPILATION?
> > > 
> > >             No
> > > 
> > >         LINKING?
> > > 
> > >             No
> > > 
> > >            On Unix systems, did you run make realclean first?
> > > 
> > >             YES!
> > > 
> > >         EXECUTION?
> > > 
> > >         The following ACE Tests failed
> > > 
> > > 1.       MEM_Stream_Test;
> > > 
> > > 2.       Multicast_Test;
> > > 
> > > 3.       Proactor_Test;
> > > 
> > > 4.       Process_Semaphore_Test
> > > 
> > > [Please indicate whether ACE, your application, or both are 
> > affected.]
> > > 
> > > Just ACE right now - have yet to write the application :-)
> > > 
> > > Several of the ACE tests failed and I was wondering if 
> > anyone knows of
> > a common causative agent.
> > > 
> > > Outputs of test runs follow:
> > > 
> > > auto_run_tests_finished: tests/MEM_Stream_Test Time:121s
Result:0
> > > 
> > > Error: (log/MEM_Stream_Test.log): Reactor::run_event_loop
timeout
> > > 
> > > Error: (log/MEM_Stream_Test.log): Reactor::run_event_loop
timeout
> > > 
> > >  ======= Begin Log File
> > > 
> > >  Sep  5 15:43:59.606 2007 at LM_DEBUG@(8032|3086649040)
> > > 
> > >  Starting MEM_Stream_Test test at Wed Sep  5 2007
15:43:59.606474
> > > 
> > >  Sep  5 15:43:59.694 2007 at LM_DEBUG@Testing Reactive MEM_Stream
> > > 
> > >  Sep  5 15:44:59.726 2007 at LM_ERROR@Reactor::run_event_loop
timeout
> > > 
> > > Sep  5 15:44:59.726 2007 at LM_DEBUG@
> > > 
> > >  *** Platform only supports non-scalable SysV semaphores ***
> > > 
> > > Sep  5 15:44:59.726 2007 at LM_DEBUG@Testing Multithreaded
MEM_Stream
> > > 
> > > Sep  5 15:45:59.728 2007 at LM_ERROR@Reactor::run_event_loop
timeout
> > > 
> > >  Sep  5 15:45:59.729 2007 at LM_DEBUG@(8032|3086649040)
> > > 
> > >  Ending MEM_Stream_Test test at Wed Sep  5 2007 15:45:59.729120
> > > 
> > >  ======= End Log File
> > > 
> > > auto_run_tests_finished: tests/Multicast_Test Time:3s Result:1
> > > 
> > > Error: (log/Multicast_Test.log): maximum wait time of 2000 msec
> > exceeded
> > > 
> > >  ======= Begin Log File
> > > 
> > > Sep  5 15:48:10.922 2007 at LM_DEBUG@(8540|3086444240)
> > > 
> > >  Starting Multicast_Test test at Wed Sep  5 2007 15:48:10.922432
> > > 
> > >  Sep  5 15:48:10.923 2007 at LM_INFO@Starting consumer...
> > > 
> > > Sep  5 15:48:10.924 2007 at LM_DEBUG@Joined 239.255.0.1/16000
> > > 
> > >  Sep  5 15:48:10.924 2007 at LM_DEBUG@Joined 239.255.0.2/16000
> > > 
> > >  Sep  5 15:48:10.925 2007 at LM_DEBUG@Joined 239.255.0.3/16000
> > > 
> > >  Sep  5 15:48:10.926 2007 at LM_DEBUG@Joined 239.255.0.4/16000
> > > 
> > >  Sep  5 15:48:10.926 2007 at LM_DEBUG@Joined 239.255.0.5/16000
> > > 
> > >  Sep  5 15:48:10.927 2007 at LM_INFO@Starting producer...
> > > 
> > > Sep  5 15:48:10.932 2007 at LM_INFO@start waiting for consumer to
> > finish...
> > > 
> > > Sep  5 15:48:12.934 2007 at LM_ERROR@maximum wait time of 2000 msec
> > exceeded
> > > 
> > >  Sep  5 15:48:12.934 2007 at LM_DEBUG@(8540|3086444240)
> > > 
> > >  Ending Multicast_Test test at Wed Sep  5 2007 15:48:12.934909
> > > 
> > >  ======= End Log File
> > > 
> > > auto_run_tests_finished: tests/Proactor_Test Time:4s Result:0
> > > 
> > > Error: (log/Proactor_Test.log):
> > > 
> > > POSIX_Asynch_IO.cpp:1088:(8600 | 3086736272):
> > > 
> > > ACE_POSIX_Asynch_Accept::handle_input: dequeueing failed:
> > > 
> > > Resource temporarily unavailable
> > > 
> > >  ======= Begin Log File
> > > 
> > > Sep  5 15:48:33.987 2007 at LM_DEBUG@(8600|3086739152)
> > > 
> > > Starting Proactor_Test test at Wed Sep  5 2007 15:48:33.988093
> > > 
> > >  Sep  5 15:48:33.988 2007 at LM_DEBUG@(3086739152) Create 
> > Proactor Type =
> > DEFAULT
> > > 
> > >  Sep  5 15:48:33.989 2007 at LM_DEBUG@(8600 | 3086739152)
> > ACE_POSIX_AIOCB_Proactor::Max Number of AIOs=1024 Sep  5
> > > 15:48:33.990 2007 at LM_DEBUG@(3065756560) MyTask started
> > > 
> > >  Sep  5 15:48:33.991 2007 at LM_DEBUG@(3055266704) MyTask started
> > > 
> > >  Sep  5 15:48:33.991 2007 at LM_DEBUG@(3044776848) MyTask started
> > > 
> > >  Sep  5 15:48:33.992
2007 at LM_ERROR@POSIX_Asynch_IO.cpp:1088:(8600
> |
> > 3086736272):ACE_POSIX_Asynch_Accept::handle_input:
> > > 
> > > dequeueing failed: Resource temporarily unavailable
> > > 
> > >  Sep  5 15:48:34.009 2007 at LM_DEBUG@(3065756560) Server 0 
> > up; now 1 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.009 2007 at LM_DEBUG@(3065756560) Server 0
connection
> > from 127.0.0.1:54505
> > > 
> > >  Sep  5 15:48:34.010 2007 at LM_DEBUG@(3065756560) Client 0 
> > up; now 1 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.010 2007 at LM_DEBUG@(3065756560) Client 0
connected
> on
> > 127.0.0.1:54505
> > > 
> > >  Sep  5 15:48:34.020 2007 at LM_DEBUG@(3065756560) Server 1 
> > up; now 2 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.020 2007 at LM_DEBUG@(3065756560) Server 1
connection
> > from 127.0.0.1:54506
> > > 
> > >  Sep  5 15:48:34.021 2007 at LM_DEBUG@(3055266704) Client 1 
> > up; now 2 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.021 2007 at LM_DEBUG@(3055266704) Client 1
connected
> on
> > 127.0.0.1:54506
> > > 
> > >  Sep  5 15:48:34.021 2007 at LM_DEBUG@(3055266704) Server 2 
> > up; now 3 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.021 2007 at LM_DEBUG@(3055266704) Server 2
connection
> > from 127.0.0.1:54507
> > > 
> > >  Sep  5 15:48:34.022 2007 at LM_DEBUG@(3055266704) Client 2 
> > up; now 3 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.022 2007 at LM_DEBUG@(3055266704) Client 2
connected
> on
> > 127.0.0.1:54507
> > > 
> > >  Sep  5 15:48:34.023 2007 at LM_DEBUG@(3055266704) Server 3 
> > up; now 4 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.023 2007 at LM_DEBUG@(3055266704) Server 3
connection
> > from 127.0.0.1:54508
> > > 
> > >  Sep  5 15:48:34.023 2007 at LM_DEBUG@(3055266704) Client 3 
> > up; now 4 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.024 2007 at LM_DEBUG@(3055266704) Client 3
connected
> on
> > 127.0.0.1:54508
> > > 
> > >  Sep  5 15:48:34.024 2007 at LM_DEBUG@(3055266704) Server 4 
> > up; now 5 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.024 2007 at LM_DEBUG@(3055266704) Server 4
connection
> > from 127.0.0.1:54509
> > > 
> > >  Sep  5 15:48:34.041 2007 at LM_DEBUG@(3044776848) Client 4 
> > up; now 5 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.041 2007 at LM_DEBUG@(3044776848) Client 4
connected
> on
> > 127.0.0.1:54509
> > > 
> > >  Sep  5 15:48:34.054 2007 at LM_DEBUG@(3044776848) Client 5 
> > up; now 6 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.055 2007 at LM_DEBUG@(3044776848) Client 5
connected
> on
> > 127.0.0.1:54510
> > > 
> > >  Sep  5 15:48:34.055 2007 at LM_DEBUG@(3044776848) Server 5 
> > up; now 6 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.055 2007 at LM_DEBUG@(3044776848) Server 5
connection
> > from 127.0.0.1:54510
> > > 
> > >  Sep  5 15:48:34.055 2007 at LM_DEBUG@(3065756560) Server 6 
> > up; now 7 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.056 2007 at LM_DEBUG@(3065756560) Server 6
connection
> > from 127.0.0.1:54511
> > > 
> > >  Sep  5 15:48:34.062 2007 at LM_DEBUG@(3055266704) Client 6 
> > up; now 7 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.062 2007 at LM_DEBUG@(3055266704) Client 6
connected
> on
> > 127.0.0.1:54511 Sep  5 15:48:34.063 2007 at LM_DEBUG@
> > > (3044776848) Server 7 up; now 8 up, 0 down.
> > > 
> > > Sep  5 15:48:34.063 2007 at LM_DEBUG@(3044776848) Server 7
connection
> > from 127.0.0.1:54512
> > > 
> > >  Sep  5 15:48:34.063 2007 at LM_DEBUG@(3044776848) Client 7 
> > up; now 8 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.063 2007 at LM_DEBUG@(3044776848) Client 7
connected
> on
> > 127.0.0.1:54512
> > > 
> > >  Sep  5 15:48:34.065 2007 at LM_DEBUG@(3065756560) Server 8 
> > up; now 9 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.065 2007 at LM_DEBUG@(3065756560) Server 8
connection
> > from 127.0.0.1:54513
> > > 
> > >  Sep  5 15:48:34.065 2007 at LM_DEBUG@(3065756560) Client 8 
> > up; now 9 up,
> > 0 down.
> > > 
> > > Sep  5 15:48:34.065 2007 at LM_DEBUG@(3065756560) Client 8
connected
> on
> > 127.0.0.1:54513
> > > 
> > >  Sep  5 15:48:34.065 2007 at LM_DEBUG@(3065756560) Server 9 up; now
> 10
> > up, 0 down.
> > > 
> > > Sep  5 15:48:34.066 2007 at LM_DEBUG@(3065756560) Server 9
connection
> > from 127.0.0.1:54514
> > > 
> > >  Sep  5 15:48:34.066 2007 at LM_DEBUG@(3065756560) Client 9 up; now
> 10
> > up, 0 down.
> > > 
> > > Sep  5 15:48:34.066 2007 at LM_DEBUG@(3065756560) Client 9
connected
> on
> > 127.0.0.1:54514
> > > 
> > >  Sep  5 15:48:34.109 2007 at LM_DEBUG@(3044776848) Client 0 sent
> 7850,
> > limit 7850
> > > 
> > >  Sep  5 15:48:34.109 2007 at LM_DEBUG@(3044776848) Closing Client 0
> > writes; 1 I/O outstanding
> > > 
> > >  Sep  5 15:48:34.115 2007 at LM_DEBUG@(3044776848) Server 0 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.116 2007 at LM_DEBUG@(3044776848) Server 0 
> > gone; now 10
> > up, 1 down
> > > 
> > >  Sep  5 15:48:34.117 2007 at LM_DEBUG@(3065756560) Client 0 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.118 2007 at LM_DEBUG@(3065756560) Client 0 
> > gone; now 10
> > up, 1 down
> > > 
> > >  Sep  5 15:48:34.158 2007 at LM_DEBUG@(3065756560) Client 3 sent
> 7850,
> > limit 7850
> > > 
> > >  Sep  5 15:48:34.158 2007 at LM_DEBUG@(3065756560) Closing Client 3
> > writes; 1 I/O outstanding
> > > 
> > >  Sep  5 15:48:34.162 2007 at LM_DEBUG@(3055266704) Server 3 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.162 2007 at LM_DEBUG@(3055266704) Server 3 
> > gone; now 10
> > up, 2 down
> > > 
> > >  Sep  5 15:48:34.163 2007 at LM_DEBUG@(3055266704) Client 3 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.163 2007 at LM_DEBUG@(3055266704) Client 3 
> > gone; now 10
> > up, 2 down
> > > 
> > >  Sep  5 15:48:34.194 2007 at LM_DEBUG@(3044776848) Client 1 sent
> 7850,
> > limit 7850
> > > 
> > >  Sep  5 15:48:34.194 2007 at LM_DEBUG@(3044776848) Closing Client 1
> > writes; 1 I/O outstanding
> > > 
> > >  Sep  5 15:48:34.196 2007 at LM_DEBUG@(3055266704) Server 1 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.196 2007 at LM_DEBUG@(3055266704) Server 1 
> > gone; now 10
> > up, 3 down
> > > 
> > >  Sep  5 15:48:34.197 2007 at LM_DEBUG@(3055266704) Client 1 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.197 2007 at LM_DEBUG@(3055266704) Client 1 
> > gone; now 10
> > up, 3 down
> > > 
> > > Sep  5 15:48:34.212 2007 at LM_DEBUG@(3044776848) Client 2 sent
7850,
> > limit 7850
> > > 
> > >  Sep  5 15:48:34.213 2007 at LM_DEBUG@(3044776848) Closing Client 2
> > writes; 1 I/O outstanding
> > > 
> > >  Sep  5 15:48:34.216 2007 at LM_DEBUG@(3065756560) Server 2 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.217 2007 at LM_DEBUG@(3065756560) Server 2 
> > gone; now 10
> > up, 4 down
> > > 
> > >  Sep  5 15:48:34.228 2007 at LM_DEBUG@(3065756560) Client 2 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.228 2007 at LM_DEBUG@(3065756560) Client 2 
> > gone; now 10
> > up, 4 down
> > > 
> > >  Sep  5 15:48:34.232 2007 at LM_DEBUG@(3044776848) Client 8 sent
> 7850,
> > limit 7850
> > > 
> > >  Sep  5 15:48:34.233 2007 at LM_DEBUG@(3044776848) Closing Client 8
> > writes; 1 I/O outstanding
> > > 
> > >  Sep  5 15:48:34.233 2007 at LM_DEBUG@(3044776848) Client 4 sent
> 7850,
> > limit 7850
> > > 
> > >  Sep  5 15:48:34.233 2007 at LM_DEBUG@(3044776848) Closing Client 4
> > writes; 1 I/O outstanding
> > > 
> > >  Sep  5 15:48:34.235 2007 at LM_DEBUG@(3055266704) Server 4 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.235 2007 at LM_DEBUG@(3055266704) Server 4 
> > gone; now 10
> > up, 5 down
> > > 
> > >  Sep  5 15:48:34.236 2007 at LM_DEBUG@(3055266704) Server 8 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.236 2007 at LM_DEBUG@(3055266704) Server 8 
> > gone; now 10
> > up, 6 down
> > > 
> > >  Sep  5 15:48:34.237 2007 at LM_DEBUG@(3055266704) Client 4 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > > Sep  5 15:48:34.237 2007 at LM_DEBUG@(3055266704) Client 4 gone;
now
> 10
> > up, 5 down
> > > 
> > >  Sep  5 15:48:34.237 2007 at LM_DEBUG@(3055266704) Client 6 sent
> 7850,
> > limit 7850 Sep  5 15:48:34.237 2007 at LM_DEBUG@
> > > (3055266704) Closing Client 6 writes; 1 I/O outstanding
> > > 
> > >  Sep  5 15:48:34.238 2007 at LM_DEBUG@(3044776848) Client 8 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.238 2007 at LM_DEBUG@(3044776848) Client 8 
> > gone; now 10
> > up, 6 down
> > > 
> > >  Sep  5 15:48:34.240 2007 at LM_DEBUG@(3044776848) Server 6 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.240 2007 at LM_DEBUG@(3044776848) Server 6 
> > gone; now 10
> > up, 7 down
> > > 
> > >  Sep  5 15:48:34.241 2007 at LM_DEBUG@(3044776848) Client 6 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.241 2007 at LM_DEBUG@(3044776848) Client 6 
> > gone; now 10
> > up, 7 down
> > > 
> > >  Sep  5 15:48:34.246 2007 at LM_DEBUG@(3065756560) Client 5 sent
> 7850,
> > limit 7850
> > > 
> > >  Sep  5 15:48:34.247 2007 at LM_DEBUG@(3065756560) Closing Client 5
> > writes; 1 I/O outstanding
> > > 
> > >  Sep  5 15:48:34.249 2007 at LM_DEBUG@(3044776848) Server 5 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.249 2007 at LM_DEBUG@(3044776848) Server 5 
> > gone; now 10
> > up, 8 down
> > > 
> > >  Sep  5 15:48:34.250 2007 at LM_DEBUG@(3044776848) Client 5 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.250 2007 at LM_DEBUG@(3044776848) Client 5 
> > gone; now 10
> > up, 8 down
> > > 
> > >  Sep  5 15:48:34.251 2007 at LM_DEBUG@(3055266704) Client 7 sent
> 7850,
> > limit 7850
> > > 
> > >  Sep  5 15:48:34.251 2007 at LM_DEBUG@(3055266704) Closing Client 7
> > writes; 1 I/O outstanding
> > > 
> > >  Sep  5 15:48:34.252 2007 at LM_DEBUG@(3055266704) Server 7 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.252 2007 at LM_DEBUG@(3055266704) Server 7 
> > gone; now 10
> > up, 9 down
> > > 
> > >  Sep  5 15:48:34.253 2007 at LM_DEBUG@(3055266704) Client 9 sent
> 7850,
> > limit 7850
> > > 
> > >  Sep  5 15:48:34.253 2007 at LM_DEBUG@(3055266704) Closing Client 9
> > writes; 1 I/O outstanding
> > > 
> > >  Sep  5 15:48:34.253 2007 at LM_DEBUG@(3065756560) Server 9 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.254 2007 at LM_DEBUG@(3065756560) Server 9 
> > gone; now 10
> > up, 10 down
> > > 
> > >  Sep  5 15:48:34.254 2007 at LM_DEBUG@(3044776848) Client 7 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes)
> > > 
> > >  Sep  5 15:48:34.254 2007 at LM_DEBUG@(3044776848) Client 7 
> > gone; now 10
> > up, 9 down
> > > 
> > >  Sep  5 15:48:34.254 2007 at LM_DEBUG@(3044776848) Client 9 dtor;
50
> > sends (7850 bytes); 51 recvs (7850 bytes) Sep  5
> > > 15:48:34.254 2007 at LM_DEBUG@(3044776848) Client 9 gone; now 10
up,
> 10
> > down
> > > 
> > >  Sep  5 15:48:37.066 2007 at LM_DEBUG@(3086739152) Sleeping 
> > til sessions
> > run down.
> > > 
> > > Sep  5 15:48:37.066 2007 at LM_DEBUG@(3086739152) Stop Thread Pool
> Task
> > > 
> > >  Sep  5 15:48:37.066 2007 at LM_DEBUG@(3086739152) Calling End
> Proactor
> > event loop
> > > 
> > >  Sep  5 15:48:37.067 2007 at LM_DEBUG@(3044776848) MyTask finished
> > > 
> > >  Sep  5 15:48:37.067 2007 at LM_DEBUG@(3065756560) MyTask finished
> > > 
> > >  Sep  5 15:48:37.067 2007 at LM_DEBUG@(3055266704) MyTask finished
> > > 
> > >  Sep  5 15:48:37.068 2007 at LM_DEBUG@(8600|3086739152)
> > > 
> > >  Ending Proactor_Test test at Wed Sep  5 2007 15:48:37.068315
> > > 
> > >  ======= End Log File
> > > 
> > > Error: (log/Process_Semaphore_Test.log): Child 8941 finished
with
> > status 1124396
> > > 
> > >  ======= Begin Log File
> > > 
> > >  Sep  5 15:49:55.081 2007 at LM_DEBUG@(8940|3086808784)
> > > 
> > >  Starting Process_Semaphore_Test test at Wed Sep  5 2007
> > 15:49:55.081995 Sep  5 15:49:55.084 2007 at LM_DEBUG@Parent spawned
> > > child process with pid = 8941.
> > > 
> > > Sep  5 15:49:55.085 2007 at LM_DEBUG@(8940) Begin ping-pong
> > > 
> > >  Sep  5 15:49:55.094 2007 at LM_DEBUG@(8940) Ping
> > > 
> > >  Sep  5 15:49:55.094 2007 at LM_DEBUG@(8940) Ping
> > > 
> > >  Sep  5 15:49:55.094 2007 at LM_DEBUG@(8940) Ping
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8940) Ping
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8940) Ping
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8940) Ping
> > > 
> > > Sep  5 15:49:55.095 2007 at LM_DEBUG@(8940) Ping
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8940) Ping
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8940) Ping
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8940) Ping
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8940) Testing timeouts
> > > 
> > >  Sep  5 15:49:58.096 2007 at LM_ERROR@Child 8941 finished with
status
> > 1124396
> > > 
> > >  Sep  5 15:49:58.097 2007 at LM_DEBUG@(8940|3086808784)
> > > 
> > >  Ending Process_Semaphore_Test test at Wed Sep  5 2007 
> > 15:49:58.097030
> > > 
> > > ======= End Log File =======
> > > 
> > >  Begin Sublog File Process_Semaphore_Test-child.log
> > > 
> > >  Sep  5 15:49:55.093 2007 at LM_DEBUG@(8941|3086227152)
> > > 
> > >  Starting Process_Semaphore_Test-child test at Wed Sep  5 2007
> > 15:49:55.093588
> > > 
> > >  Sep  5 15:49:55.094 2007 at LM_DEBUG@(8941) Begin ping-pong
> > > 
> > >  Sep  5 15:49:55.094 2007 at LM_DEBUG@(8941) Pong
> > > 
> > >  Sep  5 15:49:55.094 2007 at LM_DEBUG@(8941) Pong
> > > 
> > >  Sep  5 15:49:55.094 2007 at LM_DEBUG@(8941) Pong
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8941) Pong
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8941) Pong
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8941) Pong
> > > 
> > > Sep  5 15:49:55.095 2007 at LM_DEBUG@(8941) Pong
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8941) Pong
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8941) Pong
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8941) Pong
> > > 
> > >  Sep  5 15:49:55.095 2007 at LM_DEBUG@(8941) Testing timeouts
> > > 
> > >  Sep  5 15:49:58.098 2007 at LM_DEBUG@(8941|3086227152)
> > > 
> > >  Ending Process_Semaphore_Test-child test at Wed Sep  5 2007
> > 15:49:58.098149
> > > 
> > > ======= End Sublog File
> > > 
> > > _______________________________________________
> > > ace-bugs mailing list
> > > ace-bugs at mail.cse.wustl.edu
> > > http://mail.cse.wustl.edu/mailman/listinfo/ace-bugs
> > 
> > _______________________________________________
> > ace-bugs mailing list
> > ace-bugs at mail.cse.wustl.edu
> > http://mail.cse.wustl.edu/mailman/listinfo/ace-bugs
> > 
> 
> 
> 




More information about the Ace-users mailing list