[BUG-8361] Swapping between different wearables too quickly using "Wear" causes old wearables not to be removed from being worn when they should be - only reproduces on the Attachment fix/AIS3 viewers.

sl-service-account commented 9 years ago

This problem was fixed for attachments with the commit "MAINT-4196 WIP, including clearer inventory warnings for attachment errors" at https://bitbucket.org/lindenlab/viewer-release/commits/0ba24f221b56a974e8d829b6ff3de177a75b9825. This was the fix for BUG-6487

However the same kind of problem is still seen with wearables (system layers).

Steps To Reproduce

This bug will reproduce for any wearables, shirts, jackets, pants etc.
Create 2 new Tattoo layers in inventory - Tatt 1 and Tatt 2.
In inventory, right click Tatt 1 -> Wear
Observe Tatt 1 shows as worn after approx 2-3 seconds wait. <--- this pause is new on the attachment fix viewers and appears to cause the problem.
Wait 5 seconds. On a busy/laggy region or on a slow system, you may have to wait longer. Do not proceed until Tatt 1 shows as worn in inventory.
Right click Tatt 2 -> Wear
Observe Tatt 2 shows as worn and Tatt 1 is unworn after ~ 2-3 seconds pause.
Everything behaves as expected up to this point & only Tatt 2 is worn. (y)
Take off Tatt 2. (Right click Tatt 2 -> Take off)
Right click Tatt 1 -> Wear
Immediately right click Tatt 2 -> Wear.

Observed Behaviour
After a couple of seconds pause, Tatt 1 is worn AND Tatt 2 is worn after a further pause.

Expected Behaviour
Tatt 1 should be unworn and Tatt 2 should be worn.
Wear should always replace the worn layer, not add to it.

Other Information
This bug only reproduces on viewers using the attachment fixes/AIS3 changes.
If you test on a pre-AIS3 viewer, you will observe that when right clicking -> wear on any system layer wearable in inventory, the wearable immediately shows as worn without the long pause.
As far as I understand it, this happens because LL added callbacks to wait for the confirmation of the region before updating appearance, which can be very slow. This problem was fixed for avatar attachments by adding an instant delete (https://bitbucket.org/lindenlab/viewer-release/commits/0ba24f221b56a974e8d829b6ff3de177a75b9825). However it was not fixed for wearable layers.

Note for TPV devs

If you have merged in the AIS3/attachment fixes, this bug will break RLVa, which allows rapid changing of wearables via script. See http://jira.phoenixviewer.com/browse/FIRE-15462 - "RLVa fails to remove everything in a folder on @detach" for details of the RLVa repro.

Attachments

Whirly_BigBird.log 2015-04-06 12:32:44

Links

| Field | Value | | ------------- | ------------- | | Issue | BUG-8361 | | Summary | Swapping between different wearables too quickly using "Wear" causes old wearables not to be removed from being worn when they should be - only reproduces on the Attachment fix/AIS3 viewers. | | Type | Bug | | Priority | Unset | | Status | Accepted | | Resolution | Accepted | | Reporter | Whirly Fizzle (whirly.fizzle) | | Created at | 2015-02-01T23:08:27Z | | Updated at | 2016-05-19T21:05:47Z | ``` { 'Business Unit': ['Platform'], 'Date of First Response': '2016-05-18T23:00:50.151-0500', 'Severity': 'Unset', 'System': 'SL Viewer', 'Target Viewer Version': 'viewer-development', 'What just happened?': '.', 'What were you doing when it happened?': 'Filling in....', 'What were you expecting to happen instead?': 'Filling in...', } ```

sl-service-account commented 9 years ago

Whirly Fizzle commented at 2015-04-03T15:10:29Z

Bug still reproduces on http://wiki.secondlife.com/wiki/Release_Notes/Second_Life_Project_BigBird/3.7.27.300377

sl-service-account commented 9 years ago

Whirly Fizzle commented at 2015-04-06T16:31:29Z

Log attached from a session on BigBird where I reproduced this problem - Whirly_BigBird.log I logged in, waited a couple of minutes and then right cliked Tatt 1 -> Wear and immediately after right cliked Tatt 2 -> wear. Observed behaviour was that I was wearing both Tatt 1 and Tatt 2. Expected behaviour was that Tatt 1 should have been replaced by Tatt 2.

Log snippet where the problem reproduced - this starts at where I right clicked Tatt 1 -> Wear.

2015-04-06T16:28:24Z DEBUG: LLAppearanceMgr::updateIsDirty: clean
2015-04-06T16:28:24Z INFO: LLInventoryModel::onAISUpdateReceived: elapsed: 0.002218s
2015-04-06T16:28:24Z DEBUG: LLAppearanceMgr::updateAppearanceFromCOF:  Avatar 'Whirly Fizzle' textured_and_downloaded starting
2015-04-06T16:28:24Z DEBUG: LLVOAvatar::startPhase: started phase update_appearance_on_destroy
2015-04-06T16:28:24Z INFO: LLUpdateAppearanceOnDestroy::~LLUpdateAppearanceOnDestroy:  Avatar 'Whirly Fizzle' textured_and_downloaded done update appearance on destroy
2015-04-06T16:28:24Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase update_appearance_on_destroy elapsed 0.000069
2015-04-06T16:28:24Z DEBUG: LLAppearanceMgr::updateAppearanceFromCOF:  Avatar 'Whirly Fizzle' textured_and_downloaded starting
2015-04-06T16:28:24Z DEBUG: LLVOAvatar::startPhase: started phase update_appearance_on_destroy
2015-04-06T16:28:24Z DEBUG: LLAppearanceMgr::updateClothingOrderingInfo: Tatt 1 updating desc to: @1400 (was: )
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::updateIsDirty: clean
2015-04-06T16:28:25Z INFO: LLInventoryModel::onAISUpdateReceived: elapsed: 0.002522s
2015-04-06T16:28:25Z INFO: LLUpdateAppearanceOnDestroy::~LLUpdateAppearanceOnDestroy:  Avatar 'Whirly Fizzle' textured_and_downloaded done update appearance on destroy
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase update_appearance_on_destroy elapsed 0.822040
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::updateAppearanceFromCOF:  Avatar 'Whirly Fizzle' textured_and_downloaded starting
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::startPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded no-op, start when started already for update_appearance_from_cof
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::updateIsDirty: clean
2015-04-06T16:28:25Z DEBUG: RequestAgentUpdateAppearanceResponder::onRequestRequested: cof_version 116327 last_rcv 116325 last_req 116325 in flight 0
2015-04-06T16:28:25Z DEBUG: RequestAgentUpdateAppearanceResponder::onRequestRequested: ATT sending bake request for cof_version 116327
2015-04-06T16:28:25Z DEBUG: RequestAgentUpdateAppearanceResponder::sendRequest: request url https://sim10444.agni.lindenlab.com:12043/cap/b62d7700-2d0e-4699-c89c-c1c1b6b780db my_cof_version 116327
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 0 Girl Next Door 7a7bc596-00a0-d77a-5592-712438f28a61
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 1 Girl Next  Avatar Polka Dress Glitch Pants - Pink 5655ceb0-44d6-5e83-8072-7db029a6bc48
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 2 Girl Next Door Avatar Polka Dress Top - Pink d7ba08d1-7573-87f1-0f8d-840d7bf029b2
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 3 Girl Next Door 5501bf79-d1f4-1a63-0b9d-0e07d8a9456a
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 4 Girl Next Door - Eyes 390ee95b-0a03-5cc5-c084-95bc1c34a124
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 5 Girl Next Door - Eyebrowshaper 7ccbef1c-d809-8768-4de5-b39fb60fad68
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 6 GIrl Next Door Wedge Footshaper da5623cb-f8a3-f1ab-a0e8-271c6ac455a9
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 7 Tatt 1 d1809e15-3fe0-81ce-23e9-13096ca3ef25
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: obj_item 0 GND WedgeShoes - L 00000000-0000-0000-0000-000000000000
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: obj_item 1 GND WedgeShoes - R 00000000-0000-0000-0000-000000000000
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: obj_item 2 Ponytail Brown Hair 00000000-0000-0000-0000-000000000000
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: obj_item 3 Girl Next Door Polka Flexi Skirt - Pink 00000000-0000-0000-0000-000000000000
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::updateAppearanceFromCOF: HP block starts
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::LLWearableHoldingPattern: HP 17 created
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::startPhase: started phase holding_pattern
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::startPhase: started phase get_wearables_2
2015-04-06T16:28:25Z DEBUG: LLWearableList::getAsset: wearable 5655ceb0-44d6-5e83-8072-7db029a6bc48 found in LLWearableList
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 17 resolved 1/8
2015-04-06T16:28:25Z DEBUG: LLWearableList::getAsset: wearable d1809e15-3fe0-81ce-23e9-13096ca3ef25 found in LLWearableList
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 17 resolved 2/8
2015-04-06T16:28:25Z DEBUG: LLWearableList::getAsset: wearable d7ba08d1-7573-87f1-0f8d-840d7bf029b2 found in LLWearableList
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 17 resolved 3/8
2015-04-06T16:28:25Z DEBUG: LLWearableList::getAsset: wearable da5623cb-f8a3-f1ab-a0e8-271c6ac455a9 found in LLWearableList
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 17 resolved 4/8
2015-04-06T16:28:25Z DEBUG: LLWearableList::getAsset: wearable 7a7bc596-00a0-d77a-5592-712438f28a61 found in LLWearableList
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 17 resolved 5/8
2015-04-06T16:28:25Z DEBUG: LLWearableList::getAsset: wearable 5501bf79-d1f4-1a63-0b9d-0e07d8a9456a found in LLWearableList
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 17 resolved 6/8
2015-04-06T16:28:25Z DEBUG: LLWearableList::getAsset: wearable 7ccbef1c-d809-8768-4de5-b39fb60fad68 found in LLWearableList
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 17 resolved 7/8
2015-04-06T16:28:25Z DEBUG: LLWearableList::getAsset: wearable 390ee95b-0a03-5cc5-c084-95bc1c34a124 found in LLWearableList
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 17 resolved 8/8
2015-04-06T16:28:25Z INFO: LLWearableHoldingPattern::pollFetchCompletion:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 17 polling, done status: 1 timed out 0 elapsed 0.000006s
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase get_wearables_2 elapsed 0.000406
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::startPhase: started phase get_missing_wearables_2
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase get_missing_wearables_2 elapsed 0.000000
2015-04-06T16:28:25Z DEBUG: LLVOAvatarSelf::outputRezTiming:  Avatar 'Whirly Fizzle' textured_and_downloaded Agent wearables fetch complete. Time from avatar creation: 249.45
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onAllComplete:  Avatar 'Whirly Fizzle' textured_and_downloaded Updating 4 attachments
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onAllComplete:  Avatar 'Whirly Fizzle' textured_and_downloaded Removing 0 attachments
2015-04-06T16:28:25Z INFO: LLWearableHoldingPattern::onAllComplete:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 17 updating agent wearables with 8 wearable items 
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::updateAgentWearables: updateAgentWearables()
2015-04-06T16:28:25Z INFO: LLAgentWearables::setWearableOutfit: setWearableOutfit() start
2015-04-06T16:28:25Z DEBUG: LLAgentWearables::setWearableOutfit: mismatch, type 14 index 0 names NONE, names Tatt 1
2015-04-06T16:28:25Z DEBUG: LLAgentWearables::setWearableOutfit: matched 7 mismatched 1
2015-04-06T16:28:25Z DEBUG: LLAgentWearables::setWearableOutfit: count mismatch for type 14 current 0 requested 1
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded Self: setWearableOutfit
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        head_bodypaint: eddf62f7-7e65-1b7e-81fe-681ba54eaa0d
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_shirt: 82124ea2-e70d-47a3-4760-5a6e1d39f636
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_pants: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        eyes_iris: 6522e74d-1660-4e7f-b601-6f48c1659a77
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        hair_grain: 7ca39b4c-bd19-4699-aff7-f93fd03d3e7b
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_bodypaint: 9b084afe-ea01-fe58-6883-639c80e95216
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_bodypaint: 20a87b75-edba-a905-d357-33444665e825
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_shoes: 3ab7e2fa-9572-ef36-1a30-d855dbea4f92
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        head-baked: 488d2fb8-ed5e-e5c6-2b5e-f7f8aa5f7c5e
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper-baked: 0e66abdc-bbbe-ccab-272e-e3ba6177a15f
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower-baked: 09fcbfcf-3f96-ae48-f1bd-c4f819ddbecc
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        eyes-baked: 5cff4332-d978-7743-ee85-69295e1db524
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_socks: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_jacket: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_jacket: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_gloves: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_undershirt: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_underpants: c76d5e23-0277-1d58-0645-9263698876c0
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        skirt: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        skirt-baked: IMG_DEFAULT_AVATAR
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        hair-baked: 63c110f6-6c5b-0144-3082-089fb2acf64e
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_alpha: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_alpha: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        head_alpha: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        eyes_alpha: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        hair_alpha: null ptr
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        head_tattoo: IMG_DEFAULT_AVATAR
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_tattoo: IMG_DEFAULT_AVATAR
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_tattoo: IMG_DEFAULT_AVATAR
2015-04-06T16:28:25Z DEBUG: LLAgentWearables::setWearableOutfit: setWearableOutfit() end
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::onAllComplete:  Avatar 'Whirly Fizzle' textured_and_downloaded Adding 0 attachments
2015-04-06T16:28:25Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase holding_pattern elapsed 0.207047
2015-04-06T16:28:25Z DEBUG: LLWearableHoldingPattern::~LLWearableHoldingPattern: HP 17 deleted
2015-04-06T16:28:25Z DEBUG: LLAppearanceMgr::updateAppearanceFromCOF: HP block ends, elapsed 0.207139s
2015-04-06T16:28:26Z DEBUG: LLTexLayer::renderMorphMasks: gl alpha cache of morph mask not found, doing readback: facialhair
2015-04-06T16:28:26Z DEBUG: LLTexLayer::renderMorphMasks: gl alpha cache of morph mask not found, doing readback: upper_clothes
2015-04-06T16:28:26Z INFO: process_improved_im: process_improved_im: session_id( 04f595b0-cdc8-97f0-e710-9564824c03b2 ), from_id( 27eb1ff1-528f-4f79-bfb0-5a7cf3778c86 )
2015-04-06T16:28:26Z WARNING: LLIMModel::addMessageSilently: session 003c7b59-2c95-01fc-3e69-fc68e3b4e977does not exist 
2015-04-06T16:28:26Z INFO: display_stats: FPS: 57.00
2015-04-06T16:28:26Z DEBUG: LLAppearanceMgr::updateIsDirty: clean
2015-04-06T16:28:26Z INFO: LLInventoryModel::onAISUpdateReceived: elapsed: 0.003389s
2015-04-06T16:28:26Z DEBUG: LLAppearanceMgr::updateAppearanceFromCOF:  Avatar 'Whirly Fizzle' textured_and_downloaded starting
2015-04-06T16:28:26Z DEBUG: LLVOAvatar::startPhase: started phase update_appearance_on_destroy
2015-04-06T16:28:26Z INFO: LLUpdateAppearanceOnDestroy::~LLUpdateAppearanceOnDestroy:  Avatar 'Whirly Fizzle' textured_and_downloaded done update appearance on destroy
2015-04-06T16:28:26Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase update_appearance_on_destroy elapsed 0.000092
2015-04-06T16:28:26Z DEBUG: LLAppearanceMgr::updateAppearanceFromCOF:  Avatar 'Whirly Fizzle' textured_and_downloaded starting
2015-04-06T16:28:26Z DEBUG: LLVOAvatar::startPhase: started phase update_appearance_on_destroy
2015-04-06T16:28:26Z DEBUG: LLAppearanceMgr::updateClothingOrderingInfo: Tatt 2 updating desc to: @1401 (was: )
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::updateIsDirty: clean
2015-04-06T16:28:27Z INFO: LLInventoryModel::onAISUpdateReceived: elapsed: 0.002494s
2015-04-06T16:28:27Z INFO: LLUpdateAppearanceOnDestroy::~LLUpdateAppearanceOnDestroy:  Avatar 'Whirly Fizzle' textured_and_downloaded done update appearance on destroy
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase update_appearance_on_destroy elapsed 0.823571
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::updateAppearanceFromCOF:  Avatar 'Whirly Fizzle' textured_and_downloaded starting
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::startPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded no-op, start when started already for update_appearance_from_cof
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::updateIsDirty: clean
2015-04-06T16:28:27Z DEBUG: RequestAgentUpdateAppearanceResponder::onRequestRequested: cof_version 116329 last_rcv 116325 last_req 116327 in flight 1
2015-04-06T16:28:27Z DEBUG: RequestAgentUpdateAppearanceResponder::onRequestRequested: ATT sending bake request for cof_version 116329
2015-04-06T16:28:27Z DEBUG: RequestAgentUpdateAppearanceResponder::sendRequest: request url https://sim10444.agni.lindenlab.com:12043/cap/b62d7700-2d0e-4699-c89c-c1c1b6b780db my_cof_version 116329
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 0 Girl Next Door 7a7bc596-00a0-d77a-5592-712438f28a61
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 1 Girl Next  Avatar Polka Dress Glitch Pants - Pink 5655ceb0-44d6-5e83-8072-7db029a6bc48
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 2 Girl Next Door Avatar Polka Dress Top - Pink d7ba08d1-7573-87f1-0f8d-840d7bf029b2
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 3 Girl Next Door 5501bf79-d1f4-1a63-0b9d-0e07d8a9456a
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 4 Girl Next Door - Eyes 390ee95b-0a03-5cc5-c084-95bc1c34a124
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 5 Girl Next Door - Eyebrowshaper 7ccbef1c-d809-8768-4de5-b39fb60fad68
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 6 GIrl Next Door Wedge Footshaper da5623cb-f8a3-f1ab-a0e8-271c6ac455a9
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 7 Tatt 1 d1809e15-3fe0-81ce-23e9-13096ca3ef25
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: wear_item 8 Tatt 2 6aa18018-77b6-a2fb-bd00-e50afa917376
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: obj_item 0 GND WedgeShoes - L 00000000-0000-0000-0000-000000000000
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: obj_item 1 GND WedgeShoes - R 00000000-0000-0000-0000-000000000000
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: obj_item 2 Ponytail Brown Hair 00000000-0000-0000-0000-000000000000
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::dumpItemArray:  Avatar 'Whirly Fizzle' textured_and_downloaded asset_dump: obj_item 3 Girl Next Door Polka Flexi Skirt - Pink 00000000-0000-0000-0000-000000000000
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::updateAppearanceFromCOF: HP block starts
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::LLWearableHoldingPattern: HP 18 created
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::startPhase: started phase holding_pattern
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::startPhase: started phase get_wearables_2
2015-04-06T16:28:27Z DEBUG: LLWearableList::getAsset: wearable 5655ceb0-44d6-5e83-8072-7db029a6bc48 found in LLWearableList
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 resolved 1/9
2015-04-06T16:28:27Z DEBUG: LLWearableList::getAsset: wearable d1809e15-3fe0-81ce-23e9-13096ca3ef25 found in LLWearableList
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 resolved 2/9
2015-04-06T16:28:27Z DEBUG: LLWearableList::getAsset: wearable 6aa18018-77b6-a2fb-bd00-e50afa917376 found in LLWearableList
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 resolved 3/9
2015-04-06T16:28:27Z DEBUG: LLWearableList::getAsset: wearable d7ba08d1-7573-87f1-0f8d-840d7bf029b2 found in LLWearableList
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 resolved 4/9
2015-04-06T16:28:27Z DEBUG: LLWearableList::getAsset: wearable da5623cb-f8a3-f1ab-a0e8-271c6ac455a9 found in LLWearableList
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 resolved 5/9
2015-04-06T16:28:27Z DEBUG: LLWearableList::getAsset: wearable 7a7bc596-00a0-d77a-5592-712438f28a61 found in LLWearableList
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 resolved 6/9
2015-04-06T16:28:27Z DEBUG: LLWearableList::getAsset: wearable 5501bf79-d1f4-1a63-0b9d-0e07d8a9456a found in LLWearableList
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 resolved 7/9
2015-04-06T16:28:27Z DEBUG: LLWearableList::getAsset: wearable 7ccbef1c-d809-8768-4de5-b39fb60fad68 found in LLWearableList
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 resolved 8/9
2015-04-06T16:28:27Z DEBUG: LLWearableList::getAsset: wearable 390ee95b-0a03-5cc5-c084-95bc1c34a124 found in LLWearableList
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onWearableAssetFetch:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 resolved 9/9
2015-04-06T16:28:27Z INFO: LLWearableHoldingPattern::pollFetchCompletion:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 polling, done status: 1 timed out 0 elapsed 0.000004s
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase get_wearables_2 elapsed 0.000457
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::startPhase: started phase get_missing_wearables_2
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase get_missing_wearables_2 elapsed 0.000000
2015-04-06T16:28:27Z DEBUG: LLVOAvatarSelf::outputRezTiming:  Avatar 'Whirly Fizzle' textured_and_downloaded Agent wearables fetch complete. Time from avatar creation: 251.25
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onAllComplete:  Avatar 'Whirly Fizzle' textured_and_downloaded Updating 4 attachments
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onAllComplete:  Avatar 'Whirly Fizzle' textured_and_downloaded Removing 0 attachments
2015-04-06T16:28:27Z INFO: LLWearableHoldingPattern::onAllComplete:  Avatar 'Whirly Fizzle' textured_and_downloaded HP 18 updating agent wearables with 9 wearable items 
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::updateAgentWearables: updateAgentWearables()
2015-04-06T16:28:27Z INFO: LLAgentWearables::setWearableOutfit: setWearableOutfit() start
2015-04-06T16:28:27Z DEBUG: LLAgentWearables::setWearableOutfit: mismatch, type 14 index 1 names NONE, names Tatt 2
2015-04-06T16:28:27Z DEBUG: LLAgentWearables::setWearableOutfit: matched 8 mismatched 1
2015-04-06T16:28:27Z DEBUG: LLAgentWearables::setWearableOutfit: count mismatch for type 14 current 0 requested 2
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded Self: setWearableOutfit
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        head_bodypaint: eddf62f7-7e65-1b7e-81fe-681ba54eaa0d
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_shirt: 82124ea2-e70d-47a3-4760-5a6e1d39f636
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_pants: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        eyes_iris: 6522e74d-1660-4e7f-b601-6f48c1659a77
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        hair_grain: 7ca39b4c-bd19-4699-aff7-f93fd03d3e7b
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_bodypaint: 9b084afe-ea01-fe58-6883-639c80e95216
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_bodypaint: 20a87b75-edba-a905-d357-33444665e825
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_shoes: 3ab7e2fa-9572-ef36-1a30-d855dbea4f92
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        head-baked: 488d2fb8-ed5e-e5c6-2b5e-f7f8aa5f7c5e
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper-baked: 0e66abdc-bbbe-ccab-272e-e3ba6177a15f
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower-baked: 09fcbfcf-3f96-ae48-f1bd-c4f819ddbecc
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        eyes-baked: 5cff4332-d978-7743-ee85-69295e1db524
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_socks: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_jacket: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_jacket: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_gloves: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_undershirt: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_underpants: c76d5e23-0277-1d58-0645-9263698876c0
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        skirt: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        skirt-baked: IMG_DEFAULT_AVATAR
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        hair-baked: 63c110f6-6c5b-0144-3082-089fb2acf64e
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_alpha: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_alpha: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        head_alpha: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        eyes_alpha: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        hair_alpha: null ptr
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        head_tattoo: IMG_DEFAULT_AVATAR
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        upper_tattoo: IMG_DEFAULT_AVATAR
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::dumpAvatarTEs:  Avatar 'Whirly Fizzle' textured_and_downloaded        lower_tattoo: IMG_DEFAULT_AVATAR
2015-04-06T16:28:27Z DEBUG: LLAgentWearables::setWearableOutfit: setWearableOutfit() end
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::onAllComplete:  Avatar 'Whirly Fizzle' textured_and_downloaded Adding 0 attachments
2015-04-06T16:28:27Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase holding_pattern elapsed 0.210946
2015-04-06T16:28:27Z DEBUG: LLWearableHoldingPattern::~LLWearableHoldingPattern: HP 18 deleted
2015-04-06T16:28:27Z DEBUG: LLAppearanceMgr::updateAppearanceFromCOF: HP block ends, elapsed 0.211039s
2015-04-06T16:28:27Z DEBUG: LLTexLayer::renderMorphMasks: gl alpha cache of morph mask not found, doing readback: facialhair
2015-04-06T16:28:27Z DEBUG: LLTexLayer::renderMorphMasks: gl alpha cache of morph mask not found, doing readback: upper_clothes
2015-04-06T16:28:28Z WARNING: RequestAgentUpdateAppearanceResponder::httpFailure: appearance update request failed, status 400 reason Bad Request
2015-04-06T16:28:28Z INFO: LLAdaptiveRetryPolicy::onFailureCommon: Retry count 0 should retry after 1.000000
2015-04-06T16:28:28Z INFO: RequestAgentUpdateAppearanceResponder::onFailure: retrying
2015-04-06T16:28:28Z DEBUG: RequestAgentUpdateAppearanceResponder::httpSuccess: succeeded
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processUpdateMessage:  Avatar 'Whirly Fizzle' textured_and_downloaded 1
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance: starts
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::parseAppearanceMessage: appversion set by AppearanceData field: 1
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::parseAppearanceMessage:  Avatar 'Whirly Fizzle' textured_and_downloaded  hover received 0.000000,0.000000,0.000000
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::parseAppearanceMessage:  Avatar 'Whirly Fizzle' textured_and_downloaded  handle visual params, num_blocks 253
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::parseAppearanceMessage: appversion req by appearance_version param: 1
2015-04-06T16:28:28Z DEBUG: resolve_appearance_version: appearance version info - field 1 param: 1 final: 1
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance: this_update_cof_version 116329 last_update_request_cof_version 116329 my_cof_version 116329
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::getBakedTextureImage:  Avatar 'Whirly Fizzle' textured_and_downloaded get server-bake image from URL http://bake-texture.agni.lindenlab.com/texture/2e255955-e183-48c4-b9f9-1cd1b80db94e/head/20f8aeca-2d31-3536-c4c5-4d103f723b1b
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::getBakedTextureImage:  Avatar 'Whirly Fizzle' textured get server-bake image from URL http://bake-texture.agni.lindenlab.com/texture/2e255955-e183-48c4-b9f9-1cd1b80db94e/upper/3d2b3a6e-05bf-8354-b621-ee6baa5ee548
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::getBakedTextureImage:  Avatar 'Whirly Fizzle' textured get server-bake image from URL http://bake-texture.agni.lindenlab.com/texture/2e255955-e183-48c4-b9f9-1cd1b80db94e/lower/8f3eda09-5cf9-289c-cee9-84f295c98fc7
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::getBakedTextureImage:  Avatar 'Whirly Fizzle' textured get server-bake image from URL http://bake-texture.agni.lindenlab.com/texture/2e255955-e183-48c4-b9f9-1cd1b80db94e/eyes/5cff4332-d978-7743-ee85-69295e1db524
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::getBakedTextureImage:  Avatar 'Whirly Fizzle' textured get server-bake image from URL http://bake-texture.agni.lindenlab.com/texture/2e255955-e183-48c4-b9f9-1cd1b80db94e/hair/63c110f6-6c5b-0144-3082-089fb2acf64e
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 0 using texture id 20f8aeca-2d31-3536-c4c5-4d103f723b1b
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 1 using texture id 3d2b3a6e-05bf-8354-b621-ee6baa5ee548
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 2 using texture id 8f3eda09-5cf9-289c-cee9-84f295c98fc7
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 3 using texture id 5cff4332-d978-7743-ee85-69295e1db524
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 4 using texture id c228d1cf-4b5d-4ba8-84f4-899a0796aa97
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 5 using texture id 63c110f6-6c5b-0144-3082-089fb2acf64e
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured processAvatarAppearance start 2e255955-e183-48c4-b9f9-1cd1b80db94e first? 0 self? 1
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  handle visual params, num_params 253
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::processAvatarAppearance: Changed 80 params
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::updateRezzedStatusTimers:  Avatar 'Whirly Fizzle' textured rez state change: 3 -> 2
2015-04-06T16:28:28Z DEBUG: LLVOAvatar::startPhase: started phase load_textured_and_downloaded
2015-04-06T16:28:29Z DEBUG: RequestAgentUpdateAppearanceResponder::sendRequest: request url https://sim10444.agni.lindenlab.com:12043/cap/b62d7700-2d0e-4699-c89c-c1c1b6b780db my_cof_version 116329
2015-04-06T16:28:29Z DEBUG: LLTextureFetch::createRequest:  requesting 20f8aeca-2d31-3536-c4c5-4d103f723b1b 0x0 discard 5 type 1
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::onBakedTextureLoaded: onBakedTextureLoaded: 20f8aeca-2d31-3536-c4c5-4d103f723b1b
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::onBakedTextureLoaded:  Avatar 'Whirly Fizzle' textured discard_level 1 success 1 final 1 id 20f8aeca-2d31-3536-c4c5-4d103f723b1b
2015-04-06T16:28:29Z INFO: LLWorld::addRegion: Add region with handle: 1427166093159424 on host 216.82.51.61:13006
2015-04-06T16:28:29Z INFO: LLWorld::addRegion: Region already exists and is alive, using existing region
2015-04-06T16:28:29Z INFO: process_enable_simulator: simulator_enable() Enabling 216.82.51.61:13006 with code 209321412
2015-04-06T16:28:29Z DEBUG: LLTextureFetch::createRequest:  requesting 3d2b3a6e-05bf-8354-b621-ee6baa5ee548 0x0 discard 5 type 1
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::onBakedTextureLoaded: onBakedTextureLoaded: 3d2b3a6e-05bf-8354-b621-ee6baa5ee548
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::onBakedTextureLoaded:  Avatar 'Whirly Fizzle' textured discard_level 1 success 1 final 1 id 3d2b3a6e-05bf-8354-b621-ee6baa5ee548
2015-04-06T16:28:29Z DEBUG: RequestAgentUpdateAppearanceResponder::httpSuccess: succeeded
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance: starts
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::parseAppearanceMessage: appversion set by AppearanceData field: 1
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::parseAppearanceMessage:  Avatar 'Whirly Fizzle' textured  hover received 0.000000,0.000000,0.000000
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::parseAppearanceMessage:  Avatar 'Whirly Fizzle' textured  handle visual params, num_blocks 253
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::parseAppearanceMessage: appversion req by appearance_version param: 1
2015-04-06T16:28:29Z DEBUG: resolve_appearance_version: appearance version info - field 1 param: 1 final: 1
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance: this_update_cof_version 116329 last_update_request_cof_version 116329 my_cof_version 116329
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::getBakedTextureImage:  Avatar 'Whirly Fizzle' textured get server-bake image from URL http://bake-texture.agni.lindenlab.com/texture/2e255955-e183-48c4-b9f9-1cd1b80db94e/head/20f8aeca-2d31-3536-c4c5-4d103f723b1b
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::getBakedTextureImage:  Avatar 'Whirly Fizzle' textured get server-bake image from URL http://bake-texture.agni.lindenlab.com/texture/2e255955-e183-48c4-b9f9-1cd1b80db94e/upper/3d2b3a6e-05bf-8354-b621-ee6baa5ee548
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::getBakedTextureImage:  Avatar 'Whirly Fizzle' textured get server-bake image from URL http://bake-texture.agni.lindenlab.com/texture/2e255955-e183-48c4-b9f9-1cd1b80db94e/lower/8f3eda09-5cf9-289c-cee9-84f295c98fc7
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::getBakedTextureImage:  Avatar 'Whirly Fizzle' textured get server-bake image from URL http://bake-texture.agni.lindenlab.com/texture/2e255955-e183-48c4-b9f9-1cd1b80db94e/eyes/5cff4332-d978-7743-ee85-69295e1db524
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::getBakedTextureImage:  Avatar 'Whirly Fizzle' textured get server-bake image from URL http://bake-texture.agni.lindenlab.com/texture/2e255955-e183-48c4-b9f9-1cd1b80db94e/hair/63c110f6-6c5b-0144-3082-089fb2acf64e
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 0 using texture id 20f8aeca-2d31-3536-c4c5-4d103f723b1b
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 1 using texture id 3d2b3a6e-05bf-8354-b621-ee6baa5ee548
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 2 using texture id 8f3eda09-5cf9-289c-cee9-84f295c98fc7
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 3 using texture id 5cff4332-d978-7743-ee85-69295e1db524
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 4 using texture id c228d1cf-4b5d-4ba8-84f4-899a0796aa97
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  baked_index 5 using texture id 63c110f6-6c5b-0144-3082-089fb2acf64e
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured processAvatarAppearance start 2e255955-e183-48c4-b9f9-1cd1b80db94e first? 0 self? 1
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance:  Avatar 'Whirly Fizzle' textured  handle visual params, num_params 253
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::processAvatarAppearance: Changed 80 params
2015-04-06T16:28:29Z DEBUG: LLTextureFetch::createRequest:  requesting 8f3eda09-5cf9-289c-cee9-84f295c98fc7 0x0 discard 5 type 1
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::onBakedTextureLoaded: onBakedTextureLoaded: 8f3eda09-5cf9-289c-cee9-84f295c98fc7
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::onBakedTextureLoaded:  Avatar 'Whirly Fizzle' textured discard_level 1 success 1 final 1 id 8f3eda09-5cf9-289c-cee9-84f295c98fc7
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::onBakedTextureLoaded: onBakedTextureLoaded: 8f3eda09-5cf9-289c-cee9-84f295c98fc7
2015-04-06T16:28:29Z DEBUG: LLVOAvatar::onBakedTextureLoaded:  Avatar 'Whirly Fizzle' textured discard_level 1 success 1 final 1 id 8f3eda09-5cf9-289c-cee9-84f295c98fc7
2015-04-06T16:28:30Z INFO: LLWorld::addRegion: Add region with handle: 1428265604786944 on host 216.82.52.78:13019
2015-04-06T16:28:30Z INFO: LLWorld::addRegion: Region already exists and is alive, using existing region
2015-04-06T16:28:30Z INFO: process_enable_simulator: simulator_enable() Enabling 216.82.52.78:13019 with code 209321412
2015-04-06T16:28:30Z DEBUG: LLTextureFetch::createRequest:  requesting 20f8aeca-2d31-3536-c4c5-4d103f723b1b 512x512 discard 0 type 1
2015-04-06T16:28:30Z DEBUG: LLTextureFetch::createRequest:  requesting 3d2b3a6e-05bf-8354-b621-ee6baa5ee548 512x512 discard 0 type 1
2015-04-06T16:28:31Z DEBUG: LLTextureFetch::createRequest:  requesting 8f3eda09-5cf9-289c-cee9-84f295c98fc7 512x512 discard 0 type 1
2015-04-06T16:28:31Z DEBUG: LLVOAvatar::updateRezzedStatusTimers:  Avatar 'Whirly Fizzle' textured_and_downloaded rez state change: 2 -> 3
2015-04-06T16:28:31Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase load_textured_and_downloaded elapsed 2.673286
2015-04-06T16:28:31Z DEBUG: LLVOAvatar::stopPhase:  Avatar 'Whirly Fizzle' textured_and_downloaded stopped phase update_appearance_from_cof elapsed 27.524963

sl-service-account commented 9 years ago

Whirly Fizzle commented at 2015-04-24T23:30:51Z

Bug still reproduces on http://wiki.secondlife.com/wiki/Release_Notes/Second_Life_Project_BigBird/3.7.28.300856

sl-service-account commented 9 years ago

Whirly Fizzle commented at 2015-05-27T17:27:43Z

Bug still reproduces on the current Big-Bird RC: Second Life 3.7.29 (301943) May 18 2015 11:14:10 (Second Life Release) http://wiki.secondlife.com/wiki/Release_Notes/Second_Life_Release/3.7.29.301943

sl-service-account commented 8 years ago

Nicky Perian commented at 2016-05-19T04:00:50Z

@Whirly any update concerning newer viewers?

sl-service-account commented 8 years ago

Whirly Fizzle commented at 2016-05-19T08:13:45Z

Heya Nicky,

Bug still reproduces on default release: Second Life 4.0.5.315117 (Second Life Release). Bug still reproduces on the HttpMsg RC viewer: Second Life 4.0.5 (315019) May 6 2016 15:34:05 (Second Life Release)

Just to not though, on the LL viewer it's unlikely anyone will notice this problem because you have to be very fast when swapping out wearables with Wear to reproduce it - easiest way to repro on the LL viewer is to double left click Tatt 1 then quickly double left click Tatt 2. Double left click will always "Wear" on the LL viewer, rather then "Add".

However, on viewers that support RLV or RLVa, this bug becomes a problem because it messes up scripted outfit changes (which allow the user to swap wearables very quickly), which I'm guessing is why you are asking, because Kokua supports RLV. Kitty fixed the problem for RLVa scripted outfit changes so if you are seeing this problem in Kokua with RLV, contact Kitty Barnett for the fix, which I'm presuming should work for RLV the same as it does for RLVa. Kitty's fix does not fix the vanilla bug filed here though, but again it's unlikely users will get hit by this bug unless they are swapping wearables really quickly.

sl-service-account commented 8 years ago

Nicky Perian commented at 2016-05-19T21:01:50Z

Looking at https://jira.secondlife.com/browse/BUG-11929 I think this is the bug I am seeing. My wife sees this often. Is this bug related? Thinking it occurs with female avatars more often with the immediate changing of outfits just after logon. Also, I can't remember the acronym but could the distributed delivery is assets be a contributor?

sl-service-account commented 8 years ago

Whirly Fizzle commented at 2016-05-19T21:05:48Z

Oh BUG-11929 isn't fixed yet, Rider is working on it. BUG-11929 started with the coroutine changes, or rather became much much easier to reproduce after the coroutine changes.

secondlife / jira-archive