My query client which gather statistics for munin graph's is disconnected after 10 minutes
its issuing "serverrequestconnectioninfo" every 15 seconds
linux 32 bit TS3 server version 3.0.13.2
We are migrating towards a new forum system located at community.teamspeak.com, as such this forum will become read-only on January 29, 2020
My query client which gather statistics for munin graph's is disconnected after 10 minutes
its issuing "serverrequestconnectioninfo" every 15 seconds
linux 32 bit TS3 server version 3.0.13.2
Queries are logged like this since 3.0.13:
In previous releases the number after "query from" seemed to be some kind of session number, always increased by 1 with the next connection. Since 3.0.13 this is an almost constant number in the 50ies for all sessions. It changes sometimes, but rarely. Is this a bug, or what is this number really?Code:2016-08-17 01:31:04.112060|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:38980 issued: use sid=1 2016-08-17 01:35:34.250152|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39202 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:35:34.275645|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39202 issued: use sid=4 2016-08-17 01:36:03.903263|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39204 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:36:03.928410|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39204 issued: use sid=1 2016-08-17 01:40:33.877132|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39426 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:40:33.901469|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39426 issued: use sid=4 2016-08-17 01:41:03.864226|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39428 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:41:03.885850|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39428 issued: use sid=1 2016-08-17 01:45:01.727124|INFO |Query | |query from 55 127.0.0.1:52312 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:45:01.727384|INFO |Query | |query from 55 127.0.0.1:52312 issued: serverlist -short 2016-08-17 01:45:01.733804|INFO |Query | |query from 55 127.0.0.1:52312 issued: quit 2016-08-17 01:45:02.195783|INFO |Query | |query from 55 127.0.0.1:52319 issued: use 1 2016-08-17 01:45:02.213612|INFO |Query | |query from 55 127.0.0.1:52319 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:45:03.087456|INFO |Query | |query from 55 127.0.0.1:52329 issued: use 2 2016-08-17 01:45:03.090262|INFO |Query | |query from 55 127.0.0.1:52329 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:45:03.199110|INFO |Query | |query from 55 127.0.0.1:52332 issued: use 4 2016-08-17 01:45:03.202341|INFO |Query | |query from 55 127.0.0.1:52332 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:45:03.481399|INFO |Query | |query from 55 127.0.0.1:52341 issued: use 5 2016-08-17 01:45:03.484112|INFO |Query | |query from 55 127.0.0.1:52341 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:45:33.707732|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39652 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:45:33.729357|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39652 issued: use sid=4 2016-08-17 01:46:03.698423|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39654 issued: login with account "serveradmin"(serveradmin) 2016-08-17 01:46:03.723647|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39654 issued: use sid=1 2016-08-17 01:50:33.563960|INFO |Query | |query from 55 [2001:4dd0:xxxx:xxxx:xxxx:xxxx:xxxx:xxxx]:39876 issued: login with account "serveradmin"(serveradmin)
This log is from 3.0.13.2, Linux 64-bit.
Same here. Always having 45.
Crashed again, with 3.0.13.2
This time the process didnt hang before crashing, just died from one moment to another. Once again, there are no evidences in either ts or system logs
Last lines from all the server logs
_0.log:
_1.log:Code:2016-08-19 14:41:03.082212|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-19 14:42:03.250310|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-19 14:43:03.374378|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-19 14:44:03.529726|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-19 14:45:02.450300|ERROR | | |error writing tcp socket Connection reset by peer
_3.log: (aka the main server)Code:2016-08-19 14:12:24.697065|INFO |VirtualServerBase|1 |query client disconnected 'Unknown from 94.23.235.222:55456'(id:1965) reason 'reasonmsg=disconnecting' 2016-08-19 14:17:17.098310|INFO |VirtualServer |1 |query client connected 'Unknown from 94.23.235.222:12781'(id:1965) 2016-08-19 14:17:17.351339|INFO |VirtualServerBase|1 |query client disconnected 'Unknown from 94.23.235.222:12781'(id:1965) reason 'reasonmsg=disconnecting' 2016-08-19 14:22:12.506231|INFO |VirtualServer |1 |query client connected 'Unknown from 94.23.235.222:32588'(id:1965) 2016-08-19 14:22:12.758496|INFO |VirtualServerBase|1 |query client disconnected 'Unknown from 94.23.235.222:32588'(id:1965) reason 'reasonmsg=disconnecting' 2016-08-19 14:27:06.548019|INFO |VirtualServer |1 |query client connected 'Unknown from 94.23.235.222:52379'(id:1965) 2016-08-19 14:27:06.800335|INFO |VirtualServerBase|1 |query client disconnected 'Unknown from 94.23.235.222:52379'(id:1965) reason 'reasonmsg=disconnecting' 2016-08-19 14:41:58.730114|INFO |VirtualServer |1 |query client connected 'Unknown from 94.23.235.222:50933'(id:1965) 2016-08-19 14:41:58.983146|INFO |VirtualServerBase|1 |query client disconnected 'Unknown from 94.23.235.222:50933'(id:1965) reason 'reasonmsg=disconnecting'
I decreased the frequency of the server query connections from 1 to 5 minutes in virtual server 3, because i remember an issue a couple of versions back that had to do with the amount of connections per minute. I dont remember any errors back then, but it also doesnt mean that the crashes are related to the server query issues...Code:2016-08-19 14:41:06.502483|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:33573'(id:1964) 2016-08-19 14:41:06.551420|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:33573'(id:1964) reason 'reasonmsg=deselected virtualserver' 2016-08-19 14:42:03.767155|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:33687'(id:1964) 2016-08-19 14:42:03.811092|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:33687'(id:1964) reason 'reasonmsg=deselected virtualserver' 2016-08-19 14:42:09.125623|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:33697'(id:1964) 2016-08-19 14:42:09.173424|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:33697'(id:1964) reason 'reasonmsg=deselected virtualserver' 2016-08-19 14:43:01.505360|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:33799'(id:1964) 2016-08-19 14:43:01.552917|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:33799'(id:1964) reason 'reasonmsg=deselected virtualserver' 2016-08-19 14:43:06.675781|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:33814'(id:1964) 2016-08-19 14:43:06.720979|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:33814'(id:1964) reason 'reasonmsg=deselected virtualserver' 2016-08-19 14:44:01.856583|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:33916'(id:1964) 2016-08-19 14:44:01.914622|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:33916'(id:1964) reason 'reasonmsg=deselected virtualserver' 2016-08-19 14:44:07.031313|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:33931'(id:1964) 2016-08-19 14:44:07.079862|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:33931'(id:1964) reason 'reasonmsg=deselected virtualserver' 2016-08-19 14:45:01.404290|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:34036'(id:1964) 2016-08-19 14:45:01.456428|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:34036'(id:1964) reason 'reasonmsg=deselected virtualserver'
Can i run the server in debug mode or something, so i have more details to give you?
Can you try to reproduce that with 3.0.13.3?
I take this message: |INFO | | |Error opening file: No such file or directory
I did update to the new version 3.0.13.3, but again the same....knows someone why???
Thanks for the reply
If you are talking about the errors in the log, it looks the same:
Also, those errors dont seem to be related to SQ connections (at least based on the frequency).Code:2016-08-20 08:40:16.339268|INFO |ServerLibPriv | |TeamSpeak 3 Server 3.0.13.3 (2016-08-18 16:46:43) 2016-08-20 08:40:16.339614|INFO |ServerLibPriv | |SystemInformation: Linux 3.16.0-70-generic #90~14.04.1-Ubuntu SMP Wed Apr 6 22:56:34 UTC 2016 x86_64 Binary: 64bit 2016-08-20 08:40:16.358792|INFO |DatabaseQuery | |dbPlugin name: MariaDB plugin, version 3, (c)TeamSpeak Systems GmbH 2016-08-20 08:40:16.358983|INFO |DatabaseQuery | |dbPlugin version: 2 2016-08-20 08:40:16.842550|INFO |Accounting | |Licensing Information 2016-08-20 08:40:16.842703|INFO |Accounting | |type : Non-profit 2016-08-20 08:40:16.842773|INFO |Accounting | |starting date : Sat Jun 18 00:00:00 2016 2016-08-20 08:40:16.842829|INFO |Accounting | |ending date : Wed Dec 21 00:00:00 2016 2016-08-20 08:40:16.842878|INFO |Accounting | |max virtualservers: 10 2016-08-20 08:40:16.842926|INFO |Accounting | |max slots : 512 2016-08-20 08:40:20.511545|INFO | | |Puzzle precompute time: 3379 2016-08-20 08:40:20.512254|INFO |FileManager | |listening on 0.0.0.0:30033 2016-08-20 08:40:20.807845|INFO |CIDRManager | |updated query_ip_blacklist ips: 37.59.31.160/32, 2016-08-20 08:40:20.808191|INFO |CIDRManager | |updated query_ip_whitelist ips: 127.0.0.1/32, 192.168.0.0/24, 192.168.1.0/24, 94.23.235.222/32, 2016-08-20 08:40:20.808801|INFO |Query | |listening on 0.0.0.0:10011 2016-08-20 08:43:03.386930|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-20 08:44:02.642047|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-20 08:45:03.549862|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-20 08:46:04.087229|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-20 08:47:03.090582|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-20 08:48:03.079941|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-20 08:49:02.998319|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-20 08:50:03.046300|ERROR | | |error writing tcp socket Connection reset by peer
Virtual server 1:
Virtual server 3:Code:2016-08-20 08:40:20.679396|WARNING |PermGroupMgr |1 |cldbid: 2, assigned to unknown gid: 2, ignoring! 2016-08-20 08:40:20.730843|INFO |VirtualServer |1 |listening on 0.0.0.0:9987 2016-08-20 08:41:07.426835|INFO |VirtualServer |1 |query client connected 'Unknown from 94.23.235.222:2662'(id:1965) 2016-08-20 08:41:07.679135|INFO |VirtualServerBase|1 |query client disconnected 'Unknown from 94.23.235.222:2662'(id:1965) reason 'reasonmsg=disconnecting' 2016-08-20 08:45:45.493469|INFO |VirtualServer |1 |query client connected 'Unknown from 94.23.235.222:21648'(id:1965) 2016-08-20 08:45:45.745598|INFO |VirtualServerBase|1 |query client disconnected 'Unknown from 94.23.235.222:21648'(id:1965) reason 'reasonmsg=disconnecting' 2016-08-20 08:50:21.964655|INFO |VirtualServer |1 |query client connected 'Unknown from 94.23.235.222:40401'(id:1965) 2016-08-20 08:50:22.216412|INFO |VirtualServerBase|1 |query client disconnected 'Unknown from 94.23.235.222:40401'(id:1965) reason 'reasonmsg=disconnecting'
Im waiting for the crashCode:2016-08-20 08:40:20.806502|INFO |VirtualServer |3 |listening on 0.0.0.0:9989 2016-08-20 08:45:02.001703|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:50611'(id:1964) 2016-08-20 08:45:02.046973|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:50611'(id:1964) reason 'reasonmsg=deselected virtualserver' 2016-08-20 08:45:07.164708|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:50628'(id:1964) 2016-08-20 08:45:07.208691|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:50628'(id:1964) reason 'reasonmsg=deselected virtualserver' 2016-08-20 08:50:01.352142|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:51246'(id:1964) 2016-08-20 08:50:01.399672|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:51246'(id:1964) reason 'reasonmsg=deselected virtualserver' 2016-08-20 08:50:06.710261|INFO |VirtualServer |3 |query client connected 'Unknown from 127.0.0.1:51259'(id:1964) 2016-08-20 08:50:06.753283|INFO |VirtualServerBase|3 |query client disconnected 'Unknown from 127.0.0.1:51259'(id:1964) reason 'reasonmsg=deselected virtualserver'![]()
Thanks for the tip.
I just rebooted the physical server, but it looks like it didnt work for me:
The server crashed twice yesterday also, already after the update to 3.0.13.3, so that didnt fix it eitherCode:2016-08-21 08:55:51.540922|INFO |ServerLibPriv | |TeamSpeak 3 Server 3.0.13.3 (2016-08-18 16:46:43) 2016-08-21 08:55:51.541228|INFO |ServerLibPriv | |SystemInformation: Linux 3.16.0-77-generic #99~14.04.1-Ubuntu SMP Tue Jun 28 19:17:10 UTC 2016 x86_64 Binary: 64bit 2016-08-21 08:55:51.543375|INFO |DatabaseQuery | |dbPlugin name: MariaDB plugin, version 3, (c)TeamSpeak Systems GmbH 2016-08-21 08:55:51.543560|INFO |DatabaseQuery | |dbPlugin version: 2 2016-08-21 08:55:51.948244|INFO |Accounting | |Licensing Information 2016-08-21 08:55:51.948463|INFO |Accounting | |type : Non-profit 2016-08-21 08:55:51.948590|INFO |Accounting | |starting date : Sat Jun 18 00:00:00 2016 2016-08-21 08:55:51.948695|INFO |Accounting | |ending date : Wed Dec 21 00:00:00 2016 2016-08-21 08:55:51.948790|INFO |Accounting | |max virtualservers: 10 2016-08-21 08:55:51.948882|INFO |Accounting | |max slots : 512 2016-08-21 08:55:54.912155|INFO | | |Puzzle precompute time: 2783 2016-08-21 08:55:54.913276|INFO |FileManager | |listening on 0.0.0.0:30033 2016-08-21 08:55:55.032599|INFO |CIDRManager | |updated query_ip_blacklist ips: 37.59.31.160/32, 2016-08-21 08:55:55.032780|INFO |CIDRManager | |updated query_ip_whitelist ips: 127.0.0.1/32, 192.168.0.0/24, 192.168.1.0/24, 94.23.235.222/32, 2016-08-21 08:55:55.033165|INFO |Query | |listening on 0.0.0.0:10011 2016-08-21 08:56:03.456627|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-21 08:57:03.497718|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-21 08:58:03.684725|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-21 08:59:03.864230|ERROR | | |error reading tcp socket Connection reset by peer 2016-08-21 09:00:04.008256|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-21 09:01:03.128287|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-21 09:02:03.097968|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-21 09:03:02.332820|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-21 09:04:02.921848|ERROR | | |error writing tcp socket Connection reset by peer 2016-08-21 09:05:03.609775|ERROR | | |error reading tcp socket Connection reset by peer
From all the crashes that already occurred, i can not see a pattern. All i can say is that it can happen after a day or two, or twice with a couple of hours of interval, at no specific time, with or without users connected to either virtual server, and the same constant SQ connections. Server resources are also fine, im running it basically to host the teamspeak server.
Haahahahah OMG raining two days now and today got the same message again error reading tcp socket Connection reset by peer ,also and this mess Error opening file: No such file or directory.We have not received any answer from technical(ts) Your have taken three versions in a week and all are problematic!!!This is very BAD
btw. it doesn't help your case, but in your query whitelist your have 192.168.0.0/24 and 192.168.1.0/24 ... which is a bit inconvenient. The proper CIDR notation would be 192.168.0.0/23
ahahah...
I added the second subnet when i changed my network and forgot to remove the other. Its just not supposed to be there
Are you also running linux? x86_64?
There has to be something in common here. Either almost no one updated the server to 3.0.13 or we are very unlucky...
My servers not go down,but this mess shows that something is not working properly!!!Α few users they have (connection lost) a faw 2 log and I found this:
2016-08-21 06:01:48.256914|INFO |PktHandler |1 |Dropping client 50 because of resend timeout
2016-08-21 06:01:52.301380|INFO |PktHandler |1 |Cleaning up connection because of 11 resends of COMMAND packet
2016-08-21 06:01:52.301473|INFO |PktHandler |1 |Dropping client 35 because of resend timeout
2016-08-21 06:15:24.948338|INFO |PktHandler |1 |Cleaning up connection because of 7 resends of COMMAND packet
2016-08-21 06:15:24.948523|INFO |PktHandler |1 |Dropping client 49 because of resend timeout
2016-08-21 09:37:27.578610|INFO |PktHandler |1 |Dropping client 7 because of ping timeout 19 0 0
We need to get reply from the technical
There are currently 1 users browsing this thread. (0 members and 1 guests)