A little crash_dumps maybe something will help

REDOSS · Dec 6, 2018

A little crash_dumps maybe something will help

crash_dump_6e2c77d0-7e4c-47d8-f3954495-74938986.dmp
v1.2.31-beta [Build: 1544022855]

[2018-12-07 01:23:35] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (8ms)
[2018-12-07 01:23:35] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (8ms)
[2018-12-07 01:23:36] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (6ms)
[2018-12-07 01:23:40] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (12ms)
[2018-12-07 01:23:41] [DEBUG] 2 | Having command "mbot".
[2018-12-07 01:23:41] [DEBUG] 2 | Argument: 'list'
[2018-12-07 01:23:41] [DEBUG] 2 | [Permission] Value test result for test type 1.
[2018-12-07 01:23:41] [DEBUG] 2 | [Permission] Permission: b_client_music_channel_list Required value: 1 Gained value: 1 Force required: 1 Channel: МУЗОНЧИК Result: 1
[2018-12-07 01:23:47] [DEBUG] 2 | [Property] Changed property in db key: client_month_online_time value: 111840
[2018-12-07 01:23:47] [DEBUG] 2 | [Property] Changed property in db key: client_total_online_time value: 249720
[2018-12-07 01:23:51] [ERROR] 2 | [95.52.108.39:58556/TeamSpeakUse | 10] Handling of packet Ping needs more than 10ms (10ms)
[2018-12-07 01:23:52] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (6ms)
[2018-12-07 01:23:53] [DEBUG] 2 | [Property] Changed property in db key: client_month_online_time value: 91440
[2018-12-07 01:23:53] [DEBUG] 2 | [Property] Changed property in db key: client_total_online_time value: 189480
[2018-12-07 01:23:58] [DEBUG] 2 | Having command "mbot".
[2018-12-07 01:23:58] [DEBUG] 2 | Argument: 'select'
[2018-12-07 01:23:58] [DEBUG] 2 | Argument: '9254'
[2018-12-07 01:23:59] [DEBUG] 2 | [Property] Changed property in db key: client_month_online_time value: 5160
[2018-12-07 01:23:59] [DEBUG] 2 | [Property] Changed property in db key: client_total_online_time value: 5160
[2018-12-07 01:23:59] [DEBUG] 4 | [Property] Changed property in db key: client_month_online_time value: 103200
[2018-12-07 01:23:59] [DEBUG] 4 | [Property] Changed property in db key: client_total_online_time value: 692400
[2018-12-07 01:24:02] [DEBUG] 4 | [Property] Changed property in db key: client_month_online_time value: 264600
[2018-12-07 01:24:02] [DEBUG] 4 | [Property] Changed property in db key: client_total_online_time value: 1646760
[2018-12-07 01:24:06] [DEBUG] 2 | Having command "mbot".
[2018-12-07 01:24:06] [DEBUG] 2 | Argument: 'delete'
[2018-12-07 01:24:06] [[1m[7m[0;31mCRITICAL] [1m[7m[0;31m GEN | Soft assertion @/workspace/TeaSpeak-Parent_master-FRUL5U2YEGMIHINML2BZCK6KBI6I4EHNXBFX3JFUSZG2NLVUAXHA@3/TeaSpeak/server/src/TS3ServerClientManager.cpp:60 'cl->state == ConnectionState:

ISCONNECTED || (cl->getExternalType() != ClientType::CLIENT_VOICE)' failed! This could cause fatal fails![0m
[2018-12-07 01:24:06] [ERROR] 2 | Command handling of command sendtextmessage needs 18ms
[2018-12-07 01:24:06] [ERROR] 2 | [5.187.69.141:4232/REDOSS | 36] Handling of packet Command needs more than 10ms (18ms)

crash_dump_8df1431b-baa2-4d6b-81f6b692-f1198466.dmp
v1.2.30-beta [Build: 1543679143]

[2018-12-06 13:00:14] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (288ms)
[2018-12-06 13:00:15] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (9ms)
[2018-12-06 13:00:15] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (7ms)
[2018-12-06 13:00:15] [DEBUG] [Music] [FFMPEG][0x7f7967c0bc10] Start buffering
[2018-12-06 13:00:15] [DEBUG] [Music] [FFMPEG][0x7f7967c0bc10] Stop buffering
[2018-12-06 13:00:16] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (6ms)
[2018-12-06 13:00:17] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (5ms)
[2018-12-06 13:00:22] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (33ms)
[2018-12-06 13:00:24] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (245ms)
[2018-12-06 13:00:25] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (5ms)
[2018-12-06 13:00:26] [DEBUG] [Music] [FFMPEG][0x7f7967c0bc10] Start buffering
[2018-12-06 13:00:27] [DEBUG] [Music] [FFMPEG][0x7f7967c0bc10] Stop buffering
[2018-12-06 13:00:28] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (5ms)
[2018-12-06 13:00:29] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (30ms)
[2018-12-06 13:00:30] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (6ms)
[2018-12-06 13:00:32] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (6ms)
[2018-12-06 13:00:32] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (9ms)
[2018-12-06 13:00:34] [ERROR] 2 | [MusicBot] Resend task contained a delay of over 5ms! (111ms)
[2018-12-06 13:00:36] [[1m[7m[0;31mCRITICAL] [1m[7m[0;31m GEN | Could not shutdown server within 30 seconds! (Hangup!)[0m
[2018-12-06 13:00:36] [[1m[7m[0;31mCRITICAL] [1m[7m[0;31m GEN | Killing server![0m

crash_dump_2a3a3b21-fce3-4a51-079c5a84-1ba9ae69.dmp
On another failure unfortunately no information is left, but I think you will understand

WolverinDEV · Dec 7, 2018

Hmm did the crashes just happens randomly or is there any plausible reason?

REDOSS · Dec 7, 2018

crash_dump_6e2c77d0-7e4c-47d8-f3954495-74938986.dmp

After removing the bot and restarting the server.
./teastart.sh stop

crash_dump_8df1431b-baa2-4d6b-81f6b692-f1198466.dmp

The server was stopped by the command, was filled with RAM and swap by about 10%.
./teastart.sh stop

crash_dump_2a3a3b21-fce3-4a51-079c5a84-1ba9ae69.dmp

If I am not mistaken the error was accidental, the server continued to work.

WolverinDEV · Dec 7, 2018

Well yeah any crash dumps caused by stop actions are not that critical.
There are several multithreading issues, which causes undefined behavior.
The fact that the server crash is around 30% :/

REDOSS · Dec 7, 2018

WolverinDEV said:
Well yeah any crash dumps caused by stop actions are not that critical.
There are several multithreading issues, which causes undefined behavior.
The fact that the server crash is around 30% :/

But in any case, i reported)) and you already see there.

WolverinDEV · Dec 7, 2018

Yeah all right

I'll fix that at some point, but thats not my major point right now, as long its not a crash while runtime

REDOSS · Dec 11, 2018

1.2.31-beta-2

Code:

[2018-12-11 01:41:06] [DEBUG]   GEN | Invalid packed pushpack! Current index 117 (generation 0) Packet index 116
[2018-12-11 01:41:06] [DEBUG]     2 | [95.153.135.245:28136/StaJIone(Виктор) | 11] Failed to pushback command packet. Command true
[2018-12-11 01:41:18] [ERROR] Timer InstanceHandler::tickInstance -> statistics tick needs more than 6521 microseconds. Max allowed was 5000 microseconds.
[2018-12-11 01:41:24] [DEBUG]     2 | [Property] Changed property in db key: client_month_online_time value: 108000
[2018-12-11 01:41:24] [DEBUG]     2 | [Property] Changed property in db key: client_total_online_time value: 108000
[2018-12-11 01:41:28] [INFO]  GLOBL | Got stop signal (SIGTERM). Stopping instance.
[2018-12-11 01:41:28] [INFO]    GEN | Stopping all server instances!
[2018-12-11 01:41:28] [DEBUG]     2 | [37.204.141.105:55107/Iswho [Исху] (Миха) | 22] Received disconnect acknowledge!
[2018-12-11 01:41:28] [DEBUG]     2 | [37.204.141.105:55107/Iswho [Исху] (Миха) | 22] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:28] [INFO]      2 | Voice client 1297/DQxaQXiBXWD7gBjzUW+E5tt9IcI= (Iswho [Исху] (Миха)) from 37.204.141.105:55107 left.
[2018-12-11 01:41:28] [DEBUG]     2 | Updating server property: virtualserver_last_client_disconnect. New value: 1544481688. Query: UPDATE `properties` SET `value` = :value WHERE `serverId` = :sid AND `type` = :type AND `id` = :id AND `key` = :key
[2018-12-11 01:41:28] [DEBUG]     2 | [93.90.35.155:1092/x_EvGeNII_x (Евгений) | 16] Received disconnect acknowledge!
[2018-12-11 01:41:28] [DEBUG]     2 | [93.90.35.155:1092/x_EvGeNII_x (Евгений) | 16] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:28] [INFO]      2 | Voice client 9301/W6OQTKpdz/extYT4GMWehf44ggg= (x_EvGeNII_x (Евгений)) from 93.90.35.155:1092 left.
[2018-12-11 01:41:28] [INFO]    GEN | Stopping application
[2018-12-11 01:41:28] [DEBUG] GLOBL | Stopping all virtual servers
[2018-12-11 01:41:28] [DEBUG]     4 | [5.18.237.169:41948/IVIargo | 6] Received disconnect acknowledge!
[2018-12-11 01:41:28] [DEBUG]     4 | [5.18.237.169:41948/IVIargo | 6] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:28] [INFO]      4 | Voice client 3416/uUVMIm4PL5RaK/xQUE4CFEZWfXg= (IVIargo) from 5.18.237.169:41948 left.
[2018-12-11 01:41:28] [DEBUG]     4 | Updating server property: virtualserver_last_client_disconnect. New value: 1544481688. Query: UPDATE `properties` SET `value` = :value WHERE `serverId` = :sid AND `type` = :type AND `id` = :id AND `key` = :key
[2018-12-11 01:41:29] [[1m[7m[0;31mCRITICAL] [1m[7m[0;31m  GEN | The server crashed![0m
[2018-12-11 01:41:29] [[1m[7m[0;31mCRITICAL] [1m[7m[0;31m  GEN | Wrote crash dump to crash_dumps/crash_dump_223bee63-f438-4f79-f659ab80-ecef4523.dmp[0m
[2018-12-11 01:41:29] [[1m[7m[0;31mCRITICAL] [1m[7m[0;31m  GEN | Please report this crash to the TeaSpeak maintainer WolverinDEV[0m
[2018-12-11 01:41:29] [[1m[7m[0;31mCRITICAL] [1m[7m[0;31m  GEN | Official issue and bug tracker url: https://github.com/TeaSpeak/TeaSpeak/issues[0m
[2018-12-11 01:41:29] [[1m[7m[0;31mCRITICAL] [1m[7m[0;31m  GEN | Any reports of crashes are useless if you not provide the above generated crashlog![0m
[2018-12-11 01:41:29] [[1m[7m[0;31mCRITICAL] [1m[7m[0;31m  GEN | Stopping server[0m
[2018-12-11 01:41:33] [DEBUG]     2 | [95.153.135.245:28136/StaJIone(Виктор) | 11] Failed to receive disconnect acknowledge!
[2018-12-11 01:41:33] [DEBUG]     2 | [95.153.135.245:28136/StaJIone(Виктор) | 11] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:33] [INFO]      2 | Voice client 9154/YdZIgA8XaF3qwlZyyVDsfZ7cLUk= (StaJIone(Виктор)) from 95.153.135.245:28136 left.
[2018-12-11 01:41:33] [DEBUG]     2 | Updating server property: virtualserver_last_client_disconnect. New value: 1544481693. Query: UPDATE `properties` SET `value` = :value WHERE `serverId` = :sid AND `type` = :type AND `id` = :id AND `key` = :key
[2018-12-11 01:41:33] [DEBUG]     2 | [94.25.231.156:33055/Buran0002 (Леха) | 1] Failed to receive disconnect acknowledge!
[2018-12-11 01:41:33] [DEBUG]     2 | [94.25.231.156:33055/Buran0002 (Леха) | 1] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:33] [INFO]      2 | Voice client 9118/t0LJZmsSFiUSccaiegnntxByTYQ= (Buran0002 (Леха)) from 94.25.231.156:33055 left.
[2018-12-11 01:41:33] [DEBUG]     4 | [46.39.55.18:26787/Рома "rz1994[WLADY]" | 4] Failed to receive disconnect acknowledge!
[2018-12-11 01:41:33] [DEBUG]     4 | [46.39.55.18:26787/Рома "rz1994[WLADY]" | 4] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:33] [INFO]      4 | Voice client 4721/Jy1t5+sdgng4TR7Jo7toSVV9Vxs= (Рома "rz1994[WLADY]") from 46.39.55.18:26787 left.
[2018-12-11 01:41:33] [DEBUG]     4 | Updating server property: virtualserver_last_client_disconnect. New value: 1544481693. Query: UPDATE `properties` SET `value` = :value WHERE `serverId` = :sid AND `type` = :type AND `id` = :id AND `key` = :key
[2018-12-11 01:41:33] [DEBUG]     4 | [77.40.34.126:63041/пидрила | 7] Failed to receive disconnect acknowledge!
[2018-12-11 01:41:33] [DEBUG]     4 | [77.40.34.126:63041/пидрила | 7] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:33] [INFO]      4 | Voice client 4706/WViSWtviYqlK83kX0etj0KgqqVg= (пидрила) from 77.40.34.126:63041 left.
[2018-12-11 01:41:33] [DEBUG]     4 | [91.218.192.194:52887/TeamSpeakUser | 22] Failed to receive disconnect acknowledge!
[2018-12-11 01:41:33] [DEBUG]     4 | [91.218.192.194:52887/TeamSpeakUser | 22] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:33] [INFO]      4 | Voice client 4785/PAuCVS0oyL3nXBpJ9/5WhpXjLIo= (TeamSpeakUser) from 91.218.192.194:52887 left.
[2018-12-11 01:41:33] [DEBUG]     4 | [193.0.218.70:50137/DYADOR1 | 25] Failed to receive disconnect acknowledge!
[2018-12-11 01:41:33] [DEBUG]     4 | [193.0.218.70:50137/DYADOR1 | 25] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:33] [INFO]      4 | Voice client 4828/+4qPzdzf6i91gWYu3m2eC7FuuZw= (DYADOR1) from 193.0.218.70:50137 left.
[2018-12-11 01:41:33] [DEBUG]     4 | [91.108.28.38:20845/Random1 | 1] Failed to receive disconnect acknowledge!
[2018-12-11 01:41:33] [DEBUG]     4 | [91.108.28.38:20845/Random1 | 1] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:33] [INFO]      4 | Voice client 4751/oxpkE3d+44qDSAjRw28nhvPH1Bc= (Random1) from 91.108.28.38:20845 left.
[2018-12-11 01:41:33] [DEBUG]     4 | [5.166.234.248:64481/ETERNITY | 2] Failed to receive disconnect acknowledge!
[2018-12-11 01:41:33] [DEBUG]     4 | [5.166.234.248:64481/ETERNITY | 2] Closing voice client connection. (Flush: false)
[2018-12-11 01:41:33] [INFO]      4 | Voice client 4725/0sVYbAQt4gsC/VACJn/TBVw9gqA= (ETERNITY) from 5.166.234.248:64481 left.

WolverinDEV · Dec 11, 2018

Thanks

Actiually agfain "Just" a restart crash.
Any data loss? Should be prevented within the 31-2

REDOSS · Dec 11, 2018

WolverinDEV said:
Thanks
Actiually agfain "Just" a restart crash.
Any data loss? Should be prevented within the 31-2

Is there a problem, is there an opportunity to look? The address wrote to you in ts in private messages.

WolverinDEV · Dec 11, 2018

Hmm?
There isnt any significat problem.
Its just the shutdown process itself, which is a littlebit "buggy", but this should not effect anymore any data so its kind of okey

REDOSS · Dec 11, 2018

WolverinDEV said:
Hmm?
There isnt any significat problem.
Its just the shutdown process itself, which is a littlebit "buggy", but this should not effect anymore any data so its kind of okey

I did not know, but in any case, thanks for the help

it helped me.

WolverinDEV · Oct 13, 2019

//Closed these bugs have been fixed.
Side note: shutting down the server still may result in a crash, but its not critical

A little crash_dumps maybe something will help

REDOSS

TeaSpeak Team

Attachments

WolverinDEV

TeaSpeak Team

REDOSS

TeaSpeak Team

WolverinDEV

TeaSpeak Team

REDOSS

TeaSpeak Team

WolverinDEV

TeaSpeak Team

REDOSS

TeaSpeak Team

Attachments

WolverinDEV

TeaSpeak Team

REDOSS

TeaSpeak Team

WolverinDEV

TeaSpeak Team

REDOSS

TeaSpeak Team

WolverinDEV

TeaSpeak Team