Unable to get subsection and error: (500)

Curtis Allworth · May 12, 2016, 10:17 PM

I’m on 7597 on CentOS 6.7 with client 0.10.6 and I’m seeing the following errors in my client logs…

 5/12/2016 3:10 PM Main Overriding exception handling
 5/12/2016 3:10 PM Main Bootstrapping Zazzles
 5/12/2016 3:10 PM Controller Initialize
 5/12/2016 3:10 PM Entry Creating obj
 5/12/2016 3:10 PM Controller Start

 5/12/2016 3:10 PM Service Starting service
 5/12/2016 3:10 PM Bus Became bus server
 5/12/2016 3:10 PM Bus {
  "self": true,
  "channel": "Status",
  "data": "{\r\n  \"action\": \"load\"\r\n}"
}
 5/12/2016 3:10 PM Bus Emmiting message on channel: Status

------------------------------------------------------------------------------
--------------------------------Authentication--------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:10 PM Client-Info Version: 0.10.6
 5/12/2016 3:10 PM Client-Info OS:      Windows
 5/12/2016 3:10 PM Middleware::Authentication Waiting for authentication timeout to pass
 5/12/2016 3:10 PM Middleware::Communication Download: http://192.168.6.10/fog/management/other/ssl/srvpublic.crt
 5/12/2016 3:10 PM Data::RSA FOG Server CA cert found
 5/12/2016 3:10 PM Middleware::Authentication Cert OK
 5/12/2016 3:10 PM Middleware::Communication POST URL: http://192.168.6.10/fog/management/index.php?sub=requestClientInfo&authorize&newService
 5/12/2016 3:10 PM Middleware::Response Success
 5/12/2016 3:10 PM Middleware::Authentication Authenticated


 5/12/2016 3:10 PM Bus Registering ParseBus in channel Power
 5/12/2016 3:10 PM Middleware::Communication URL: http://192.168.6.10/fog/management/index.php?sub=requestClientInfo&mac=F0:4D:A2:FA:62:9D||00:00:00:00:00:00:00:E0&newService&json
 5/12/2016 3:10 PM Middleware::Communication ERROR: Could not contact FOG server
 5/12/2016 3:10 PM Middleware::Communication ERROR: The remote server returned an error: (500) Internal Server Error.
 5/12/2016 3:10 PM Middleware::Response Success
 5/12/2016 3:10 PM Middleware::Communication URL: http://192.168.6.10/fog/service/getversion.php?clientver&newService&json
 5/12/2016 3:10 PM Middleware::Communication URL: http://192.168.6.10/fog/service/getversion.php?newService&json

 5/12/2016 3:10 PM Service Creating user agent cache
 5/12/2016 3:10 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:10 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:10 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:10 PM Middleware::Response ERROR: Object reference not set to an instance of an object.

------------------------------------------------------------------------------
---------------------------------ClientUpdater--------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:10 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:10 PM Client-Info Client OS:      Windows
 5/12/2016 3:10 PM Client-Info Server Version: 7597
 5/12/2016 3:10 PM Middleware::Response Success
------------------------------------------------------------------------------


------------------------------------------------------------------------------
----------------------------------TaskReboot----------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:10 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:10 PM Client-Info Client OS:      Windows
 5/12/2016 3:10 PM Client-Info Server Version: 7597
 5/12/2016 3:10 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:10 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:10 PM Service ERROR: Unable to run module
 5/12/2016 3:10 PM Service ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------


------------------------------------------------------------------------------
--------------------------------HostnameChanger-------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:10 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:10 PM Client-Info Client OS:      Windows
 5/12/2016 3:10 PM Client-Info Server Version: 7597
 5/12/2016 3:10 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:10 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:10 PM Service ERROR: Unable to run module
 5/12/2016 3:10 PM Service ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------


------------------------------------------------------------------------------
---------------------------------SnapinClient---------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:10 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:10 PM Client-Info Client OS:      Windows
 5/12/2016 3:10 PM Client-Info Server Version: 7597
 5/12/2016 3:10 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:10 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:10 PM Service ERROR: Unable to run module
 5/12/2016 3:10 PM Service ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------


------------------------------------------------------------------------------
--------------------------------PrinterManager--------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:10 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:10 PM Client-Info Client OS:      Windows
 5/12/2016 3:10 PM Client-Info Server Version: 7597
 5/12/2016 3:10 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:10 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:10 PM Service ERROR: Unable to run module
 5/12/2016 3:10 PM Service ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------


------------------------------------------------------------------------------
-----------------------------------GreenFOG-----------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:10 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:10 PM Client-Info Client OS:      Windows
 5/12/2016 3:10 PM Client-Info Server Version: 7597
 5/12/2016 3:10 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:10 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:10 PM Service ERROR: Unable to run module
 5/12/2016 3:10 PM Service ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------


------------------------------------------------------------------------------
----------------------------------UserTracker---------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:10 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:10 PM Client-Info Client OS:      Windows
 5/12/2016 3:10 PM Client-Info Server Version: 7597
 5/12/2016 3:10 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:10 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:10 PM Middleware::Communication URL: http://192.168.6.10/fog/service/usertracking.report.php?action=login&user=KWCS_WS_XXX\zadmin&mac=F0:4D:A2:FA:62:9D||00:00:00:00:00:00:00:E0&newService&json
------------------------------------------------------------------------------

 5/12/2016 3:10 PM Middleware::Communication URL: http://192.168.6.10/fog/management/index.php?sub=requestClientInfo&configure&newService&json
 5/12/2016 3:10 PM Middleware::Response Success
 5/12/2016 3:10 PM Service Sleeping for 71 seconds
 5/12/2016 3:11 PM Middleware::Communication URL: http://192.168.6.10/fog/management/index.php?sub=requestClientInfo&mac=F0:4D:A2:FA:62:9D||00:00:00:00:00:00:00:E0&newService&json
 5/12/2016 3:11 PM Middleware::Communication ERROR: Could not contact FOG server
 5/12/2016 3:11 PM Middleware::Communication ERROR: The remote server returned an error: (500) Internal Server Error.
 5/12/2016 3:11 PM Middleware::Response Success
 5/12/2016 3:11 PM Middleware::Communication URL: http://192.168.6.10/fog/service/getversion.php?clientver&newService&json
 5/12/2016 3:11 PM Middleware::Communication URL: http://192.168.6.10/fog/service/getversion.php?newService&json

 5/12/2016 3:11 PM Service Creating user agent cache
 5/12/2016 3:11 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:11 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:11 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:11 PM Middleware::Response ERROR: Object reference not set to an instance of an object.

------------------------------------------------------------------------------
---------------------------------ClientUpdater--------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:11 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:11 PM Client-Info Client OS:      Windows
 5/12/2016 3:11 PM Client-Info Server Version: 7597
 5/12/2016 3:11 PM Middleware::Response Success
------------------------------------------------------------------------------


------------------------------------------------------------------------------
----------------------------------TaskReboot----------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:11 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:11 PM Client-Info Client OS:      Windows
 5/12/2016 3:11 PM Client-Info Server Version: 7597
 5/12/2016 3:11 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:11 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:11 PM Service ERROR: Unable to run module
 5/12/2016 3:11 PM Service ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------


------------------------------------------------------------------------------
--------------------------------HostnameChanger-------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:11 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:11 PM Client-Info Client OS:      Windows
 5/12/2016 3:11 PM Client-Info Server Version: 7597
 5/12/2016 3:11 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:11 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:11 PM Service ERROR: Unable to run module
 5/12/2016 3:11 PM Service ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------


------------------------------------------------------------------------------
---------------------------------SnapinClient---------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:11 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:11 PM Client-Info Client OS:      Windows
 5/12/2016 3:11 PM Client-Info Server Version: 7597
 5/12/2016 3:11 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:11 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:11 PM Service ERROR: Unable to run module
 5/12/2016 3:11 PM Service ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------


------------------------------------------------------------------------------
--------------------------------PrinterManager--------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:11 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:11 PM Client-Info Client OS:      Windows
 5/12/2016 3:11 PM Client-Info Server Version: 7597
 5/12/2016 3:11 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:11 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:11 PM Service ERROR: Unable to run module
 5/12/2016 3:11 PM Service ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------


------------------------------------------------------------------------------
-----------------------------------GreenFOG-----------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:11 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:11 PM Client-Info Client OS:      Windows
 5/12/2016 3:11 PM Client-Info Server Version: 7597
 5/12/2016 3:11 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:11 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
 5/12/2016 3:11 PM Service ERROR: Unable to run module
 5/12/2016 3:11 PM Service ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------


------------------------------------------------------------------------------
----------------------------------UserTracker---------------------------------
------------------------------------------------------------------------------
 5/12/2016 3:11 PM Client-Info Client Version: 0.10.6
 5/12/2016 3:11 PM Client-Info Client OS:      Windows
 5/12/2016 3:11 PM Client-Info Server Version: 7597
 5/12/2016 3:11 PM Middleware::Response ERROR: Unable to get subsection
 5/12/2016 3:11 PM Middleware::Response ERROR: Object reference not set to an instance of an object.
------------------------------------------------------------------------------

 5/12/2016 3:11 PM Middleware::Communication URL: http://192.168.6.10/fog/management/index.php?sub=requestClientInfo&configure&newService&json
 5/12/2016 3:11 PM Middleware::Response Success
 5/12/2016 3:11 PM Service Sleeping for 80 seconds

Could my problem be related to this one? https://forums.fogproject.org/topic/7382/fogservice-errors-for-all-modules

Tom Elliott · May 12, 2016, 10:27 PM

I don’t think it’s related. What’s in your apache error logs?

Curtis Allworth · May 12, 2016, 10:48 PM

I’m seeing the following in the Apache error log…

[Thu May 12 15:10:39 2016] [error] [client 192.168.6.105] PHP Fatal error: Function name must be a string in /var/www/html/fog/lib/client/printerclient.class.php on line 7
[Thu May 12 15:10:13 2016] [error] [client 192.168.6.105] PHP Fatal error: Function name must be a string in /var/www/html/fog/lib/client/printerclient.class.php on line 7
[Thu May 12 15:09:56 2016] [error] [client 192.168.6.104] PHP Warning: array_map(): An error occurred while invoking the map callback in /var/www/html/fog/lib/fog/fogcontroller.class.php on line 197, referer: http://fogsrvr.vanfcog.org/fog/management/index.php?node=host&sub=edit&id=138
[Thu May 12 15:01:09 2016] [error] [client 192.168.6.105] File does not exist: /var/www/html/favicon.ico, referer: http://fogsrvr/fog/project
[Thu May 12 15:01:09 2016] [error] [client 192.168.6.105] File does not exist: /var/www/html/fog/project
[Thu May 12 14:57:41 2016] [error] [client 192.168.6.105] PHP Fatal error: Function name must be a string in /var/www/html/fog/lib/client/printerclient.class.php on line 7
[Thu May 12 14:55:49 2016] [error] [client 192.168.6.105] PHP Fatal error: Function name must be a string in /var/www/html/fog/lib/client/printerclient.class.php on line 7
[Thu May 12 14:54:21 2016] [error] [client 192.168.6.105] PHP Fatal error: Function name must be a string in /var/www/html/fog/lib/client/printerclient.class.php on line 7

Of those errors the “PHP Fatal error: Function name must be a string in /var/www/html/fog/lib/client/printerclient.class.php on line 7” appears in the log probably a few hundred times.

Tom Elliott · May 12, 2016, 11:14 PM

@Curtis-Allworth Please update and try again, should work.

Curtis Allworth · May 13, 2016, 12:13 AM

@Tom-Elliott Thank you so much! That resolved it.

MadsMagnus · May 27, 2016, 12:43 PM

@Tom-Elliott

I am getting this error too. When you say update, do you mean the server or client services?

Tom Elliott · May 27, 2016, 12:48 PM

@MadsMagnus If the server is giving this issue (which it is), then update the server.

MadsMagnus · May 27, 2016, 12:54 PM

@Tom-Elliott

I see nothing in my apache2 log since monday… Quite strange.

Tom Elliott · May 27, 2016, 1:03 PM

@MadsMagnus What do you mean?

Did you update?

MadsMagnus · May 27, 2016, 1:03 PM

@Tom-Elliott

Literally my apache2 log does not have a new post since monday… A lot has happened since monday ^^ But I probably got the FOG server running properly there.

I will snapshot my VM and give it an update.

Greg Plamondon · May 27, 2016, 2:38 PM

@Tom-Elliott said in Unable to get subsection and error: (500):

@MadsMagnus If the server is giving this issue (which it is), then update the server.

Worked for me, Thanks.

MadsMagnus · May 30, 2016, 8:15 AM

@Tom-Elliott

Server updated to 7907 but still the same… Does the newest trunk have an updated FOGservice aswell?

Unable to get subsection
Object reference not set to an instance of an object
Unable to run module
Object reference not set to an instance of an object

Joe Schmitt · May 30, 2016, 4:26 PM

@MadsMagnus, the client hasn’t been updated yet. I verified and the latest revision (7931) sends all of the correct data to the client. 7907 should as well. More than likely there’s and Authentication section in your fog.log file which will state it failed to authenticate (probably an invalid security token). Try “Resetting Encryption Data” for the computer having this issue?

MadsMagnus · May 31, 2016, 8:39 AM

@Joe-Schmitt

Not exactly sure what you mean by that.

But I do see this in the log:
Authentication ERROR: Could not get security token
Authentication ERROR: Could not find file C:\Program Files (x86)\FOG\token.dat

URfog · May 31, 2016, 8:58 AM

Same for me

Version 7937 Debian 8

Wayne Workman · Jun 7, 2016, 9:01 AM

@MadsMagnus The “reset encryption” can be done from the host’s general menu, it’s a huge button at the top that says “reset encryption data”. You can also do this via groups using the same method.

MadsMagnus · Jun 7, 2016, 9:01 AM

@Wayne-Workman

This worked perfectly. Now the log just says:

“Users still logged in and enforce is disabled, delaying any further actions”

I cannot seem to find a solution to this, let alone understand what they mean by “enforce”

URfog · Jun 7, 2016, 10:44 AM

I use FOG_ENFORCE_HOST_CHANGES in the Active Directory Defaults Section.

Perhaps that …

MadsMagnus · Jun 7, 2016, 11:15 AM

@URfog

Yeah maybe it will work if I am part of an AD, but the machine I am testing this on is the Windows image - so no AD for this bad boy.

Wayne Workman · Jun 7, 2016, 6:55 AM

Asking @joe-schmitt to take a second look. In the mean time, @MadsMagnus please post a newer log.

Unable to get subsection and error: (500)

212

12.0k

17.3k

155.2k