possible new bug - relto tree

[johnsojc]

We know what but not why... <sigh>

[D'Lanor]

It's not saving the new time of last growth, so it grows again when I go somewhere else and then navigate back again to relto.

Except that lines like "(04/03 22:45:56) Dni time: 1333467954, last growth: 1333467954" show that it did get saved. It seems to reset between visits.

What the multiple lines with Dni time \ last growth also tell us is that the code under OnServerInitComplete is executed multiple times, which should NOT happen. /me thinks Dirtsand needs a bit of tweaking.

[Acorn]

just a quick reply to johnsojc's questions - I think that there's nothing to stop it growing exponentially now it's started, because it keeps reverting back to that original date when it last grew, and that will trigger repeated growth. I expect that if I log in now it'll grow again as soon as I arrive - as it did yesterday. My assumption is that if I then just sit in relto and don't go anywhere, it won't grow again for 15 days, but if I leave and return it'll trigger each time. But I don't fancy sitting in relto for 15 days just to test this!

The first time I logged out, I had logged out and switched to my other avvie before quitting, (but I stayed with the same avvie during the course of the log extracts I posted up). The second time I stayed with the same avvie throughout, and quit rather than logged out.

Best of luck in 3 days' time!

Yes, D'lanor, sorry not to be precise, it does use the new time for when it last grew while I'm in relto but reverts back when I leave and come back.

[johnsojc]

My other avatar will hit 15 days in about 5.5 hours... I will try to run a test this afternoon. I will look for the lastgrowth value reverting...

Results of my test did not reproduce Acorn's experience bug discovered a new wrinkle...

Test120404 Show Spoiler

[NOTE:] check login before expected growth...

(04/04 13:10:13) Dni time: 1333537806, last growth: 1332243299
(04/04 13:10:13) Growsizes: 0
(04/04 13:10:13) CurrentValue: 31, size: 3, state 1
(04/04 13:10:13) psnlYeeshaPageChanges: Attempting to enable drawing and collision on PonderosaBig_03...

[NOTE:] Projected growth time = 1333539299 @ 13:35:06
[NOTE:] Launch Gehn...

(04/04 13:35:45) Dni time: 1333539338, last growth: 1332243299
(04/04 13:35:45) Growsizes: 1
(04/04 13:35:45) CurrentValue: 31, size: 4, state 1
(04/04 13:35:45) psnlYeeshaPageChanges: Attempting to disable drawing and collision on PondorosaBig_09...
(04/04 13:35:45) Dni time: 1333539338, last growth: 1333539338
(04/04 13:35:45) Growsizes: 0
(04/04 13:35:45) CurrentValue: 41, size: 4, state 1
(04/04 13:35:45) psnlYeeshaPageChanges: Attempting to disable drawing and collision on PonderosaBig_03...
(04/04 13:35:45) Dni time: 1333539338, last growth: 1333539338
(04/04 13:35:45) Growsizes: 0
(04/04 13:35:45) CurrentValue: 41, size: 4, state 1
(04/04 13:35:45) psnlYeeshaPageChanges: Attempting to enable drawing and collision on PonderosaBig_04...

[NOTE:] size updated to 4... linked to Gira...

(04/04 13:42:41) psnlBookshelf.IGetAgeFromBook(): picked book goes to Gira
(04/04 13:42:41) psnlBookshelf.IGetLinkFromBook(): before city lookup, ageName = Gira
(04/04 13:42:41) psnlBookshelf.IGetLinkFromBook(): after city lookup, ageName = Gira
(04/04 13:42:41) psnlBookshelf.IGetLinkFromBook(): found Owned linkGira
(04/04 13:42:41) psnlBookshelf.ILink(): attempting link to Gira(Eder Gira)

[NOTE:] linked back to relto... !!!! Tree reverted to size 3 but last growth time updated!!!!

(04/04 13:43:04) Dni time: 1333539777, last growth: 1333539338
(04/04 13:43:04) Growsizes: 0
(04/04 13:43:04) CurrentValue: 31, size: 3, state 1
(04/04 13:43:04) psnlYeeshaPageChanges: Attempting to disable drawing and collision on PondorosaBig_09...
(04/04 13:43:04) Dni time: 1333539777, last growth: 1333539338
(04/04 13:43:04) Growsizes: 0
(04/04 13:43:04) CurrentValue: 31, size: 3, state 1
(04/04 13:43:04) psnlYeeshaPageChanges: Attempting to enable drawing and collision on PonderosaBig_03...
(04/04 13:43:04) Dni time: 1333539777, last growth: 1333539338
(04/04 13:43:04) Growsizes: 0
(04/04 13:43:04) CurrentValue: 31, size: 3, state 1
(04/04 13:43:04) psnlYeeshaPageChanges: Attempting to disable drawing and collision on PonderosaBig_04...

[NOTE:] logout to avatar selection... log back in to Relto... size still 3...

(04/04 13:53:53) Dni time: 1333540427, last growth: 1333539338
(04/04 13:53:53) Growsizes: 0
(04/04 13:53:53) CurrentValue: 31, size: 3, state 1
(04/04 13:53:53) psnlYeeshaPageChanges: Attempting to enable drawing and collision on PonderosaBig_03...

[NOTE:] quit... relaunch Gehn...

(04/04 14:00:09) Dni time: 1333540803, last growth: 1333539338
(04/04 14:00:09) Growsizes: 0
(04/04 14:00:09) CurrentValue: 31, size: 3, state 1
(04/04 14:00:09) psnlYeeshaPageChanges: Attempting to enable drawing and collision on PonderosaBig_03...

[NOTE;] size still 3... last growth remains updated... wait 15 days...

Bottom line is the last growth time got saved but the new size did not. I actually saw the larger tree and then it was smaller the next time I linked in.

[Acorn]

nice one, johnsojc! Even weirder than my glitch! The incredible shrinking tree!

[johnsojc]

Perhaps this is related to the problems we saw with the vault DB getting hammered during the Pod Party. There might be conditions where an update simply does not get written into the SDL. In my test, the value of yeesha page 10 should have been set to 41 (I think this is the code that does it).

Code: Select all

        elif sizechanged:
            SDLVar.setInt( (size * 10) + state)
            AgeVault.updateAgeSDL(self.ageSDL)

Apparently this did not happen.

In your case, the last growth failed to update. I doubt the code for the tree has changed and I hesitate to point a finger at the DB process since I simply have no idea how it works. Something very wierd is going on.

[Tsar Hoikas]

The vault DB was fine during the pod party... We had a choke point at a single mutex on the auth server. Getting rid of it is going to be pain.

On SDL, I have long suspected that some SDL issues didn't get cleared up in my SDL bug roundup just before launch. Particularly, I believe the Gira baskets are the result of some fields that are somehow corrupted in the SDL blob. It might be that our state merging process has a subtle bug, but I don't really know what's going on there, but obviously something is up.

[johnsojc]

IIRC, there have always been issues with the tree since MOUL. Reports of the tree either growing too fast or not at seem to rattle in the back of my mind. Gah! MOUL started up back in late 2006 (prelaunch). This is a minor irritation compared to other issues and we've gnawed on it about as much as we can just looking at logs.

[Acorn]

[edit - I bumped this - it was originally posted around a year ago]

For completeness: the tree just grew from stages 5 - 9 in only 3 minutes, via visits to Ahnonay and to my wardrobe - the wardrobe visit triggered two stages because I ended up falling into the grey nothingness (which clearly counts as being on relto - and I get the fireplace sound effects while I'm there) and then had to use my relto book to get back onto the island. Let me know if you want any more log extracts. But I think you've probably got what you need.

[Acorn]

I thought I'd bump this because my trees are still growing too fast. AcornGehn13 and 14 have recently had the same experience - once the tree has started to grow, all you need to do is jump off relto a few times and the tree reaches its (in my view ugly) maximum height in a matter of minutes. I always switch it off when it's full size, so it means I get to enjoy it for only a short time even if I don't deliberately trigger the accelerated growth by jumping off relto.