Mantis Bug Tracker

View Issue Details Jump to Notes ] Issue History ] Print ]
IDProjectCategoryView StatusDate SubmittedLast Update
0005305opensim[GRID] Robust Serverpublic2011-01-06 00:542015-02-28 16:31
Reporteraiaustin 
Assigned To 
PrioritynormalSeverityminorReproducibilityhave not tried
StatusnewResolutionopen 
PlatformOSOS Version
Product Versionmaster (dev code) 
Target VersionFixed in Version 
Summary0005305: [HOME AGENT HANDLER]: Invalid parameters for agent message
DescriptionNoted this message on tests of 0.7.1 dev master code r/14741 from 4-Jan-2011

[HOME AGENT HANDLER]: Invalid parameters for agent message /homeagent
/e24a9015-f5ca-452b-8c95d32e34cb9d64/,
TagsNo tags attached.
Git Revision or version number0.7.1 dev master
Run Mode Grid (Multiple Regions per Sim)
Physics EngineODE
Script Engine
Environment.NET / Windows32
Mono VersionNone
Viewer
Attached Files

- Relationships

-  Notes
(0017782)
Diva (administrator)
2011-01-06 16:23

Are you sure this is the exact debug message, with a comma at the end? Is there any way you can double check on the log?
(0017790)
aiaustin (developer)
2011-01-07 01:56
edited on: 2011-01-07 02:01

Yes Diva... I just checked my Robust.exe log (using r/14747 5-Jan-2011 0.7.1 dev master version) and it has the comma on the end. I attach the immediate activity ahead of the message in case this gives useful information about a typical HG login attempt...

... BUT... I notice that the avatar UUID referred to in the [HOME AGENT HANDLER]: Invalid parameters error message is actually referring to MY avatar for "Ai Austin" (e24a9015-f5ca-452b-8c95-d32e34cb9d64) and a logout was done just a bit before that it seems. I cannot recall what I was doing when this occurred.. but I know yesterday I was HG jump testing between Openvue, OSGrid, Ansky grid and your UCI Grid 03.

2011-01-06 16:13:34,679 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to login foreign agent Miguel Rotunno @ http://hg.osgrid.org:80/ [^] (1c2f340a-ae55-4635-aa8d-53d8da96ac41) at destination Vue-9000
2011-01-06 16:13:34,681 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Verifying http://virtual.aiai.ed.ac.uk:8002 [^] against http://virtual.aiai.ed.ac.uk:8002 [^]
2011-01-06 16:13:34,686 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-06 16:13:35,115 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Identity verified for Miguel Rotunno @ http://hg.osgrid.org:80/ [^]
2011-01-06 16:13:35,118 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: User is ok
2011-01-06 16:13:35,122 DEBUG - OpenSim.Services.PresenceService.PresenceService [PRESENCE SERVICE]: LoginAgent 1c2f340a-ae55-4635-aa8d-53d8da96ac41 with session de2df621-a097-4b10-9c4f-837fbafcb890 and ssession 787e627f-b909-4130-81cf-ae691f34f395
2011-01-06 16:13:35,124 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Login presence ok
2011-01-06 16:13:35,127 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: destination ok: Vue-9000
2011-01-06 16:13:35,129 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: launching agent ViaHGLogin
2011-01-06 16:13:35,192 INFO - OpenSim.Framework.Servers.HttpServer.BaseHttpServer [BASE HTTP SERVER]: slow request <unknown> for / took 515 ms
2011-01-06 16:13:37,889 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: region Vue-9000 has 0 neighours
2011-01-06 16:13:44,991 DEBUG - OpenSim.Services.AvatarService.AvatarService [AVATAR SERVICE]: SetAvatar for 1c2f340a-ae55-4635-aa8d-53d8da96ac41, attachs=5
2011-01-06 16:13:51,433 DEBUG - OpenSim.Services.AvatarService.AvatarService [AVATAR SERVICE]: SetAvatar for 1c2f340a-ae55-4635-aa8d-53d8da96ac41, attachs=5
2011-01-06 16:15:41,793 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: GetRegionsByName grid.jezsworld.co.uk:8002
2011-01-06 16:15:41,796 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: Found 0 regions
2011-01-06 16:15:47,029 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: GetRegionsByName grid.jezsworld.co.uk:8002
2011-01-06 16:15:47,031 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: Found 0 regions
2011-01-06 16:16:01,219 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: GetRegionsByName unethika.kicks-ass.net:8002:Bent_Spoke
2011-01-06 16:16:01,222 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: Found 0 regions
2011-01-06 16:16:05,627 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: region Vue-9000 has 0 neighours
2011-01-06 16:17:47,950 DEBUG - OpenSim.Services.PresenceService.PresenceService [PRESENCE SERVICE]: Session 75b3f040-5b64-41d5-ba78-673b4e4ccb4f logout
2011-01-06 16:17:47,957 DEBUG - OpenSim.Services.UserAccountService.GridUserService [GRID USER SERVICE]: User e24a9015-f5ca-452b-8c95-d32e34cb9d64 is offline
2011-01-06 16:18:15,906 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: GetRegionsByName metaversesims.net:9000
2011-01-06 16:18:15,909 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: Found 0 regions
2011-01-06 16:18:24,108 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: GetRegionsByName metaversesims.net:9000
2011-01-06 16:18:24,110 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: Found 0 regions
2011-01-06 16:18:34,999 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: GetRegionsByName metaversesims.net:9000
2011-01-06 16:18:35,001 DEBUG - OpenSim.Services.GridService.GridService [GRID SERVICE]: Found 0 regions
2011-01-06 16:20:02,342 DEBUG - OpenSim.Services.PresenceService.PresenceService [PRESENCE SERVICE]: Session de2df621-a097-4b10-9c4f-837fbafcb890 logout
2011-01-06 16:31:36,393 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to link to Vue-9000
2011-01-06 16:32:30,424 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to link to Vue-9000
2011-01-06 17:06:42,742 INFO - OpenSim.Server.Handlers.Hypergrid.HomeAgentHandler [HOME AGENT HANDLER]: Invalid parameters for agent message /homeagent/e24a9015-f5ca-452b-8c95d32e34cb9d64/,


Then it continues......

2011-01-06 17:18:44,699 DEBUG - OpenSim.Services.HypergridService.GatekeeperService [GATEKEEPER SERVICE]: Request to get hyperlink region bd09a792-eba5-11dc-95ff-0800200c9a66
2011-01-06 17:18:45,152 INFO - OpenSim.Framework.AgentCircuitData [AGENTCIRCUITDATA] agentid=d21d26d9-179d-457b-9906-e464a4c0b5b2, child=True, startpos=<131.3746, 130.9945, 25.61282>


......

(0017792)
aiaustin (developer)
2011-01-07 02:22

Diva, this is a bit unrelated but I just spotted this again close by where I was extracting the logs on the comment earlier. As you know there are some ROBUST messages related to logins and HG that say what the Gatekeeper sees a user as... but the log messages just end with nothing after the "sees me as".

10:16:00 - [USER AGENT SERVICE]: Gatekeeper sees me as
(0017798)
Diva (administrator)
2011-01-07 07:58

Have you seen this happen again, or was it just this once? -- I'm talking about the "/homeagent/<uuid>/," message. It is a bizarre message that can only be explained by some bizarre bug in the underlying http server. If it happens sometimes, I can turn on more debug to try to pin down its origin.
(0017813)
aiaustin (developer)
2011-01-09 04:31

In my logs of r/14747 I only see one inmstance of this message Diva.

I have also checked the logs since I last upgraded to r/14751 and cannot see a repeat yet, but that was only a day ort two ago. I will watch out for more instances.

In case its helpful I note two other messages I keep seeing. The first often occurs in yellow (warning?) and the second I include here as I see a (new?) ";" in the URL.

12:17:45 - [HOME AGENT HANDLER]: Unauthorized machine 129.215.219.138 tried to set client ip to 82.41.239.115

12:19:20 - [USER AGENT SERVICE]: Verifying agent token http://virtual.aiai.ed.ac.uk:8002/;8e32344d-9285-4abf-a9ad-1d664f6c2cac [^] against http://virtual.aiai.ed.ac.uk:8002/;8e32344d-9285-4abf-a9ad-1d664f6c2cac [^]

- Issue History
Date Modified Username Field Change
2011-01-06 00:54 aiaustin New Issue
2011-01-06 00:55 aiaustin Git Revision => 0.7.1 dev master
2011-01-06 00:55 aiaustin SVN Revision => 14741
2011-01-06 00:55 aiaustin Run Mode => Grid (Multiple Regions per Sim)
2011-01-06 00:55 aiaustin Physics Engine => ODE
2011-01-06 00:55 aiaustin Environment => .NET / Windows32
2011-01-06 00:55 aiaustin Mono Version => None
2011-01-06 16:23 Diva Note Added: 0017782
2011-01-07 01:56 aiaustin Note Added: 0017790
2011-01-07 01:57 aiaustin Note Edited: 0017790
2011-01-07 02:01 aiaustin Note Edited: 0017790
2011-01-07 02:22 aiaustin Note Added: 0017792
2011-01-07 07:58 Diva Note Added: 0017798
2011-01-09 04:31 aiaustin Note Added: 0017813
2014-01-23 15:41 justincc Category Robust Server => [GRID] Robust Server


Copyright © 2000 - 2012 MantisBT Group
Powered by Mantis Bugtracker