Discussion:
[omniORB] Re: ORBscanGranularity == shutdown time
Felix Nawothnig
2009-09-18 07:34:25 UTC
Permalink
[..] I was forgetting that on Windows and HPUX, the recv()
system call (and other related calls) is not interrupted when the
underlying socket is closed. Therefore, omniORB uses a select() call
with a timeout of the scan granularity instead.
I'm not aware of any other way it could be done. If anyone knows how
to do it, in a way that doesn't terribly uglify the code, please let
me know.
I've been digging along the sources in that area - actually due to a
different issue, with app. verifier (win32 thing) enabled shutdown often
throws exceptions about invalid handles passed to a select() call on
connection shutdown due to a semi (?) race-con in
SocketCollection::Select() - when I found that mail.

Vaguely related - SocketCollection::Select() uses a pipe to wake the
select() call under some circumstances (not on Win32 - but the timeout is
small so the impact isn't that nasty *cough*), the same thing could
obviously be used in tcpConnection::Recv() - but not on Win32. :-)

On Windows instead one could utilize WSAEventSelect() and
WSAWaitForMultipleEvents() instead of the select() - the latter should
also accept all other kinds of synchronization primitives (say an event).
I'm not yet familiar enough with the code in question to say whether or
not it's feasible to introduce another synchronization mechasism between
whatever code paths close the sockets and tcpConnection::Recv()...

(Yea, I'm really lost here right now - if you used Visual Studio's "jump
to declaration / definition" and "search whole solution" features for 2
years it's hard to start thinking by yourself again. Maybe I'll just
create a dummy project :-)

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?

On a second note - as I'm trying to get my shutdown right I noticed an
issue with the patch I sent - I was kinda overeager with the
notifications, calling the interceptor after the ORB was shutdown is not
really helpful... as a following work_pending() call yields
BAD_INV_ORDER... so I removed those calls again.

Cheers,

Felix
Duncan Grisby
2009-09-22 22:17:24 UTC
Permalink
On Friday 18 September, "Felix Nawothnig" wrote:

[...]
Post by Felix Nawothnig
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? And
please post a trace from traceLevel 25 traceThreadId 1 traceTime 1.
That will give some useful information about what is going on.

Cheers,

Duncan.
--
-- Duncan Grisby --
-- ***@grisby.org --
-- http://www.grisby.org --
Felix Nawothnig
2009-09-23 14:49:41 UTC
Permalink
Post by Duncan Grisby
Post by Felix Nawothnig
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...
Post by Duncan Grisby
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. :-)
Microsoft C++-Ausnahme: omni::giopStream::CommFailure an
Speicherposition 0x043ff898..

An exception (first chance) at ... Microsoft C++-Exception: ... at memory
address 0x043ff898
Post by Duncan Grisby
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.
Loading...