High MySQL CPU Usage Bogging Down Server
-
@uwpviolator said in High MySQL CPU Usage Bogging Down Server:
I did update a handful of machines (manually) to the new FOG Client 11.14 for testing.
It’s possible the high CPU load is being caused by most of the clients being an older version. @Joe-Schmitt thoughts?
-
@wayne-workman So you’re saying because there are just a few 11.14 FOG clients? Currently the client on the Fog Server is 11.12.
-
Just checking machines now and I am finding this. So we need to reset encryption
------------------------------------------------------------------------------ ----------------------------------UserTracker--------------------------------- ------------------------------------------------------------------------------ 2/19/2018 12:40 PM Client-Info Client Version: 0.11.13 2/19/2018 12:40 PM Client-Info Client OS: Windows 2/19/2018 12:40 PM Client-Info Server Version: 1.4.4 2/19/2018 12:40 PM Middleware::Response ERROR: Unable to get subsection 2/19/2018 12:40 PM Middleware::Response ERROR: Object reference not set to an instance of an object. 2/19/2018 12:40 PM Service Sleeping for 60 seconds
-
@uwpviolator said in High MySQL CPU Usage Bogging Down Server:
Just checking machines now and I am finding this. So we need to reset encryption
Can’t hurt.
-
@wayne-workman Rest Encryption but clients could not reach server to get cert so they keep trying and trying. Killed for service via GPO and will bring back online. It has already come back under control but we will have to see come tomorrow.
-
@uwpviolator said in High MySQL CPU Usage Bogging Down Server:
clients could not reach server to get cert so they keep trying and trying.
What’s the new error in the fog.log file from one of them? Please give us the whole ‘section’ where the error is.
-
2/19/2018 11:52 AM Service Sleeping for 1241 seconds 2/19/2018 12:13 PM Middleware::Communication URL: http://fogserver/fog/management/index.php?sub=requestClientInfo&configure&newService&json 2/19/2018 12:13 PM Middleware::Communication ERROR: Could not contact FOG server 2/19/2018 12:13 PM Middleware::Communication ERROR: Unable to connect to the remote server 2/19/2018 12:13 PM Middleware::Response Success 2/19/2018 12:13 PM Service ERROR: Invalid promptTime, using default 2/19/2018 12:13 PM Middleware::Communication URL: http://fogserver/fog/management/index.php?sub=requestClientInfo&mac=10:60:4B:85:D2:35&newService&json 2/19/2018 12:14 PM Middleware::Communication ERROR: Could not contact FOG server 2/19/2018 12:14 PM Middleware::Communication ERROR: Unable to connect to the remote server 2/19/2018 12:14 PM Middleware::Response Success 2/19/2018 12:14 PM Middleware::Communication URL: http://fogserver/fog/service/getversion.php?clientver&newService&json 2/19/2018 12:14 PM Middleware::Communication URL: http://fogserver/fog/service/getversion.php?newService&json 2/19/2018 12:14 PM Service Creating user agent cache 2/19/2018 12:14 PM Middleware::Response ERROR: Unable to get subsection 2/19/2018 12:14 PM Middleware::Response ERROR: Object reference not set to an instance of an object. 2/19/2018 12:14 PM Middleware::Response ERROR: Unable to get subsection 2/19/2018 12:14 PM Middleware::Response ERROR: Object reference not set to an instance of an object. 2/19/2018 12:14 PM Middleware::Response ERROR: Unable to get subsection 2/19/2018 12:14 PM Middleware::Response ERROR: Object reference not set to an instance of an object. ------------------------------------------------------------------------------ ---------------------------------ClientUpdater-------------------------------- ------------------------------------------------------------------------------ 2/19/2018 12:14 PM Client-Info Client Version: 0.11.12 2/19/2018 12:14 PM Client-Info Client OS: Windows 2/19/2018 12:14 PM Client-Info Server Version: 1.4.4 2/19/2018 12:14 PM Middleware::Response Success 2/19/2018 12:14 PM ClientUpdater ERROR: Unable to parse versions 2/19/2018 12:14 PM ClientUpdater ERROR: Input string was not in a correct format. ------------------------------------------------------------------------------ ------------------------------------------------------------------------------ ----------------------------------TaskReboot---------------------------------- ------------------------------------------------------------------------------ 2/19/2018 12:14 PM Client-Info Client Version: 0.11.12 2/19/2018 12:14 PM Client-Info Client OS: Windows 2/19/2018 12:14 PM Client-Info Server Version: 1.4.4 2/19/2018 12:14 PM Middleware::Response ERROR: Unable to get subsection 2/19/2018 12:14 PM Middleware::Response ERROR: Object reference not set to an instance of an object. ------------------------------------------------------------------------------ --------------------------------HostnameChanger------------------------------- ------------------------------------------------------------------------------ 2/19/2018 12:14 PM Client-Info Client Version: 0.11.12 2/19/2018 12:14 PM Client-Info Client OS: Windows 2/19/2018 12:14 PM Client-Info Server Version: 1.4.4 2/19/2018 12:14 PM Middleware::Response ERROR: Unable to get subsection 2/19/2018 12:14 PM Middleware::Response ERROR: Object reference not set to an instance of an object. ------------------------------------------------------------------------------ ---------------------------------SnapinClient--------------------------------- ------------------------------------------------------------------------------ 2/19/2018 12:14 PM Client-Info Client Version: 0.11.12 2/19/2018 12:14 PM Client-Info Client OS: Windows 2/19/2018 12:14 PM Client-Info Server Version: 1.4.4 2/19/2018 12:14 PM Middleware::Response ERROR: Unable to get subsection 2/19/2018 12:14 PM Middleware::Response ERROR: Object reference not set to an instance of an object. ------------------------------------------------------------------------------ --------------------------------PrinterManager-------------------------------- ------------------------------------------------------------------------------ 2/19/2018 12:14 PM Client-Info Client Version: 0.11.12 2/19/2018 12:14 PM Client-Info Client OS: Windows 2/19/2018 12:14 PM Client-Info Server Version: 1.4.4 2/19/2018 12:14 PM Middleware::Response ERROR: Unable to get subsection 2/19/2018 12:14 PM Middleware::Response ERROR: Object reference not set to an instance of an object. ------------------------------------------------------------------------------ --------------------------------PowerManagement------------------------------- ------------------------------------------------------------------------------ 2/19/2018 12:14 PM Client-Info Client Version: 0.11.12 2/19/2018 12:14 PM Client-Info Client OS: Windows 2/19/2018 12:14 PM Client-Info Server Version: 1.4.4 2/19/2018 12:14 PM Middleware::Response ERROR: Unable to get subsection 2/19/2018 12:14 PM Middleware::Response ERROR: Object reference not set to an instance of an object. ------------------------------------------------------------------------------ ----------------------------------UserTracker--------------------------------- ------------------------------------------------------------------------------ 2/19/2018 12:14 PM Client-Info Client Version: 0.11.12 2/19/2018 12:14 PM Client-Info Client OS: Windows 2/19/2018 12:14 PM Client-Info Server Version: 1.4.4 2/19/2018 12:14 PM Middleware::Response ERROR: Unable to get subsection 2/19/2018 12:14 PM Middleware::Response ERROR: Object reference not set to an instance of an object. 2/19/2018 12:14 PM Service Sleeping for 60 seconds 2/19/2018 12:15 PM Middleware::Communication URL: http://fogserver/fog/management/index.php?sub=requestClientInfo&configure&newService&json 2/19/2018 12:16 PM Middleware::Response Success 2/19/2018 12:16 PM Middleware::Communication URL: http://fogserver/fog/management/index.php?sub=requestClientInfo&mac=10:60:4B:85:D2:35&newService&json 2/19/2018 12:17 PM Middleware::Response Success 2/19/2018 12:17 PM Middleware::Communication URL: http://fogserver/fog/service/getversion.php?clientver&newService&json 2/19/2018 12:17 PM Middleware::Communication URL: http://fogserver/fog/service/getversion.php?newService&json 2/19/2018 12:17 PM Service Creating user agent cache 2/19/2018 12:17 PM Middleware::Response Module is disabled globally on the FOG server 2/19/2018 12:17 PM Middleware::Response Module is disabled on the host 2/19/2018 12:17 PM Middleware::Response Module is disabled globally on the FOG server
-
@uwpviolator said in High MySQL CPU Usage Bogging Down Server:
Can you actually access your FOG Server with that address?
http://fogserver/fog/management -
@wayne-workman Yes but this only after we killed the FOG service on clients. That freed up the CPU to start allowing clients to authenticate again.
-
@uwpviolator I see. Can you check your Apache error log for problems?
-
[Mon Feb 19 13:13:08.200450 2018] [php7:warn] [pid 4912] [client 10.120.151.193:61680] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.128957 2018] [php7:warn] [pid 4277] [client 10.129.150.173:60025] PHP Warning: PDOStatement::execute(): MySQL server has gone away in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.205088 2018] [php7:warn] [pid 4277] [client 10.129.150.173:60025] PHP Warning: PDOStatement::execute(): Error reading result set's header in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.210500 2018] [php7:warn] [pid 4277] [client 10.129.150.173:60025] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.220202 2018] [php7:warn] [pid 2671] [client 10.121.150.77:53345] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.231038 2018] [php7:warn] [pid 4943] [client 10.116.1.137:50185] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.319301 2018] [php7:warn] [pid 4987] [client 10.113.150.174:54611] PHP Warning: PDOStatement::execute(): MySQL server has gone away in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.319336 2018] [php7:warn] [pid 4987] [client 10.113.150.174:54611] PHP Warning: PDOStatement::execute(): Error reading result set's header in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.339659 2018] [php7:warn] [pid 3850] [client 10.92.150.14:62267] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.359975 2018] [php7:warn] [pid 4291] [client 10.120.1.122:56845] PHP Warning: PDOStatement::execute(): MySQL server has gone away in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.360012 2018] [php7:warn] [pid 4291] [client 10.120.1.122:56845] PHP Warning: PDOStatement::execute(): Error reading result set's header in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.364681 2018] [php7:warn] [pid 3722] [client 10.121.150.67:62773] PHP Warning: PDOStatement::execute(): MySQL server has gone away in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.364715 2018] [php7:warn] [pid 3722] [client 10.121.150.67:62773] PHP Warning: PDOStatement::execute(): Error reading result set's header in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.377304 2018] [php7:warn] [pid 4987] [client 10.113.150.174:54611] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.425173 2018] [php7:warn] [pid 4564] [client 10.106.150.74:61776] PHP Warning: PDOStatement::execute(): MySQL server has gone away in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.425219 2018] [php7:warn] [pid 4564] [client 10.106.150.74:61776] PHP Warning: PDOStatement::execute(): Error reading result set's header in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.428607 2018] [php7:warn] [pid 4564] [client 10.106.150.74:61776] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.441358 2018] [php7:warn] [pid 1095] [client 10.129.150.221:50776] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.562152 2018] [php7:warn] [pid 3722] [client 10.121.150.67:62773] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.436269 2018] [php7:warn] [pid 4291] [client 10.120.1.122:56845] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.602369 2018] [php7:warn] [pid 3848] [client 10.103.1.26:51877] PHP Warning: array_combine(): Both parameters should have an equal number of elements in /var/www/html/fog/lib/fog/fogbase.class.php on line 1029 [Mon Feb 19 13:13:08.618425 2018] [php7:warn] [pid 4738] [client 10.106.151.97:51232] PHP Warning: PDOStatement::execute(): MySQL server has gone away in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.618477 2018] [php7:warn] [pid 4738] [client 10.106.151.97:51232] PHP Warning: PDOStatement::execute(): Error reading result set's header in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.642636 2018] [php7:warn] [pid 4565] [client 10.75.1.49:51793] PHP Warning: PDOStatement::execute(): MySQL server has gone away in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.642677 2018] [php7:warn] [pid 4565] [client 10.75.1.49:51793] PHP Warning: PDOStatement::execute(): Error reading result set's header in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.684912 2018] [php7:warn] [pid 4299] [client 10.116.151.206:56595] PHP Warning: PDOStatement::execute(): MySQL server has gone away in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:08.684974 2018] [php7:warn] [pid 4299] [client 10.116.151.206:56595] PHP Warning: PDOStatement::execute(): Error reading result set's header in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:09.096405 2018] [php7:warn] [pid 3858] [client 10.105.150.66:55526] PHP Warning: PDOStatement::execute(): MySQL server has gone away in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:09.096461 2018] [php7:warn] [pid 3858] [client 10.105.150.66:55526] PHP Warning: PDOStatement::execute(): Error reading result set's header in /var/www/html/fog/lib/db/pdodb.class.php on line 582 [Mon Feb 19 13:13:09.299891 2018] [php7:error] [pid 1236] [client 10.107.1.19:44883] PHP Fatal error: Uncaught Error: Call to a member function lastInsertId() on boolean in /var/www/html/fog/lib/db/pdodb.class.php:443\nStack trace:\n#0 /var/www/html/fog/lib/fog/fogcontroller.class.php(527): PDODB->insertId()\n#1 /var/www/html/fog/lib/fog/hookmanager.class.php(59): FOGController->save()\n#2 /var/www/html/fog/lib/fog/bootmenu.class.php(1157): HookManager->processEvent('IPXE_EDIT', Array)\n#3 /var/www/html/fog/lib/fog/bootmenu.class.php(197): BootMenu->_parseMe(Array)\n#4 /var/www/html/fog/service/ipxe/boot.php(35): BootMenu->__construct(Object(Host))\n#5 {main}\n thrown in /var/www/html/fog/lib/db/pdodb.class.php on line 443 [Mon Feb 19 13:13:09.883195 2018] [php7:error] [pid 3886] [client 10.88.1.67:52314] PHP Fatal error: Uncaught Error: Call to a member function lastInsertId() on boolean in /var/www/html/fog/lib/db/pdodb.class.php:443\nStack trace:\n#0 /var/www/html/fog/lib/fog/fogcontroller.class.php(527): PDODB->insertId()\n#1 /var/www/html/fog/lib/fog/hookmanager.class.php(59): FOGController->save()\n#2 /var/www/html/fog/lib/fog/bootmenu.class.php(1157): HookManager->processEvent('IPXE_EDIT', Array)\n#3 /var/www/html/fog/lib/fog/bootmenu.class.php(197): BootMenu->_parseMe(Array)\n#4 /var/www/html/fog/service/ipxe/boot.php(35): BootMenu->__construct(Object(Host))\n#5 {main}\n thrown in /var/www/html/fog/lib/db/pdodb.class.php on line 443 [Mon Feb 19 13:13:10.104024 2018] [php7:error] [pid 3977] [client 10.84.1.2:54487] PHP Fatal error: Uncaught Error: Call to a member function lastInsertId() on boolean in /var/www/html/fog/lib/db/pdodb.class.php:443\nStack trace:\n#0 /var/www/html/fog/lib/fog/fogcontroller.class.php(527): PDODB->insertId()\n#1 /var/www/html/fog/lib/fog/hookmanager.class.php(59): FOGController->save()\n#2 /var/www/html/fog/lib/fog/bootmenu.class.php(1157): HookManager->processEvent('IPXE_EDIT', Array)\n#3 /var/www/html/fog/lib/fog/bootmenu.class.php(197): BootMenu->_parseMe(Array)\n#4 /var/www/html/fog/service/ipxe/boot.php(35): BootMenu->__construct(Object(Host))\n#5 {main}\n thrown in /var/www/html/fog/lib/db/pdodb.class.php on line 443 [Mon Feb 19 13:14:25.954217 2018] [core:warn] [pid 982] AH00045: child process 3981 still did not exit, sending a SIGTERM [Mon Feb 19 13:14:27.961702 2018] [core:warn] [pid 982] AH00045: child process 3981 still did not exit, sending a SIGTERM [Mon Feb 19 13:14:29.963817 2018] [core:warn] [pid 982] AH00045: child process 3981 still did not exit, sending a SIGTERM [Mon Feb 19 13:14:31.965940 2018] [core:error] [pid 982] AH00046: child process 3981 still did not exit, sending a SIGKILL [Mon Feb 19 13:14:32.970135 2018] [mpm_prefork:notice] [pid 982] AH00169: caught SIGTERM, shutting down [Mon Feb 19 13:14:33.576263 2018] [mpm_prefork:notice] [pid 15054] AH00163: Apache/2.4.29 (Ubuntu) OpenSSL/1.1.0g configured -- resuming normal operations [Mon Feb 19 13:14:33.576327 2018] [core:notice] [pid 15054] AH00094: Command line: '/usr/sbin/apache2' [Mon Feb 19 13:15:44.013030 2018] [mpm_prefork:error] [pid 15054] AH00161: server reached MaxRequestWorkers setting, consider raising the MaxRequestWorkers setting
-
@uwpviolator said in High MySQL CPU Usage Bogging Down Server:
PDOStatement::execute(): MySQL server has gone away in /var/www/html/fog/lib/db/pdodb.class.php on line 582
MySQL might be crashing - or running out of buffer space or ram. What’s your max clients set at? Max packet size? Those are mysql settings.
-
One log shows .11.12 and the other shows 0.11.14, are you getting logs from the same machine?
-
@wayne-workman Our mpm_prefork.conf
# prefork MPM # StartServers: number of server processes to start # MinSpareServers: minimum number of server processes which are kept spare # MaxSpareServers: maximum number of server processes which are kept spare # MaxRequestWorkers: maximum number of server processes allowed to start # MaxConnectionsPerChild: maximum number of requests a server process serves <IfModule mpm_prefork_module> StartServers 10 MinSpareServers 8 MaxSpareServers 15 MaxRequestWorkers 500 ServerLimit 500 MaxConnectionsPerChild 0 </IfModule> # vim: syntax=apache ts=4 sw=4 sts=4 sr noet
-
@tom-elliott No.
Been working on getting Windows 1709 working with FOG. Put the new client on about 30 machines to test last week. Our admin doesnt want to update FOG until there is a stable release. Was told I could have 11.14 in my environment but my server only has 11.12 on it. Have not added it to push out.
-
@wayne-workman I upped max connections to 1000 today. Before it was 500
Maximum number of connections 1000
Query cache size in bytes 256MB
Maximum packet size 16MBEverything else is default
-
@uwpviolator I understand just wondering why were seeing three logs from different machines. I’ve seen versions 0.11.12 0.11.13 and 0.11.14.
I’m just trying to get information. I doubt the version client you’re running is the problem. Maybe client checkin time is too low?
-
@tom-elliott No our admin just upped that on Friday to.
-
@uwpviolator This would retrieve logs for MySQL:
journalctl -u mysql.service
Or if using mariadb:journalctl -u mariadb.service
Anything interesting in there? Use your arrow keys to navigate up/down/left/right. -
@wayne-workman said in High MySQL CPU Usage Bogging Down Server:
journalctl -u mariadb.service
Nope it just says start and stop service.
-- Logs begin at Mon 2018-02-19 12:13:31 CST, end at Mon 2018-02-19 15:24:26 CST. -- Feb 19 12:13:33 FogDB systemd[1]: Starting MySQL Community Server... Feb 19 12:13:37 FogDB systemd[1]: Started MySQL Community Server. Feb 19 13:13:01 FogDB systemd[1]: Stopping MySQL Community Server... Feb 19 13:13:08 FogDB systemd[1]: Stopped MySQL Community Server. Feb 19 13:13:08 FogDB systemd[1]: Starting MySQL Community Server... Feb 19 13:13:10 FogDB systemd[1]: Started MySQL Community Server.