Project

General

Profile

Bug #2466 ยป rudder-log.log

Nicolas PERRON, 2012-04-23 15:06

 
15:01:09.488 [main] DEBUG bootstrap.liftweb.checks.CheckDIT - DIT entry 'groupCategoryId=SystemGroups,groupCategoryId=GroupRoot,ou=Rudder,cn=rudder-configuration' already in LDAP directory, nothing to do
15:01:09.489 [main] DEBUG bootstrap.liftweb.checks.CheckDIT - DIT entry 'ou=Nodes Configuration,ou=Rudder,cn=rudder-configuration' already in LDAP directory, nothing to do
15:01:09.489 [main] DEBUG bootstrap.liftweb.checks.CheckDIT - DIT entry 'ou=Archives,ou=Rudder,cn=rudder-configuration' already in LDAP directory, nothing to do
15:01:09.489 [main] DEBUG bootstrap.liftweb.checks.CheckDIT - DIT entry 'ou=Archives,ou=Rudder,cn=rudder-configuration' already in LDAP directory, nothing to do
15:01:09.490 [main] INFO bootstrap.liftweb.checks.CheckDIT - All require DIT entries present in the LDAP directory
15:01:09.503 [main] DEBUG bootstrap.liftweb.checks.CheckInitUserTemplateLibrary - The root user template library was initialized on 2012/04/23 01:59
15:01:09.805 [pool-3-thread-2] DEBUG com.normation.cfclerk.services.impl.TechniqueRepositoryImpl - Not reloading technique library as nothing changed since last reload
15:01:09.871 [main] DEBUG migration-2.3-2.4-eventlog-xml-format-1.0-2 - No migration detected by migration script (table 'migrationeventlog' is empty or does not exists)
15:01:10.034 [main] DEBUG net.liftweb.util.Props - Loaded key/value properties from resource /props/production.default.props
2012-04-23 15:01:10.061:INFO::Started SelectChannelConnector@127.0.0.1:8080
15:01:45.311 [pool-3-thread-13] DEBUG com.normation.rudder.repository.ldap.LDAPRuleRepository - Activated groups are ArrayBuffer(hasPolicyServer-root, d284484f-91f2-4ba0-9d36-3a2a90702591, 714a4766-b338-4fc7-920b-061b916d6df0)
15:01:45.409 [pool-3-thread-13] DEBUG com.normation.rudder.repository.ldap.LDAPRuleRepository - Checking activation of group hasPolicyServer-root for the target of rule hasPolicyServer-root
15:01:45.423 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Configuration rules dependency solved in 121 millisec, start to build RuleVals
15:01:45.710 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Historization of name done in 287 millisec
15:01:45.755 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal inventory from the ruleId RuleId(inventory-all)
15:01:45.761 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal distributePolicy from the ruleId RuleId(root-DP)
15:01:45.769 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal common from the ruleId RuleId(hasPolicyServer-root)
15:01:45.772 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CMDBENDPOINT The cmdb endpoint : ArrayBuffer()
15:01:45.773 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are CMDBENDPOINT ArrayBuffer()
15:01:45.774 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CLIENTSFOLDERS List of agent to contact via runagent : ArrayBuffer()
15:01:45.775 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are CLIENTSFOLDERS ArrayBuffer()
15:01:45.775 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : OWNER User launching cfe (usually root) : ArrayBuffer(${node.admin})
15:01:45.778 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are OWNER ArrayBuffer(${node.admin})
15:01:45.778 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CHILDRENID List of uids of nodes that receive policies from this machine : ArrayBuffer(${hasPolicyServer-root.target.id})
15:01:45.779 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing configuration rule's parameterized value on target: ${hasPolicyServer-root.target.id}
15:01:45.796 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are CHILDRENID ArrayBuffer(root)
15:01:45.796 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : BUNDLELIST Bundle list : ArrayBuffer()
15:01:45.796 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are BUNDLELIST ArrayBuffer()
15:01:45.796 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : COMMUNITY The Cfengine Community agent : ArrayBuffer()
15:01:45.796 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are COMMUNITY ArrayBuffer()
15:01:45.796 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ADMIN List of admins of nodes that receive policies from this machine : ArrayBuffer(${hasPolicyServer-root.target.admin})
15:01:45.796 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing configuration rule's parameterized value on target: ${hasPolicyServer-root.target.admin}
15:01:45.800 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are ADMIN ArrayBuffer(root)
15:01:45.800 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ALLOWCONNECT List of ip allowed to connect to the node (policyserver + children if any) : ArrayBuffer()
15:01:45.800 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are ALLOWCONNECT ArrayBuffer()
15:01:45.800 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SHARED_FILES_FOLDER The path to the shared files folder : ArrayBuffer()
15:01:45.801 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are SHARED_FILES_FOLDER ArrayBuffer()
15:01:45.801 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : NOVA The Cfengine Nova agent : ArrayBuffer()
15:01:45.801 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are NOVA ArrayBuffer()
15:01:45.801 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : UUID UUID of the machine : ArrayBuffer(${node.id})
15:01:45.801 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are UUID ArrayBuffer(${node.id})
15:01:45.801 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : NODEROLE List of nodeConfiguration roles : ArrayBuffer()
15:01:45.801 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are NODEROLE ArrayBuffer()
15:01:45.801 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYSERVER_ADMIN The policy server admin allowed to connect to this node via cf-runagent (see also distributePolicy.ADMIN) : ArrayBuffer(root)
15:01:45.802 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are POLICYSERVER_ADMIN ArrayBuffer(root)
15:01:45.802 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : COMMUNITYPORT The port used by the community edition : ArrayBuffer()
15:01:45.802 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are COMMUNITYPORT ArrayBuffer()
15:01:45.802 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYSERVER Promises server hostname : ArrayBuffer(rudder-snapshot.normation.com)
15:01:45.802 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are POLICYSERVER ArrayBuffer(rudder-snapshot.normation.com)
15:01:45.802 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : LICENSESPAID Number of Nova licences paid : ArrayBuffer()
15:01:45.802 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are LICENSESPAID ArrayBuffer()
15:01:45.802 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYSERVER_ID UUID of the policy server : ArrayBuffer(root)
15:01:45.802 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are POLICYSERVER_ID ArrayBuffer(root)
15:01:45.803 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : INPUTLIST Input list : ArrayBuffer()
15:01:45.803 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are INPUTLIST ArrayBuffer()
15:01:45.803 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CLIENTSLIST List of agent to contact via runagent : ArrayBuffer()
15:01:45.803 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are CLIENTSLIST ArrayBuffer()
15:01:45.803 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYCHILDREN List of node that receive policies from this machine : ArrayBuffer(${hasPolicyServer-root.target.hostname})
15:01:45.803 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing configuration rule's parameterized value on target: ${hasPolicyServer-root.target.hostname}
15:01:45.806 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are POLICYCHILDREN ArrayBuffer(rudder-snapshot.normation.com)
15:01:45.806 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ALLOWEDNETWORK The network(s) allowed to connect to the server (can use the / parameter) : ArrayBuffer(192.168.0.0/24)
15:01:45.806 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are ALLOWEDNETWORK ArrayBuffer(192.168.0.0/24)
15:01:45.808 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - RuleVals built in 97 millisec, start to build targetNodeConfiguration
15:01:45.811 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.SystemVariableServiceImpl - Preparing the system variables for server root
15:01:45.813 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ${hasPolicyServer-root.target.hostname} : ArrayBuffer(${hasPolicyServer-root.target.hostname})
15:01:45.813 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing configuration rule's parameterized value on target: ${hasPolicyServer-root.target.hostname}
15:01:45.815 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - setted variable values are ${hasPolicyServer-root.target.hostname} ArrayBuffer(rudder-snapshot.normation.com)
15:01:45.818 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.SystemVariableServiceImpl - System variables for server root done
15:01:45.845 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - targetNodeConfiguration built in 37 millisec, start to update whose needed to be updated.
15:01:45.851 [pool-3-thread-13] DEBUG com.normation.rudder.services.servers.NodeConfigurationServiceImpl - Updating node configuration root
15:01:46.009 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - RuleVals updated in 163 millisec, detect changes.
15:01:46.010 [pool-3-thread-13] INFO com.normation.rudder.services.servers.NodeConfigurationChangeDetectServiceImpl - Checking changes in node root
15:01:46.023 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Detected the changes in the NodeConfiguration to trigger change in CR in 14 millisec. Update the SN in the nodes
15:01:46.048 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Serial number updated in the nodes in 24 millisec. Update information in crval.
15:01:46.050 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Updated serial in crval in 2 millisec. Write promisses.
15:01:46.058 [pool-3-thread-13] DEBUG com.normation.rudder.services.servers.NodeConfigurationServiceImpl - Written in ldap the node configuration caches in 0 millisec
15:01:46.063 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Configuration rules deployed in 13 millisec, process report information
15:01:46.070 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Reports updated in 7 millisec
15:01:46.071 [pool-3-thread-13] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Deployment completed in 770 millisec
15:01:46.073 [pool-3-thread-13] INFO com.normation.rudder.batch.AsyncDeploymentAgent - Successful deployment 4 [2012/04/23 15:01:45 - 2012/04/23 15:01:46]
    (1-1/1)