2015-07-09 11:36:18 425.511  5658 NXSERVER Updating NX_FEATURES and NX_VERSION because it wasn't given by parent.
2015-07-09 11:36:18 430.024  5658 NXSERVER Updating environment: setting up NX_FEATURES.
2015-07-09 11:36:18 430.125  5658 NXSERVER New value: myhost11,VMwareInc.VMwareVirtualPlatform,Linux,Ubuntu,3.13.0,x86_64,2,3956285440,311
2015-07-09 11:36:18 430.248  5658 NXSERVER Updating environment: setting up NX_VERSION
2015-07-09 11:36:18 430.337  5658 NXSERVER New value: 4.6.4
2015-07-09 11:36:18 430.960  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/uuid with mode 0 and permissions 0 from Server::getMyUUID.
2015-07-09 11:36:18 431.102  5658 NXSERVER NXClose FD#9 from Server::getMyUUID.
2015-07-09 11:36:18 431.170  5658 NXSERVER Got uuid from file befa52d5-2c24-40f5-b084-7faaa2bfc849.
2015-07-09 11:36:18 459.142  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/nodes.db.lock with mode 1089 and permissions 420 from main::lockFile.
2015-07-09 11:36:18 459.450  5658 NXSERVER nxflock: NXPL::NXFileLock(9, 1) returned '1'.
2015-07-09 11:36:18 459.616  5658 NXSERVER NXOpen FD#10 - file /usr/NX/etc/nodes.db with mode 0 and permissions 0 from NXNodes::reloadNodesDB.
2015-07-09 11:36:18 459.879  5658 NXSERVER NXClose FD#10 from NXNodes::reloadNodesDB.
2015-07-09 11:36:18 460.033  5658 NXSERVER NXClose FD#9 from main::unLockFile.
2015-07-09 11:36:18 460.269  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/groups.db.lock with mode 1089 and permissions 420 from main::lockFile.
2015-07-09 11:36:18 460.416  5658 NXSERVER nxflock: NXPL::NXFileLock(9, 1) returned '1'.
2015-07-09 11:36:18 460.566  5658 NXSERVER NXOpen FD#10 - file /usr/NX/etc/groups.db with mode 0 and permissions 0 from NXGroups::init.
2015-07-09 11:36:18 460.727  5658 NXSERVER NXClose FD#10 from NXGroups::init.
2015-07-09 11:36:18 460.864  5658 NXSERVER NXClose FD#9 from main::unLockFile.
2015-07-09 11:36:18 461.023  5658 NXSERVER NXCluster database doesn't exist.
2015-07-09 11:36:18 461.510  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 461.884  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/server.lic with mode 0 and permissions 0 from NXLicense::readLicenseFile.
2015-07-09 11:36:18 462.118  5658 NXSERVER NXClose FD#9 from NXLicense::readLicenseFile.
2015-07-09 11:36:18 462.749  5658 NXSERVER Loading profiles DB.
2015-07-09 11:36:18 462.919  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/profiles.db.lock with mode 1089 and permissions 420 from main::lockFile.
2015-07-09 11:36:18 463.046  5658 NXSERVER nxflock: NXPL::NXFileLock(9, 1) returned '1'.
2015-07-09 11:36:18 463.192  5658 NXSERVER NXOpen FD#10 - file /usr/NX/etc/profiles.db with mode 0 and permissions 0 from NXProfilesDB::__load.
2015-07-09 11:36:18 463.369  5658 NXSERVER NXClose FD#10 from NXProfilesDB::__load.
2015-07-09 11:36:18 463.509  5658 NXSERVER NXClose FD#9 from main::unLockFile.
2015-07-09 11:36:18 463.766  5658 NXSERVER parse_nx_command: test,5653,noloop,
2015-07-09 11:36:18 463.891  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 464.140  5658 NXSERVER Checking NXCluster feature.
2015-07-09 11:36:18 464.330  5658 NXSERVER NXCluster: disabled by config.
2015-07-09 11:36:18 464.698  5658 NXSERVER Sent request message 'NX> 105 '
2015-07-09 11:36:18 465.475  5658 NXSERVER NXParser: signal 'CHLD' received.
2015-07-09 11:36:18 465.630  5658 NXSERVER Received 'SIGCHLD' signal:going to handle it
2015-07-09 11:36:18 465.754  5658 NXSERVER handleSIGCHLD
2015-07-09 11:36:18 468.139  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 468.405  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 468.648  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 468.864  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 469.079  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 469.308  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 469.520  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 469.731  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 469.941  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 470.151  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 470.380  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 470.592  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 470.802  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 471.012  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 471.293  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 471.505  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 471.734  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 471.973  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 472.217  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 472.445  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 472.688  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 472.920  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 473.147  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 473.388  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 473.807  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 474.022  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 474.233  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 474.488  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 474.716  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 474.927  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 475.137  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 475.345  5658 NXSERVER received response 'hello NXCLIENT - Version 4.6.4'
2015-07-09 11:36:18 475.626  5658 NXSERVER Checking NXCluster feature.
2015-07-09 11:36:18 475.749  5658 NXSERVER NXCluster: disabled by config.
2015-07-09 11:36:18 475.893  5658 NXSERVER no user currently logged in
2015-07-09 11:36:18 476.049  5658 NXSERVER User not yet authorized to access.
2015-07-09 11:36:18 476.303  5658 NXSERVER Client set to  - ..
2015-07-09 11:36:18 476.569  5658 NXSERVER NXShell: bye means silent exit.
2015-07-09 11:36:18 476.719  5658 NXSERVER Checking NXCluster feature.
2015-07-09 11:36:18 476.836  5658 NXSERVER NXCluster: disabled by config.
2015-07-09 11:36:18 477.039  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/hosts.db with mode 0 and permissions 0 from main::getClientRedirect.
2015-07-09 11:36:18 477.244  5658 NXSERVER NXClose FD#9 from main::getClientRedirect.
2015-07-09 11:36:18 477.375  5658 NXSERVER Cannot be found client IP: '10.10.106.83' in hosts.db.
2015-07-09 11:36:18 477.593  5658 NXSERVER Sent response message 'NX> 134 Accepted protocol: 4.6.4'
2015-07-09 11:36:18 477.740  5658 NXSERVER Checking ignore message for command 'hello'.
2015-07-09 11:36:18 477.867  5658 NXSERVER Dont have to send ignore message.
2015-07-09 11:36:18 477.985  5658 NXSERVER Request for disconnect never sent to main server.
2015-07-09 11:36:18 478.150  5658 NXSERVER Timestamp 'Command hello' time passed '0.002' seconds. 
2015-07-09 11:36:18 478.284  5658 NXSERVER Finished handling command 'hello' after 0.002 seconds.
2015-07-09 11:36:18 478.474  5658 NXSERVER Sent request message 'NX> 105 '
2015-07-09 11:36:18 482.375  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 482.610  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 482.829  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 483.044  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 483.294  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 483.530  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 483.764  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 483.977  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 484.198  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 484.432  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 484.642  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 484.872  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 485.083  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 485.301  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 485.511  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 485.738  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 485.949  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 486.205  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 486.426  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 486.675  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 486.890  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 487.074  5658 NXSERVER received response 'SET SHELL_MODE SHELL'
2015-07-09 11:36:18 487.260  5658 NXSERVER Checking NXCluster feature.
2015-07-09 11:36:18 487.457  5658 NXSERVER NXCluster: disabled by config.
2015-07-09 11:36:18 487.585  5658 NXSERVER no user currently logged in
2015-07-09 11:36:18 487.728  5658 NXSERVER User not yet authorized to access.
2015-07-09 11:36:18 487.981  5658 NXSERVER Local IP determined from SSH_CONNECTION: 10.10.106.83 62140 10.2.2.60 22
2015-07-09 11:36:18 488.148  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 488.326  5658 NXSERVER Found real user name 'test' from name: 'test'.
2015-07-09 11:36:18 488.566  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/guests.db.lock with mode 1089 and permissions 420 from main::lockFile.
2015-07-09 11:36:18 488.706  5658 NXSERVER nxflock: NXPL::NXFileLock(9, 1) returned '1'.
2015-07-09 11:36:18 488.867  5658 NXSERVER NXOpen FD#10 - file /usr/NX/etc/guests.db with mode 0 and permissions 0 from NXUsersManager::__get.
2015-07-09 11:36:18 489.027  5658 NXSERVER open '/usr/NX/etc/guests.db' for read
2015-07-09 11:36:18 489.255  5658 NXSERVER NXClose FD#10 from NXUsersManager::__get.
2015-07-09 11:36:18 489.450  5658 NXSERVER NXClose FD#9 from main::unLockFile.
2015-07-09 11:36:18 489.657  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 489.808  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 489.990  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 490.135  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 490.320  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 490.453  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 490.659  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/administrators.db.lock with mode 1089 and permissions 420 from main::lockFile.
2015-07-09 11:36:18 490.805  5658 NXSERVER nxflock: NXPL::NXFileLock(9, 1) returned '1'.
2015-07-09 11:36:18 490.955  5658 NXSERVER NXOpen FD#10 - file /usr/NX/etc/administrators.db with mode 0 and permissions 0 from NXUsersManager::__get.
2015-07-09 11:36:18 491.076  5658 NXSERVER open '/usr/NX/etc/administrators.db' for read
2015-07-09 11:36:18 491.219  5658 NXSERVER NXClose FD#10 from NXUsersManager::__get.
2015-07-09 11:36:18 491.354  5658 NXSERVER NXClose FD#9 from main::unLockFile.
2015-07-09 11:36:18 491.506  5658 NXSERVER User 'test' logged in from '10.10.106.83'.
2015-07-09 11:36:18 491.697  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/users.db.lock with mode 1089 and permissions 420 from main::lockFile.
2015-07-09 11:36:18 491.844  5658 NXSERVER nxflock: NXPL::NXFileLock(9, 1) returned '1'.
2015-07-09 11:36:18 492.021  5658 NXSERVER NXOpen FD#10 - file /usr/NX/etc/users.db with mode 0 and permissions 0 from NXUsersManager::__get.
2015-07-09 11:36:18 492.186  5658 NXSERVER open '/usr/NX/etc/users.db' for read
2015-07-09 11:36:18 492.368  5658 NXSERVER NXClose FD#10 from NXUsersManager::__get.
2015-07-09 11:36:18 492.534  5658 NXSERVER NXClose FD#9 from main::unLockFile.
2015-07-09 11:36:18 492.670  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 492.824  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 492.989  5658 NXSERVER Sent response message 'NX> 103 Hello on board test.'
2015-07-09 11:36:18 493.123  5658 NXSERVER Message Hello on board sent
2015-07-09 11:36:18 493.328  5658 NXSERVER Sent response message 'NX> 106 NXSERVER-4.6.4 LESE OS: Linux HW: VMware Inc. VMware Virtual Platform'
2015-07-09 11:36:18 493.554  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/hosts.db with mode 0 and permissions 0 from main::getClientRedirect.
2015-07-09 11:36:18 493.714  5658 NXSERVER NXClose FD#9 from main::getClientRedirect.
2015-07-09 11:36:18 493.843  5658 NXSERVER Cannot be found client IP: '10.10.106.83' in hosts.db.
2015-07-09 11:36:18 494.074  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/users.db.lock with mode 1089 and permissions 420 from main::lockFile.
2015-07-09 11:36:18 494.209  5658 NXSERVER nxflock: NXPL::NXFileLock(9, 1) returned '1'.
2015-07-09 11:36:18 494.372  5658 NXSERVER NXOpen FD#10 - file /usr/NX/etc/users.db with mode 0 and permissions 0 from NXUsersManager::list.
2015-07-09 11:36:18 494.536  5658 NXSERVER NXClose FD#10 from NXUsersManager::list.
2015-07-09 11:36:18 494.717  5658 NXSERVER NXClose FD#9 from main::unLockFile.
2015-07-09 11:36:18 494.941  5658 NXSERVER Checking ignore message for command 'set'.
2015-07-09 11:36:18 495.067  5658 NXSERVER Dont have to send ignore message.
2015-07-09 11:36:18 495.213  5658 NXSERVER Request for disconnect never sent to main server.
2015-07-09 11:36:18 495.377  5658 NXSERVER Timestamp 'Command set' time passed '0.008' seconds. 
2015-07-09 11:36:18 495.501  5658 NXSERVER Finished handling command 'set' after 0.008 seconds.
2015-07-09 11:36:18 495.739  5658 NXSERVER Sent request message 'NX> 105 '
2015-07-09 11:36:18 496.205  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 496.481  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 496.747  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 496.978  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 497.222  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 497.464  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 497.747  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 497.987  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 498.209  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 498.450  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 498.716  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 498.940  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 499.160  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 499.380  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 499.568  5658 NXSERVER received response 'connectpolicy'
2015-07-09 11:36:18 499.797  5658 NXSERVER Checking NXCluster feature.
2015-07-09 11:36:18 499.932  5658 NXSERVER NXCluster: disabled by config.
2015-07-09 11:36:18 500.080  5658 NXSERVER Current user is 'test' from '10.10.106.83'
2015-07-09 11:36:18 500.240  5658 NXSERVER User not yet authorized to access.
2015-07-09 11:36:18 500.481  5658 NXSERVER Sent response message 'NX> 164 Connection policy:'
2015-07-09 11:36:18 500.801  5658 NXSERVER Checking ignore message for command 'connectpolicy'.
2015-07-09 11:36:18 500.930  5658 NXSERVER Dont have to send ignore message.
2015-07-09 11:36:18 501.054  5658 NXSERVER Request for disconnect never sent to main server.
2015-07-09 11:36:18 501.252  5658 NXSERVER Timestamp 'Command connectpolicy' time passed '0.001' seconds. 
2015-07-09 11:36:18 501.376  5658 NXSERVER Finished handling command 'connectpolicy' after 0.001 seconds.
2015-07-09 11:36:18 501.596  5658 NXSERVER Sent request message 'NX> 105 '
2015-07-09 11:36:18 504.187  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 504.441  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 504.662  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 504.877  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 505.113  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 505.350  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 505.573  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 505.785  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 506.040  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 506.254  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 506.483  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 506.695  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 506.913  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 507.104  5658 NXSERVER received response 'resourcelist'
2015-07-09 11:36:18 507.312  5658 NXSERVER Checking NXCluster feature.
2015-07-09 11:36:18 507.466  5658 NXSERVER NXCluster: disabled by config.
2015-07-09 11:36:18 507.619  5658 NXSERVER Current user is 'test' from '10.10.106.83'
2015-07-09 11:36:18 507.783  5658 NXSERVER User not yet authorized to access.
2015-07-09 11:36:18 508.052  5658 NXSERVER getLastParameters: command parameters ''.
2015-07-09 11:36:18 508.187  5658 NXSERVER getParameters: parameter string is ''.
2015-07-09 11:36:18 508.362  5658 NXSERVER Resource list: only one parameter param [].
2015-07-09 11:36:18 508.533  5658 NXSERVER Resource list for user[test], class[], value[] node[]
2015-07-09 11:36:18 508.667  5658 NXSERVER Get session resources: user 'test' node '' filtered_value ''.
2015-07-09 11:36:18 508.949  5658 NXSERVER Searching nodes in database.
2015-07-09 11:36:18 509.105  5658 NXSERVER Amount of nodes in array: 1.
2015-07-09 11:36:18 509.255  5658 NXSERVER Check resources for nodes 'localhost:4000'.
2015-07-09 11:36:18 509.784  5658 NXSERVER Set user: test groups by: test.
2015-07-09 11:36:18 513.461  5658 NXSERVER Get value result for class: session is type unix-script with value .
2015-07-09 11:36:18 513.620  5658 NXSERVER Get nodes sessions.
2015-07-09 11:36:18 513.826  5658 NXSERVER Server config type: unix-console,unix-default,unix-application,physical-desktop,shadow,unix-xsession-default,unix-kde,unix-xdm.
2015-07-09 11:36:18 513.980  5658 NXSERVER Server config internal types: virtualConsole,virtualApplicationDefault,virtualUnixApplication,physicalDesktop,virtualAttach,virtualDefault,virtualKde,virtualXdm,
2015-07-09 11:36:18 514.120  5658 NXSERVER Sessions available on node localhost:4000: virtualConsole,virtualApplicationDefault,virtualUnixApplication,physicalDesktop,virtualAttach,virtualDefault,virtualKde,virtualXdm,.
2015-07-09 11:36:18 514.297  5658 NXSERVER Session 'virtualConsole' allow in profiles '1' not deny on nodes '1'.
2015-07-09 11:36:18 514.446  5658 NXSERVER Session 'nxFrameBuffer' allow in profiles '1' not deny on nodes ''.
2015-07-09 11:36:18 514.568  5658 NXSERVER Session 'virtualGnome' allow in profiles '1' not deny on nodes ''.
2015-07-09 11:36:18 514.687  5658 NXSERVER Session 'virtualVms' allow in profiles '1' not deny on nodes ''.
2015-07-09 11:36:18 514.823  5658 NXSERVER Session 'customForeignMaster' allow in profiles '1' not deny on nodes ''.
2015-07-09 11:36:18 514.942  5658 NXSERVER Session 'virtualVnc' allow in profiles '1' not deny on nodes ''.
2015-07-09 11:36:18 515.073  5658 NXSERVER Session 'virtualDefault' allow in profiles '1' not deny on nodes '1'.
2015-07-09 11:36:18 515.208  5658 NXSERVER Session 'virtualRDP' allow in profiles '1' not deny on nodes ''.
2015-07-09 11:36:18 515.377  5658 NXSERVER Session 'foreignDesktop' allow in profiles '1' not deny on nodes ''.
2015-07-09 11:36:18 515.525  5658 NXSERVER Session 'virtualDesktop' allow in profiles '1' not deny on nodes ''.
2015-07-09 11:36:18 515.647  5658 NXSERVER Session 'virtualCde' allow in profiles '1' not deny on nodes ''.
2015-07-09 11:36:18 515.786  5658 NXSERVER Session 'virtualAttach' allow in profiles '1' not deny on nodes '1'.
2015-07-09 11:36:18 515.936  5658 NXSERVER Session 'virtualKde' allow in profiles '1' not deny on nodes '1'.
2015-07-09 11:36:18 516.058  5658 NXSERVER Session 'virtualUnixApplication' allow in profiles '1' not deny on nodes '1'.
2015-07-09 11:36:18 516.206  5658 NXSERVER Session 'foreignAttach' allow in profiles '1' not deny on nodes ''.
2015-07-09 11:36:18 516.345  5658 NXSERVER Session 'virtualApplicationDefault' allow in profiles '1' not deny on nodes '1'.
2015-07-09 11:36:18 516.514  5658 NXSERVER Session 'virtualXdm' allow in profiles '1' not deny on nodes '1'.
2015-07-09 11:36:18 516.637  5658 NXSERVER Session 'physicalDesktop' allow in profiles '1' not deny on nodes '1'.
2015-07-09 11:36:18 516.972  5658 NXSERVER Searching nodes in database.
2015-07-09 11:36:18 517.152  5658 NXSERVER Amount of nodes in array: 1.
2015-07-09 11:36:18 517.287  5658 NXSERVER Check resources for nodes 'localhost:4000'.
2015-07-09 11:36:18 519.512  5658 NXSERVER Searching nodes in database.
2015-07-09 11:36:18 519.655  5658 NXSERVER Amount of nodes in array: 1.
2015-07-09 11:36:18 519.806  5658 NXSERVER getNodeDenyServices: resources not retrieved, checking local node.cfg
2015-07-09 11:36:18 519.983  5658 NXSERVER NXOpen FD#9 - file /usr/NX/etc/node.cfg with mode 0 and permissions 0 from Common::NXCore::parse_config_file.
2015-07-09 11:36:18 520.112  5658 NXSERVER initialization: starting parse of config file '/usr/NX/etc/node.cfg'
2015-07-09 11:36:18 520.249  5658 NXSERVER Process initialized: nxserver test 5653 noloop
2015-07-09 11:36:18 532.737  5658 NXSERVER NXClose FD#9 from Common::NXCore::parse_config_file.
2015-07-09 11:36:18 532.931  5658 NXSERVER Initialization: file /usr/NX/etc/test.node.cfg doesn't exist. Skipping configuration.
2015-07-09 11:36:18 533.078  5658 NXSERVER checkNodeCfg: denied services [printer-ipp-sharing,printer-smb-sharing,printer-virtual-sharing,] in node.cfg
2015-07-09 11:36:18 533.202  5658 NXSERVER Services denied in node profile and deny on node: [printer-ipp-sharing,printer-smb-sharing,printer-virtual-sharing,]
2015-07-09 11:36:18 533.575  5658 NXSERVER Searching nodes in database.
2015-07-09 11:36:18 533.727  5658 NXSERVER Amount of nodes in array: 1.
2015-07-09 11:36:18 533.856  5658 NXSERVER Check resources for nodes 'localhost:4000'.
2015-07-09 11:36:18 535.107  5658 NXSERVER Get value result for class: feature is type bandwidth with value .
2015-07-09 11:36:18 535.287  5658 NXSERVER Searching nodes in database.
2015-07-09 11:36:18 535.419  5658 NXSERVER Amount of nodes in array: 1.
2015-07-09 11:36:18 535.590  5658 NXSERVER Searching nodes in database.
2015-07-09 11:36:18 535.753  5658 NXSERVER Amount of nodes in array: 1.
2015-07-09 11:36:18 535.879  5658 NXSERVER Check resources for nodes 'localhost:4000'.
2015-07-09 11:36:18 536.205  5658 NXSERVER Get value result for class: node is type limit with value .
2015-07-09 11:36:18 536.401  5658 NXSERVER Sent response message 'NX> 104 Resource list:'
2015-07-09 11:36:18 536.869  5658 NXSERVER Checking ignore message for command 'resourcelist'.
2015-07-09 11:36:18 536.999  5658 NXSERVER Dont have to send ignore message.
2015-07-09 11:36:18 537.122  5658 NXSERVER Request for disconnect never sent to main server.
2015-07-09 11:36:18 537.304  5658 NXSERVER Timestamp 'Command resourcelist' time passed '0.030' seconds. 
2015-07-09 11:36:18 537.421  5658 NXSERVER Finished handling command 'resourcelist' after 0.030 seconds.
2015-07-09 11:36:18 537.668  5658 NXSERVER Sent request message 'NX> 105 '
2015-07-09 11:36:18 554.677  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 554.959  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 555.217  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 555.464  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 555.686  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 556.022  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 556.346  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 556.594  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 556.812  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 557.028  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 557.242  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 557.476  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 557.692  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 557.905  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 558.135  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 558.349  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 558.582  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 558.798  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 559.139  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 559.414  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 559.631  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 559.843  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 560.055  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 560.293  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 560.524  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 560.736  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 561.002  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 561.272  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 561.506  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 561.724  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 561.996  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 562.207  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 562.429  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 562.660  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 562.928  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 563.157  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 563.370  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 563.582  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 563.810  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 564.020  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 564.276  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 564.490  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 564.717  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 564.971  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 565.203  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 565.447  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 565.679  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 565.891  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 566.138  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 566.364  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 566.612  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 566.825  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 567.052  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 567.295  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 567.526  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 567.738  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 567.966  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 568.213  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 568.454  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 568.673  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 568.890  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 569.112  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 569.330  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 569.564  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 569.781  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 570.031  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 570.270  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 570.511  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 570.743  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 570.981  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 571.197  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 571.432  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 571.658  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 571.895  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 572.140  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 572.395  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 572.625  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 572.919  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:18 573.126  5658 NXSERVER received response 'listsession --status="disconnected,connected" --type="all" --shadowable="yes"'
2015-07-09 11:36:18 574.173  5658 NXSERVER Checking NXCluster feature.
2015-07-09 11:36:18 574.309  5658 NXSERVER NXCluster: disabled by config.
2015-07-09 11:36:18 574.455  5658 NXSERVER Current user is 'test' from '10.10.106.83'
2015-07-09 11:36:18 574.617  5658 NXSERVER User not yet authorized to access.
2015-07-09 11:36:18 574.800  5658 NXSERVER getLastParameters: command parameters '--status="disconnected,connected" --type="all" --shadowable="yes"'.
2015-07-09 11:36:18 574.956  5658 NXSERVER getParameters: parameter string is '--status="disconnected,connected" --type="all" --shadowable="yes"'.
2015-07-09 11:36:18 575.441  5658 NXSERVER getPwNam: Returning userinfo.
2015-07-09 11:36:18 575.587  5658 NXSERVER Found real user name 'test' from name: 'test'.
2015-07-09 11:36:18 576.613  5658 NXSERVER count_user_capacity: calculation for user: 
2015-07-09 11:36:18 576.753  5658 NXSERVER User capacity: virtual/connections: 0/0
2015-07-09 11:36:18 576.887  5658 NXSERVER __setCapacityLimits user_capacity: [0/0]
2015-07-09 11:36:18 577.010  5658 NXSERVER __getSessions in module: size of array is 0
2015-07-09 11:36:18 577.438  5658 NXSERVER NXFrameBuffer session is not running.
2015-07-09 11:36:18 577.655  5658 NXSERVER __setDataToColumns: client is supporting platform parameters
2015-07-09 11:36:18 577.879  5658 NXSERVER Sent response message 'NX> 127 Session list of user 'test': '
2015-07-09 11:36:18 578.487  5658 NXSERVER Sent response message 'NX> 148 Server capacity: not reached for user: test'
2015-07-09 11:36:18 578.644  5658 NXSERVER Checking ignore message for command 'listsession'.
2015-07-09 11:36:18 578.770  5658 NXSERVER Dont have to send ignore message.
2015-07-09 11:36:18 578.929  5658 NXSERVER Request for disconnect never sent to main server.
2015-07-09 11:36:18 579.093  5658 NXSERVER Timestamp 'Command listsession' time passed '0.005' seconds. 
2015-07-09 11:36:18 579.237  5658 NXSERVER Finished handling command 'listsession' after 0.005 seconds.
2015-07-09 11:36:18 579.447  5658 NXSERVER Sent request message 'NX> 105 '
2015-07-09 11:36:22 203.618  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 204.001  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 204.253  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 204.486  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 204.712  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 204.936  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 205.161  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 205.382  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 205.607  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 205.831  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 206.071  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 206.298  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 206.522  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 206.745  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 206.967  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 207.219  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 207.444  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 207.667  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 207.889  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 208.112  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 208.378  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 208.614  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 208.838  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 209.059  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 209.296  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 209.519  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 209.741  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 209.964  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 210.187  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 210.409  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 210.656  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 210.898  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 211.121  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 211.344  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 211.575  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 211.797  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 212.020  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 212.504  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 212.828  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 213.146  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 213.489  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 213.828  5658 NXSERVER NXParser: checkCanRead has: FD#0
2015-07-09 11:36:22 214.133  5658 NXSERVER received response 'setsession --type="unix-xsession-default"'
2015-07-09 11:36:22 215.946  5658 NXSERVER Checking NXCluster feature.
2015-07-09 11:36:22 216.200  5658 NXSERVER NXCluster: disabled by config.
2015-07-09 11:36:22 216.400  5658 NXSERVER Current user is 'test' from '10.10.106.83'
2015-07-09 11:36:22 216.638  5658 NXSERVER User not yet authorized to access.
2015-07-09 11:36:22 216.914  5658 NXSERVER getLastParameters: command parameters '--type="unix-xsession-default"'.
2015-07-09 11:36:22 217.089  5658 NXSERVER getParameters: parameter string is '--type="unix-xsession-default"'.
2015-07-09 11:36:22 217.434  5658 NXSERVER Start handler session set.
2015-07-09 11:36:22 217.631  5658 NXSERVER Session type request by client: virtualDefault.
2015-07-09 11:36:22 217.826  5658 NXSERVER handler_session_set CLIENT_SUPPORT_NODE_SELECTION [1]
2015-07-09 11:36:22 218.263  5658 NXSERVER Adding state: sessionSelectNode with functionToHandle __handleStateSessionSelectNode.
2015-07-09 11:36:22 218.449  5658 NXSERVER Adding transition between sessionSelectNode and nxshell with nodeSelected.
2015-07-09 11:36:22 218.628  5658 NXSERVER Adding transition between sessionSelectNode and sessionSetRemoteNodeSpecificParameters with nodeSelectedWithoutSessionSet.
2015-07-09 11:36:22 218.828  5658 NXSERVER Adding state: sessionParametersVerification with functionToHandle __handleStateSessionParametersVerification.
2015-07-09 11:36:22 219.001  5658 NXSERVER Adding transition between sessionParametersVerification and nxshell with backFromSubsystem.
2015-07-09 11:36:22 219.183  5658 NXSERVER Adding transition between sessionParametersVerification and sessionSetRemoteNodeSpecificParameters with parametersInitialized.
2015-07-09 11:36:22 219.355  5658 NXSERVER Adding transition between sessionParametersVerification and sessionID with nodeNotSelected.
2015-07-09 11:36:22 219.527  5658 NXSERVER Adding transition between sessionParametersVerification and setSessionToAttach with setNodeToAttach.
2015-07-09 11:36:22 219.720  5658 NXSERVER Adding state: sessionSetRemoteNodeSpecificParameters with functionToHandle __handleStateSessionSetRemoteNodeSpecificParameters.
2015-07-09 11:36:22 219.891  5658 NXSERVER Adding transition between sessionSetRemoteNodeSpecificParameters and sessionID with parametersSet.
2015-07-09 11:36:22 220.060  5658 NXSERVER Adding state: sessionID with functionToHandle __handleStateSessionID.
2015-07-09 11:36:22 220.240  5658 NXSERVER Adding transition between sessionID and sessionGetMainSessionParameters with sessionIDset.
2015-07-09 11:36:22 220.413  5658 NXSERVER Adding transition between sessionID and sessionCreateInDB with nodeNotSelected.
2015-07-09 11:36:22 220.585  5658 NXSERVER Adding state: sessionGetMainSessionParameters with functionToHandle __handleStateSessionGetMainSessionParameters.
2015-07-09 11:36:22 220.757  5658 NXSERVER Adding transition between sessionGetMainSessionParameters and sessionCheckProfiles with parametersGet.
2015-07-09 11:36:22 220.950  5658 NXSERVER Adding transition between sessionGetMainSessionParameters and sessionInitializeForeignNode with initializeForeignNode.
2015-07-09 11:36:22 221.120  5658 NXSERVER Adding state: sessionCheckProfiles with functionToHandle __handleStateSessionCheckProfiles.
2015-07-09 11:36:22 221.375  5658 NXSERVER Adding transition between sessionCheckProfiles and nxshell with error.
2015-07-09 11:36:22 221.554  5658 NXSERVER Adding transition between sessionCheckProfiles and sessionDisconnectOld with profileUpdated.
2015-07-09 11:36:22 221.722  5658 NXSERVER Adding state: sessionDisconnectOld with functionToHandle __handleStateDisconnectDirectlyConnected.
2015-07-09 11:36:22 221.915  5658 NXSERVER Adding transition between sessionDisconnectOld and nxshell with waitingOnSessionClose.
2015-07-09 11:36:22 222.086  5658 NXSERVER Adding transition between sessionDisconnectOld and sessionAsk4attach with sessionNotNeedToBeClosed.
2015-07-09 11:36:22 222.276  5658 NXSERVER Adding transition between sessionDisconnectOld and sessionAsk4attach with sessionClosed.
2015-07-09 11:36:22 222.453  5658 NXSERVER Adding state: sessionAsk4attach with functionToHandle __handleStateSessionAsk4attach.
2015-07-09 11:36:22 222.643  5658 NXSERVER Adding transition between sessionAsk4attach and nxshell with waitingForUserAnswer.
2015-07-09 11:36:22 222.832  5658 NXSERVER Adding transition between sessionAsk4attach and sessionHandlePrepareToShadow with accessAllow.
2015-07-09 11:36:22 223.021  5658 NXSERVER Adding transition between sessionAsk4attach and nxshell with error.
2015-07-09 11:36:22 223.191  5658 NXSERVER Adding state: sessionHandlePrepareToShadow with functionToHandle __sessionHandlePrepareToShadow.
2015-07-09 11:36:22 223.359  5658 NXSERVER Adding transition between sessionHandlePrepareToShadow and nxshell with prepareToShadowSent.
2015-07-09 11:36:22 223.532  5658 NXSERVER Adding transition between sessionHandlePrepareToShadow and sessionCreateInDB with readyToShadow.
2015-07-09 11:36:22 223.700  5658 NXSERVER Adding state: nxshell with functionToHandle __handleStateNXShell.
2015-07-09 11:36:22 223.891  5658 NXSERVER Adding transition between nxshell and sessionAsk4attach with sessionClosed.
2015-07-09 11:36:22 224.062  5658 NXSERVER Adding transition between nxshell and sessionHandlePrepareToShadow with accessAllow.
2015-07-09 11:36:22 224.259  5658 NXSERVER Adding transition between nxshell and sessionDisconnectOld with tryToDisconnectAgain.
2015-07-09 11:36:22 224.432  5658 NXSERVER Adding transition between nxshell and sessionCreateInDB with readyToShadow.
2015-07-09 11:36:22 224.621  5658 NXSERVER Adding state: sessionCreateInDB with functionToHandle __handleStateSessionCreateInDB.
2015-07-09 11:36:22 224.814  5658 NXSERVER Adding transition between sessionCreateInDB and sessionCreateOnRemoteNode with skipCreateSession.
2015-07-09 11:36:22 224.982  5658 NXSERVER Adding transition between sessionCreateInDB and sessionCreateOnRemoteNode with sessionCreated.
2015-07-09 11:36:22 225.169  5658 NXSERVER Adding transition between sessionCreateInDB and sessionSelectNode with nodeNotSelected.
2015-07-09 11:36:22 225.339  5658 NXSERVER Adding state: sessionCreateOnRemoteNode with functionToHandle __handleStateSessionCreateOnRemoteNode.
2015-07-09 11:36:22 225.529  5658 NXSERVER Adding transition between sessionCreateOnRemoteNode and sessionSaveDisplay with localNode.
2015-07-09 11:36:22 225.701  5658 NXSERVER Adding transition between sessionCreateOnRemoteNode and nxshell with sessionClosed.
2015-07-09 11:36:22 225.871  5658 NXSERVER Adding state: sessionSaveDisplay with functionToHandle __handleStateSessionSaveDisplay.
2015-07-09 11:36:22 226.040  5658 NXSERVER Adding transition between sessionSaveDisplay and sessionParametersSave with displaySaved.
2015-07-09 11:36:22 226.211  5658 NXSERVER Adding transition between sessionSaveDisplay and sessionParametersSave with skipSaveingDisplay.
2015-07-09 11:36:22 226.399  5658 NXSERVER Adding state: sessionParametersSave with functionToHandle __handleStateSessionParametersSave.
2015-07-09 11:36:22 226.591  5658 NXSERVER Adding transition between sessionParametersSave and sessionSetUDPAndFirewall with parametersSaved.
2015-07-09 11:36:22 226.759  5658 NXSERVER Adding transition between sessionParametersSave and sessionSetUDPAndFirewall with skipParametersSave.
2015-07-09 11:36:22 226.956  5658 NXSERVER Adding state: sessionSetUDPAndFirewall with functionToHandle __handleStateSessionSetUDPAndFirewall.
2015-07-09 11:36:22 227.125  5658 NXSERVER Adding transition between sessionSetUDPAndFirewall and sessionStart with firewallSet.
2015-07-09 11:36:22 227.327  5658 NXSERVER Adding transition between sessionSetUDPAndFirewall and sessionStart with skipFirewallSet.
2015-07-09 11:36:22 227.518  5658 NXSERVER Adding state: sessionStart with functionToHandle __handleStateStartSession.
2015-07-09 11:36:22 227.686  5658 NXSERVER Adding transition between sessionStart and sessionParametersVerification with startFirstAttach.
2015-07-09 11:36:22 227.877  5658 NXSERVER Adding transition between sessionStart and nxshell with sessionStarted.
2015-07-09 11:36:22 228.044  5658 NXSERVER Adding transition between sessionStart and nxshell with error.
2015-07-09 11:36:22 228.224  5658 NXSERVER Adding state: sessionInitializeForeignNode with functionToHandle __handleStateInitializeForeignNode.
2015-07-09 11:36:22 228.396  5658 NXSERVER Adding transition between sessionInitializeForeignNode and sessionCheckProfiles with foreignNodeInitialized.
2015-07-09 11:36:22 228.568  5658 NXSERVER Adding state: setSessionToAttach with functionToHandle __handleSetSessionForAttach.
2015-07-09 11:36:22 228.754  5658 NXSERVER Adding transition between setSessionToAttach and sessionSetRemoteNodeSpecificParameters with nodeSelected.
2015-07-09 11:36:22 228.923  5658 NXSERVER Adding transition between setSessionToAttach and nxshell with error.
2015-07-09 11:36:22 229.106  5658 NXSERVER Going to handling state: sessionSetRemoteNodeSpecificParameters with __handleStateSessionSetRemoteNodeSpecificParameters.
2015-07-09 11:36:22 229.278  5658 NXSERVER Handle state: set remote node specific parameters.
2015-07-09 11:36:22 229.505  5658 NXSERVER Transition from sessionSetRemoteNodeSpecificParameters with event parametersSet is sessionID.
2015-07-09 11:36:22 229.672  5658 NXSERVER Next state: sessionID
2015-07-09 11:36:22 229.865  5658 NXSERVER Going to handling state: sessionID with __handleStateSessionID.
2015-07-09 11:36:22 230.053  5658 NXSERVER Handle state: SessionID
2015-07-09 11:36:22 230.248  5658 NXSERVER Generating session ID.
2015-07-09 11:36:22 230.431  5658 NXSERVER NXPL was already loaded.
2015-07-09 11:36:22 230.598  5658 NXSERVER NXPL::NXGetRandomString start. 
2015-07-09 11:36:22 230.823  5658 NXSERVER NXPL::NXGetRandomString stop. 
2015-07-09 11:36:22 230.999  5658 NXSERVER Set session id to:  42B7156DAF9DC482B9C22491D86692AF
2015-07-09 11:36:22 231.199  5658 NXSERVER Get session id: 42B7156DAF9DC482B9C22491D86692AF.
2015-07-09 11:36:22 231.385  5658 NXSERVER Transition from sessionID with event nodeNotSelected is sessionCreateInDB.
2015-07-09 11:36:22 231.552  5658 NXSERVER Next state: sessionCreateInDB
2015-07-09 11:36:22 231.739  5658 NXSERVER Going to handling state: sessionCreateInDB with __handleStateSessionCreateInDB.
2015-07-09 11:36:22 231.910  5658 NXSERVER Handle state: create session in dabatase.
2015-07-09 11:36:22 232.155  5658 NXSERVER Get session id: 42B7156DAF9DC482B9C22491D86692AF.
2015-07-09 11:36:22 232.485  5658 NXSERVER NXPL was already loaded.
2015-07-09 11:36:22 232.679  5658 NXSERVER NXPL::NXGetRandomString start. 
2015-07-09 11:36:22 232.845  5658 NXSERVER NXPL::NXGetRandomString stop. 
2015-07-09 11:36:22 233.583  5658 NXSERVER nxListenOnSocket: listening on [20000] from NXTools::findFreePortAndOpen.
2015-07-09 11:36:22 233.866  5658 NXSERVER nxListenOnSocket: NXPL::NXOpenSocketToListenEx(20000, 100, 1) returned 'FD#9'.
2015-07-09 11:36:22 234.055  5658 NXSERVER Starting listen on socket: 20000
2015-07-09 11:36:22 234.236  5658 NXSERVER Creating selector for server -local
2015-07-09 11:36:22 234.465  5658 NXSERVER Global selector: adding FD#9 - server's socket with callback NXNodeExec::serverSocket_parser.
2015-07-09 11:36:22 234.641  5658 NXSERVER Added NXNodeExec::socketserver to the gSelector
2015-07-09 11:36:22 234.927  5658 NXSERVER Handle connection limits.
2015-07-09 11:36:22 235.136  5658 NXSERVER Locking ... /usr/NX/var/db/running/.InfoManager.lock
2015-07-09 11:36:22 235.305  5658 NXSERVER lock-refcounter [0]
2015-07-09 11:36:22 235.565  5658 NXSERVER refcounter set to: 1
2015-07-09 11:36:22 235.734  5658 NXSERVER immediately lock file '/usr/NX/var/db/running/.InfoManager.lock'
2015-07-09 11:36:22 236.708  5658 NXSERVER count_user_capacity: calculation for user: test
2015-07-09 11:36:22 236.889  5658 NXSERVER User capacity: virtual/connections: 0/0
2015-07-09 11:36:22 237.183  5658 NXSERVER count_user_capacity: calculation for user: test
2015-07-09 11:36:22 237.354  5658 NXSERVER User capacity: virtual/connections: 0/0
2015-07-09 11:36:22 237.569  5658 NXSERVER Handle connection limits OK
2015-07-09 11:36:22 237.758  5658 NXSERVER Get session id: 42B7156DAF9DC482B9C22491D86692AF.
2015-07-09 11:36:22 238.290  5658 NXSERVER setServerPid called 5658
2015-07-09 11:36:22 238.512  5658 NXSERVER setStatus --> Starting
2015-07-09 11:36:22 238.837  5658 NXSERVER Inserting session sessionId [42B7156DAF9DC482B9C22491D86692AF] on 'running' DB.
2015-07-09 11:36:22 239.831  5658 NXSERVER Unlocking ...
2015-07-09 11:36:22 240.008  5658 NXSERVER lock-refcounter [1]
2015-07-09 11:36:22 240.206  5658 NXSERVER dec lock refcounter: 0
2015-07-09 11:36:22 240.378  5658 NXSERVER immediately unlock file '/usr/NX/var/db/running/.InfoManager.lock'
2015-07-09 11:36:22 240.575  5658 NXSERVER Unlocked
2015-07-09 11:36:22 240.750  5658 NXSERVER Transition from sessionCreateInDB with event nodeNotSelected is sessionSelectNode.
2015-07-09 11:36:22 240.930  5658 NXSERVER Next state: sessionSelectNode
2015-07-09 11:36:22 241.128  5658 NXSERVER Going to handling state: sessionSelectNode with __handleStateSessionSelectNode.
2015-07-09 11:36:22 241.301  5658 NXSERVER Handle state: select node.
2015-07-09 11:36:22 241.510  5658 NXSERVER Starting select node procedure for session type virtualDefault.
2015-07-09 11:36:22 241.708  5658 NXSERVER Searching nodes in database.
2015-07-09 11:36:22 241.887  5658 NXSERVER Searching parameters: sessionType 'virtualDefault'.
2015-07-09 11:36:22 242.100  5658 NXSERVER Server config type: unix-console,unix-default,unix-application,physical-desktop,shadow,unix-xsession-default,unix-kde,unix-xdm.
2015-07-09 11:36:22 242.303  5658 NXSERVER Server config internal types: virtualConsole,virtualApplicationDefault,virtualUnixApplication,physicalDesktop,virtualAttach,virtualDefault,virtualKde,virtualXdm,
2015-07-09 11:36:22 242.483  5658 NXSERVER Node 'localhost:4000' sessions: 'virtualConsole,virtualApplicationDefault,virtualUnixApplication,physicalDesktop,virtualAttach,virtualDefault,virtualKde,virtualXdm,'.
2015-07-09 11:36:22 242.668  5658 NXSERVER Amount of nodes in array: 1.
2015-07-09 11:36:22 242.892  5658 NXSERVER Nodes weight is not available.
2015-07-09 11:36:22 244.731  5658 NXSERVER Node 'localhost:4000' limit is 0.
2015-07-09 11:36:22 244.962  5658 NXSERVER NXOpen FD#10 - file /usr/NX/var/num with mode 0 and permissions 0 from NXSelectNode::__takeNodeNumber.
2015-07-09 11:36:22 245.242  5658 NXSERVER NXClose FD#10 from NXSelectNode::__takeNodeNumber.
2015-07-09 11:36:22 245.470  5658 NXSERVER NXOpen FD#10 - file /usr/NX/var/num with mode 65 and permissions 384 from NXSelectNode::__takeNodeNumber.
2015-07-09 11:36:22 245.696  5658 NXSERVER NXClose FD#10 from NXSelectNode::__takeNodeNumber.
2015-07-09 11:36:22 245.884  5658 NXSERVER Simple round robin node list: localhost:4000.
2015-07-09 11:36:22 246.054  5658 NXSERVER There are 1 nodes available: localhost:4000.
2015-07-09 11:36:22 246.230  5658 NXSERVER Using round robin algorithm for selecting the node.
2015-07-09 11:36:22 246.405  5658 NXSERVER Node selected to start session is localhost:4000.
2015-07-09 11:36:22 246.605  5658 NXSERVER Checking profiles for node localhost:4000 and session type virtualDefault.
2015-07-09 11:36:22 247.044  5658 NXSERVER Check session type virtualDefault for user test and node localhost:4000.
2015-07-09 11:36:22 247.481  5658 NXSERVER Node localhost:4000 is enable on server profiles.
2015-07-09 11:36:22 247.663  5658 NXSERVER Checking resources on node localhost:4000.
2015-07-09 11:36:22 249.362  5658 NXSERVER Node 'localhost:4000' limit is 0.
2015-07-09 11:36:22 249.601  5658 NXSERVER Check if nxnode [localhost:4000] could run next session.
2015-07-09 11:36:22 249.843  5658 NXSERVER askNode: service 'getConnectionLimit' with '' on 'localhost:4000'.
2015-07-09 11:36:22 250.072  5658 NXSERVER askNode login '' preferredAuthMethod '' specifyTimeout ''skipForwarding '' protocol ''
2015-07-09 11:36:22 250.242  5658 NXSERVER Login value is empty, try to get login.
2015-07-09 11:36:22 250.502  5658 NXSERVER New login value is 'test'.
2015-07-09 11:36:22 250.719  5658 NXSERVER isRunned - localhost/test
2015-07-09 11:36:22 250.973  5658 NXSERVER NXNodeExec::stderr is set to FD#.
2015-07-09 11:36:22 251.144  5658 NXSERVER NXNodeExec::stdin is set to FD#.
2015-07-09 11:36:22 251.353  5658 NXSERVER NXNodeExec::stdout is set to FD#.
2015-07-09 11:36:22 251.519  5658 NXSERVER askNode run __start
2015-07-09 11:36:22 251.766  5658 NXSERVER __start 'getConnectionLimit' '' on 'localhost:4000'.
2015-07-09 11:36:22 251.941  5658 NXSERVER __start login 'test' authMethod '' specifyTimeout '' protocol ''
2015-07-09 11:36:22 252.154  5658 NXSERVER Starting local node for user test.
2015-07-09 11:36:22 252.380  5658 NXSERVER Starting session node through nxserver --daemon.
2015-07-09 11:36:22 252.618  5658 NXSERVER NXOpen FD#10 - file /usr/NX/var/run/nxserver.pid with mode 0 and permissions 0 from NXClientSystemDaemons::__getServerOptionsFile.
2015-07-09 11:36:22 252.880  5658 NXSERVER NXClose FD#10 from NXClientSystemDaemons::__getServerOptionsFile.
2015-07-09 11:36:22 253.069  5658 NXSERVER Read PID from file '/usr/NX/var/run/nxserver.pid': 5339.
2015-07-09 11:36:22 253.336  5658 NXSERVER NXOpen FD#10 - file /usr/NX/var/db/server/cookie with mode 0 and permissions 0 from main::get_cookie_and_port.
2015-07-09 11:36:22 253.592  5658 NXSERVER NXClose FD#10 from main::get_cookie_and_port.
2015-07-09 11:36:22 253.825  5658 NXSERVER NXOpen FD#10 - file /usr/NX/var/db/server/port with mode 0 and permissions 0 from main::get_cookie_and_port.
2015-07-09 11:36:22 254.051  5658 NXSERVER NXClose FD#10 from main::get_cookie_and_port.
2015-07-09 11:36:22 254.238  5658 NXSERVER Connecting to the nxserver on port: 24580
2015-07-09 11:36:22 254.422  5658 NXSERVER NXConnectLocal to localhost:24580 from NXClientSystemDaemons::openConnection.
2015-07-09 11:36:22 255.742  5339 NXSERVER Global selector: something to read on FD#10 - server daemon's socket.
2015-07-09 11:36:22 255.957  5339 NXSERVER AcceptSocket accepted on 'FD#10': [FD#16].
2015-07-09 11:36:22 256.081  5339 NXSERVER Accepted new connection on FD#16.
2015-07-09 11:36:22 256.195  5339 NXSERVER Adding custom handle for FD#16 to monitoring hash.
2015-07-09 11:36:22 256.331  5339 NXSERVER Global selector: adding FD#16 - server --daemon's socket accepted handle with callback NXServerDaemon::serverSocketAccepted_parser.
2015-07-09 11:36:22 256.507  5339 NXSERVER WARNING! Service: 'nxd' is not started, pid file doesn't exist.
2015-07-09 11:36:22 260.222  5658 NXSERVER NXPL::NXConnectLocal return: FD#10.
2015-07-09 11:36:22 260.430  5658 NXSERVER Descriptor FD#10 has been set as not inheritable.
2015-07-09 11:36:22 260.720  5339 NXSERVER Global selector: something to read on FD#16 - server --daemon's socket accepted handle.
2015-07-09 11:36:22 260.850  5339 NXSERVER Server --daemon parser for FD#16.
2015-07-09 11:36:22 260.978  5339 NXSERVER Read 'NX> *****', 36 bytes from FD#16.
2015-07-09 11:36:22 261.096  5339 NXSERVER Connection FD#16 not authorized, yet.
2015-07-09 11:36:22 261.185  5339 NXSERVER Authorizing connection on FD#16.
2015-07-09 11:36:22 261.291  5339 NXSERVER Connection authorized on FD#16.
2015-07-09 11:36:22 261.621  5658 NXSERVER Message sent to nxserver: NX> *****
2015-07-09 11:36:22 261.808  5658 NXSERVER NXPL was already loaded.
2015-07-09 11:36:22 261.976  5658 NXSERVER NXPL::NXGetRandomString start. 
2015-07-09 11:36:22 262.157  5658 NXSERVER NXPL::NXGetRandomString stop. 
2015-07-09 11:36:22 262.337  5658 NXSERVER Get session id: 42B7156DAF9DC482B9C22491D86692AF.
2015-07-09 11:36:22 262.523  5658 NXSERVER Get session id: 42B7156DAF9DC482B9C22491D86692AF.
2015-07-09 11:36:22 262.829  5658 NXSERVER Set node priority based on session type  [virtualDefault]
2015-07-09 11:36:22 262.975  5658 NXSERVER Node will be run with [realtime] priority.
2015-07-09 11:36:22 263.207  5658 NXSERVER NXPL was already loaded.
2015-07-09 11:36:22 263.347  5658 NXSERVER setSocketsForServerNodeChain - NXPL::NXPipeCreate
2015-07-09 11:36:22 263.468  5658 NXSERVER NXPL::NXPipeCreate start. 
2015-07-09 11:36:22 263.613  5658 NXSERVER NXPipeCreate(FD#11, FD#12, 1) returned '0'
2015-07-09 11:36:22 263.748  5658 NXSERVER NXPL::NXPipeCreate stop. 
2015-07-09 11:36:22 263.868  5658 NXSERVER NXPL::NXPipeCreate return: 1 [11|12]
2015-07-09 11:36:22 263.984  5658 NXSERVER NXPL::NXDescriptorInheritable start. 
2015-07-09 11:36:22 264.117  5658 NXSERVER NXPL::NXDescriptorInheritable stop. 
2015-07-09 11:36:22 264.244  5658 NXSERVER NXPL::NXDescriptorInheritable return: 1
2015-07-09 11:36:22 264.443  5339 NXSERVER Global selector: something to read on FD#16 - server --daemon's socket accepted handle.
2015-07-09 11:36:22 264.510  5339 NXSERVER Server --daemon parser for FD#16.
2015-07-09 11:36:22 264.614  5339 NXSERVER Read 'NX> 1044 Start node for virtual session=***** username=test pid=5658 socketPathEncoded=%%2ftmp%%2fsession-***** socketCookie=***** priotity=realtime runNodeMode=0 SSH_CONNECTION=10.10.106.83+62140+10.2.2.60+22 SSH_CLIENT=10.10.106.83+62140+22 NX_USER_GROUPS=test. \n', 344 bytes from FD#16.
2015-07-09 11:36:22 264.690  5339 NXSERVER Cannot find node assigned to socket FD#16.
2015-07-09 11:36:22 264.809  5339 NXSERVER Parse daemon message 'NX> 1044 Start node for virtual session=***** username=test pid=5658 socketPathEncoded=%%2ftmp%%2fsession-***** socketCookie=***** priotity=realtime runNodeMode=0 SSH_CONNECTION=10.10.106.83+62140+10.2.2.60+22 SSH_CLIENT=10.10.106.83+62140+22 NX_USER_GROUPS=test. ' in buffer left ''.
2015-07-09 11:36:22 264.907  5339 NXSERVER Received message [1044][Start node for virtual session=42B7156DAF9DC482B9C22491D86692AF username=test pid=5658 socketPathEncoded=%%2ftmp%%2fsession-42B7156DAF9DC482B9C22491D86692AF socketCookie=2356B33D85A63989CD17B77074C79D47 priotity=realtime runNodeMode=0 SSH_CONNECTION=10.10.106.83+62140+10.2.2.60+22 SSH_CLIENT=10.10.106.83+62140+22 NX_USER_GROUPS=test. ] from FD#16
2015-07-09 11:36:22 264.977  5339 NXSERVER Received request for create virtual session node process.
2015-07-09 11:36:22 265.133  5339 NXSERVER NXPL::NXAcquireDescriptor(5658, 1, /tmp/session-42B7156DAF9DC482B9C22491D86692AF, ***)
2015-07-09 11:36:22 265.366  5658 NXSERVER Message sent to nxserver: NX> 1044 Start node for virtual session=***** username=test pid=5658 socketPathEncoded=%%2ftmp%%2fsession-***** socketCookie=***** priotity=realtime runNodeMode=0 SSH_CONNECTION=10.10.106.83+62140+10.2.2.60+22 SSH_CLIENT=10.10.106.83+62140+22 NX_USER_GROUPS=test. \n
2015-07-09 11:36:22 265.506  5658 NXSERVER NXPL::NXYieldDescriptor(12, /tmp/session-42B7156DAF9DC482B9C22491D86692AF, ***)
2015-07-09 11:36:22 266.377  5339 NXSERVER NXPL::NXAcquireDescriptor(5658, 1, /tmp/session-42B7156DAF9DC482B9C22491D86692AF, ***) 18
2015-07-09 11:36:22 266.581  5339 NXSERVER NXRunCommand: setting command to '/usr/NX/bin/nxexec --node --user test --priority  --mode 0'.
2015-07-09 11:36:22 266.685  5339 NXSERVER NXRunCommand: setting to save pid to 'SCALAR(0x2213820)'.
2015-07-09 11:36:22 266.761  5339 NXSERVER NXRunCommand: key 'use as stdin' set getStdinFD
2015-07-09 11:36:22 266.829  5339 NXSERVER NXRunCommand: call: setStdinFD_redirect(18)
2015-07-09 11:36:22 266.903  5339 NXSERVER NXRunCommand: set stdinFD redirect as: 18
2015-07-09 11:36:22 266.964  5339 NXSERVER NXRunCommand: key 'use as stdout' set getStdOutFD
2015-07-09 11:36:22 267.019  5339 NXSERVER NXRunCommand: call: setStdoutFD_redirect(18)
2015-07-09 11:36:22 267.086  5339 NXSERVER NXRunCommand: set stdoutFD redirect as: 18
2015-07-09 11:36:22 267.165  5339 NXSERVER NXRunCommand: setting CMD_IN not to be closed.
2015-07-09 11:36:22 267.224  5339 NXSERVER NXRunCommand: setting CMD_OUT not to be closed.
2015-07-09 11:36:22 267.323  5339 NXSERVER NXRunCommand: setChildDescriptors started
2015-07-09 11:36:22 267.381  5339 NXSERVER NXRunCommand: __setupParentChildStdin started
2015-07-09 11:36:22 267.436  5339 NXSERVER NXRunCommand: getStdin_redirect return 18
2015-07-09 11:36:22 267.497  5339 NXSERVER NXRunCommand: __setupParentChildStdout started
2015-07-09 11:36:22 267.614  5339 NXSERVER NXOpen FD#17 - file /usr/NX/var/log/nxerror.log with mode 1089 and permissions 384 from Common::NXRunCommand::__setupParentChildStderr.
2015-07-09 11:36:22 267.687  5339 NXSERVER NXRunCommand: getChildStdin return 18
2015-07-09 11:36:22 267.746  5339 NXSERVER Descriptors set. Child :18, 18, 17. Parent , .
2015-07-09 11:36:22 267.800  5339 NXSERVER NXRunCommand: getChildStdin return 18
2015-07-09 11:36:22 267.867  5339 NXSERVER nxProcessCreate: '/usr/NX/bin/nxexec' '/usr/NX/bin/nxexec /usr/NX/bin/nxexec --node --user test --priority  --mode 0' 'NX_FEATURES=myhost11,VMwareInc.VMwareVirtualPlatform,Linux,Ubuntu 14.04.2 LTS,3.13.0,x86_64,2,3956285440,311 NX_USER_GROUPS=test. NX_VERSION=4.6.4 SSH_CLIENT=10.10.106.83 62140 22 SSH_CONNECTION=10.10.106.83 62140 10.2.2.60 22' '18' '18' '17' '101'
2015-07-09 11:36:22 269.998  5339 NXSERVER Added '5676/5676' to children list.
2015-07-09 11:36:22 270.374  5339 NXSERVER NXRunCommand: close after run - close FD#18.
2015-07-09 11:36:22 270.474  5339 NXSERVER NXClose FD#18 from Common::NXRunCommand::run.
2015-07-09 11:36:22 270.589  5339 NXSERVER NXRunCommand: Closing ChildStderr
2015-07-09 11:36:22 270.719  5339 NXSERVER NXClose FD#17 from Common::NXRunCommand::closeChildDescriptors.
2015-07-09 11:36:22 270.808  5339 NXSERVER NXRunCommand: child descriptors closed.
2015-07-09 11:36:22 270.911  5339 NXSERVER NXRunCommand: saving pid in SCALAR(0x2213820)
2015-07-09 11:36:22 271.006  5339 NXSERVER NXRunCommand: running in background.
2015-07-09 11:36:22 271.331  5339 NXSERVER NXClose FD#16 from NXServerDaemon::serverSocketAccepted_parser.
2015-07-09 11:36:22 271.921  5658 NXSERVER NXPL::NXYieldDescriptor(12, /tmp/session-42B7156DAF9DC482B9C22491D86692AF, ***) 12
2015-07-09 11:36:22 272.148  5658 NXSERVER Something to read from accepted nxserver monitor socket on FD#10.
2015-07-09 11:36:22 272.239  5658 NXSERVER Read 'Node started with pid=5676 ' on FD#10
2015-07-09 11:36:22 274.954  5658 NXSERVER Something to read from accepted nxserver monitor socket on FD#10.
2015-07-09 11:36:22 275.030  5658 NXSERVER Connection was closed.
2015-07-09 11:36:22 275.119  5658 NXSERVER NXClose FD#10 from NXClientSystemDaemons::closeConnection.
2015-07-09 11:36:22 275.361  5658 NXSERVER Reply from daemon: Node started with pid=5676 .
2015-07-09 11:36:22 275.466  5658 NXSERVER Session node started with pid 5676 on handler 11.
2015-07-09 11:36:22 275.564  5658 NXSERVER NXNodeExec::stdin is set to FD#11.
2015-07-09 11:36:22 275.636  5658 NXSERVER NXNodeExec::stdout is set to FD#11.
2015-07-09 11:36:22 275.709  5658 NXSERVER NXNodeExec::stderr is set to FD#2.
2015-07-09 11:36:22 275.821  5658 NXSERVER Start read until: 1000
2015-07-09 11:36:22 275.890  5658 NXSERVER Adding to the selector: FD#11
2015-07-09 11:36:22 276.394  5658 NXSERVER Something to read on FD#11.
2015-07-09 11:36:22 276.472  5658 NXSERVER Something to read on node stdout.
2015-07-09 11:36:22 276.558  5658 NXSERVER Read '' 0 from FD#11.
2015-07-09 11:36:22 276.645  5658 NXSERVER NXClose FD#11 from NXNodeExec::__read_until.
2015-07-09 11:36:22 276.713  5658 NXSERVER NXNodeExec::stdout is set to FD#.
2015-07-09 11:36:22 276.840  5658 NXSERVER waiting process: with pid '5676' using 5s as timeout
2015-07-09 11:36:22 276.926  5658 NXSERVER NXProcess with pid: 5676 not monitored, adding watchdog.
2015-07-09 11:36:22 277.107  5658 NXSERVER NXPL::NXAddWatchdog(5676, 17) executed.
2015-07-09 11:36:22 277.434  5339 NXSERVER NXParser: signal 'CHLD' received.
2015-07-09 11:36:22 277.525  5339 NXSERVER Received 'SIGCHLD' signal:going to handle it
2015-07-09 11:36:22 277.605  5339 NXSERVER handleSIGCHLD
2015-07-09 11:36:22 277.663  5339 NXSERVER handleSIGCHLD checking child: 5676
2015-07-09 11:36:22 277.749  5339 NXSERVER WARNING! Process (5676/5676) finished with signal '13'.
2015-07-09 11:36:22 277.815  5339 NXSERVER Going to call NXProcessRemove(5676)
2015-07-09 11:36:22 277.913  5339 NXSERVER Process '/usr/NX/bin/nxexec --node --user test --priority  --mode 0' with pid '5676/5676' finished after 0,7 seconds.
2015-07-09 11:36:22 278.022  5339 NXSERVER nxDefaultExitCodeHandler: process with pid 5676 just died with exit code '13'.
2015-07-09 11:36:27 277.583  5658 NXSERVER NXParser: signal 'CHLD' received.
2015-07-09 11:36:27 277.705  5658 NXSERVER Received 'SIGCHLD' signal:going to handle it
2015-07-09 11:36:27 277.767  5658 NXSERVER handleSIGCHLD
2015-07-09 11:36:27 277.834  5658 NXSERVER handleSIGCHLD checking not child process: 5676
2015-07-09 11:36:27 277.895  5658 NXSERVER handleSIGCHLD: not child process: 5676 is not running.
2015-07-09 11:36:27 277.952  5658 NXSERVER Executing callback [CODE(0x2a7b050)] for process [5676]
2015-07-09 11:36:27 278.044  5658 NXSERVER nxDefaultWatchdogExitHandler: process with pid [5676] just died.
2015-07-09 11:36:27 278.207  5658 NXSERVER __read_until stop 1000
2015-07-09 11:36:27 278.267  5658 NXSERVER __read_until ''.
2015-07-09 11:36:27 278.335  5658 NXSERVER ERROR! Cannot connect to local node.
2015-07-09 11:36:27 278.390  5658 NXSERVER Function clean called
2015-07-09 11:36:27 278.472  5658 NXSERVER NXClose FD#11 from NXNodeExec::clean.
2015-07-09 11:36:27 278.532  5658 NXSERVER WARNING! NXClose trying to close unknown descriptor FD#11 from NXNodeExec::clean.
2015-07-09 11:36:27 278.586  5658 NXSERVER NXNodeExec::stdin is set to FD#.
2015-07-09 11:36:27 278.681  5658 NXSERVER NXNodeExec::socketserver closing.
2015-07-09 11:36:27 278.741  5658 NXSERVER NXClose FD#9 from NXNodeExec::clean.
2015-07-09 11:36:27 280.769  5658 NXSERVER Handling Exception::Base.
2015-07-09 11:36:27 280.858  5658 NXSERVER NXPL was already loaded.
2015-07-09 11:36:27 280.950  5658 NXSERVER NXPL::NXGetRandomString start. 
2015-07-09 11:36:27 281.011  5658 NXSERVER NXPL::NXGetRandomString stop. 
2015-07-09 11:36:27 281.151  5658 NXSERVER Sent response message 'NX> 595 Server could not establish communication with local node.'
2015-07-09 11:36:27 282.128  5658 NXSERVER Finalize process.
2015-07-09 11:36:27 282.270  5658 NXSERVER Connection to client still open.
2015-07-09 11:36:27 282.395  5658 NXSERVER Closing client connection.
2015-07-09 11:36:27 282.614  5658 NXSERVER NXClose FD#3 from NXBegin::finalizeProcess.
2015-07-09 11:36:27 282.770  5658 NXSERVER NXClose FD#12 from NXBegin::finalizeProcess.
2015-07-09 11:36:27 282.937  5658 NXSERVER NXClose FD#2 from NXBegin::finalizeProcess.