Mantis Bug Tracker

View Issue Details Jump to Notes ] Issue History ] Print ]
IDProjectCategoryView StatusDate SubmittedLast Update
0007494opensim[REGION] OpenSim Corepublic2015-03-10 11:572015-03-11 15:47
ReporterOtakuMegane 
Assigned To 
PrioritynormalSeveritymajorReproducibilityalways
StatusnewResolutionopen 
PlatformLinuxOSCentOSOS Version6.5
Product Versionmaster (dev code) 
Target VersionFixed in Version 
Summary0007494: Trouble crossing borders when offline regions are nearby
DescriptionWhen trying to cross borders between regions there is a long delay (about 30-35 seconds) if the region the avatar is currently in has one or more offline regions neighboring it. During this delay avatars can continue moving around the current region but will be stopped at the border. After approximately 30 seconds an attempt will usually be successful.

The problem seems to have appeared at commit 4c5d7d4683e34f9ac061da649ebf29e23d612faf
Steps To ReproduceGet onto a region with at least one neighbor that is offline then try to cross over into another region.
Additional InformationThese are some messages that come up in the console and seem to be related:

2015-03-04 16:14:11,064 INFO - OpenSim.Framework.WebUtil [LOGHTTP]: Slow JSON-RPC request 849 PUT to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/ [^] took 10001ms, 0ms writing, {"message_type":"AgentPosition","region_handle":"11000613838452992","circuit_code":"0","agent_uuid":"baccf1e5-8155-4488-a0cc-75ff9b415d9d","session_uuid":"66c482d3-a5da-4cf3-a555-424420cbeb5b","positi
2015-03-04 16:14:11,064 DEBUG - OpenSim.Framework.WebUtil [LOGHTTP]: JSON-RPC request 849 PUT to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/ [^] FAILED: The request timed out
2015-03-04 16:14:12,979 INFO - OpenSim.Framework.WebUtil [LOGHTTP]: Slow JSON-RPC request 852 DELETE to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/67b206a9-c314-4776-8e8f-2931c3537b69/?auth=66c482d3-a5da-4cf3-a555-424420cbeb5b [^] took 10001ms, 1ms writing,
2015-03-04 16:14:12,979 DEBUG - OpenSim.Framework.WebUtil [LOGHTTP]: JSON-RPC request 852 DELETE to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/67b206a9-c314-4776-8e8f-2931c3537b69/?auth=66c482d3-a5da-4cf3-a555-424420cbeb5b [^] FAILED: The request timed out
2015-03-04 16:14:12,979 INFO - OpenSim.Framework.WebUtil [LOGHTTP]: Slow JSON-RPC request 853 DELETE to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/5191114f-f7e8-4657-860d-8650f2043c51/?auth=66c482d3-a5da-4cf3-a555-424420cbeb5b [^] took 10001ms, 1ms writing,
2015-03-04 16:14:12,979 DEBUG - OpenSim.Framework.WebUtil [LOGHTTP]: JSON-RPC request 853 DELETE to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/5191114f-f7e8-4657-860d-8650f2043c51/?auth=66c482d3-a5da-4cf3-a555-424420cbeb5b [^] FAILED: The request timed out
2015-03-04 16:14:21,065 INFO - OpenSim.Framework.WebUtil [LOGHTTP]: Slow JSON-RPC request 855 PUT to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/ [^] took 10001ms, 0ms writing, {"message_type":"AgentPosition","region_handle":"11000613838452992","circuit_code":"0","agent_uuid":"baccf1e5-8155-4488-a0cc-75ff9b415d9d","session_uuid":"66c482d3-a5da-4cf3-a555-424420cbeb5b","positi
2015-03-04 16:14:21,065 DEBUG - OpenSim.Framework.WebUtil [LOGHTTP]: JSON-RPC request 855 PUT to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/ [^] FAILED: The request timed out
2015-03-04 16:14:26,055 INFO - OpenSim.Framework.WebUtil [LOGHTTP]: Slow JSON-RPC request 836 POST to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/ [^] took 30021ms, 0ms writing, {"agent_id":"baccf1e5-8155-4488-a0cc-75ff9b415d9d","caps_path":"82f3abe6-cfc8-4717-a916-e051f4e6e9a2","children_seeds":[{"handle":"11000613838452992","seed":"534d9ad8-2114-46e7-82c3-803241d56b07"},{"h
2015-03-04 16:14:26,055 DEBUG - OpenSim.Framework.WebUtil [LOGHTTP]: JSON-RPC request 836 POST to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/ [^] FAILED: The request timed out
2015-03-04 16:14:56,078 INFO - OpenSim.Framework.WebUtil [LOGHTTP]: Slow JSON-RPC request 856 POST to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/ [^] took 30023ms, 0ms writing, {"agent_id":"baccf1e5-8155-4488-a0cc-75ff9b415d9d","caps_path":"82f3abe6-cfc8-4717-a916-e051f4e6e9a2","children_seeds":[{"handle":"11000613838452992","seed":"534d9ad8-2114-46e7-82c3-803241d56b07"},{"h
2015-03-04 16:14:56,078 DEBUG - OpenSim.Framework.WebUtil [LOGHTTP]: JSON-RPC request 856 POST to http://209.250.2.163:9000/agent/baccf1e5-8155-4488-a0cc-75ff9b415d9d/ [^] FAILED: The request timed out
TagsNo tags attached.
Git Revision or version number
Run Mode Grid (1 Region per Sim) , Grid (Multiple Regions per Sim)
Physics EngineBulletSim
Script Engine
EnvironmentMono / Linux64
Mono VersionOther
ViewerSingularity, Firestorm
Attached Files

- Relationships

-  Notes
(0027836)
justincc (administrator)
2015-03-11 15:32

I investigated this with local offline regions created by simply terminating the OpenSimulator process. In this case it doesn't happen - the communication attempts are rejected immediately with "JSON-RPC request ... FAILED: Error: ConnectFailure (ConnectionRefused)" as one would expect since there is no server present to listen for requests.

So I suspect that these some server is actually present for these 'offline' regions and accepts but never responds to the request. It is difficult to do much about this - the timeout could possibly be shortened but if that goes too far then problems are created when regions are simply a little slow to respond.

I would say that osgrid either has to investigate why people are putting up servers that are present but never reply and/or remove them manually from the map.
(0027837)
dahlia (administrator)
2015-03-11 15:47

I've noticed similar issues on OSGrid when placing regions in busy areas of the map and there are nearby offline regions. It's *as if* attempted communications with offline regions starves thread resources in the simulator and the region is effectively frozen until enough timeouts occur that normal threads can resume. Often the simulator console has many watchdog delay warnings at the same time. I suspect threadpool tasks may be spinning on waiting for responses rather than freeing up for other tasks but I've not debugged it to that level.

- Issue History
Date Modified Username Field Change
2015-03-10 11:57 OtakuMegane New Issue
2015-03-11 15:32 justincc Note Added: 0027836
2015-03-11 15:47 dahlia Note Added: 0027837


Copyright © 2000 - 2012 MantisBT Group
Powered by Mantis Bugtracker