Player data disk malformed
Need More Info, UrgentPublic
Actions

Description

Player data gets corrupted and unable to be saved or loaded, i dont know what triggers this issue but its been happening a lot lately, nitrado support suggested me to contact you as they have no idea either.

Players get this error once kicked :

Some players manage to connect, but if server restarts/crashes => they can no longer connect, and their progression gets rolled back/erased

In some cases server keeps restarting in loop, and each time rolls any player progression made back (world progression stays).

All cases have one thing in common => they all point at player database disk image is malformed

Details

Severity: None
Resolution: Open
Reproducibility: N/A
Operating System: Windows 7
Category: General

Steps To Reproduce

Unknown, suspect its triggered by players who have items that were removed from the game in their inventory

Additional Information

parts from logs that i have access to :

1:56:36.291 [Login]: Adding prioritized player SmokeyGOAT18 (281244918) to login queue at position 0
1:56:36.291 [LoginMachine]: Add player SmokeyGOAT18 (281244918)
1:56:36.291 [StateMachine]: Player SmokeyGOAT18 (dpnid 281244918 uid ) Entering AuthPlayerLoginState
1:56:36.291 Server: SetClientState dpid=281244918 id=0 name=SmokeyGOAT18 CREATED -> CONNECTED
1:56:36.306 [StateMachine]: Player SmokeyGOAT18 (dpnid 281244918 uid ) Entering WaitAuthPlayerLoginState
1:56:36.447 !!! CEStorageElement::Save Battery9V:37118 parent problem, parent:613c3c20, hierParent:59b12760, _moveOutState:2
1:56:36.556 Player SmokeyGOAT18 connected (id=149E667975DEBCE8283B5E158676E07B46DD2828).
1:56:36.572 [StateMachine]: Player SmokeyGOAT18 (dpnid 281244918 uid ) Entering WaitPlayerAssignedLoginState
1:56:36.775 !!! CEStorageElement::Save Battery9V:37450 parent problem, parent:590b78c0, hierParent:59b02530, _moveOutState:2
1:56:36.931 [StateMachine]: Player SmokeyGOAT18 (dpnid 281244918 uid 149E667975DEBCE8283B5E158676E07B46DD2828) Entering DBGetLoginTimeLoginState
1:56:36.962 [StateMachine]: Player SmokeyGOAT18 (dpnid 281244918 uid 149E667975DEBCE8283B5E158676E07B46DD2828) Entering DBWaitLoginTimeLoginState
1:56:36.978 [StateMachine]: Player SmokeyGOAT18 (dpnid 281244918 uid 149E667975DEBCE8283B5E158676E07B46DD2828) Entering DBGetCharacterLoginState
1:56:36.994 !!! [CE][offlineDB] :: Can't load player: database disk image is malformed
1:56:37.09 [StateMachine]: Player SmokeyGOAT18 (dpnid 281244918 uid 149E667975DEBCE8283B5E158676E07B46DD2828) State Error (DBGetCharacterLoginState)
1:56:37.09 Player SmokeyGOAT18 (281244918) kicked from server: 56 (Something went wrong on the server.)
1:56:37.09 [StateMachine]: Kick player SmokeyGOAT18 (dpnid 281244918 uid 149E667975DEBCE8283B5E158676E07B46DD2828) State DBGetCharacterLoginState
1:56:37.09 [Disconnect]: Client 281244918 early disconnect
1:56:37.25 [Disconnect]: No player -> remove player info 281244918
1:56:37.25 [Disconnect]: DisconnectPlayerFinish 281244918
1:56:37.25 [Disconnect]: Remove player info 281244918
1:56:37.25 [Disconnect]: Player destroy 281244918

1:56:37.25 NETWORK (E): server: Player dpid=281244918 index not removed

2:17:54.932 [Login]: Adding player CorneliusDaGreek (318195364) to login queue at position 0
2:17:54.932 [LoginMachine]: Add player CorneliusDaGreek (318195364)
2:17:54.932 [StateMachine]: Player CorneliusDaGreek (dpnid 318195364 uid ) Entering AuthPlayerLoginState
2:17:54.932 Server: SetClientState dpid=318195364 id=0 name=CorneliusDaGreek CREATED -> CONNECTED
2:17:54.948 [StateMachine]: Player CorneliusDaGreek (dpnid 318195364 uid ) Entering WaitAuthPlayerLoginState
2:17:55.244 Player CorneliusDaGreek connected (id=C8GfLLRqh-HUa-tKbdv2e6KP0v8ZdzBjICTpJhpOEiM=).
2:17:55.260 [StateMachine]: Player CorneliusDaGreek (dpnid 318195364 uid ) Entering WaitPlayerAssignedLoginState
2:17:55.651 [StateMachine]: Player CorneliusDaGreek (dpnid 318195364 uid C8GfLLRqh-HUa-tKbdv2e6KP0v8ZdzBjICTpJhpOEiM=) Entering DBGetLoginTimeLoginState
2:17:55.666 !!! [CE][offlineDB] :: Can't create player: database disk image is malformed
2:17:55.682 [StateMachine]: Player CorneliusDaGreek (dpnid 318195364 uid C8GfLLRqh-HUa-tKbdv2e6KP0v8ZdzBjICTpJhpOEiM=) State Error (DBGetLoginTimeLoginState)
2:17:55.682 Player CorneliusDaGreek (318195364) kicked from server: 52 (Unexpected database response. (32))
2:17:55.682 [StateMachine]: Kick player CorneliusDaGreek (dpnid 318195364 uid C8GfLLRqh-HUa-tKbdv2e6KP0v8ZdzBjICTpJhpOEiM=) State DBGetLoginTimeLoginState
2:17:55.697 [Disconnect]: Client 318195364 early disconnect
2:17:55.697 [Disconnect]: No player -> remove player info 318195364
2:17:55.697 [Disconnect]: DisconnectPlayerFinish 318195364
2:17:55.697 [Disconnect]: Remove player info 318195364

2:17:55.697 [Disconnect]: Player destroy 318195364

This is just example of what it says when players try to connect, it does it for almost all of them, but rare few manage to connect, until server crashes, then they start getting this error too.

Only solution currently is wiping (reinstalling the game), we tried to wipe player progress via economy.xml file, but its not working for wiping player data no more

Event Timeline

chipman created this task.Mar 8 2022, 2:36 AM

Hello chipman.
Were you manually editing the player database file?
Regards,
Geez

This happened on my server last night also.

Player progress has been lost, Nitrado Level 1 support indicated a corrupt player db file, escalated it to Level 2 support. Waiting to hear back from them. This is on Xbox, and we don't have access to the player db

Hi Geez, do you mean economy.xml file ? No we did not edit it, at least not before error started to occur, when i first had this problem i tried to change player load="1" to "0" (with save ="1"), to wipe player data, it worked before 1.16, but not anymore

this is how economy.xml looks

<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<economy>

<dynamic init="1" load="1" respawn="1" save="1"/>
<animals init="1" load="0" respawn="1" save="0"/>
<zombies init="1" load="0" respawn="1" save="0"/>
<vehicles init="1" load="1" respawn="1" save="1"/>
<randoms init="0" load="0" respawn="1" save="0"/>
<custom init="0" load="0" respawn="0" save="0"/>
<building init="1" load="1" respawn="0" save="1"/>
<player init="1" load="1" respawn="1" save="1"/>

</economy>

by changing load="1" to "0", with everything else at "1", game would not load player data, and save that state => resulting in wiped player data, but currently its not working for <player />, i tried to wipe player data this way only after error with player data corruption happened

chipman edited Additional Information. (Show Details)Mar 9 2022, 12:44 AM

In T163640#2286132, @chipman wrote:
Hi Geez, do you mean economy.xml file ? No we did not edit it, at least not before error started to occur, when i first had this problem i tried to change player load="1" to "0" (with save ="1"), to wipe player data, it worked before 1.16, but not anymore

this is how economy.xml looks

<?xml version="1.0" encoding="UTF-8" standalone="yes"?>
<economy>
<dynamic init="1" load="1" respawn="1" save="1"/>
<animals init="1" load="0" respawn="1" save="0"/>
<zombies init="1" load="0" respawn="1" save="0"/>
<vehicles init="1" load="1" respawn="1" save="1"/>
<randoms init="0" load="0" respawn="1" save="0"/>
<custom init="0" load="0" respawn="0" save="0"/>
<building init="1" load="1" respawn="0" save="1"/>
<player init="1" load="1" respawn="1" save="1"/>
</economy>

by changing load="1" to "0", with everything else at "1", game would not load player data, and save that state => resulting in wiped player data, but currently its not working for <player />, i tried to wipe player data this way only after error with player data corruption happened

Hello chipman.
Talking more about the players.db in your Storage folder as this file appears to be the one that is corrupted.
Regards,
Geez

Also, was there a crash before this issue has started to occur?
Regards,
Geez

Plus, can you please send us an IP of the server? and have you tried to ask nitrado to wipe the server storage/player database before? Possibly just the players.db file.
Regards,
Geez

In T163640#2286452, @Geez wrote:

Plus, can you please send us an IP of the server? and have you tried to ask nitrado to wipe the server storage/player database before? Possibly just the players.db file.
Regards,
Geez

Hi, as of right now there is one server having this issue : 95.156.224.24:11100
upd. server was wiped today, so problem is gone for now

I have not asked them to wipe player data base, will ask now tho, and also we dont have direct access to player.db on console, only way i know to interact with player data was thru economy.xml file, but even that is not working anymore.

Hello chipman.
Can you please provide us with UserID, name of the server or the new IP and port? As it appears that the IP has changed.
Regards,
Geez

In T163640#2287108, @Geez wrote:

Hello chipman.
Can you please provide us with UserID, name of the server or the new IP and port? As it appears that the IP has changed.
Regards,
Geez

Yes, i already wiped the server and now its running fine, but another one just now started to show first signs (players rolling back each time they log out, and new players cant log in and get kicked with player data error)

small portion of players are unable to connect in this case, a lot of them still can connect and play, but no player progress is saved, meaning that players are able to die and respawn fully geared again (if they log out and log back on server), world progress does not seem to be affected by the roll backs, only player character data gets rolled back to the state they were in when they first logged in.

here an example of how it looks like https://www.xbox.com/en-US/play/media/6FSR629R

chipman added a comment.Mar 12 2022, 8:09 AM

This comment was removed by chipman.

Hello chipman.
Do you still experience any issues?
Regards,
Geez

not anymore, soon will be around a week without anything similar happening, haven't done any changes to xml files on my side

not related :

Is economy.xml file working as intended ? specifically concerning "player" line
Reason im asking is because, when i was trying to wipe player db by changing load to 0, it would not work (but works for dynamic, or vehicles for example), and i know it used to work before, thats how i used to do soft wipes, by editing dynamic and player line

<dynamic init="1" load="1" respawn="1" save="1"/> event spawns, tents, containers etc.

<animals init="1" load="0" respawn="1" save="0"/> bears, wolves etc.

<zombies init="1" load="0" respawn="1" save="0"/> infected

<vehicles init="1" load="1" respawn="1" save="1"/> cars

<randoms init="0" load="0" respawn="1" save="0"/> dynamic events like helis

<custom init="1" load="1" respawn="1" save="1"/> mapgroouppos and init and territories

<building init="1" load="1" respawn="1" save="1"/> buildings in the map

<player init="1" load="1" respawn="1" save="1"/> player information