[omniORB] Re: ORBscanGranularity == shutdown time

Felix Nawothnig fn at drdannenberg.de
Wed Sep 23 01:55:46 BST 2009


>> Doesn't solve my original "invalid handle" exception though. Do you
>> know whether this is behaviour (selecting fds which may have been
>> closed) is intended?
> What exactly is the problem you are seeing?  Can you give a complete
> explanation of what your code is doing, and how it goes wrong?

Okay - let's start with what I'm doing: Nothing, really. :-) The process
serves a few CORBA objects using a POA with a locator and a couple of
default POAs. Default threading policy for all POAs. I don't think I
touched any weird config settings (see the log).

To trigger the bug I just (gracefully) shutdown the client on the other
side (which didn't even finish, client obviously hangs because I trapped
the server-side exception and broke into the debugger).

Note that adding a sched_yield() (Sleep(0) on Windows) before that
select() mentioned later makes this one _very_ reproducable (right now it
happens maybe 1 of 10 times on my dual-core).

Now let's talk about the problem I'm seeing...

On Win32 there is the Application Verifier, included in the Microsoft
Debugging Tools for Windows. With some kernel support it provides various
debugging features slightly adjusting the way the system works - along the
lines of the page-heap (cheap analogue to valgrind), it can simulate
low-memory conditions, trap access to invalid TLS slots, etc.

Among these features is also a check for invalid handle accesses. The way
it works is that instead of the functions in ntdll returning
STATUS_INVALID_HANDLE they instead raise a structured exception, which can
be trapped in the debugger.

Now, omniORB sometimes calls select(), passing closed (or maybe just
shutdown()ed, I could check that) file descriptors, the Winsock
implementation obviously eventually ends up calling a wait function in
ntdll which the then throws the exception.

Obviously I mostly want this one gone because I like to always have the
app. verifier enabled when debugging my application...

But I suspect one could also argue that even if calling select() with
invalid arguments is okay (the code in question explicitly checks for
WSAENOTSOCK followed by some dubious claims about WSAEINVAL) this race-con
could still provoke buggy behaviour if the file descriptor is re-used
during the race.

Granted, that situation seems to be rather unlikely... but in my opinion
calling select() with invalid arguments is a bug in any case. :-)

Note that I did add traces to all close() / shutdown()'s and dumped the
fds, this is definitly not caused by select() failing because the socket
was closed during the select call (even if it was, there is no
synchronization being performed there anyway) - it's definitly closed /
shut down in thread A, following by calling select() in thread B.

Again I apologize for not remembering whether it was shutdown() or
close(). :-)

Also note that from the source-code the behaviour on unix is slightly
different - the failing select() will yield a negative return code from
SocketCollection::Select() there (but I don't know whether or not that
would have any consequences). This difference is very suspicious to me as
the race-con most likely exists there too...

> And please post a trace from traceLevel 25 traceThreadId 1 traceTime 1.
> That will give some useful information about what is going on.

Full log is attached to this mail.

I suppose the only relevant parts are the last few  lines:

<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:14:12.468000: Server
connection refcount = 0
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:14:12.468000: throw
giopStream::CommFailure from
giopStream.cc:875(0,NO,COMM_FAILURE_UnMarshalArguments)
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:14:12.468000: Server close
connection from giop:tcp:127.0.0.1:56740
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe:
Microsoft C++-Ausnahme: omni::giopStream::CommFailure an Speicherposition
0x03fffa68..
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:14:12.484000: Server
connection refcount = 1
Eine Ausnahme (erste Chance) bei 0x7c91e4ff (ntdll.dll) in Core.exe:
0xC0000008: An invalid handle was specified.

A stack-trace of the exception yields this source-code line in omniORB:


    CORBA::Boolean
    SocketCollection::Select() {

...

        if (rfds.fd_count) {
            // Windows select() ignores its first argument.
===>        count = select(0, &rfds, 0, 0, &timeout);
        }
        else {

...

    }

You always see the same sequence when this happens ("Server connection
refcount = 0" in thread A, context switch, "throw giopStream::CommFailure
from giopStream.cc:875(0,NO,COMM_FAILURE_UnMarshalArguments)" in thread B,
"Server close connection from giop:tcp:127.0.0.1:56740" in thread A and
then the exception in thread B.

Sorry for the German in the log - that's Visual Studio's fault. :-)

The meaning should be obvious but I'll still provide some rough translations:

> Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe:
Microsoft C++-Ausnahme: omni::giopStream::CommFailure an
Speicherposition 0x043ff898..

An exception (first chance) at ... Microsoft C++-Exception: ... at memory
address 0x043ff898

> Der Thread 'Win32 Thread' (0xe54) hat mit Code 0 (0x0) geendet.

The Thread ... terminated with exit code 0.

So far.


Cheers,

Felix

-------------- next part --------------
"Core.exe": "C:\Development\ecd-cc\Src\Core\debug\Core.exe" geladen, Symbole wurden geladen.
"Core.exe": "C:\WINDOWS\system32\ntdll.dll" geladen, Symbole geladen (ohne Quellinformationen).
AVRF: Core.exe: pid 0x157C: flags 0x6: application verifier enabled
"Core.exe": "C:\WINDOWS\system32\verifier.dll" geladen, Keine Symbole geladen.
"Core.exe": "C:\WINDOWS\system32\kernel32.dll" geladen, Symbole geladen (ohne Quellinformationen).
AVRF: verifier.dll provider initialized for Core.exe with flags 0x6 
"Core.exe": "C:\Development\qt-all-opensource-src-4.5.2\bin\QtCored4.dll" geladen, Symbole wurden geladen.
"Core.exe": "C:\WINDOWS\system32\user32.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\gdi32.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\ole32.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\advapi32.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\rpcrt4.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\secur32.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\msvcrt.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\ws2_32.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\ws2help.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\WinSxS\x86_Microsoft.VC80.DebugCRT_1fc8b3b9a1e18e3b_8.0.50727.4053_x-ww_d014c028\msvcp80d.dll" geladen, Symbole wurden geladen.
"Core.exe": "C:\WINDOWS\WinSxS\x86_Microsoft.VC80.DebugCRT_1fc8b3b9a1e18e3b_8.0.50727.4053_x-ww_d014c028\msvcr80d.dll" geladen, Symbole wurden geladen.
"Core.exe": "C:\WINDOWS\system32\shlwapi.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\psapi.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\imm32.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\Programme\Kaspersky Lab\Kaspersky Anti-Virus 6.0 for Windows Workstations\adialhk.dll" geladen, Keine Symbole geladen.
"Core.exe": "C:\Programme\Kaspersky Lab\Kaspersky Anti-Virus 6.0 for Windows Workstations\adialhk.dll" entladen.
<5656>Info: Registering servant class Core::AircraftModel
<5656>Info: Registering servant class Core::AircraftModel
<5656>Info: Registering servant class Core::AircraftModel
<5656>Info: Registering servant class Core::Scenario
<5656>Info: Registering servant class Core::Terrain
<5656>Info: Registering servant class Core::IFileImpl
<5656>Info: Registering servant class Core::Scenario
<5656>Info: Registering servant class Core::Terrain
"Core.exe": "C:\WINDOWS\system32\winmm.dll" geladen, Symbole geladen (ohne Quellinformationen).
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.046000: Version: 4.1.4
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.062000: Distribution date: Thu Sep  3 18:53:51 BST 2009 dgrisby
"Core.exe": "C:\WINDOWS\system32\mswsock.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\hnetcfg.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\wshtcpip.dll" geladen, Symbole geladen (ohne Quellinformationen).
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.078000: Warning: unable to create an IPv6 socket. Unable to obtain the list of IPv6 interface addresses (10047).
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.093000: My addresses are: 
omniORB: 192.168.10.13
omniORB: 192.168.56.1
omniORB: 127.0.0.1
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.093000: Maximum supported GIOP version is 1.2
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.109000: Native char code sets: ISO-8859-1 UTF-8.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.109000: Transmission char code sets: ISO-8859-1(1.2) ISO-8859-1(1.1) ISO-8859-1(1.0) UTF-8(1.2) UTF-8(1.1).
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.125000: Native wide char code sets: UTF-16.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.125000: Transmission wide char code sets: UTF-16(1.2).
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.125000: Initialising omniDynamic library.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.140000: Current configuration is as follows:
omniORB:   DefaultInitRef (file) = 
omniORB:   DefaultInitRef (args) = 
omniORB:   InitRef = NameService=corbaname::localhost
omniORB:   abortOnInternalError = 0
omniORB:   abortOnNativeException = 1
omniORB:   acceptBiDirectionalGIOP = 0
omniORB:   acceptMisalignedTcIndirections = 0
omniORB:   bootstrapAgentHostname = 
omniORB:   bootstrapAgentPort = 900
omniORB:   clientCallTimeOutPeriod = 0
omniORB:   clientConnectTimeOutPeriod = 0
omniORB:   clientTransportRule = * unix,ssl,tcp
omniORB:   configFile = C:\Development\old_omniorb-4_1\omniorb.cfg
omniORB:   connectionWatchImmediate = 0
omniORB:   connectionWatchPeriod = 50000
omniORB:   copyValuesInLocalCalls = 1
omniORB:   diiThrowsSysExceptions = 0
omniORB:   dumpConfiguration = 0
omniORB:   endPoint = giop:tcp:localhost:
omniORB:   endPointPublish = addr
omniORB:   giopMaxMsgSize = 2097152
omniORB:   giopTargetAddressMode = KeyAddr
omniORB:   id = omniORB4
omniORB:   idleThreadTimeout = 10
omniORB:   immediateAddressSwitch = 0
omniORB:   inConScanPeriod = 180
omniORB:   lcdMode = 0
omniORB:   maxGIOPConnectionPerServer = 5
omniORB:   maxGIOPVersion = 1.2
omniORB:   maxInterleavedCallsPerConnection = 5
omniORB:   maxServerThreadPerConnection = 100
omniORB:   maxServerThreadPoolSize = 100
omniORB:   maxSocketRecv = 131072
omniORB:   maxSocketSend = 131072
omniORB:   nativeCharCodeSet = ISO-8859-1
omniORB:   nativeWCharCodeSet = UTF-16
omniORB:   objectTableSize = 0
omniORB:   offerBiDirectionalGIOP = 0
omniORB:   oneCallPerConnection = 1
omniORB:   outConScanPeriod = 120
omniORB:   poaHoldRequestTimeout = 0
omniORB:   poaUniquePersistentSystemIds = 1
omniORB:   principal = [Null]
omniORB:   resetTimeOutOnRetries = 0
omniORB:   scanGranularity = 3
omniORB:   serverCallTimeOutPeriod = 0
omniORB:   serverTransportRule = * unix,ssl,tcp
omniORB:   socketSendBuffer = 16384
omniORB:   strictIIOP = 1
omniORB:   supportBootstrapAgent = 0
omniORB:   supportCurrent = 1
omniORB:   supportPerThreadTimeOut = 1
omniORB:   tcAliasExpand = 0
omniORB:   threadPerConnectionLowerLimit = 9000
omniORB:   threadPerConnectionPolicy = 1
omniORB:   threadPerConnectionUpperLimit = 10000
omniORB:   threadPoolWatchConnection = 1
omniORB:   traceExceptions = 1
omniORB:   traceFile = [stderr]
omniORB:   traceInvocationReturns = 0
omniORB:   traceInvocations = 0
omniORB:   traceLevel = 25
omniORB:   traceThreadId = 1
omniORB:   traceTime = 1
omniORB:   unixTransportDirectory = /tmp/omni-%u
omniORB:   unixTransportPermission =  777
omniORB:   useTypeCodeIndirections = 1
omniORB:   validateUTF8 = 0
omniORB:   verifyObjectExistsAndType = 1
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.218000: Initialising incoming endpoints.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.218000: Instantiate endpoint 'giop:tcp:localhost:'
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.218000: Explicit bind to host localhost.
"Core.exe": "C:\WINDOWS\system32\dnsapi.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\rasadhlp.dll" geladen, Symbole geladen (ohne Quellinformationen).
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.234000: Bind to address 127.0.0.1 ephemeral port.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.234000: Publish specification: 'addr'
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.234000: Try to publish 'addr' for endpoint giop:tcp:localhost:56721
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.250000: Publish endpoint 'giop:tcp:localhost:56721'
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.250000: Starting serving incoming endpoints.
<5004>Info: omniORB: omniORB: (1) 2009-09-23 00:11:43.250000: AsyncInvoker: thread id = 1 has started. Total threads = 1
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.250000: Adding root<0> (activating) to object table.
<5004>Info: omniORB: omniORB: (1) 2009-09-23 00:11:43.250000: giopRendezvouser task execute for giop:tcp:localhost:56721
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.265000: State root<0> (activating) -> active
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.265000: Creating ref to local: root<0>
 target id      : IDL:omg.org/PortableServer/ServantLocator:1.0
 most derived id: IDL:omg.org/PortableServer/ServantLocator:1.0
<5656>Info: Registering invoker 03498FD0
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.265000: Adding root<1> (activating) to object table.
"Core.exe": "C:\WINDOWS\system32\version.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\version.dll" entladen.
"Core.exe": "C:\WINDOWS\system32\userenv.dll" geladen, Keine Symbole geladen.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.281000: State root<1> (activating) -> active
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.281000: Creating ref to local: root<1>
 target id      : IDL:Cybercopter/IDirectory:1.0
 most derived id: IDL:Cybercopter/IDirectory:1.0
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.296000: Creating ref to remote: key<NameService>
 target id      : IDL:omg.org/CORBA/Object:1.0
 most derived id:
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.296000: Initial reference `NameService' resolved from configuration file.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.312000: Client attempt to connect to giop:tcp:localhost:2809
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:11:43.312000: AsyncInvoker: thread id = 2 has started. Total threads = 2
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.312000: Name 'localhost' resolved: 127.0.0.1
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:11:43.312000: Scavenger task execute.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.312000: Client opened connection to giop:tcp:127.0.0.1:2809
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.328000: sendChunk: to giop:tcp:127.0.0.1:2809 100 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.328000: inputMessage: from giop:tcp:127.0.0.1:2809 25 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.328000: Creating ref to remote: key<NameService>
 target id      : IDL:omg.org/CosNaming/NamingContext:1.0
 most derived id:
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.343000: sendChunk: to giop:tcp:127.0.0.1:2809 92 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.343000: inputMessage: from giop:tcp:127.0.0.1:2809 228 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.343000: Creating ref to remote: root/<ddacb24a01000ac4/1>
 target id      : IDL:omg.org/CORBA/Object:1.0
 most derived id: IDL:omg.org/CosNaming/NamingContextExt:1.0
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.343000: ObjRef() -- deleted.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.359000: LocateRequest to remote: root/<ddacb24a01000ac4/1>
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.375000: Client attempt to connect to giop:tcp:localhost:1561
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.375000: Name 'localhost' resolved: 127.0.0.1
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.375000: Client opened connection to giop:tcp:127.0.0.1:1561
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.390000: sendChunk: to giop:tcp:127.0.0.1:1561 38 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.390000: inputMessage: from giop:tcp:127.0.0.1:1561 20 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.390000: Send codeset service context: (ISO-8859-1,UTF-16)
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.390000: sendChunk: to giop:tcp:127.0.0.1:1561 260 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.390000: inputMessage: from giop:tcp:127.0.0.1:1561 24 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.406000: ObjRef(IDL:Cybercopter/IDirectory:1.0) -- deleted.
<5656>Info: Registering invoker 03B28FD0
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.406000: Adding root<2> (activating) to object table.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.406000: State root<2> (activating) -> active
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.406000: Creating ref to local: root<2>
 target id      : IDL:Cybercopter/IPlayer:1.0
 most derived id: IDL:Cybercopter/IPlayer:1.0
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.406000: sendChunk: to giop:tcp:127.0.0.1:1561 232 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.421000: inputMessage: from giop:tcp:127.0.0.1:1561 24 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.421000: ObjRef(IDL:Cybercopter/IPlayer:1.0) -- deleted.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.421000: Adding root<3> (activating) to object table.
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.421000: State root<3> (activating) -> active
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.421000: Creating ref to local: root<3>
 target id      : IDL:Cybercopter/ICore:1.0
 most derived id: IDL:Cybercopter/ICore:1.0
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.437000: sendChunk: to giop:tcp:127.0.0.1:1561 232 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.437000: inputMessage: from giop:tcp:127.0.0.1:1561 24 bytes
<5656>Info: omniORB: omniORB: (0) 2009-09-23 00:11:43.437000: ObjRef(IDL:Cybercopter/ICore:1.0) -- deleted.
"Core.exe": "C:\WINDOWS\system32\msctf.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\version.dll" geladen, Symbole geladen (ohne Quellinformationen).
"Core.exe": "C:\WINDOWS\system32\version.dll" entladen.
"Core.exe": "C:\WINDOWS\system32\msctfime.ime" geladen, Symbole geladen (ohne Quellinformationen).
<5004>Info: omniORB: omniORB: (1) 2009-09-23 00:11:44.109000: Server accepted connection from giop:tcp:127.0.0.1:56724
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.125000: AsyncInvoker: thread id = 3 has started. Total threads = 3
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.140000: giopWorker task execute.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.140000: Accepted connection from giop:tcp:127.0.0.1:56724 because of this rule: "* unix,ssl,tcp"
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.156000: inputMessage: from giop:tcp:127.0.0.1:56724 38 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.171000: Handling a GIOP LOCATE_REQUEST.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.171000: sendChunk: to giop:tcp:127.0.0.1:56724 20 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.203000: inputMessage: from giop:tcp:127.0.0.1:56724 248 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.203000: Receive codeset service context and set TCS to (ISO-8859-1,UTF-16)
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.218000: Creating ref to remote: root<0>
 target id      : IDL:Cybercopter/IObserver:1.0
 most derived id: IDL:Cybercopter/IDirectoryObserver:1.0
<5984>Info: Tried to dump non-existant observer
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.218000: LocateRequest to remote: root<0>
<5984>Info: Registered observer <non-existant-observer> at subject
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.218000: Client attempt to connect to giop:tcp:localhost:56376
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.234000: LocateRequest to remote: root<0>
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.234000: sendChunk: to giop:tcp:127.0.0.1:56724 24 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.234000: Name 'localhost' resolved: 127.0.0.1
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.234000: Client attempt to connect to giop:tcp:localhost:56376
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.234000: Client opened connection to giop:tcp:127.0.0.1:56376
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.250000: Name 'localhost' resolved: 127.0.0.1
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.250000: sendChunk: to giop:tcp:127.0.0.1:56376 38 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.265000: inputMessage: from giop:tcp:127.0.0.1:56376 20 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.265000: Send codeset service context: (ISO-8859-1,UTF-16)
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.265000: Client opened connection to giop:tcp:127.0.0.1:56376
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.265000: sendChunk: to giop:tcp:127.0.0.1:56376 88 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.281000: inputMessage: from giop:tcp:127.0.0.1:56724 38 bytes
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.281000: sendChunk: to giop:tcp:127.0.0.1:56376 38 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.281000: Handling a GIOP LOCATE_REQUEST.
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.281000: inputMessage: from giop:tcp:127.0.0.1:56376 85 bytes
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.296000: inputMessage: from giop:tcp:127.0.0.1:56376 20 bytes
<5248>Info: Added servant class Cybercopter::Directory/Ios.exe[5676]@SIMSON to registry
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.296000: sendChunk: to giop:tcp:127.0.0.1:56376 84 bytes
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.296000: inputMessage: from giop:tcp:127.0.0.1:56376 24 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.296000: sendChunk: to giop:tcp:127.0.0.1:56724 20 bytes
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.312000: sendChunk: to giop:tcp:127.0.0.1:56376 76 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.312000: inputMessage: from giop:tcp:127.0.0.1:56724 224 bytes
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.312000: inputMessage: from giop:tcp:127.0.0.1:56376 24 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.312000: Creating ref to remote: root<1>
 target id      : IDL:Cybercopter/IObserver:1.0
 most derived id: IDL:Cybercopter/IDirectoryObserver:1.0
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.328000: sendChunk: to giop:tcp:127.0.0.1:56376 76 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.328000: LocateRequest to remote: root<1>
<5984>Info: Tried to dump non-existant observer
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.328000: sendChunk: to giop:tcp:127.0.0.1:56376 38 bytes
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.328000: inputMessage: from giop:tcp:127.0.0.1:56376 24 bytes
<5984>Info: Registered observer <non-existant-observer> at subject
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.343000: sendChunk: to giop:tcp:127.0.0.1:56724 24 bytes
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.343000: LocateRequest to remote: root<1>
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.343000: inputMessage: from giop:tcp:127.0.0.1:56376 20 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.343000: sendChunk: to giop:tcp:127.0.0.1:56376 68 bytes
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.359000: sendChunk: to giop:tcp:127.0.0.1:56376 38 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.359000: inputMessage: from giop:tcp:127.0.0.1:56376 96 bytes
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.375000: inputMessage: from giop:tcp:127.0.0.1:56376 20 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.375000: inputMessage: from giop:tcp:127.0.0.1:56724 38 bytes
<5248>Info: Added servant class Cybercopter::DlgScenarioSelection/Ios.exe[5676]@SIMSON to registry
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.375000: Handling a GIOP LOCATE_REQUEST.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.375000: sendChunk: to giop:tcp:127.0.0.1:56724 20 bytes
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.375000: sendChunk: to giop:tcp:127.0.0.1:56376 84 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.390000: inputMessage: from giop:tcp:127.0.0.1:56724 228 bytes
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.390000: inputMessage: from giop:tcp:127.0.0.1:56376 24 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.390000: Creating ref to remote: root/CorbaMgr<0>
 target id      : IDL:Cybercopter/IObserver:1.0
 most derived id: IDL:Cybercopter/IPlayerObserver:1.0
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.390000: sendChunk: to giop:tcp:127.0.0.1:56376 76 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.390000: LocateRequest to remote: root/CorbaMgr<0>
<5984>Info: Tried to dump non-existant observer
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.406000: inputMessage: from giop:tcp:127.0.0.1:56376 24 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.406000: sendChunk: to giop:tcp:127.0.0.1:56376 47 bytes
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.406000: sendChunk: to giop:tcp:127.0.0.1:56376 76 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.406000: inputMessage: from giop:tcp:127.0.0.1:56376 20 bytes
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.406000: inputMessage: from giop:tcp:127.0.0.1:56376 24 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.421000: Send codeset service context: (ISO-8859-1,UTF-16)
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.421000: sendChunk: to giop:tcp:127.0.0.1:56376 96 bytes
<5984>Info: Registered observer <non-existant-observer> at subject
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.421000: sendChunk: to giop:tcp:127.0.0.1:56376 92 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.421000: sendChunk: to giop:tcp:127.0.0.1:56724 24 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.437000: inputMessage: from giop:tcp:127.0.0.1:56376 86 bytes
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.453000: inputMessage: from giop:tcp:127.0.0.1:56376 24 bytes
<5248>Info: Added servant class Cybercopter::MainWindow/Ios.exe[5676]@SIMSON to registry
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.453000: sendChunk: to giop:tcp:127.0.0.1:56376 76 bytes
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.453000: sendChunk: to giop:tcp:127.0.0.1:56376 81 bytes
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.484000: inputMessage: from giop:tcp:127.0.0.1:56376 24 bytes
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.484000: sendChunk: to giop:tcp:127.0.0.1:56376 84 bytes
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:44.484000: inputMessage: from giop:tcp:127.0.0.1:56376 24 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.843000: Error in network receive (start of message): giop:tcp:127.0.0.1:56724
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.859000: throw giopStream::CommFailure from giopStream.cc:875(0,NO,COMM_FAILURE_UnMarshalArguments)
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: omni::giopStream::CommFailure an Speicherposition 0x03fffa68..
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.875000: Server connection refcount = 1
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.875000: Server connection refcount = 0
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:44.875000: Server close connection from giop:tcp:127.0.0.1:56724
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.343000: sendChunk: to giop:tcp:127.0.0.1:56376 60 bytes
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.359000: Error in network receive (start of message): giop:tcp:127.0.0.1:56376
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.359000: throw giopStream::CommFailure from giopStream.cc:875(0,MAYBE,COMM_FAILURE_WaitingForReply)
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: omni::giopStream::CommFailure an Speicherposition 0x040ff898..
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.375000: Client connection refcount = 0
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.375000: Client close connection to giop:tcp:127.0.0.1:56376
<4372>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.390000: throw COMM_FAILURE from omniObjRef.cc:805 (MAYBE,COMM_FAILURE_WaitingForReply)
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: CORBA::COMM_FAILURE an Speicherposition 0x040ff1c8..
<4372>Warn: Subject lost connection to class Cybercopter::Directory/Ios.exe[5676]@SIMSON - unregistering observer
<4372>Info: Unregistering observer class Cybercopter::Directory/Ios.exe[5676]@SIMSON at subject
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.421000: sendChunk: to giop:tcp:127.0.0.1:56376 60 bytes
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: boost::thread_interrupted an Speicherposition 0x040ffd7e..
Der Thread 'Win32 Thread' (0x1114) hat mit Code 0 (0x0) geendet.
Der Thread 'Win32 Thread' (0x1524) hat mit Code 0 (0x0) geendet.
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.421000: Error in network receive (start of message): giop:tcp:127.0.0.1:56376
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.437000: throw giopStream::CommFailure from giopStream.cc:875(0,MAYBE,COMM_FAILURE_WaitingForReply)
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: omni::giopStream::CommFailure an Speicherposition 0x042ff898..
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.453000: Client connection refcount = 0
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.453000: Client close connection to giop:tcp:127.0.0.1:56376
<488>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.468000: throw COMM_FAILURE from omniObjRef.cc:805 (MAYBE,COMM_FAILURE_WaitingForReply)
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: CORBA::COMM_FAILURE an Speicherposition 0x042ff1c8..
<488>Warn: Subject lost connection to class Cybercopter::DlgScenarioSelection/Ios.exe[5676]@SIMSON - unregistering observer
<488>Info: Unregistering observer class Cybercopter::DlgScenarioSelection/Ios.exe[5676]@SIMSON at subject
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: boost::thread_interrupted an Speicherposition 0x042ffd7e..
Der Thread 'Win32 Thread' (0x1e8) hat mit Code 0 (0x0) geendet.
Der Thread 'Win32 Thread' (0x13ac) hat mit Code 0 (0x0) geendet.
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.500000: Send codeset service context: (ISO-8859-1,UTF-16)
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.500000: Client attempt to connect to giop:tcp:localhost:56376
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:45.515000: Name 'localhost' resolved: 127.0.0.1
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:46.468000: Failed to connect (no peer name): 127.0.0.1
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:46.468000: Switch rope to use address giop:tcp:localhost:56376
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:46.468000: Unable to open new connection: giop:tcp:localhost:56376
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:46.484000: throw giopStream::CommFailure from giopStream.cc:1149(0,NO,TRANSIENT_ConnectFailed)
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: omni::giopStream::CommFailure an Speicherposition 0x043ff930..
<6036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:46.484000: throw TRANSIENT from omniObjRef.cc:810 (NO,TRANSIENT_ConnectFailed)
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: CORBA::TRANSIENT an Speicherposition 0x043ff260..
<6036>Warn: Subject lost connection to class Cybercopter::MainWindow/Ios.exe[5676]@SIMSON - unregistering observer
<6036>Info: Unregistering observer class Cybercopter::MainWindow/Ios.exe[5676]@SIMSON at subject
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: boost::thread_interrupted an Speicherposition 0x043ffd7e..
Der Thread 'Win32 Thread' (0x1794) hat mit Code 0 (0x0) geendet.
Der Thread 'Win32 Thread' (0x14dc) hat mit Code 0 (0x0) geendet.
<5004>Info: omniORB: omniORB: (1) 2009-09-23 00:11:50.781000: Server accepted connection from giop:tcp:127.0.0.1:56739
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:50.796000: giopWorker task execute.
<5004>Info: omniORB: omniORB: (1) 2009-09-23 00:11:50.796000: Server accepted connection from giop:tcp:127.0.0.1:56740
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:50.796000: Accepted connection from giop:tcp:127.0.0.1:56739 because of this rule: "* unix,ssl,tcp"
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:50.812000: inputMessage: from giop:tcp:127.0.0.1:56739 38 bytes
<5004>Info: omniORB: omniORB: (1) 2009-09-23 00:11:50.812000: Server accepted connection from giop:tcp:127.0.0.1:56741
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:11:50.812000: AsyncInvoker: thread id = 4 has started. Total threads = 4
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:11:50.812000: giopWorker task execute.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:50.812000: Handling a GIOP LOCATE_REQUEST.
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:11:50.812000: AsyncInvoker: thread id = 5 has started. Total threads = 5
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:11:50.812000: Accepted connection from giop:tcp:127.0.0.1:56740 because of this rule: "* unix,ssl,tcp"
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:50.812000: sendChunk: to giop:tcp:127.0.0.1:56739 20 bytes
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:11:50.828000: inputMessage: from giop:tcp:127.0.0.1:56740 38 bytes
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:11:50.828000: giopWorker task execute.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:50.843000: inputMessage: from giop:tcp:127.0.0.1:56739 252 bytes
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:11:50.843000: Handling a GIOP LOCATE_REQUEST.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:50.843000: Receive codeset service context and set TCS to (ISO-8859-1,UTF-16)
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:11:50.843000: Accepted connection from giop:tcp:127.0.0.1:56741 because of this rule: "* unix,ssl,tcp"
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:50.843000: Creating ref to remote: root/CorbaMgr<0>
 target id      : IDL:Cybercopter/IObserver:1.0
 most derived id: IDL:Cybercopter/IPlayerObserver:1.0
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:11:50.843000: inputMessage: from giop:tcp:127.0.0.1:56741 38 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.859000: LocateRequest to remote: root/CorbaMgr<0>
<5984>Info: Tried to dump non-existant observer
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:11:50.859000: Handling a GIOP LOCATE_REQUEST.
<5984>Info: Registered observer <non-existant-observer> at subject
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:11:50.859000: sendChunk: to giop:tcp:127.0.0.1:56741 20 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:50.906000: sendChunk: to giop:tcp:127.0.0.1:56739 24 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.859000: LocateRequest to remote: root/CorbaMgr<0>
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.906000: Client attempt to connect to giop:tcp:localhost:56728
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:11:50.906000: inputMessage: from giop:tcp:127.0.0.1:56741 248 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.906000: Client attempt to connect to giop:tcp:localhost:56728
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:11:50.906000: Receive codeset service context and set TCS to (ISO-8859-1,UTF-16)
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.906000: Name 'localhost' resolved: 127.0.0.1
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:11:50.921000: Creating ref to remote: root<1>
 target id      : IDL:Cybercopter/IObserver:1.0
 most derived id: IDL:Cybercopter/IDirectoryObserver:1.0
<5456>Info: Tried to dump non-existant observer
<5456>Info: Registered observer <non-existant-observer> at subject
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.937000: Client opened connection to giop:tcp:127.0.0.1:56728
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.937000: Name 'localhost' resolved: 127.0.0.1
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.937000: sendChunk: to giop:tcp:127.0.0.1:56728 47 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.937000: Client opened connection to giop:tcp:127.0.0.1:56728
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:11:50.953000: sendChunk: to giop:tcp:127.0.0.1:56741 24 bytes
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.953000: LocateRequest to remote: root<1>
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.953000: inputMessage: from giop:tcp:127.0.0.1:56728 20 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.953000: sendChunk: to giop:tcp:127.0.0.1:56728 47 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.968000: Send codeset service context: (ISO-8859-1,UTF-16)
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.968000: Client attempt to connect to giop:tcp:localhost:56728
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.984000: inputMessage: from giop:tcp:127.0.0.1:56728 20 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.984000: sendChunk: to giop:tcp:127.0.0.1:56728 96 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.984000: Send codeset service context: (ISO-8859-1,UTF-16)
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:50.984000: sendChunk: to giop:tcp:127.0.0.1:56728 108 bytes
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.000000: Name 'localhost' resolved: 127.0.0.1
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.000000: Client opened connection to giop:tcp:127.0.0.1:56728
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:11:51.000000: sendChunk: to giop:tcp:127.0.0.1:56740 20 bytes
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.015000: sendChunk: to giop:tcp:127.0.0.1:56728 38 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:51.015000: inputMessage: from giop:tcp:127.0.0.1:56739 224 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:51.015000: Creating ref to remote: root<0>
 target id      : IDL:Cybercopter/IObserver:1.0
 most derived id: IDL:Cybercopter/IDirectoryObserver:1.0
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.015000: inputMessage: from giop:tcp:127.0.0.1:56728 20 bytes
<5984>Info: Tried to dump non-existant observer
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.031000: Send codeset service context: (ISO-8859-1,UTF-16)
<5984>Info: Registered observer <non-existant-observer> at subject
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.031000: sendChunk: to giop:tcp:127.0.0.1:56728 100 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:51.031000: sendChunk: to giop:tcp:127.0.0.1:56739 24 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.031000: LocateRequest to remote: root<0>
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.046000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.046000: Client attempt to connect to giop:tcp:localhost:56728
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.046000: sendChunk: to giop:tcp:127.0.0.1:56728 76 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.046000: Name 'localhost' resolved: 127.0.0.1
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.062000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.062000: sendChunk: to giop:tcp:127.0.0.1:56728 76 bytes
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.062000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.062000: Client opened connection to giop:tcp:127.0.0.1:56728
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.078000: sendChunk: to giop:tcp:127.0.0.1:56728 38 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.078000: inputMessage: from giop:tcp:127.0.0.1:56728 86 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.078000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.078000: inputMessage: from giop:tcp:127.0.0.1:56728 20 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.078000: sendChunk: to giop:tcp:127.0.0.1:56728 76 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.093000: sendChunk: to giop:tcp:127.0.0.1:56728 84 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.093000: sendChunk: to giop:tcp:127.0.0.1:56728 81 bytes
<5248>Info: Added servant class Cybercopter::MainWindow/Ios.exe[5536]@SIMSON to registry
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.109000: sendChunk: to giop:tcp:127.0.0.1:56728 68 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.109000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.109000: inputMessage: from giop:tcp:127.0.0.1:56728 96 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.109000: sendChunk: to giop:tcp:127.0.0.1:56728 76 bytes
<5248>Info: Added servant class Cybercopter::DlgScenarioSelection/Ios.exe[5536]@SIMSON to registry
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.125000: sendChunk: to giop:tcp:127.0.0.1:56728 68 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.125000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<5248>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.125000: inputMessage: from giop:tcp:127.0.0.1:56728 85 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.125000: sendChunk: to giop:tcp:127.0.0.1:56728 76 bytes
<5248>Info: Added servant class Cybercopter::Directory/Ios.exe[5536]@SIMSON to registry
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.140000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.187000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.187000: sendChunk: to giop:tcp:127.0.0.1:56728 84 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:51.296000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:51.937000: inputMessage: from giop:tcp:127.0.0.1:56739 60 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:51.937000: sendChunk: to giop:tcp:127.0.0.1:56739 24 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:51.968000: inputMessage: from giop:tcp:127.0.0.1:56739 60 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:51.968000: sendChunk: to giop:tcp:127.0.0.1:56739 24 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.046000: inputMessage: from giop:tcp:127.0.0.1:56739 60 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.062000: sendChunk: to giop:tcp:127.0.0.1:56739 24 bytes
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:52.078000: sendChunk: to giop:tcp:127.0.0.1:56728 60 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.078000: inputMessage: from giop:tcp:127.0.0.1:56739 60 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.093000: sendChunk: to giop:tcp:127.0.0.1:56739 24 bytes
<3464>Info: omniORB: omniORB: (?) 2009-09-23 00:11:52.109000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:52.140000: sendChunk: to giop:tcp:127.0.0.1:56728 60 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.156000: inputMessage: from giop:tcp:127.0.0.1:56739 60 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.156000: sendChunk: to giop:tcp:127.0.0.1:56739 24 bytes
<4036>Info: omniORB: omniORB: (?) 2009-09-23 00:11:52.171000: inputMessage: from giop:tcp:127.0.0.1:56728 24 bytes
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:11:52.296000: sendChunk: to giop:tcp:127.0.0.1:56728 68 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.375000: inputMessage: from giop:tcp:127.0.0.1:56739 228 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.406000: Creating ref to remote: root/CorbaMgr<0>
 target id      : IDL:Cybercopter/IObserver:1.0
 most derived id: IDL:Cybercopter/IPlayerObserver:1.0
<5984>Info: Unregistering observer class Cybercopter::MainWindow/Ios.exe[5536]@SIMSON at subject
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.437000: sendChunk: to giop:tcp:127.0.0.1:56739 24 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.453000: omniRemoteIdentity deleted.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.453000: ObjRef(IDL:Cybercopter/IPlayerObserver:1.0) -- deleted.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.468000: inputMessage: from giop:tcp:127.0.0.1:56739 224 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.468000: Creating ref to remote: root<0>
 target id      : IDL:Cybercopter/IObserver:1.0
 most derived id: IDL:Cybercopter/IDirectoryObserver:1.0
<5984>Info: Unregistering observer class Cybercopter::Directory/Ios.exe[5536]@SIMSON at subject
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: boost::thread_interrupted an Speicherposition 0x0470fd7e..
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.484000: sendChunk: to giop:tcp:127.0.0.1:56739 24 bytes
Der Thread 'Win32 Thread' (0xfc4) hat mit Code 0 (0x0) geendet.
Der Thread 'Win32 Thread' (0xd78) hat mit Code 0 (0x0) geendet.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.484000: omniRemoteIdentity deleted.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.484000: ObjRef(IDL:Cybercopter/IDirectoryObserver:1.0) -- deleted.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.500000: inputMessage: from giop:tcp:127.0.0.1:56739 224 bytes
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.500000: Creating ref to remote: root<1>
 target id      : IDL:Cybercopter/IObserver:1.0
 most derived id: IDL:Cybercopter/IDirectoryObserver:1.0
<5984>Info: Unregistering observer class Cybercopter::DlgScenarioSelection/Ios.exe[5536]@SIMSON at subject
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: boost::thread_interrupted an Speicherposition 0x0450fd7e..
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.515000: sendChunk: to giop:tcp:127.0.0.1:56739 24 bytes
Der Thread 'Win32 Thread' (0xd88) hat mit Code 0 (0x0) geendet.
Der Thread 'Win32 Thread' (0x1538) hat mit Code 0 (0x0) geendet.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.515000: omniRemoteIdentity deleted.
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:11:52.515000: ObjRef(IDL:Cybercopter/IDirectoryObserver:1.0) -- deleted.
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:43.328000: Scavenger close connection to giop:tcp:localhost:2809
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:43.343000: Client connection refcount (forced) = 0
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:43.343000: Client close connection to giop:tcp:127.0.0.1:2809
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:43.359000: Scavenger close connection to giop:tcp:localhost:1561
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:43.390000: sendCloseConnection: to giop:tcp:127.0.0.1:1561 12 bytes
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:43.390000: Client connection refcount (forced) = 0
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:43.390000: Client close connection to giop:tcp:127.0.0.1:1561
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.390000: Scavenger close connection to giop:tcp:localhost:56728
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.421000: sendCloseConnection: to giop:tcp:127.0.0.1:56728 12 bytes
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.421000: Client connection refcount (forced) = 0
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.437000: Client close connection to giop:tcp:127.0.0.1:56728
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.453000: Scavenger close connection to giop:tcp:localhost:56728
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.468000: sendCloseConnection: to giop:tcp:127.0.0.1:56728 12 bytes
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.484000: Client connection refcount (forced) = 0
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.500000: Client close connection to giop:tcp:127.0.0.1:56728
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.500000: Scavenger close connection to giop:tcp:localhost:56728
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.515000: sendCloseConnection: to giop:tcp:127.0.0.1:56728 12 bytes
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.531000: Client connection refcount (forced) = 0
<5804>Info: omniORB: omniORB: (2) 2009-09-23 00:13:49.531000: Client close connection to giop:tcp:127.0.0.1:56728
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:14:11.906000: Error in network receive (start of message): giop:tcp:127.0.0.1:56728
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:14:11.906000: Error in network receive (start of message): giop:tcp:127.0.0.1:56739
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:14:11.937000: Error in network receive (start of message): giop:tcp:127.0.0.1:56740
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:14:11.937000: Error in network receive (start of message): giop:tcp:127.0.0.1:56741
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:14:11.968000: throw giopStream::CommFailure from giopStream.cc:875(0,MAYBE,COMM_FAILURE_WaitingForReply)
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:14:11.968000: throw giopStream::CommFailure from giopStream.cc:875(0,NO,COMM_FAILURE_UnMarshalArguments)
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: omni::giopStream::CommFailure an Speicherposition 0x043ff898..
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:14:12.000000: Client connection refcount = 0
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: omni::giopStream::CommFailure an Speicherposition 0x042ffa68..
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:14:12.234000: Client close connection to giop:tcp:127.0.0.1:56728
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:14:12.437000: throw giopStream::CommFailure from giopStream.cc:875(0,NO,COMM_FAILURE_UnMarshalArguments)
<3668>Info: omniORB: omniORB: (?) 2009-09-23 00:14:12.437000: throw COMM_FAILURE from omniObjRef.cc:805 (MAYBE,COMM_FAILURE_WaitingForReply)
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:14:12.437000: Server connection refcount = 1
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: omni::giopStream::CommFailure an Speicherposition 0x040ffa68..
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: CORBA::COMM_FAILURE an Speicherposition 0x043ff1c8..
<3668>Warn: Subject lost connection to class Cybercopter::MainWindow/Ios.exe[5536]@SIMSON - unregistering observer
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:14:12.453000: Server connection refcount = 1
<3668>Info: Unregistering observer class Cybercopter::MainWindow/Ios.exe[5536]@SIMSON at subject
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:14:12.453000: Server connection refcount = 0
<3668>Info: To be unregistered observer not found in subject's m_observers
<5456>Info: omniORB: omniORB: (5) 2009-09-23 00:14:12.468000: Server close connection from giop:tcp:127.0.0.1:56741
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: boost::thread_interrupted an Speicherposition 0x043ffd7e..
Der Thread 'Win32 Thread' (0xe54) hat mit Code 0 (0x0) geendet.
Der Thread 'Win32 Thread' (0x1078) hat mit Code 0 (0x0) geendet.
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:14:12.468000: Server connection refcount = 0
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:14:12.468000: throw giopStream::CommFailure from giopStream.cc:875(0,NO,COMM_FAILURE_UnMarshalArguments)
<5728>Info: omniORB: omniORB: (4) 2009-09-23 00:14:12.468000: Server close connection from giop:tcp:127.0.0.1:56740
Eine Ausnahme (erste Chance) bei 0x7c812afb (kernel32.dll) in Core.exe: Microsoft C++-Ausnahme: omni::giopStream::CommFailure an Speicherposition 0x03fffa68..
<5984>Info: omniORB: omniORB: (3) 2009-09-23 00:14:12.484000: Server connection refcount = 1
Eine Ausnahme (erste Chance) bei 0x7c91e4ff (ntdll.dll) in Core.exe: 0xC0000008: An invalid handle was specified.


More information about the omniORB-list mailing list