[omniORB] omniORB 4.0.1 hangs in giopServer::deactivate()

Wed Apr 23 07:17:02 2003

--=-PuNM6NnySb3yZpo87gqT
Content-Type: text/plain
Content-Transfer-Encoding: 7bit

On Tue, 2003-04-08 at 13:32, Duncan Grisby wrote:
> On Friday 4 April, Bastiaan Bakker wrote:
> 
> > The giopServer still has one 1 connection (pd_nconnections == 1), so I
> > guess it's waiting for it to close. But I don't see where this is
> > supposed to happen...
> > Can anyone give me hint on how to proceed to debug this?
> 
> Please can you post a trace with -ORBtraceLevel 25 -ORBtraceThreadId
> 1.

Hi,

I have attached the minimal traces that I needed to reproduce the hang.

I use omniORB 4.0.1 on RedHat Linux 8.0. omniORB was compiled with gcc
3.2.

Can you help me locating the cause of the problem?

TIA,

Matej

-- 
Matej Kenda, Lead Engineer
HERMES SoftLab (www.hermes-softlab.com)
Erjavceva 2, 5000 Nova Gorica, Slovenia

--=-PuNM6NnySb3yZpo87gqT
Content-Disposition: attachment; filename=hung-process.txt
Content-Type: text/plain; name=hung-process.txt; charset=UTF-8
Content-Transfer-Encoding: 7bit

[A 016384 17:05:48.708] ORB parameters:
InitRef = NameService=corbaname:iiop:cumulus.hermes.si:2809
DefaultInitRef = corbaloc:iiop:cumulus.hermes.si:2809
maxGIOPConnectionPerServer = 64
[A 016384 17:05:48.708] Set EV: OMNIORB_CONFIG = "/etc/opt/ivd/omniORB.cfg"
[A 016384 17:05:48.708] Initializing ORB.
[A 016384 17:05:48.708] omniORB: Configuration file "/etc/opt/ivd/omniORB.cfg" either does not exist or is not a file. No settings read.
[A 016384 17:05:48.709] omniORB: (0) Distribution date: Fri Mar 14 11:27:17 GMT 2003 dgrisby
[A 016384 17:05:48.710] omniORB: (0) Initialising omniDynamic library.
[A 016384 17:05:48.710] Obtaining reference to RootPOA.
[A 016384 17:05:48.737] Getting reference to NameService.
[A 016384 17:05:48.738] omniORB: (0) Invoke '_is_a' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:48.962] Getting object reference of IVD/rm
[A 016384 17:05:48.962] omniORB: (0) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:48.963] omniORB: (0) Invoke '_non_existent' on remote: root<0>
[A 016384 17:05:48.982] Getting object reference of IVD/svc/cumulus@hermes@si
[A 016384 17:05:48.982] omniORB: (0) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:48.983] omniORB: (0) Invoke '_non_existent' on remote: root<0>
[A 016384 17:05:48.984] Getting object reference of IVD/rm
[A 016384 17:05:48.984] omniORB: (0) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:48.984] omniORB: (0) Invoke '_non_existent' on remote: root<0>
[A 016384 17:05:48.985] omniORB: (0) Invoke 'SelectAllPartition' on remote: root<0>
[A 016384 17:05:48.999] Getting object reference of IVD/mgr/cumulus@hermes@si/part/part0003
[A 016384 17:05:49.000] omniORB: (0) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:49.000] omniORB: (0) Invoke '_non_existent' on remote: root<0>
[A 016384 17:05:49.004] omniORB: (0) Invoke 'Execute' on remote: root<0>
[A 016384 17:05:49.013] Getting object reference of IVD/mgr/cumulus@hermes@si/part/part0003
[A 016384 17:05:49.013] omniORB: (0) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:49.014] omniORB: (0) Invoke '_non_existent' on remote: root<0>
[A 016384 17:05:50.016] omniORB: (0) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:50.017] omniORB: (0) Invoke '_non_existent' on remote: root<0>
[A 016384 17:05:50.019] Binding context: IVD
[A 016384 17:05:50.019] omniORB: (0) Invoke 'bind_new_context' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:50.021] omniORB: (0) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:50.021] Binding context: mgr
[A 016384 17:05:50.021] omniORB: (0) Invoke 'bind_new_context' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:50.023] omniORB: (0) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:50.023] Binding context: cumulus@hermes@si
[A 016384 17:05:50.023] omniORB: (0) Invoke 'bind_new_context' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:50.025] omniORB: (0) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:50.025] omniORB: (0) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:50.026] omniORB: (0) Invoke '_non_existent' on remote: root<0>
[A 016384 17:05:50.027] Binding object name: mif
[A 016384 17:05:50.027] omniORB: (0) Invoke 'bind' on remote: key<0x4e616d6553657276696365>
[A 016384 17:05:50.028] Already bound (rebinding)
[A 016384 17:05:50.028] omniORB: (0) Invoke 'rebind' on remote: key<0x4e616d6553657276696365>
[A 065541 17:06:19.516] omniORB: (4) Accepted connection from giop:tcp:10.65.1.58:33065 because of this rule: "* unix,ssl,tcp"
[A 065541 17:06:19.516] omniORB: (4) Dispatching remote call '_non_existent' to: root<0> (active)
[A 065541 17:06:19.518] omniORB: (4) Dispatching remote call 'FormatAndInitMedium' to: root<0> (active)
[A 065541 17:06:19.518] omniORB: (4) Invoke 'SelectMedia' on remote: root<0>
[A 065541 17:06:19.525] omniORB: (4) Invoke 'SelectMediaPool' on remote: root<0>
[A 065541 17:06:19.527] omniORB: (4) Invoke 'SelectAllPartition' on remote: root<0>
[A 065541 17:06:19.529] omniORB: (4) Invoke 'SelectAllMediaVolByBarcode' on remote: root<0>
[A 065541 17:06:19.535] omniORB: (4) Invoke 'GetNewJobID' on remote: root<0>
[A 065541 17:06:19.540] omniORB: (4) Invoke 'DisplayMessage' on remote: root<0>
[A 065541 17:06:19.541] omniORB: (4) Invoke 'DisplayMessage' on remote: root<0>
[A 065541 17:06:19.541] omniORB: (4) Invoke 'GetResources' on remote: root<0>
[A 098311 17:06:19.557] omniORB: (6) Accepted connection from giop:tcp:10.65.1.58:33067 because of this rule: "* unix,ssl,tcp"
[A 098311 17:06:19.558] omniORB: (6) Dispatching remote call 'AssignResources' to: root<16777216> (active)
[A 098311 17:06:19.558] omniORB: (6) Invoke 'DisplayMessage' on remote: root<0>
[A 081926 17:06:19.559] omniORB: (5) Invoke 'GetHost' on remote: root<0>
[A 081926 17:06:19.564] omniORB: (5) Invoke 'SelectDriveByKey' on remote: root<0>
[A 081926 17:06:19.566] omniORB: (5) Invoke 'DisplayMessage' on remote: root<0>
[A 081926 17:06:19.567] omniORB: (5) Invoke 'DisplayMessage' on remote: root<0>
[A 081926 17:06:19.567] Getting object reference of IVD/svc/cumulus@hermes@si
[A 081926 17:06:19.568] omniORB: (5) Invoke 'resolve' on remote: key<0x4e616d6553657276696365>
[A 081926 17:06:19.568] omniORB: (5) Invoke '_non_existent' on remote: root<0>
[A 081926 17:06:19.569] omniORB: (5) Invoke 'Execute' on remote: root<0>
[A 114696 17:06:19.672] omniORB: (7) Accepted connection from giop:tcp:10.65.1.58:33070 because of this rule: "* unix,ssl,tcp"
[A 114696 17:06:19.673] omniORB: (7) Dispatching remote call 'GetJobParams' to: root<16777216> (active)
[A 114696 17:06:19.674] omniORB: (7) Dispatching remote call 'RegisterBEA' to: root<16777216> (active)
[A 081926 17:06:20.628] omniORB: (5) Invoke 'UseResources' on remote: root<0>
[A 081926 17:06:20.670] omniORB: (5) Invoke 'GetVolumeSizes' on remote: root<0>
[A 081926 17:06:20.670] omniORB: (5) Invoke 'SelectMedia' on remote: root<0>
[A 081926 17:06:20.674] omniORB: (5) Invoke 'UpdateMedia' on remote: root<0>
[A 081926 17:06:20.681] omniORB: (5) Invoke 'DisplayMessage' on remote: root<0>
[A 081926 17:06:20.682] omniORB: (5) Invoke 'DisplayMessage' on remote: root<0>
[A 081926 17:06:20.682] omniORB: (5) Invoke 'GetVolInfo' on remote: root<0>
[A 081926 17:06:31.499] omniORB: (5) Invoke 'DisplayMessage' on remote: root<0>
[A 081926 17:06:31.500] omniORB: (5) Invoke 'Init' on remote: root<0>
[A 081926 17:06:41.606] omniORB: (5) Invoke 'UpdateMediaVol' on remote: root<0>
[A 081926 17:06:41.613] omniORB: (5) Invoke 'DisplayMessage' on remote: root<0>
[A 081926 17:06:41.614] Will call poa->deactivate_object().
[A 081926 17:06:41.614] omniORB: (5) Invoke 'UseNewResource' on remote: root<0>
[A 081926 17:06:41.615] omniORB: (5) Invoke 'DisplayMessage' on remote: root<0>
[A 081926 17:06:41.615] omniORB: (5) Invoke 'Remove' on remote: root<0>
[A 081926 17:06:41.616] omniORB: (5) Invoke 'Remove' on remote: root<0>
[A 081926 17:06:41.617] omniORB: (5) Invoke 'ReleaseResource' on remote: root<0>
[A 131077 17:06:58.706] omniORB: (8) Accepted connection from giop:tcp:10.65.1.58:33077 because of this rule: "* unix,ssl,tcp"
[A 131077 17:06:58.709] omniORB: (8) Dispatching remote call '_non_existent' to: root<0> (active)
[A 131077 17:06:58.712] omniORB: (8) Dispatching remote call 'JobInfo' to: root<0> (active)
[A 131077 17:06:58.713] omniORB: (8) Invoke 'GetAllJobs' on remote: root<0>
[A 131077 17:06:58.719] omniORB: (8) Invoke 'DisplayMessage' on remote: root<0>
[A 131077 17:06:59.851] omniORB: (8) Accepted connection from giop:tcp:10.65.1.58:33082 because of this rule: "* unix,ssl,tcp"
[A 131077 17:06:59.851] omniORB: (8) Dispatching remote call '_non_existent' to: root<0> (active)
[A 131077 17:06:59.852] omniORB: (8) Dispatching remote call 'JobInfo' to: root<0> (active)
[A 131077 17:06:59.853] omniORB: (8) Invoke 'GetAllJobs' on remote: root<0>
[A 131077 17:06:59.854] omniORB: (8) Invoke 'DisplayMessage' on remote: root<0>
[A 131077 17:07:00.981] omniORB: (8) Accepted connection from giop:tcp:10.65.1.58:33087 because of this rule: "* unix,ssl,tcp"
[A 131077 17:07:00.981] omniORB: (8) Dispatching remote call '_non_existent' to: root<0> (active)
[A 131077 17:07:00.982] omniORB: (8) Dispatching remote call 'JobInfo' to: root<0> (active)
[A 131077 17:07:00.983] omniORB: (8) Invoke 'GetAllJobs' on remote: root<0>
[A 131077 17:07:00.984] omniORB: (8) Invoke 'DisplayMessage' on remote: root<0>
[A 131077 17:07:02.111] omniORB: (8) Accepted connection from giop:tcp:10.65.1.58:33092 because of this rule: "* unix,ssl,tcp"
[A 131077 17:07:02.111] omniORB: (8) Dispatching remote call '_non_existent' to: root<0> (active)
[A 131077 17:07:02.112] omniORB: (8) Dispatching remote call 'JobInfo' to: root<0> (active)
[A 131077 17:07:02.113] omniORB: (8) Invoke 'GetAllJobs' on remote: root<0>
[A 131077 17:07:02.114] omniORB: (8) Invoke 'DisplayMessage' on remote: root<0>
[A 131077 17:07:03.241] omniORB: (8) Accepted connection from giop:tcp:10.65.1.58:33097 because of this rule: "* unix,ssl,tcp"
[A 131077 17:07:03.241] omniORB: (8) Dispatching remote call '_non_existent' to: root<0> (active)
[A 131077 17:07:03.242] omniORB: (8) Dispatching remote call 'JobInfo' to: root<0> (active)
[A 131077 17:07:03.242] omniORB: (8) Invoke 'GetAllJobs' on remote: root<0>
[A 131077 17:07:03.244] omniORB: (8) Invoke 'DisplayMessage' on remote: root<0>
[A 049156 17:07:04.924] omniORB: (3) Invoke 'Remove' on remote: root<0>
[A 049156 17:07:04.929] Will call poa->deactivate_object().
[A 049156 17:07:04.929] About to call m_orb->shutdown(0). Won't wait for invocations to finish.

--=-PuNM6NnySb3yZpo87gqT--