Project

General

Profile

Bug #4716 » DEBUG_2014_04_01.stderrout.log

Debug loglevel - Anonymous, 2014-04-01 10:14

 
[2014-04-01 10:01:20] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 28 ms (started at 2014/04/01 10:01:20, finished at 2014/04/01 10:01:20)
[2014-04-01 10:01:25] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:01:25] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #39: Starting analysis for run times from 2014/04/01 10:01:20 up to 2014/04/01 10:01:25 (runs after SQL table ID 119232)
[2014-04-01 10:01:25] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - There are no nodes executions to store
[2014-04-01 10:01:25] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #39: Finished analysis in 28 ms. Added or updated 0 agent runs (up to SQL table ID 119232)
[2014-04-01 10:01:25] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 90 ms (started at 2014/04/01 10:01:25, finished at 2014/04/01 10:01:25)
[2014-04-01 10:01:26] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - All relevant information fetched in 827ms, start names historization.
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Historization of name done in 1895ms, start to build RuleVals.
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal inventory from the ruleId inventory-all
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal distributePolicy from the ruleId root-DP
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal common from the ruleId hasPolicyServer-root
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal checkGenericFileContent from the ruleId 5e348ec8-e901-4666-83cd-ded1debfe0d3
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal distributePolicy from the ruleId bb8ee6c0-0dff-4f82-a2fc-efffc0c45853-DP
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal common from the ruleId hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - RuleVals built in 127ms, start to expand their values.
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CLIENTSFOLDERS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: CLIENTSFOLDERS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SHARED_FILES_FOLDER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: SHARED_FILES_FOLDER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SYSLOGPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: SYSLOGPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CMDBENDPOINT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: CMDBENDPOINT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : OWNER: [${rudder.node.admin}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: OWNER: [${rudder.node.admin}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CHILDRENID: [${rudder.hasPolicyServer-root.target.id}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing rule's parameterized value on target: ${rudder.hasPolicyServer-root.target.id}
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: CHILDRENID: [root, bb8ee6c0-0dff-4f82-a...]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : BUNDLELIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: BUNDLELIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : COMMUNITY: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: COMMUNITY: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : DAVPASSWORD: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: DAVPASSWORD: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ADMIN: [${rudder.hasPolicyServer-root.target.admin}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing rule's parameterized value on target: ${rudder.hasPolicyServer-root.target.admin}
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: ADMIN: [root, root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ALLOWCONNECT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: ALLOWCONNECT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SHARED_FILES_FOLDER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: SHARED_FILES_FOLDER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : NOVA: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: NOVA: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : UUID: [${rudder.node.id}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: UUID: [${rudder.node.id}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : MANAGED_NODES_NAME: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: MANAGED_NODES_NAME: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SKIPIDENTIFY: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: SKIPIDENTIFY: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SYSLOGPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: SYSLOGPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : NODEROLE: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: NODEROLE: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYSERVER_ADMIN: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: POLICYSERVER_ADMIN: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : DAVUSER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: DAVUSER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : COMMUNITYPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: COMMUNITYPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYSERVER: [serveur-rudder]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: POLICYSERVER: [serveur-rudder]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : LICENSESPAID: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: LICENSESPAID: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : DENYBADCLOCKS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: DENYBADCLOCKS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYSERVER_ID: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: POLICYSERVER_ID: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : AUTHORIZED_NETWORKS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: AUTHORIZED_NETWORKS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : INPUTLIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: INPUTLIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CLIENTSLIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: CLIENTSLIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYCHILDREN: [${rudder.hasPolicyServer-root.target.hostname}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing rule's parameterized value on target: ${rudder.hasPolicyServer-root.target.hostname}
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: POLICYCHILDREN: [serveur-rudder, relay-rudder]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ALLOWEDNETWORK: [1.0.0.0/8]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: ALLOWEDNETWORK: [1.0.0.0/8]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : MANAGED_NODES_ID: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: MANAGED_NODES_ID: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_PERM: [644]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_PERM: [644]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_DELETION_REGEXP: [deleteme.*]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_DELETION_REGEXP: [deleteme.*]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_SECTION_MANAGEMENT: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_SECTION_MANAGEMENT: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_MODIFICATION_REGEXP: [replaceme.*]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_MODIFICATION_REGEXP: [replaceme.*]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_MODIFICATION_DESTINATION: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_MODIFICATION_DESTINATION: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_ENFORCE_CREATE_ONLY_BOOLEAN: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_ENFORCE_CREATE_ONLY_BOOLEAN: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_ENFORCE: [true]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_ENFORCE: [true]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_MODIFICATION_BOOLEAN: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_MODIFICATION_BOOLEAN: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_PERMISSION_ADJUSTMENT: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_PERMISSION_ADJUSTMENT: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_PATH: [/rudder/ok]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_PATH: [/rudder/ok]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_GROUP: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_GROUP: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_OWNER: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_OWNER: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_SECTION_FOOTER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_SECTION_FOOTER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_PAYLOAD: [OK]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_PAYLOAD: [OK]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_SECTION_HEADER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_SECTION_HEADER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_POST_HOOK_COMMAND: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_POST_HOOK_COMMAND: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_CREATE_BOOLEAN: [true]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_CREATE_BOOLEAN: [true]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_SECTION_CONTENT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_SECTION_CONTENT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_POST_HOOK_RUN: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_POST_HOOK_RUN: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : GENERIC_FILE_CONTENT_DELETION_BOOLEAN: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: GENERIC_FILE_CONTENT_DELETION_BOOLEAN: [false]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CLIENTSFOLDERS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: CLIENTSFOLDERS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SHARED_FILES_FOLDER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: SHARED_FILES_FOLDER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SYSLOGPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: SYSLOGPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CMDBENDPOINT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: CMDBENDPOINT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : OWNER: [${rudder.node.admin}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: OWNER: [${rudder.node.admin}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CHILDRENID: [${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.target.id}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing rule's parameterized value on target: ${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.target.id}
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: CHILDRENID: [7e9a3418-6432-45d9-8...]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : BUNDLELIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: BUNDLELIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : COMMUNITY: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: COMMUNITY: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : DAVPASSWORD: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: DAVPASSWORD: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ADMIN: [${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.target.admin}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing rule's parameterized value on target: ${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.target.admin}
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: ADMIN: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ALLOWCONNECT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: ALLOWCONNECT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SHARED_FILES_FOLDER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: SHARED_FILES_FOLDER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : NOVA: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: NOVA: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : UUID: [${rudder.node.id}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: UUID: [${rudder.node.id}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : MANAGED_NODES_NAME: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: MANAGED_NODES_NAME: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SKIPIDENTIFY: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: SKIPIDENTIFY: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : SYSLOGPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: SYSLOGPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : NODEROLE: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: NODEROLE: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYSERVER_ADMIN: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: POLICYSERVER_ADMIN: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : DAVUSER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: DAVUSER: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : COMMUNITYPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: COMMUNITYPORT: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYSERVER: [relay-rudder]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: POLICYSERVER: [relay-rudder]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : LICENSESPAID: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: LICENSESPAID: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : DENYBADCLOCKS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: DENYBADCLOCKS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYSERVER_ID: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: POLICYSERVER_ID: [root]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : AUTHORIZED_NETWORKS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: AUTHORIZED_NETWORKS: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : INPUTLIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: INPUTLIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : CLIENTSLIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: CLIENTSLIST: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : POLICYCHILDREN: [${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.target.hostname}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing rule's parameterized value on target: ${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.target.hostname}
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: POLICYCHILDREN: [noeud-rudder]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ALLOWEDNETWORK: [1.0.0.0/8, 2.0.0.0/8]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: ALLOWEDNETWORK: [1.0.0.0/8, 2.0.0.0/8]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : MANAGED_NODES_ID: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: MANAGED_NODES_ID: []
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - RuleVals expanded in 352, start to build node's new configuration.
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.SystemVariableServiceImpl - Preparing the system variables for server root
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ${rudder.hasPolicyServer-root.ALLOWEDNETWORK}: [${rudder.hasPolicyServer-root.ALLOWEDNETWORK}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing rule's parameterized value on variable: ${rudder.hasPolicyServer-root.ALLOWEDNETWORK}
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal common from the ruleId hasPolicyServer-root
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: ${rudder.hasPolicyServer-root.ALLOWEDNETWORK}: [1.0.0.0/8]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ${rudder.hasPolicyServer-root.target.hostname}: [${rudder.hasPolicyServer-root.target.hostname}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing rule's parameterized value on target: ${rudder.hasPolicyServer-root.target.hostname}
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: ${rudder.hasPolicyServer-root.target.hostname}: [serveur-rudder, relay-rudder]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.SystemVariableServiceImpl - System variables for server root done
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.SystemVariableServiceImpl - Preparing the system variables for server bb8ee6c0-0dff-4f82-a2fc-efffc0c45853
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.ALLOWEDNETWORK}: [${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.ALLOWEDNETWORK}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing rule's parameterized value on variable: ${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.ALLOWEDNETWORK}
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.RuleValServiceImpl - Creating a DirectiveVal common from the ruleId hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: ${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.ALLOWEDNETWORK}: [1.0.0.0/8, 2.0.0.0/8]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing variable : ${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.target.hostname}: [${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.target.hostname}]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Processing rule's parameterized value on target: ${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.target.hostname}
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.ParameterizedValueLookupServiceImpl - Setted variable values are: ${rudder.hasPolicyServer-bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.target.hostname}: [noeud-rudder]
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.SystemVariableServiceImpl - System variables for server bb8ee6c0-0dff-4f82-a2fc-efffc0c45853 done
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.SystemVariableServiceImpl - Preparing the system variables for server 7e9a3418-6432-45d9-8924-71b5690b9db0
[2014-04-01 10:01:28] DEBUG com.normation.rudder.services.policies.SystemVariableServiceImpl - System variables for server 7e9a3418-6432-45d9-8924-71b5690b9db0 done
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Node's target onfiguration built in 543, start to update whose needed to be updated.
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.servers.NodeConfigurationServiceImpl - Updating node configuration 7e9a3418-6432-45d9-8924-71b5690b9db0
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.servers.NodeConfigurationServiceImpl - Updating node configuration bb8ee6c0-0dff-4f82-a2fc-efffc0c45853
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.servers.NodeConfigurationServiceImpl - Updating node configuration root
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - RuleVals updated in 368 millisec, detect changes.
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.servers.NodeConfigurationChangeDetectServiceImpl - Checking changes in node NodeId(bb8ee6c0-0dff-4f82-a2fc-efffc0c45853)
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.servers.NodeConfigurationChangeDetectServiceImpl - Checking changes in node NodeId(root)
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.servers.NodeConfigurationChangeDetectServiceImpl - Checking changes in node NodeId(7e9a3418-6432-45d9-8924-71b5690b9db0)
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Detected the changes in the NodeConfiguration to trigger change in CR in 283ms, updating the SN in the nodes
[2014-04-01 10:01:29] INFO com.normation.rudder.services.servers.NodeConfigurationServiceImpl - Configuration of following nodes were updated, their promises are going to be written: bb8ee6c0-0dff-4f82-a2fc-efffc0c45853, root, 7e9a3418-6432-45d9-8924-71b5690b9db0
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Preparing the PI variables for container /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Variable system named CLIENTSFOLDERS not found in the extended variables environnement
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Prepared the tml for the node NodeId(bb8ee6c0-0dff-4f82-a2fc-efffc0c45853)
[2014-04-01 10:01:29] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Preparing reporting information from meta technique
[2014-04-01 10:01:30] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:01:30] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #40: Starting analysis for run times from 2014/04/01 10:01:25 up to 2014/04/01 10:01:30 (runs after SQL table ID 119232)
[2014-04-01 10:01:30] DEBUG com.normation.rudder.reports.execution.WoReportsExecutionSquerylRepository - Closed 0 execution, out of the 0 that should have been closed
[2014-04-01 10:01:30] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #40: Finished analysis in 116 ms. Added or updated 1 agent runs, up to SQL table ID 119237 (last run time was 2014/04/01 10:01:26)
[2014-04-01 10:01:30] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 132 ms (started at 2014/04/01 10:01:30, finished at 2014/04/01 10:01:30)
[2014-04-01 10:01:30] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community checkGenericFileContent/4.0/checkGenericFileContent.cf
[2014-04-01 10:01:30] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/1.0/site.cf
[2014-04-01 10:01:30] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/1.0/rudder_parameters.cf
[2014-04-01 10:01:30] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/cron/rudder_agent_community_cron
[2014-04-01 10:01:30] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/1.0/update.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/1.0/cf-served.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community rudder_promises_generated
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community promises.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/cron/rudder_agent_nova_cron
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/1.0/check_zypper.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community failsafe.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/1.0/rudder_stdlib.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/1.0/rudder_lib.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/1.0/internal_security.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/1.0/e2s_activation.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community common/1.0/process_matching.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community inventory/1.0/fetchFusionTools.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community inventory/1.0/virtualMachines.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community inventory/1.0/fusionAgent.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/1.0/propagatePromises.cf
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/logrotate.conf/rudder.rhel
[2014-04-01 10:01:31] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/1.0/integrityCheck.cf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/rsyslog.conf/rudder-rsyslog-root.conf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/logrotate.conf/rudder.ubuntu
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/1.0/aliveCheck.cf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/1.0/initCheck.cf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/rsyslog.conf/rudder-rsyslog-relay.conf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/1.0/postgresCheck.cf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/logrotate.conf/rudder.debian
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/1.0/logrotateCheck.cf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/1.0/passwordCheck.cf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/1.0/techniqueReload.cf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/1.0/networkCheck.cf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/1.0/rsyslogConf.cf
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community distributePolicy/logrotate.conf/rudder.suse
[2014-04-01 10:01:32] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community clientlist/clientlist.cf
[2014-04-01 10:01:35] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:01:35] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #41: Starting analysis for run times from 2014/04/01 10:01:26 up to 2014/04/01 10:01:35 (runs after SQL table ID 119237)
[2014-04-01 10:01:35] DEBUG com.normation.rudder.reports.execution.WoReportsExecutionSquerylRepository - Closed 0 execution, out of the 0 that should have been closed
[2014-04-01 10:01:35] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #41: Finished analysis in 86 ms. Added or updated 0 agent runs, up to SQL table ID 119254 (last run time was 2014/04/01 10:01:26)
[2014-04-01 10:01:35] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 135 ms (started at 2014/04/01 10:01:35, finished at 2014/04/01 10:01:35)
[2014-04-01 10:01:40] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:01:40] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #42: Starting analysis for run times from 2014/04/01 10:01:26 up to 2014/04/01 10:01:40 (runs after SQL table ID 119254)
[2014-04-01 10:01:40] DEBUG com.normation.rudder.reports.execution.WoReportsExecutionSquerylRepository - Closed 0 execution, out of the 0 that should have been closed
[2014-04-01 10:01:40] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #42: Finished analysis in 94 ms. Added or updated 0 agent runs, up to SQL table ID 119269 (last run time was 2014/04/01 10:01:26)
[2014-04-01 10:01:40] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 115 ms (started at 2014/04/01 10:01:40, finished at 2014/04/01 10:01:40)
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Timing cf-promise for /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/rules/cfengine-community: 11739ms (11s)
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Preparing the PI variables for container /var/rudder/cfengine-community/inputs.new
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Variable system named CLIENTSFOLDERS not found in the extended variables environnement
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Prepared the tml for the node NodeId(root)
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Preparing reporting information from meta technique
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new checkGenericFileContent/4.0/checkGenericFileContent.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/1.0/site.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/1.0/rudder_parameters.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/cron/rudder_agent_community_cron
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/1.0/update.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/1.0/cf-served.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new rudder_promises_generated
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new promises.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/cron/rudder_agent_nova_cron
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/1.0/check_zypper.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new failsafe.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/1.0/rudder_stdlib.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/1.0/rudder_lib.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/1.0/internal_security.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/1.0/e2s_activation.cf
[2014-04-01 10:01:44] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new common/1.0/process_matching.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new inventory/1.0/fetchFusionTools.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new inventory/1.0/virtualMachines.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new inventory/1.0/fusionAgent.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/1.0/propagatePromises.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/logrotate.conf/rudder.rhel
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/1.0/integrityCheck.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/rsyslog.conf/rudder-rsyslog-root.conf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/logrotate.conf/rudder.ubuntu
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/1.0/aliveCheck.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/1.0/initCheck.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/rsyslog.conf/rudder-rsyslog-relay.conf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/1.0/postgresCheck.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/logrotate.conf/rudder.debian
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/1.0/logrotateCheck.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/1.0/passwordCheck.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/1.0/techniqueReload.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/1.0/networkCheck.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/1.0/rsyslogConf.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #43: Starting analysis for run times from 2014/04/01 10:01:26 up to 2014/04/01 10:01:45 (runs after SQL table ID 119269)
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new distributePolicy/logrotate.conf/rudder.suse
[2014-04-01 10:01:45] DEBUG com.normation.rudder.reports.execution.WoReportsExecutionSquerylRepository - Closed 1 execution, out of the 1 that should have been closed
[2014-04-01 10:01:45] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/cfengine-community/inputs.new clientlist/clientlist.cf
[2014-04-01 10:01:45] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #43: Finished analysis in 101 ms. Added or updated 1 agent runs, up to SQL table ID 119272 (last run time was 2014/04/01 10:01:26)
[2014-04-01 10:01:45] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 133 ms (started at 2014/04/01 10:01:45, finished at 2014/04/01 10:01:45)
[2014-04-01 10:01:50] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:01:50] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #44: Starting analysis for run times from 2014/04/01 10:01:26 up to 2014/04/01 10:01:50 (runs after SQL table ID 119272)
[2014-04-01 10:01:50] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - There are no nodes executions to store
[2014-04-01 10:01:50] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #44: Finished analysis in 36 ms. Added or updated 0 agent runs (up to SQL table ID 119272)
[2014-04-01 10:01:50] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 51 ms (started at 2014/04/01 10:01:50, finished at 2014/04/01 10:01:50)
[2014-04-01 10:01:55] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:01:55] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #45: Starting analysis for run times from 2014/04/01 10:01:50 up to 2014/04/01 10:01:55 (runs after SQL table ID 119272)
[2014-04-01 10:01:55] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - There are no nodes executions to store
[2014-04-01 10:01:55] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #45: Finished analysis in 49 ms. Added or updated 0 agent runs (up to SQL table ID 119272)
[2014-04-01 10:01:55] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 69 ms (started at 2014/04/01 10:01:55, finished at 2014/04/01 10:01:55)
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Timing cf-promise for /var/rudder/cfengine-community/inputs.new: 10333ms (10s)
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Preparing the PI variables for container /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Prepared the tml for the node NodeId(7e9a3418-6432-45d9-8924-71b5690b9db0)
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Preparing reporting information from meta technique
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/1.0/site.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/1.0/rudder_parameters.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/cron/rudder_agent_community_cron
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/1.0/update.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/1.0/cf-served.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community rudder_promises_generated
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community promises.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/cron/rudder_agent_nova_cron
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/1.0/check_zypper.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community failsafe.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/1.0/rudder_stdlib.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/1.0/rudder_lib.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/1.0/internal_security.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/1.0/e2s_activation.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community common/1.0/process_matching.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community inventory/1.0/fetchFusionTools.cf
[2014-04-01 10:01:56] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community inventory/1.0/virtualMachines.cf
[2014-04-01 10:01:57] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Create promises file /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community inventory/1.0/fusionAgent.cf
[2014-04-01 10:02:00] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:02:00] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #46: Starting analysis for run times from 2014/04/01 10:01:55 up to 2014/04/01 10:02:00 (runs after SQL table ID 119272)
[2014-04-01 10:02:00] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - There are no nodes executions to store
[2014-04-01 10:02:00] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #46: Finished analysis in 49 ms. Added or updated 0 agent runs (up to SQL table ID 119272)
[2014-04-01 10:02:00] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 64 ms (started at 2014/04/01 10:02:00, finished at 2014/04/01 10:02:00)
[2014-04-01 10:02:05] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:02:05] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #47: Starting analysis for run times from 2014/04/01 10:02:00 up to 2014/04/01 10:02:05 (runs after SQL table ID 119272)
[2014-04-01 10:02:05] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - There are no nodes executions to store
[2014-04-01 10:02:05] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #47: Finished analysis in 35 ms. Added or updated 0 agent runs (up to SQL table ID 119272)
[2014-04-01 10:02:05] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 50 ms (started at 2014/04/01 10:02:05, finished at 2014/04/01 10:02:05)
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Timing cf-promise for /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new/rules/cfengine-community: 9141ms (9s)
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Backuping old promises from /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853 to /var/rudder/backup/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Copying new promises into /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Moving folders from /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new to /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Backuping old promises from /var/rudder/cfengine-community/inputs to /var/rudder/cfengine-community/inputs.bkp
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Copying new promises into /var/rudder/cfengine-community/inputs
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Moving folders from /var/rudder/cfengine-community/inputs.new to /var/rudder/cfengine-community/inputs
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Backuping old promises from /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0 to /var/rudder/backup/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Copying new promises into /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Moving folders from /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new to /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0
[2014-04-01 10:02:06] ERROR com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Could not find freshly created promises at /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0.new
[2014-04-01 10:02:06] ERROR com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Could not write promises into /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0, reason :
java.io.IOException: Created promises not found !!!!
at com.normation.cfclerk.services.impl.Cf3PromisesFileWriterServiceImpl.com$normation$cfclerk$services$impl$Cf3PromisesFileWriterServiceImpl$$moveNewNodeFolder(Cf3PromisesFileWriterServiceImpl.scala:362) ~[cfclerk-2.9.4.jar:na]
[2014-04-01 10:02:06] INFO com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Restoring old promises on folder /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853
[2014-04-01 10:02:06] INFO com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Restoring old promises on folder /var/rudder/cfengine-community/inputs
[2014-04-01 10:02:06] INFO com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Restoring old promises on folder /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0
[2014-04-01 10:02:06] ERROR com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - Could not find freshly backup promises at /var/rudder/backup/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0
[2014-04-01 10:02:06] ERROR com.normation.rudder.services.policies.RudderCf3PromisesFileWriterServiceImpl - could not restore old promises into /var/rudder/share/bb8ee6c0-0dff-4f82-a2fc-efffc0c45853.new/share/7e9a3418-6432-45d9-8924-71b5690b9db0
[2014-04-01 10:02:06] DEBUG com.normation.rudder.services.policies.DeploymentServiceImpl - Deployment completed in 40967 millisec
[2014-04-01 10:02:06] ERROR com.normation.rudder.batch.AsyncDeploymentAgent$DeployerAgent - Error when doing deployment, reason Cannot write configuration node <- Backup promises could not be found, and valid promises couldn't be restored !!!!
[2014-04-01 10:02:06] ERROR com.normation.rudder.batch.AsyncDeploymentAgent - Deployment error for process '54' at 2014/04/01 10:02:06: Cannot write configuration node
[2014-04-01 10:02:10] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:02:11] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #48: Starting analysis for run times from 2014/04/01 10:02:05 up to 2014/04/01 10:02:11 (runs after SQL table ID 119272)
[2014-04-01 10:02:11] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - There are no nodes executions to store
[2014-04-01 10:02:11] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #48: Finished analysis in 32 ms. Added or updated 0 agent runs (up to SQL table ID 119272)
[2014-04-01 10:02:11] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 40 ms (started at 2014/04/01 10:02:10, finished at 2014/04/01 10:02:11)
[2014-04-01 10:02:16] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:02:16] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #49: Starting analysis for run times from 2014/04/01 10:02:11 up to 2014/04/01 10:02:16 (runs after SQL table ID 119272)
[2014-04-01 10:02:16] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - There are no nodes executions to store
[2014-04-01 10:02:16] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #49: Finished analysis in 31 ms. Added or updated 0 agent runs (up to SQL table ID 119272)
[2014-04-01 10:02:16] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 49 ms (started at 2014/04/01 10:02:16, finished at 2014/04/01 10:02:16)
[2014-04-01 10:02:21] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:02:21] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #50: Starting analysis for run times from 2014/04/01 10:02:16 up to 2014/04/01 10:02:21 (runs after SQL table ID 119272)
[2014-04-01 10:02:21] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - There are no nodes executions to store
[2014-04-01 10:02:21] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #50: Finished analysis in 21 ms. Added or updated 0 agent runs (up to SQL table ID 119272)
[2014-04-01 10:02:21] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 30 ms (started at 2014/04/01 10:02:21, finished at 2014/04/01 10:02:21)
[2014-04-01 10:02:26] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task starting
[2014-04-01 10:02:26] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #51: Starting analysis for run times from 2014/04/01 10:02:21 up to 2014/04/01 10:02:26 (runs after SQL table ID 119272)
[2014-04-01 10:02:26] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - There are no nodes executions to store
[2014-04-01 10:02:26] DEBUG com.normation.rudder.reports.execution.ReportsExecutionService - [Store Agent Run Times] Task #51: Finished analysis in 18 ms. Added or updated 0 agent runs (up to SQL table ID 119272)
[2014-04-01 10:02:26] DEBUG com.normation.rudder.batch.AbstractScheduler$StatusManager - [Store Agent Run Times] Scheduled task finished in 25 ms (started at 2014/04/01 10:02:26, finished at 2014/04/01 10:02:26)
(3-3/3)