Mantis Bug Tracker

View Revisions: Issue #7774 All Revisions ] Back to Issue ]
Summary 0007774: Complex avatar with mesh parts fails to complete HG teleport
Revision 2015-12-01 03:55 by aiaustin
Description I am testing HG teleport between OSGrid, AiLand and Openvue grids using a robot avatar that has complex mesh parts... I managed to teleport once in 4 attempts, and in the viewer for the teleporting robot it showed the avatar correctly (presumably as it was cached there) - see "Arrival-as-it-should-look.jpg. But to the other avatar present the robot avatar only showed the core prim parts - see Arrival-with-no-mesh-parts_001.jpg. None of the mesh made it even after waiting 5 minutes. Each of the other attempts, the teleport failed altogether, and the avatar was just returned to the source region after a minute or more of trying.

I notice a long or slow transfer of the information between simulators.. as would be expected give the mesh attachments are quite complex. Teleports of this avatar between the same grids seemed to work fine when last tests about a month ago.

-----------------------------------------------------------------
At the source end (on an OSGrid region) for the teleporting robot... Valkyrie.Resident

11:23:01 - [HYPERGRID LINKER]: Link to virtual.aiai.ed.ac.uk:8002 Informatics, in <3509,0>
11:23:01 - [GRID SERVICE]: GetRegionByPosition. Did not find region in database. Pos=<3509,0>
11:23:01 - [GATEKEEPER SERVICE CONNECTOR]: Linking to http://virtual.aiai.ed.ac.uk:8002/ [^]
11:23:01 - [HYPERGRID LINKER]: Region already exists in coordinates <2448,0>
11:23:01 - [ENTITY TRANSFER STATE MACHINE]: SetInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=Preparing
11:23:01 - [ENTITY TRANSFER MODULE]: GetRegionContainingWorldLocation: call, XY=<626816,128>
11:23:01 - [GRID SERVICE]: GetRegionByPosition. Found region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics in database. Pos=<2448,0>
11:23:01 - [LOCAL GRID SERVICE CONNECTOR]: GetRegionByPosition. Got region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics from grid service. Pos=<2448,0>
11:23:01 - [REMOTE GRID CONNECTOR]: GetRegionByPosition. Added region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics to the cache. Pos=<2448,0>, RegionHandle=2691604464795648
11:23:01 - [ENTITY TRANSFER MODULE]: GetRegionContainingWorldLocation: Found region using legacy size. rloc=<626688,0>. Rname=http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics
11:23:01 - [HG ENTITY TRANSFER MODULE]: region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics flags: 524
11:23:01 - [HG ENTITY TRANSFER MODULE]: Destination region is hyperlink
11:23:01 - [GATEKEEPER SERVICE CONNECTOR]: contacting http://virtual.aiai.ed.ac.uk:8002/ [^]
11:23:01 - [HG ENTITY TRANSFER MODULE]: GetFinalDestination: ServerURI=http://virtual3.aiai.ed.ac.uk:9000/ [^]
11:23:01 - [ENTITY TRANSFER MODULE]: Teleporting Valkyrie Resident 2480d607-7164-4385-b203-73de16a149b5 from Vue-Port to http://virtual.aiai.ed.ac.uk:8002/ [^] (http://virtual3.aiai.ed.ac.uk:9000/ [^]) Informatics/<128, 128, 25>
11:23:02 - [REMOTE SIMULATION CONNECTOR]: QueryAccess to http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/a664c885-e876-11dc-95ff-0800200c9a66/ [^] returned True, reason , version 0.4/0.4
11:23:02 - [ENTITY TRANSFER MODULE]: Vue-Port transfer protocol version to Informatics is 0.4 / 0.4
11:23:02 - [ENTITY TRANSFER MODULE]: Determined that region Informatics at 9048,9047 needs new child agent for agent Valkyrie Resident from Vue-Port
11:23:02 - [HG ENTITY TRANSFER MODULE]: CreateAgent http://virtual.aiai.ed.ac.uk:8002/ [^] http://virtual3.aiai.ed.ac.uk:9000/ [^]
11:23:02 - [REMOTE SIMULATION CONNECTOR]: Creating agent at http://64.31.16.122:80/ [^]
11:23:03 - [HG INVENTORY ACCESS MODULE]: Changing root inventory for user Valkyrie Resident
11:23:04 - [ENTITY TRANSFER STATE MACHINE]: UpdateInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=Transferring
11:23:04 - [ENTITY TRANSFER MODULE]: Sending new CAPS seed url http://virtual3.aiai.ed.ac.uk:9000/CAPS/93ae96e4-0eb8-47ba-90d4-0cc7698309d50000/ [^] from Vue-Port to Valkyrie Resident
Region (root) #
Region (root) #
Region (root) # STICKS HERE
Invalid command
Region (root) #
11:23:34 - [WEB UTIL]: Slow ServiceOSD request 7754 PUT http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/ [^] took 30140ms, 0ms writing(0 at Json; 0 at comp), 15104 bytes (254510 uncomp): {"message_type":"AgentData","region_id":"7d6d7132-1d16-475b-830a-9301fb78e1e2","circuit_code":"0","agent_uuid":"2480d607-7164-4385-b203-73de16a149b5","session_uuid":"043391ce-b429-438c-99e0-4d81cec005
Region (root) #
Region (root) #
Region (root) # STICKS AGAIN
Invalid command
11:24:04 - [WEB UTIL]: Slow ServiceOSD request 7755 PUT http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/ [^] took 30172ms, 16ms writing(16 at Json; 16 at comp), 254510 bytes (254510 uncomp): {"message_type":"AgentData","region_id":"7d6d7132-1d16-475b-830a-9301fb78e1e2","circuit_code":"0","agent_uuid":"2480d607-7164-4385-b203-73de16a149b5","session_uuid":"043391ce-b429-438c-99e0-4d81cec005
11:24:04 - [ENTITY TRANSFER MODULE]: UpdateAgent failed on teleport of Valkyrie Resident to Informatics. Keeping avatar in Vue-Port
11:24:04 - [ENTITY TRANSFER STATE MACHINE]: UpdateInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=CleaningUp
11:24:04 - [REMOTE SIMULATION CONNECTOR]: CloseAgent http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/a664c885-e876-11dc-95ff-0800200c9a66/?auth=043391ce-b429-438c-99e0-4d81cec005bc [^]
11:24:04 - [HG INVENTORY ACCESS MODULE]: Restoring root folder for local user Valkyrie Resident
11:24:04 - [ENTITY TRANSFER STATE MACHINE]: Agent 2480d607-7164-4385-b203-73de16a149b5 cleared from transit in Vue-Port
Region (root) #
Region (root) #
Region (root) # FAILED HERE
Invalid command
Region (root) #
Region (root) #

-----------------------------------------------------------------
At thedestination end (on openvue grid Informatics region)

11:30:44 - [SCENE]: Region Informatics told of incoming child agent Valkyrie.Resident @hg.osgrid.org 2480d607-7164-4385-b203-73de16a149b5 (circuit code 123675133, IP 129.215.219.86, viewer Firestorm-Releasex64 4.7.5.47975, teleportflags (ViaLogin), position <128, 128, 25>. From region Vue-Port (7d6d7132-1d16-475b-830a-9301fb78e1e2) @ http://hg.osgrid.org:80/ [^]
11:30:44 - [SCENE]: Region Informatics authenticated and authorized incoming child agent Valkyrie.Resident @hg.osgrid.org 2480d607-7164-4385-b203-73de16a149b5 (circuit code 123675133)
11:30:44 - [CreateCaps]: new caps agent 2480d607-7164-4385-b203-73de16a149b5, circuit 123675133, path 93ae96e4-0eb8-47ba-90d4-0cc7698309d5, time 0
11:30:44 - [VivoxVoice]: OnRegisterCaps: agentID 2480d607-7164-4385-b203-73de16a149b5 caps OpenSim.Framework.Capabilities.Caps
11:30:44 - [EVENTQUEUE]: Found Existing UUID!
11:30:44 - [AGENT HANDLER]: SYNC CreateAgent True Authorized
11:30:45 - [CHILDAGENTDATAUPDATE]: got packed appearance
11:30:45 - [SCENE]: Incoming child agent update for 2480d607-7164-4385-b203-73de16a149b5 in Informatics
11:31:15 - [SCENE PRESENCE]: Did not find presence with id 2480d607-7164-4385-b203-73de16a149b5 in Informatics before timeout
11:31:15 - [LOGHTTP]: Slow handling of 1169 PUT /agent/2480d607-7164-4385-b203-73de16a149b5/ from 129.215.219.85:65055 took 30094ms
11:31:15 - [CHILDAGENTDATAUPDATE]: got packed appearance
11:31:15 - [SCENE]: Incoming child agent update for 2480d607-7164-4385-b203-73de16a149b5 in Informatics
11:31:45 - [SCENE PRESENCE]: Did not find presence with id 2480d607-7164-4385-b203-73de16a149b5 in Informatics before timeout
11:31:45 - [LOGHTTP]: Slow handling of 1179 PUT /agent/2480d607-7164-4385-b203-73de16a149b5/ from 129.215.219.85:65067 took 30109ms
11:31:45 - [AGENT HANDLER]: >>> DELETE <<< RegionID: a664c885-e876-11dc-95ff-0800200c9a66; from: 129.215.219.85; auth_code: 043391ce-b429-438c-99e0-4d81cec005bc
11:31:45 - [SCENE]: Called CloseClient() with agent ID 2480d607-7164-4385-b203-73de16a149b5 but no such presence is in Informatics

Revision 2015-12-01 03:44 by aiaustin
Description I am testing HG teleport between OSGrid, AiLand and Openvue grids using a robot avatar that has complex mesh parts... I managed to teleport once in 4 attempts, and in the viewer for the teleporting robot it showed the avatar correctly (presumably as it was cached there). But to the other avatar present the robot avatar only showed the core prim parts. None of the mesh made it even after waiting 5 minutes. Each of the other attempts, the teleport failed altogether, and the avatar was just returned to the source region after a minute or more of trying.

I notice a long or slow transfer of the information between simulators.. as would be expected give the mesh attachments are quite complex. Teleports of this avatar between the same grids seemed to work fine when last tests about a month ago.

-----------------------------------------------------------------
At the source end (on an OSGrid region) for the teleporting robot... Valkyrie.Resident

11:23:01 - [HYPERGRID LINKER]: Link to virtual.aiai.ed.ac.uk:8002 Informatics, in <3509,0>
11:23:01 - [GRID SERVICE]: GetRegionByPosition. Did not find region in database. Pos=<3509,0>
11:23:01 - [GATEKEEPER SERVICE CONNECTOR]: Linking to http://virtual.aiai.ed.ac.uk:8002/ [^]
11:23:01 - [HYPERGRID LINKER]: Region already exists in coordinates <2448,0>
11:23:01 - [ENTITY TRANSFER STATE MACHINE]: SetInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=Preparing
11:23:01 - [ENTITY TRANSFER MODULE]: GetRegionContainingWorldLocation: call, XY=<626816,128>
11:23:01 - [GRID SERVICE]: GetRegionByPosition. Found region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics in database. Pos=<2448,0>
11:23:01 - [LOCAL GRID SERVICE CONNECTOR]: GetRegionByPosition. Got region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics from grid service. Pos=<2448,0>
11:23:01 - [REMOTE GRID CONNECTOR]: GetRegionByPosition. Added region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics to the cache. Pos=<2448,0>, RegionHandle=2691604464795648
11:23:01 - [ENTITY TRANSFER MODULE]: GetRegionContainingWorldLocation: Found region using legacy size. rloc=<626688,0>. Rname=http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics
11:23:01 - [HG ENTITY TRANSFER MODULE]: region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics flags: 524
11:23:01 - [HG ENTITY TRANSFER MODULE]: Destination region is hyperlink
11:23:01 - [GATEKEEPER SERVICE CONNECTOR]: contacting http://virtual.aiai.ed.ac.uk:8002/ [^]
11:23:01 - [HG ENTITY TRANSFER MODULE]: GetFinalDestination: ServerURI=http://virtual3.aiai.ed.ac.uk:9000/ [^]
11:23:01 - [ENTITY TRANSFER MODULE]: Teleporting Valkyrie Resident 2480d607-7164-4385-b203-73de16a149b5 from Vue-Port to http://virtual.aiai.ed.ac.uk:8002/ [^] (http://virtual3.aiai.ed.ac.uk:9000/ [^]) Informatics/<128, 128, 25>
11:23:02 - [REMOTE SIMULATION CONNECTOR]: QueryAccess to http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/a664c885-e876-11dc-95ff-0800200c9a66/ [^] returned True, reason , version 0.4/0.4
11:23:02 - [ENTITY TRANSFER MODULE]: Vue-Port transfer protocol version to Informatics is 0.4 / 0.4
11:23:02 - [ENTITY TRANSFER MODULE]: Determined that region Informatics at 9048,9047 needs new child agent for agent Valkyrie Resident from Vue-Port
11:23:02 - [HG ENTITY TRANSFER MODULE]: CreateAgent http://virtual.aiai.ed.ac.uk:8002/ [^] http://virtual3.aiai.ed.ac.uk:9000/ [^]
11:23:02 - [REMOTE SIMULATION CONNECTOR]: Creating agent at http://64.31.16.122:80/ [^]
11:23:03 - [HG INVENTORY ACCESS MODULE]: Changing root inventory for user Valkyrie Resident
11:23:04 - [ENTITY TRANSFER STATE MACHINE]: UpdateInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=Transferring
11:23:04 - [ENTITY TRANSFER MODULE]: Sending new CAPS seed url http://virtual3.aiai.ed.ac.uk:9000/CAPS/93ae96e4-0eb8-47ba-90d4-0cc7698309d50000/ [^] from Vue-Port to Valkyrie Resident
Region (root) #
Region (root) #
Region (root) # STICKS HERE
Invalid command
Region (root) #
11:23:34 - [WEB UTIL]: Slow ServiceOSD request 7754 PUT http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/ [^] took 30140ms, 0ms writing(0 at Json; 0 at comp), 15104 bytes (254510 uncomp): {"message_type":"AgentData","region_id":"7d6d7132-1d16-475b-830a-9301fb78e1e2","circuit_code":"0","agent_uuid":"2480d607-7164-4385-b203-73de16a149b5","session_uuid":"043391ce-b429-438c-99e0-4d81cec005
Region (root) #
Region (root) #
Region (root) # STICKS AGAIN
Invalid command
11:24:04 - [WEB UTIL]: Slow ServiceOSD request 7755 PUT http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/ [^] took 30172ms, 16ms writing(16 at Json; 16 at comp), 254510 bytes (254510 uncomp): {"message_type":"AgentData","region_id":"7d6d7132-1d16-475b-830a-9301fb78e1e2","circuit_code":"0","agent_uuid":"2480d607-7164-4385-b203-73de16a149b5","session_uuid":"043391ce-b429-438c-99e0-4d81cec005
11:24:04 - [ENTITY TRANSFER MODULE]: UpdateAgent failed on teleport of Valkyrie Resident to Informatics. Keeping avatar in Vue-Port
11:24:04 - [ENTITY TRANSFER STATE MACHINE]: UpdateInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=CleaningUp
11:24:04 - [REMOTE SIMULATION CONNECTOR]: CloseAgent http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/a664c885-e876-11dc-95ff-0800200c9a66/?auth=043391ce-b429-438c-99e0-4d81cec005bc [^]
11:24:04 - [HG INVENTORY ACCESS MODULE]: Restoring root folder for local user Valkyrie Resident
11:24:04 - [ENTITY TRANSFER STATE MACHINE]: Agent 2480d607-7164-4385-b203-73de16a149b5 cleared from transit in Vue-Port
Region (root) #
Region (root) #
Region (root) # FAILED HERE
Invalid command
Region (root) #
Region (root) #

-----------------------------------------------------------------
At thedestination end (on openvue grid Informatics region)

11:30:44 - [SCENE]: Region Informatics told of incoming child agent Valkyrie.Resident @hg.osgrid.org 2480d607-7164-4385-b203-73de16a149b5 (circuit code 123675133, IP 129.215.219.86, viewer Firestorm-Releasex64 4.7.5.47975, teleportflags (ViaLogin), position <128, 128, 25>. From region Vue-Port (7d6d7132-1d16-475b-830a-9301fb78e1e2) @ http://hg.osgrid.org:80/ [^]
11:30:44 - [SCENE]: Region Informatics authenticated and authorized incoming child agent Valkyrie.Resident @hg.osgrid.org 2480d607-7164-4385-b203-73de16a149b5 (circuit code 123675133)
11:30:44 - [CreateCaps]: new caps agent 2480d607-7164-4385-b203-73de16a149b5, circuit 123675133, path 93ae96e4-0eb8-47ba-90d4-0cc7698309d5, time 0
11:30:44 - [VivoxVoice]: OnRegisterCaps: agentID 2480d607-7164-4385-b203-73de16a149b5 caps OpenSim.Framework.Capabilities.Caps
11:30:44 - [EVENTQUEUE]: Found Existing UUID!
11:30:44 - [AGENT HANDLER]: SYNC CreateAgent True Authorized
11:30:45 - [CHILDAGENTDATAUPDATE]: got packed appearance
11:30:45 - [SCENE]: Incoming child agent update for 2480d607-7164-4385-b203-73de16a149b5 in Informatics
11:31:15 - [SCENE PRESENCE]: Did not find presence with id 2480d607-7164-4385-b203-73de16a149b5 in Informatics before timeout
11:31:15 - [LOGHTTP]: Slow handling of 1169 PUT /agent/2480d607-7164-4385-b203-73de16a149b5/ from 129.215.219.85:65055 took 30094ms
11:31:15 - [CHILDAGENTDATAUPDATE]: got packed appearance
11:31:15 - [SCENE]: Incoming child agent update for 2480d607-7164-4385-b203-73de16a149b5 in Informatics
11:31:45 - [SCENE PRESENCE]: Did not find presence with id 2480d607-7164-4385-b203-73de16a149b5 in Informatics before timeout
11:31:45 - [LOGHTTP]: Slow handling of 1179 PUT /agent/2480d607-7164-4385-b203-73de16a149b5/ from 129.215.219.85:65067 took 30109ms
11:31:45 - [AGENT HANDLER]: >>> DELETE <<< RegionID: a664c885-e876-11dc-95ff-0800200c9a66; from: 129.215.219.85; auth_code: 043391ce-b429-438c-99e0-4d81cec005bc
11:31:45 - [SCENE]: Called CloseClient() with agent ID 2480d607-7164-4385-b203-73de16a149b5 but no such presence is in Informatics

Revision 2015-12-01 03:30 by aiaustin
Description I am testing HG teleport between OSGrid, AiLand and Openvue grids using a robot avatar that has complex mesh parts... I managed to teleport once in 4 attempts, and in the viewer for the teleporting robot it showed the avatar correctly (presumably as it was cached there). But to the other avatar present the robot avatar only showed the core prim parts. None of the mesh made it even after waiting 5 minutes.

I notice a long or slow transfer of the information between simulators.. as would be expected give the mesh attachments are quite complex. Teleports of this avatar between the same grids seemed to work fine when last tests about a month ago.

-----------------------------------------------------------------
At the source end (on an OSGrid region) for the teleporting robot... Valkyrie.Resident

11:23:01 - [HYPERGRID LINKER]: Link to virtual.aiai.ed.ac.uk:8002 Informatics, in <3509,0>
11:23:01 - [GRID SERVICE]: GetRegionByPosition. Did not find region in database. Pos=<3509,0>
11:23:01 - [GATEKEEPER SERVICE CONNECTOR]: Linking to http://virtual.aiai.ed.ac.uk:8002/ [^]
11:23:01 - [HYPERGRID LINKER]: Region already exists in coordinates <2448,0>
11:23:01 - [ENTITY TRANSFER STATE MACHINE]: SetInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=Preparing
11:23:01 - [ENTITY TRANSFER MODULE]: GetRegionContainingWorldLocation: call, XY=<626816,128>
11:23:01 - [GRID SERVICE]: GetRegionByPosition. Found region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics in database. Pos=<2448,0>
11:23:01 - [LOCAL GRID SERVICE CONNECTOR]: GetRegionByPosition. Got region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics from grid service. Pos=<2448,0>
11:23:01 - [REMOTE GRID CONNECTOR]: GetRegionByPosition. Added region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics to the cache. Pos=<2448,0>, RegionHandle=2691604464795648
11:23:01 - [ENTITY TRANSFER MODULE]: GetRegionContainingWorldLocation: Found region using legacy size. rloc=<626688,0>. Rname=http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics
11:23:01 - [HG ENTITY TRANSFER MODULE]: region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics flags: 524
11:23:01 - [HG ENTITY TRANSFER MODULE]: Destination region is hyperlink
11:23:01 - [GATEKEEPER SERVICE CONNECTOR]: contacting http://virtual.aiai.ed.ac.uk:8002/ [^]
11:23:01 - [HG ENTITY TRANSFER MODULE]: GetFinalDestination: ServerURI=http://virtual3.aiai.ed.ac.uk:9000/ [^]
11:23:01 - [ENTITY TRANSFER MODULE]: Teleporting Valkyrie Resident 2480d607-7164-4385-b203-73de16a149b5 from Vue-Port to http://virtual.aiai.ed.ac.uk:8002/ [^] (http://virtual3.aiai.ed.ac.uk:9000/ [^]) Informatics/<128, 128, 25>
11:23:02 - [REMOTE SIMULATION CONNECTOR]: QueryAccess to http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/a664c885-e876-11dc-95ff-0800200c9a66/ [^] returned True, reason , version 0.4/0.4
11:23:02 - [ENTITY TRANSFER MODULE]: Vue-Port transfer protocol version to Informatics is 0.4 / 0.4
11:23:02 - [ENTITY TRANSFER MODULE]: Determined that region Informatics at 9048,9047 needs new child agent for agent Valkyrie Resident from Vue-Port
11:23:02 - [HG ENTITY TRANSFER MODULE]: CreateAgent http://virtual.aiai.ed.ac.uk:8002/ [^] http://virtual3.aiai.ed.ac.uk:9000/ [^]
11:23:02 - [REMOTE SIMULATION CONNECTOR]: Creating agent at http://64.31.16.122:80/ [^]
11:23:03 - [HG INVENTORY ACCESS MODULE]: Changing root inventory for user Valkyrie Resident
11:23:04 - [ENTITY TRANSFER STATE MACHINE]: UpdateInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=Transferring
11:23:04 - [ENTITY TRANSFER MODULE]: Sending new CAPS seed url http://virtual3.aiai.ed.ac.uk:9000/CAPS/93ae96e4-0eb8-47ba-90d4-0cc7698309d50000/ [^] from Vue-Port to Valkyrie Resident
Region (root) #
Region (root) #
Region (root) # STICKS HERE
Invalid command
Region (root) #
11:23:34 - [WEB UTIL]: Slow ServiceOSD request 7754 PUT http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/ [^] took 30140ms, 0ms writing(0 at Json; 0 at comp), 15104 bytes (254510 uncomp): {"message_type":"AgentData","region_id":"7d6d7132-1d16-475b-830a-9301fb78e1e2","circuit_code":"0","agent_uuid":"2480d607-7164-4385-b203-73de16a149b5","session_uuid":"043391ce-b429-438c-99e0-4d81cec005
Region (root) #
Region (root) #
Region (root) # STICKS AGAIN
Invalid command
11:24:04 - [WEB UTIL]: Slow ServiceOSD request 7755 PUT http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/ [^] took 30172ms, 16ms writing(16 at Json; 16 at comp), 254510 bytes (254510 uncomp): {"message_type":"AgentData","region_id":"7d6d7132-1d16-475b-830a-9301fb78e1e2","circuit_code":"0","agent_uuid":"2480d607-7164-4385-b203-73de16a149b5","session_uuid":"043391ce-b429-438c-99e0-4d81cec005
11:24:04 - [ENTITY TRANSFER MODULE]: UpdateAgent failed on teleport of Valkyrie Resident to Informatics. Keeping avatar in Vue-Port
11:24:04 - [ENTITY TRANSFER STATE MACHINE]: UpdateInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=CleaningUp
11:24:04 - [REMOTE SIMULATION CONNECTOR]: CloseAgent http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/a664c885-e876-11dc-95ff-0800200c9a66/?auth=043391ce-b429-438c-99e0-4d81cec005bc [^]
11:24:04 - [HG INVENTORY ACCESS MODULE]: Restoring root folder for local user Valkyrie Resident
11:24:04 - [ENTITY TRANSFER STATE MACHINE]: Agent 2480d607-7164-4385-b203-73de16a149b5 cleared from transit in Vue-Port
Region (root) #
Region (root) #
Region (root) # FAILED HERE
Invalid command
Region (root) #
Region (root) #

-----------------------------------------------------------------
At thedestination end (on openvue grid Informatics region)

11:30:44 - [SCENE]: Region Informatics told of incoming child agent Valkyrie.Resident @hg.osgrid.org 2480d607-7164-4385-b203-73de16a149b5 (circuit code 123675133, IP 129.215.219.86, viewer Firestorm-Releasex64 4.7.5.47975, teleportflags (ViaLogin), position <128, 128, 25>. From region Vue-Port (7d6d7132-1d16-475b-830a-9301fb78e1e2) @ http://hg.osgrid.org:80/ [^]
11:30:44 - [SCENE]: Region Informatics authenticated and authorized incoming child agent Valkyrie.Resident @hg.osgrid.org 2480d607-7164-4385-b203-73de16a149b5 (circuit code 123675133)
11:30:44 - [CreateCaps]: new caps agent 2480d607-7164-4385-b203-73de16a149b5, circuit 123675133, path 93ae96e4-0eb8-47ba-90d4-0cc7698309d5, time 0
11:30:44 - [VivoxVoice]: OnRegisterCaps: agentID 2480d607-7164-4385-b203-73de16a149b5 caps OpenSim.Framework.Capabilities.Caps
11:30:44 - [EVENTQUEUE]: Found Existing UUID!
11:30:44 - [AGENT HANDLER]: SYNC CreateAgent True Authorized
11:30:45 - [CHILDAGENTDATAUPDATE]: got packed appearance
11:30:45 - [SCENE]: Incoming child agent update for 2480d607-7164-4385-b203-73de16a149b5 in Informatics
11:31:15 - [SCENE PRESENCE]: Did not find presence with id 2480d607-7164-4385-b203-73de16a149b5 in Informatics before timeout
11:31:15 - [LOGHTTP]: Slow handling of 1169 PUT /agent/2480d607-7164-4385-b203-73de16a149b5/ from 129.215.219.85:65055 took 30094ms
11:31:15 - [CHILDAGENTDATAUPDATE]: got packed appearance
11:31:15 - [SCENE]: Incoming child agent update for 2480d607-7164-4385-b203-73de16a149b5 in Informatics
11:31:45 - [SCENE PRESENCE]: Did not find presence with id 2480d607-7164-4385-b203-73de16a149b5 in Informatics before timeout
11:31:45 - [LOGHTTP]: Slow handling of 1179 PUT /agent/2480d607-7164-4385-b203-73de16a149b5/ from 129.215.219.85:65067 took 30109ms
11:31:45 - [AGENT HANDLER]: >>> DELETE <<< RegionID: a664c885-e876-11dc-95ff-0800200c9a66; from: 129.215.219.85; auth_code: 043391ce-b429-438c-99e0-4d81cec005bc
11:31:45 - [SCENE]: Called CloseClient() with agent ID 2480d607-7164-4385-b203-73de16a149b5 but no such presence is in Informatics

Revision 2015-12-01 03:28 by aiaustin
Description I am testing HG teleport between OSGrid, AiLand and Openvue grids using a robot avatar that has complex mesh parts... I managed to teleport once in 4 attempts, and in the viewer for the teleporting robot it showed the avatar correctly (presumably as it was cached there). But to the other avatar present the robot avatar only showed the core prim parts. None of the mesh made it even after waiting 5 minutes.

I notice a long or slow transfer of the information between simulators.. as would be expected give the mesh attachments are quite complex. Teleports of this avatar between the same grids seemed to work fine when last tests about a month ago.

-----------------------------------------------------------------
11:30:44 - [SCENE]: Region Informatics told of incoming child agent Valkyrie.Resident @hg.osgrid.org 2480d607-7164-4385-b203-73de16a149b5 (circuit code 123675133, IP 129.215.219.86, viewer Firestorm-Releasex64 4.7.5.47975, teleportflags (ViaLogin), position <128, 128, 25>. From region Vue-Port (7d6d7132-1d16-475b-830a-9301fb78e1e2) @ http://hg.osgrid.org:80/ [^]
11:30:44 - [SCENE]: Region Informatics authenticated and authorized incoming child agent Valkyrie.Resident @hg.osgrid.org 2480d607-7164-4385-b203-73de16a149b5 (circuit code 123675133)
11:30:44 - [CreateCaps]: new caps agent 2480d607-7164-4385-b203-73de16a149b5, circuit 123675133, path 93ae96e4-0eb8-47ba-90d4-0cc7698309d5, time 0
11:30:44 - [VivoxVoice]: OnRegisterCaps: agentID 2480d607-7164-4385-b203-73de16a149b5 caps OpenSim.Framework.Capabilities.Caps
11:30:44 - [EVENTQUEUE]: Found Existing UUID!
11:30:44 - [AGENT HANDLER]: SYNC CreateAgent True Authorized
11:30:45 - [CHILDAGENTDATAUPDATE]: got packed appearance
11:30:45 - [SCENE]: Incoming child agent update for 2480d607-7164-4385-b203-73de16a149b5 in Informatics
11:31:15 - [SCENE PRESENCE]: Did not find presence with id 2480d607-7164-4385-b203-73de16a149b5 in Informatics before timeout
11:31:15 - [LOGHTTP]: Slow handling of 1169 PUT /agent/2480d607-7164-4385-b203-73de16a149b5/ from 129.215.219.85:65055 took 30094ms
11:31:15 - [CHILDAGENTDATAUPDATE]: got packed appearance
11:31:15 - [SCENE]: Incoming child agent update for 2480d607-7164-4385-b203-73de16a149b5 in Informatics
11:31:45 - [SCENE PRESENCE]: Did not find presence with id 2480d607-7164-4385-b203-73de16a149b5 in Informatics before timeout
11:31:45 - [LOGHTTP]: Slow handling of 1179 PUT /agent/2480d607-7164-4385-b203-73de16a149b5/ from 129.215.219.85:65067 took 30109ms
11:31:45 - [AGENT HANDLER]: >>> DELETE <<< RegionID: a664c885-e876-11dc-95ff-0800200c9a66; from: 129.215.219.85; auth_code: 043391ce-b429-438c-99e0-4d81cec005bc
11:31:45 - [SCENE]: Called CloseClient() with agent ID 2480d607-7164-4385-b203-73de16a149b5 but no such presence is in Informatics

-----------------------------------------------------------------
At the source end (on an OSGrid region) for the teleporting robot... Valkyrie.Resident

11:23:01 - [HYPERGRID LINKER]: Link to virtual.aiai.ed.ac.uk:8002 Informatics, in <3509,0>
11:23:01 - [GRID SERVICE]: GetRegionByPosition. Did not find region in database. Pos=<3509,0>
11:23:01 - [GATEKEEPER SERVICE CONNECTOR]: Linking to http://virtual.aiai.ed.ac.uk:8002/ [^]
11:23:01 - [HYPERGRID LINKER]: Region already exists in coordinates <2448,0>
11:23:01 - [ENTITY TRANSFER STATE MACHINE]: SetInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=Preparing
11:23:01 - [ENTITY TRANSFER MODULE]: GetRegionContainingWorldLocation: call, XY=<626816,128>
11:23:01 - [GRID SERVICE]: GetRegionByPosition. Found region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics in database. Pos=<2448,0>
11:23:01 - [LOCAL GRID SERVICE CONNECTOR]: GetRegionByPosition. Got region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics from grid service. Pos=<2448,0>
11:23:01 - [REMOTE GRID CONNECTOR]: GetRegionByPosition. Added region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics to the cache. Pos=<2448,0>, RegionHandle=2691604464795648
11:23:01 - [ENTITY TRANSFER MODULE]: GetRegionContainingWorldLocation: Found region using legacy size. rloc=<626688,0>. Rname=http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics
11:23:01 - [HG ENTITY TRANSFER MODULE]: region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics flags: 524
11:23:01 - [HG ENTITY TRANSFER MODULE]: Destination region is hyperlink
11:23:01 - [GATEKEEPER SERVICE CONNECTOR]: contacting http://virtual.aiai.ed.ac.uk:8002/ [^]
11:23:01 - [HG ENTITY TRANSFER MODULE]: GetFinalDestination: ServerURI=http://virtual3.aiai.ed.ac.uk:9000/ [^]
11:23:01 - [ENTITY TRANSFER MODULE]: Teleporting Valkyrie Resident 2480d607-7164-4385-b203-73de16a149b5 from Vue-Port to http://virtual.aiai.ed.ac.uk:8002/ [^] (http://virtual3.aiai.ed.ac.uk:9000/ [^]) Informatics/<128, 128, 25>
11:23:02 - [REMOTE SIMULATION CONNECTOR]: QueryAccess to http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/a664c885-e876-11dc-95ff-0800200c9a66/ [^] returned True, reason , version 0.4/0.4
11:23:02 - [ENTITY TRANSFER MODULE]: Vue-Port transfer protocol version to Informatics is 0.4 / 0.4
11:23:02 - [ENTITY TRANSFER MODULE]: Determined that region Informatics at 9048,9047 needs new child agent for agent Valkyrie Resident from Vue-Port
11:23:02 - [HG ENTITY TRANSFER MODULE]: CreateAgent http://virtual.aiai.ed.ac.uk:8002/ [^] http://virtual3.aiai.ed.ac.uk:9000/ [^]
11:23:02 - [REMOTE SIMULATION CONNECTOR]: Creating agent at http://64.31.16.122:80/ [^]
11:23:03 - [HG INVENTORY ACCESS MODULE]: Changing root inventory for user Valkyrie Resident
11:23:04 - [ENTITY TRANSFER STATE MACHINE]: UpdateInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=Transferring
11:23:04 - [ENTITY TRANSFER MODULE]: Sending new CAPS seed url http://virtual3.aiai.ed.ac.uk:9000/CAPS/93ae96e4-0eb8-47ba-90d4-0cc7698309d50000/ [^] from Vue-Port to Valkyrie Resident
Region (root) #
Region (root) #
Region (root) # STICKS HERE
Invalid command
Region (root) #
11:23:34 - [WEB UTIL]: Slow ServiceOSD request 7754 PUT http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/ [^] took 30140ms, 0ms writing(0 at Json; 0 at comp), 15104 bytes (254510 uncomp): {"message_type":"AgentData","region_id":"7d6d7132-1d16-475b-830a-9301fb78e1e2","circuit_code":"0","agent_uuid":"2480d607-7164-4385-b203-73de16a149b5","session_uuid":"043391ce-b429-438c-99e0-4d81cec005
Region (root) #
Region (root) #
Region (root) # STICKS AGAIN
Invalid command
11:24:04 - [WEB UTIL]: Slow ServiceOSD request 7755 PUT http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/ [^] took 30172ms, 16ms writing(16 at Json; 16 at comp), 254510 bytes (254510 uncomp): {"message_type":"AgentData","region_id":"7d6d7132-1d16-475b-830a-9301fb78e1e2","circuit_code":"0","agent_uuid":"2480d607-7164-4385-b203-73de16a149b5","session_uuid":"043391ce-b429-438c-99e0-4d81cec005
11:24:04 - [ENTITY TRANSFER MODULE]: UpdateAgent failed on teleport of Valkyrie Resident to Informatics. Keeping avatar in Vue-Port
11:24:04 - [ENTITY TRANSFER STATE MACHINE]: UpdateInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=CleaningUp
11:24:04 - [REMOTE SIMULATION CONNECTOR]: CloseAgent http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/a664c885-e876-11dc-95ff-0800200c9a66/?auth=043391ce-b429-438c-99e0-4d81cec005bc [^]
11:24:04 - [HG INVENTORY ACCESS MODULE]: Restoring root folder for local user Valkyrie Resident
11:24:04 - [ENTITY TRANSFER STATE MACHINE]: Agent 2480d607-7164-4385-b203-73de16a149b5 cleared from transit in Vue-Port
Region (root) #
Region (root) #
Region (root) # FAILED HERE
Invalid command
Region (root) #
Region (root) #
Revision 2015-12-01 03:26 by aiaustin
Description I am testing HG teleport between OSGrid, AiLand and Openvue grids using a robot avatar that has complex mesh parts... I managed to teleport once in 4 attempts, and in the viewer for the teleporting robot it showed the avatar correctly (presumably as it was cached there). But to the other avatar present the robot avatar only showed the core prim parts. None of the mesh made it even after waiting 5 minutes.

I notice a long or slow transfer of the information between simulators.. as would be expected give the mesh attachments are quite complex.


At the destination end (On Openvue grid)...

To be added in a moment

At the source end (on an OSGrid region) for the teleporting robot... Valkyrie.Resident

11:23:01 - [HYPERGRID LINKER]: Link to virtual.aiai.ed.ac.uk:8002 Informatics, in <3509,0>
11:23:01 - [GRID SERVICE]: GetRegionByPosition. Did not find region in database. Pos=<3509,0>
11:23:01 - [GATEKEEPER SERVICE CONNECTOR]: Linking to http://virtual.aiai.ed.ac.uk:8002/ [^]
11:23:01 - [HYPERGRID LINKER]: Region already exists in coordinates <2448,0>
11:23:01 - [ENTITY TRANSFER STATE MACHINE]: SetInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=Preparing
11:23:01 - [ENTITY TRANSFER MODULE]: GetRegionContainingWorldLocation: call, XY=<626816,128>
11:23:01 - [GRID SERVICE]: GetRegionByPosition. Found region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics in database. Pos=<2448,0>
11:23:01 - [LOCAL GRID SERVICE CONNECTOR]: GetRegionByPosition. Got region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics from grid service. Pos=<2448,0>
11:23:01 - [REMOTE GRID CONNECTOR]: GetRegionByPosition. Added region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics to the cache. Pos=<2448,0>, RegionHandle=2691604464795648
11:23:01 - [ENTITY TRANSFER MODULE]: GetRegionContainingWorldLocation: Found region using legacy size. rloc=<626688,0>. Rname=http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics
11:23:01 - [HG ENTITY TRANSFER MODULE]: region http://virtual.aiai.ed.ac.uk:8002/ [^] Informatics flags: 524
11:23:01 - [HG ENTITY TRANSFER MODULE]: Destination region is hyperlink
11:23:01 - [GATEKEEPER SERVICE CONNECTOR]: contacting http://virtual.aiai.ed.ac.uk:8002/ [^]
11:23:01 - [HG ENTITY TRANSFER MODULE]: GetFinalDestination: ServerURI=http://virtual3.aiai.ed.ac.uk:9000/ [^]
11:23:01 - [ENTITY TRANSFER MODULE]: Teleporting Valkyrie Resident 2480d607-7164-4385-b203-73de16a149b5 from Vue-Port to http://virtual.aiai.ed.ac.uk:8002/ [^] (http://virtual3.aiai.ed.ac.uk:9000/ [^]) Informatics/<128, 128, 25>
11:23:02 - [REMOTE SIMULATION CONNECTOR]: QueryAccess to http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/a664c885-e876-11dc-95ff-0800200c9a66/ [^] returned True, reason , version 0.4/0.4
11:23:02 - [ENTITY TRANSFER MODULE]: Vue-Port transfer protocol version to Informatics is 0.4 / 0.4
11:23:02 - [ENTITY TRANSFER MODULE]: Determined that region Informatics at 9048,9047 needs new child agent for agent Valkyrie Resident from Vue-Port
11:23:02 - [HG ENTITY TRANSFER MODULE]: CreateAgent http://virtual.aiai.ed.ac.uk:8002/ [^] http://virtual3.aiai.ed.ac.uk:9000/ [^]
11:23:02 - [REMOTE SIMULATION CONNECTOR]: Creating agent at http://64.31.16.122:80/ [^]
11:23:03 - [HG INVENTORY ACCESS MODULE]: Changing root inventory for user Valkyrie Resident
11:23:04 - [ENTITY TRANSFER STATE MACHINE]: UpdateInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=Transferring
11:23:04 - [ENTITY TRANSFER MODULE]: Sending new CAPS seed url http://virtual3.aiai.ed.ac.uk:9000/CAPS/93ae96e4-0eb8-47ba-90d4-0cc7698309d50000/ [^] from Vue-Port to Valkyrie Resident
Region (root) #
Region (root) #
Region (root) # STICKS HERE
Invalid command
Region (root) #
11:23:34 - [WEB UTIL]: Slow ServiceOSD request 7754 PUT http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/ [^] took 30140ms, 0ms writing(0 at Json; 0 at comp), 15104 bytes (254510 uncomp): {"message_type":"AgentData","region_id":"7d6d7132-1d16-475b-830a-9301fb78e1e2","circuit_code":"0","agent_uuid":"2480d607-7164-4385-b203-73de16a149b5","session_uuid":"043391ce-b429-438c-99e0-4d81cec005
Region (root) #
Region (root) #
Region (root) # STICKS AGAIN
Invalid command
11:24:04 - [WEB UTIL]: Slow ServiceOSD request 7755 PUT http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/ [^] took 30172ms, 16ms writing(16 at Json; 16 at comp), 254510 bytes (254510 uncomp): {"message_type":"AgentData","region_id":"7d6d7132-1d16-475b-830a-9301fb78e1e2","circuit_code":"0","agent_uuid":"2480d607-7164-4385-b203-73de16a149b5","session_uuid":"043391ce-b429-438c-99e0-4d81cec005
11:24:04 - [ENTITY TRANSFER MODULE]: UpdateAgent failed on teleport of Valkyrie Resident to Informatics. Keeping avatar in Vue-Port
11:24:04 - [ENTITY TRANSFER STATE MACHINE]: UpdateInTransit. agent=2480d607-7164-4385-b203-73de16a149b5, newState=CleaningUp
11:24:04 - [REMOTE SIMULATION CONNECTOR]: CloseAgent http://virtual3.aiai.ed.ac.uk:9000/agent/2480d607-7164-4385-b203-73de16a149b5/a664c885-e876-11dc-95ff-0800200c9a66/?auth=043391ce-b429-438c-99e0-4d81cec005bc [^]
11:24:04 - [HG INVENTORY ACCESS MODULE]: Restoring root folder for local user Valkyrie Resident
11:24:04 - [ENTITY TRANSFER STATE MACHINE]: Agent 2480d607-7164-4385-b203-73de16a149b5 cleared from transit in Vue-Port
Region (root) #
Region (root) #
Region (root) # FAILED HERE
Invalid command
Region (root) #
Region (root) #


Copyright © 2000 - 2012 MantisBT Group
Powered by Mantis Bugtracker