Mantis Bug Tracker

View Issue Details Jump to Notes ] Issue History ] Print ]
IDProjectCategoryView StatusDate SubmittedLast Update
0005323opensim[GRID] Robust Serverpublic2011-01-12 09:242015-02-28 16:32
Reporterjabba 
Assigned To 
PrioritynormalSeverityminorReproducibilityN/A
StatusnewResolutionopen 
PlatformOSOS Version
Product Version 
Target VersionFixed in Version 
Summary0005323: GATEKEEPER SERVICE (USER AGENT SERVICE) Grid URI verification fails
DescriptionI upgraded my private grid to the current OSGrid software release (opensim-4ac5809.tar.gz) and tried to HG-TP from my grid (Annuna Grid) to OSGrid using an Annund Grid avie and from OSGrid to Annuna Grid using an OSGrid avie.

From my grid to OSGrid is working always.

From OSGrid to my grid fails on some regions, others are working. Target regions of my grid are hosted in the same opensim instance, therefore have the same configuration, only different regions ports.

Failure seems to be in GATEKEEPER SERVICE.
(see additional information)

I did not remove my private information from the logs here as I think these might be of interest when analyzing the bug.
Additional InformationThe following extract from OpenSim.log was written from the source region of the HG TP. HG destination (written in chat and clicked) was:
secondlife://grid.annuna.net:8002:Psytrance/ [^]
TP window opened with region map image. TP was not working (see below).

2011-01-12 17:35:59,620 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: GetRegionsByName grid.annuna.net:8002:Psytrance
2011-01-12 17:35:59,621 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to annuna city
2011-01-12 17:35:59,621 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to annuna lsc1 01
2011-01-12 17:35:59,621 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to annuna lsc1 02
2011-01-12 17:35:59,621 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to annuna lsc1 03
2011-01-12 17:35:59,622 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to tongland
2011-01-12 17:35:59,622 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to lexington
2011-01-12 17:35:59,622 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to wolleswelt killesberg
2011-01-12 17:35:59,622 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to wolleswelt hauptbahnhof
2011-01-12 17:35:59,623 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to wolleswelt schlossgarten
2011-01-12 17:35:59,623 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to wolleswelt innenstadt
2011-01-12 17:35:59,623 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to wolleswelt schlossplatz
2011-01-12 17:35:59,623 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to wolleswelt degerloch
2011-01-12 17:35:59,624 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to wolleswelt ssc
2011-01-12 17:35:59,624 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to http://grid.annuna.net:8002 [^]
2011-01-12 17:35:59,624 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to http://grid.annuna.net:8002 [^]
2011-01-12 17:35:59,624 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to http://grid.annuna.net:8002 [^]
2011-01-12 17:35:59,625 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to http://grid-ww.talentraspel.de:8002/ [^] wild living
2011-01-12 17:35:59,625 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to http://grid-ww.talentraspel.de:8002/ [^] wild shopping
2011-01-12 17:35:59,625 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to http://virtual.aiai.ed.ac.uk:8002/ [^] vue-9000
2011-01-12 17:35:59,625 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to http://hypergrid.org:8002/ [^] monkey island
2011-01-12 17:35:59,626 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to http://hypergrid.org:8002/ [^] redicomland
2011-01-12 17:35:59,626 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to http://81.169.133.181:8002/ [^] feenwald
2011-01-12 17:35:59,626 DEBUG - OpenSim.Data.Null.NullRegionData [NULL REGION DATA]: comparing grid.annuna.net:8002:psytrance to http://grid.annuna.net:8002/ [^] shiva
2011-01-12 17:35:59,626 DEBUG - OpenSim.Services.GridService.HypergridLinker [HYPERGRID LINKER]: Link to grid.annuna.net:8002:Psytrance, in 30530-0
2011-01-12 17:35:59,627 DEBUG - OpenSim.Services.Connectors.Hypergrid.GatekeeperServiceConnector [GATEKEEPER SERVICE CONNECTOR]: Linking to http://grid.annuna.net:8002/ [^]
2011-01-12 17:35:59,636 DEBUG - OpenSim.Services.GridService.HypergridLinker [HYPERGRID LINKER]: Region already exists in coordinates 14868 0
2011-01-12 17:36:00,820 DEBUG - OpenSim.Region.CoreModules.World.Land.LandManagementModule [LAND] got parcelID 00000000-0000-0000-0000-000000000000
2011-01-12 17:36:03,535 DEBUG - OpenSim.Region.CoreModules.Framework.EntityTransfer.HGEntityTransferModule [HG ENTITY TRANSFER MODULE]: region 3ab1b1f1-943f-4326-b9f5-dbef7d543a18 flags: 524
2011-01-12 17:36:03,535 DEBUG - OpenSim.Region.CoreModules.Framework.EntityTransfer.HGEntityTransferModule [HG ENTITY TRANSFER MODULE]: Destination region 3ab1b1f1-943f-4326-b9f5-dbef7d543a18 is hyperlink
2011-01-12 17:36:03,536 DEBUG - OpenSim.Services.Connectors.Hypergrid.GatekeeperServiceConnector [GATEKEEPER SERVICE CONNECTOR]: contacting http://aurora.dmsp.de:8002/ [^]
2011-01-12 17:36:03,541 DEBUG - OpenSim.Region.CoreModules.Framework.EntityTransfer.HGEntityTransferModule [HG ENTITY TRANSFER MODULE]: GetFinalDestination serveruri -> http://grid.annuna.net:9000/ [^]
2011-01-12 17:36:03,541 DEBUG - OpenSim.Region.CoreModules.Framework.EntityTransfer.EntityTransferModule [ENTITY TRANSFER MODULE]: Final destination is x=9997 y=10002 3ab1b1f1-943f-4326-b9f5-dbef7d543a18@http://grid.annuna.net:9000/ [^]
2011-01-12 17:36:03,541 DEBUG - OpenSim.Region.CoreModules.Framework.EntityTransfer.EntityTransferModule [ENTITY TRANSFER MODULE]: Request Teleport to http://aurora.dmsp.de:8002/ [^] (http://grid.annuna.net:9000/ [^]) Psytrance/<128, 128, 0>
2011-01-12 17:36:03,542 DEBUG - OpenSim.Region.CoreModules.Framework.EntityTransfer.HGEntityTransferModule [HG ENTITY TRANSFER MODULE]: CreateAgent http://aurora.dmsp.de:8002/ [^] http://grid.annuna.net:9000/ [^]
2011-01-12 17:36:03,543 DEBUG - OpenSim.Services.Connectors.Hypergrid.UserAgentServiceConnector [USER AGENT CONNECTOR]: new connector to http://grid.annuna.net:8002/ [^] (http://78.46.22.11:8002/ [^])
2011-01-12 17:36:03,545 INFO - OpenSim.Services.Connectors.Hypergrid.UserAgentServiceConnector [USER AGENT CONNECTOR]: Posted CreateAgent request to remote sim http://78.46.22.11:8002/homeagent/88923f2f-7113-4b94-a05a-1713b92776e2/, [^] region Psytrance, x=2559232 y=2560512
2011-01-12 17:36:03,555 INFO - OpenSim.Services.Connectors.Hypergrid.UserAgentServiceConnector [USER AGENT CONNECTOR]: DoCreateChildAgentCall reply was {"reason":"Unable to verify identity"}


ROBUST server of my own grid logged meanwhile:

2011-01-12 17:35:59,628 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to link to Psytrance
2011-01-12 17:36:03,537 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to get hyperlink region 3ab1b1f1-943f-4326-b9f5-dbef7d543a18
2011-01-12 17:36:03,547 WARN - OpenSim.Server.Handlers.Hypergrid.HomeAgentHandler [HOME AGENT HANDLER]: Unauthorized machine 78.46.22.11 tried to set client ip to 145.253.64.227
2011-01-12 17:36:03,547 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] agentid=88923f2f-7113-4b94-a05a-1713b92776e2, child=True, startpos=<128, 128, 0>
2011-01-12 17:36:03,548 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] unpacked appearance
2011-01-12 17:36:03,548 DEBUG - OpenSim.Services.HypergridService.UserAgentService [USER AGENT SERVICE]: Request to login user Jabbaah.Annuna @grid.annuna.net (@stored IP) to grid http://aurora.dmsp.de:8002/ [^]
2011-01-12 17:36:03,548 DEBUG - OpenSim.Services.HypergridService.UserAgentService [USER AGENT SERVICE]: m_grid - http://grid.annuna.net:8002/, [^] gn - http://aurora.dmsp.de:8002/ [^]
2011-01-12 17:36:03,550 DEBUG - OpenSim.Services.Connectors.Simulation.SimulationServiceConnector [REMOTE SIMULATION CONNECTOR]: Posted CreateAgent request to remote sim http://aurora.dmsp.de:8002/foreignagent/88923f2f-7113-4b94-a05a-1713b92776e2/, [^] region Psytrance, x=2559232 y=2560512
2011-01-12 17:36:03,552 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] agentid=88923f2f-7113-4b94-a05a-1713b92776e2, child=True, startpos=<128, 128, 0>
2011-01-12 17:36:03,552 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] unpacked appearance
2011-01-12 17:36:03,552 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to login foreign agent Jabbaah.Annuna @grid.annuna.net @ http://grid.annuna.net:8002/ [^] (88923f2f-7113-4b94-a05a-1713b92776e2) at destination Psytrance
2011-01-12 17:36:03,553 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Verifying http://aurora.dmsp.de:8002 [^] against http://grid.annuna.net:8002 [^]
2011-01-12 17:36:03,553 INFO - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Unable to verify identity of agent Jabbaah.Annuna @grid.annuna.net. Refusing service.
2011-01-12 17:36:03,554 DEBUG - OpenSim.Services.Connectors.Simulation.SimulationServiceConnector [REMOTE SIMULATION CONNECTOR]: DoCreateChildAgentCall reply was {"reason":"Unable to verify identity","your_ip":"78.46.22.11"}
2011-01-12 17:36:03,554 DEBUG - OpenSim.Services.HypergridService.UserAgentService [USER AGENT SERVICE]: Unable to login user Jabbaah.Annuna @grid.annuna.net to grid http://aurora.dmsp.de:8002/, [^] reason: Unable to verify identity


I suspect that the function GetRegionByPosition() (by GetFinalDestination()) returns the external hostname of the targetted Gatekeeper Service by using the IP address? (my code reading of C# is not so great...)
On the other hand it works for other regions of my grid hosted on the same instance.

Background:
My host's domain name grid.annuna.net is resolved to 78.46.22.11 but reverse DNS points to aurora.dmsp.de
(Host has multiple DNS names)


TagsNo tags attached.
Git Revision or version number4ac5809
Run Mode Grid (Multiple Regions per Sim)
Physics EngineODE
Script Engine
EnvironmentMono / Linux32
Mono Version2.4.2
Viewer
Attached Files

- Relationships

-  Notes
(0017825)
jabba (reporter)
2011-01-13 01:33

Added some more logging for analysis. This log is from my ROBUST server logging 3 incoming hg tp requests:

1.) TP to region Annuna Center from some other grid (unknown) - failed:
    [GATEKEEPER SERVICE]: Verifying http://annuna.net:8002 [^] against http://grid.annuna.net:8002 [^]

2.) TP to region Psytrance from OSGrid - failed:
    [GATEKEEPER SERVICE]: Verifying http://aurora.dmsp.de:8002 [^] against http://grid.annuna.net:8002 [^]

3.) TP to region Annuna Center from OSGrid - successful:
    [GATEKEEPER SERVICE]: Verifying http://grid.annuna.net:8002 [^] against http://grid.annuna.net:8002 [^]

For me the main issue stays: Where does the first parameter of the above Gatekeeper message comes from? I cannot find the source. But this seems to be at least quite near to the bug...


2011-01-13 09:46:04,041 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to link to Annuna Center
2011-01-13 09:46:04,521 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to get hyperlink region 2e29d148-06ba-4862-a54c-1e3b6c894ca3
2011-01-13 09:46:04,837 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] agentid=8d61cf80-06b9-4fdd-b31f-324fced3790f, child=True, startpos=<128, 128, 30>
2011-01-13 09:46:04,838 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] unpacked appearance
2011-01-13 09:46:04,838 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to login foreign agent Sweet JaneX @ http://204.236.242.209:9500/ [^] (8d61cf80-06b9-4fdd-b31f-324fced3790f) at destination Annuna Center
2011-01-13 09:46:04,838 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Verifying http://annuna.net:8002 [^] against http://grid.annuna.net:8002 [^]
2011-01-13 09:46:04,839 INFO - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Unable to verify identity of agent Sweet JaneX. Refusing service.
2011-01-13 10:02:48,184 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to link to Psytrance
2011-01-13 10:02:55,516 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to get hyperlink region 3ab1b1f1-943f-4326-b9f5-dbef7d543a18
2011-01-13 10:02:56,295 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] agentid=0968d87d-6138-42d9-94d5-7f5df1d3874f, child=True, startpos=<128, 128, 0>
2011-01-13 10:02:56,295 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] unpacked appearance
2011-01-13 10:02:56,296 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to login foreign agent Jabbaah Annuna @ http://hg.osgrid.org:80/ [^] (0968d87d-6138-42d9-94d5-7f5df1d3874f) at destination Psytrance
2011-01-13 10:02:56,296 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Verifying http://aurora.dmsp.de:8002 [^] against http://grid.annuna.net:8002 [^]
2011-01-13 10:02:56,296 INFO - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Unable to verify identity of agent Jabbaah Annuna. Refusing service.
2011-01-13 10:03:14,114 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to link to Annuna Center
2011-01-13 10:03:18,116 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to get hyperlink region 2e29d148-06ba-4862-a54c-1e3b6c894ca3
2011-01-13 10:03:18,954 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] agentid=0968d87d-6138-42d9-94d5-7f5df1d3874f, child=True, startpos=<128, 128, 0>
2011-01-13 10:03:18,954 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] unpacked appearance
2011-01-13 10:03:18,954 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to login foreign agent Jabbaah Annuna @ http://hg.osgrid.org:80/ [^] (0968d87d-6138-42d9-94d5-7f5df1d3874f) at destination Annuna Center
2011-01-13 10:03:18,955 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Verifying http://grid.annuna.net:8002 [^] against http://grid.annuna.net:8002 [^]
2011-01-13 10:03:18,956 DEBUG - OpenSim.Services.Connectors.Hypergrid.UserAgentServiceConnector [USER AGENT CONNECTOR]: new connector to http://hg.osgrid.org:80/ [^] (http://69.162.125.163:80/ [^])
2011-01-13 10:03:19,221 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Identity verified for Jabbaah Annuna @ http://hg.osgrid.org:80/ [^]
2011-01-13 10:03:19,223 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: User is ok
2011-01-13 10:03:19,269 DEBUG - OpenSim.Services.PresenceService.PresenceService [PRESENCE SERVICE]: LoginAgent 0968d87d-6138-42d9-94d5-7f5df1d3874f with session d2d7830b-ccb9-468d-bce0-1d25f6d1c393 and ssession 81ba7db6-1a56-4099-a5fd-5ed5a5e7de99
2011-01-13 10:03:19,269 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Login presence ok
2011-01-13 10:03:19,271 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: destination ok: Annuna Center
2011-01-13 10:03:19,271 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: launching agent ViaHGLogin
2011-01-13 10:03:24,283 DEBUG - OpenSim.Services.Connectors.Simulation.SimulationServiceConnector [REMOTE SIMULATION CONNECTOR]: Posted CreateAgent request to remote sim http://grid.annuna.net:9000/agent/0968d87d-6138-42d9-94d5-7f5df1d3874f/, [^] region Annuna Center, x=2560000 y=2560000
2011-01-13 10:03:24,629 DEBUG - OpenSim.Services.Connectors.Simulation.SimulationServiceConnector [REMOTE SIMULATION CONNECTOR]: DoCreateChildAgentCall reply was {"success":true,"your_ip":"78.46.22.11"}

- Issue History
Date Modified Username Field Change
2011-01-12 09:24 jabba New Issue
2011-01-12 09:24 jabba Git Revision => 4ac5809
2011-01-12 09:24 jabba SVN Revision => 0
2011-01-12 09:24 jabba Run Mode => Grid (Multiple Regions per Sim)
2011-01-12 09:24 jabba Physics Engine => ODE
2011-01-12 09:24 jabba Environment => Mono / Linux32
2011-01-12 09:24 jabba Mono Version => 2.4.2
2011-01-13 01:33 jabba Note Added: 0017825
2014-01-23 15:41 justincc Category Robust Server => [GRID] Robust Server


Copyright © 2000 - 2012 MantisBT Group
Powered by Mantis Bugtracker