[rudder-users] Rudder Root Service Periodic Restart

John Robert MENDOZA bert at asti.dost.gov.ph
Tue Oct 7 07:03:40 CEST 2014


Hello Francois,

Thank you for your response. Once in a while, I encounter an error 
message "Cannot contact the server at this time." which refreshes the 
page I'm on and shows an animation "Rudder is loading, please wait". 
After then, I end up on the login page. Upon investigation of the log 
files, I found that the application might be triggering a "graceful" 
shutdown. I've enclosed the relevant log file for your closer inspection.

Thanks,
Bert





On Monday, 06 October, 2014 08:59 PM, Francois Armand wrote:
> On 05/10/2014 06:40, John Robert T. Mendoza wrote:
>> Hello,
>>
>> I'm encountering periodic restarts of the rudder root service. This results of me being dropped from my current web session and prompts me to log in again. Is this an intentional behaviour or did I misconfigure something?
>>
>> Thanks,
>>
>
>
> Hello,
>
> Periodic restart are not an intentional behavior, so there seems to 
> have something not cool is happening.
>
> First, perhaps the application is not really restarting. Do you see 
> any wainting screen ("Rudder is loading, plea wait") befor being 
> redirected to the login screen ?
> Does the PID of the application is changing during these events ?
> You can know the PID of Rudder server with command:
>
>   $ ps aux | grep rudder | grep java
>
> If Rudder is not restarting, perhaps the problem is on the 
> authentication part (for example, at some point, the server is loosing 
> your authentication cookie and so ask you a new authentication).
>
> If the application is restarting, could you please tell us if there is 
> any errors  in the log: /var/log/rudder/webapp/xxxx_stderrout.log ?
>
> Thanks,
>
> -- 
> ------------------------------------------------------------------------
> *François ARMAND*
> /Directeur de la R&D/
> Normation <http://www.normation.com>
> ------------------------------------------------------------------------
> *87 rue de Turbigo, 75003 Paris, France*
> Telephone: 	+33 (0)1 83 62 99 23
> Mobile: 	+33 (0)6 63 37 60 55
> ------------------------------------------------------------------------
>

-------------- next part --------------
An HTML attachment was scrubbed...
URL: <http://www.rudder-project.org/pipermail/rudder-users/attachments/20141007/a95de030/attachment-0001.html>
-------------- next part --------------
A non-text attachment was scrubbed...
Name: not available
Type: image/png
Size: 3503 bytes
Desc: not available
URL: <http://www.rudder-project.org/pipermail/rudder-users/attachments/20141007/a95de030/attachment-0001.png>
-------------- next part --------------
2014-10-05 12:30:19.033:INFO:oejs.Server:jetty-7.6.14.v20131031
2014-10-05 12:30:19.067:INFO:oejdp.ScanningAppProvider:Deployment monitor /opt/rudder/jetty7/webapps at interval 1
2014-10-05 12:30:19.075:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/jetty7/webapps/spdy.war
2014-10-05 12:30:19.169:INFO:oejw.WebInfConfiguration:Extract jar:file:/opt/rudder/jetty7/webapps/spdy.war!/ to /tmp/jetty-127.0.0.1-8080-spdy.war-_spdy-any-/webapp
2014-10-05 12:30:19.804:INFO:oejsh.ContextHandler:started o.e.j.w.WebAppContext{/spdy,file:/tmp/jetty-127.0.0.1-8080-spdy.war-_spdy-any-/webapp/},/opt/rudder/jetty7/webapps/spdy.war
2014-10-05 12:30:19.857:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/jetty7/webapps/async-rest
2014-10-05 12:30:20.179:INFO:oejsh.ContextHandler:started o.e.j.w.WebAppContext{/async-rest,file:/opt/rudder/jetty7/webapps/async-rest/},/opt/rudder/jetty7/webapps/async-rest
2014-10-05 12:30:20.187:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/jetty7/webapps/cometd.war
2014-10-05 12:30:20.202:INFO:oejw.WebInfConfiguration:Extract jar:file:/opt/rudder/jetty7/webapps/cometd.war!/ to /tmp/jetty-127.0.0.1-8080-cometd.war-_cometd-any-/webapp
2014-10-05 12:30:21.748:INFO:oejsh.ContextHandler:started o.e.j.w.WebAppContext{/cometd,file:/tmp/jetty-127.0.0.1-8080-cometd.war-_cometd-any-/webapp/},/opt/rudder/jetty7/webapps/cometd.war
2014-10-05 12:30:21,947 main [ INFO][AnnotationCometdServlet] Processed annotated service org.cometd.examples.ChatService at 28a92d4a
2014-10-05 12:30:22,044 main [ INFO][CometdDemoServlet] Monitored Subscribe from seti_517rkzgem5r6yam4inhmxl32jr - last connect 0 ms ago for /seti/http_localhost_8080_cometd
2014-10-05 12:30:22,047 main [ INFO][CometdDemoServlet] Monitored Subscribe from seti_517rkzgem5r6yam4inhmxl32jr - last connect 0 ms ago for /seti/all
2014-10-05 12:30:22,055 main [DEBUG][AuctionService] Subscribing oortion#bids to /auction/*
2014-10-05 12:30:22,056 main [DEBUG][AuctionService] Subscribing oortion#bid to /service/auction/bid
2014-10-05 12:30:22,056 main [DEBUG][AuctionService] Subscribing oortion#bidder to /service/auction/bidder
2014-10-05 12:30:22,056 main [DEBUG][AuctionService] Subscribing oortion#search to /service/auction/search
2014-10-05 12:30:22,056 main [DEBUG][AuctionService] Subscribing oortion#category to /service/auction/category
2014-10-05 12:30:22,057 main [DEBUG][AuctionService] Subscribing oortion#categories to /service/auction/categories
2014-10-05 12:30:22,059 main [DEBUG][AuctionChatService] Subscribing chat#trackMembers to /auction/chat/**
2014-10-05 12:30:22,059 main [DEBUG][AuctionChatService] Subscribing chat#privateChat to /service/auction/chat
2014-10-05 12:30:22.059:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/jetty7/webapps/root
2014-10-05 12:30:22.264:INFO:oejsh.ContextHandler:started o.e.j.w.WebAppContext{/,file:/opt/rudder/jetty7/webapps/root/},/opt/rudder/jetty7/webapps/root
2014-10-05 12:30:22.269:INFO:oejdp.ScanningAppProvider:Deployment monitor /opt/rudder/jetty7/contexts at interval 1
2014-10-05 12:30:22.272:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/jetty7/contexts/test-jndi.xml
2014-10-05 12:30:22.546:INFO:oejsh.ContextHandler:started o.e.j.w.WebAppContext{/test-jndi,file:/opt/rudder/jetty7/webapps/test-jndi/},/opt/rudder/jetty7/webapps/test-jndi
2014-10-05 12:30:22.576:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/jetty7/contexts/test-jaas.xml
2014-10-05 12:30:22.799:INFO:oejsh.ContextHandler:started o.e.j.w.WebAppContext{/test-jaas,file:/opt/rudder/jetty7/webapps/test-jaas/},/opt/rudder/jetty7/webapps/test-jaas
2014-10-05 12:30:22.803:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/share/webapps/rudder.xml
2014-10-05 12:30:22.821:INFO:oejw.WebInfConfiguration:Extract jar:file:/opt/rudder/share/webapps/rudder.war!/ to /tmp/jetty-127.0.0.1-8080-rudder.war-_rudder-any-/webapp
Use configuration file defined by JVM property -Dlogback.configurationFile : /opt/rudder/etc/logback.xml
[2014-10-05 12:30:28] INFO  application - Use configuration file defined by JVM property -Drudder.configFile : /opt/rudder/etc/rudder-web.properties
[2014-10-05 12:30:31] INFO  com.normation.rudder.batch.AbstractScheduler$StatusManager - Starting [Store Agent Run Times] scheduler with a period of 5 s
[2014-10-05 12:30:31] INFO  application - List of registered properties:
[2014-10-05 12:30:31] INFO  application - registered property: awt.toolkit="sun.awt.X11.XToolkit"
[2014-10-05 12:30:31] INFO  application - registered property: bin.emergency.stop="/opt/rudder/bin/cfe-red-button.sh"
[2014-10-05 12:30:31] INFO  application - registered property: derby.system.home="/tmp"
[2014-10-05 12:30:31] INFO  application - registered property: file.encoding.pkg="sun.io"
[2014-10-05 12:30:31] INFO  application - registered property: file.separator="/"
[2014-10-05 12:30:31] INFO  application - registered property: history.inventories.rootdir="/var/rudder/inventories/historical"
[2014-10-05 12:30:31] INFO  application - registered property: inventoryweb.configFile="/opt/rudder/etc/inventory-web.properties"
[2014-10-05 12:30:31] INFO  application - registered property: java.awt.graphicsenv="sun.awt.X11GraphicsEnvironment"
[2014-10-05 12:30:31] INFO  application - registered property: java.awt.printerjob="sun.print.PSPrinterJob"
[2014-10-05 12:30:31] INFO  application - registered property: java.class.path="/opt/rudder/jetty7/lib/jetty-xml-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/servlet-api-2.5.jar:/opt/rudder/jetty7/lib/jetty-http-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-continuation-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-server-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-security-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-servlet-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-webapp-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-deploy-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-servlets-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-annotations-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/annotations/javax.annotation-1.1.0.v201108011116.jar:/opt/rudder/jetty7/lib/annotations/org.objectweb.asm-3.1.0.v200803061910.jar:/opt/rudder/jetty7/lib/jdbc/derby/derby-10.6.1.0.jar:/opt/rudder/jetty7/lib/jdbc/derby/derbytools-10.6.1.0.jar:/opt/rudder/jetty7/lib/jetty-jmx-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jsp/com.sun.el-1.0.0.v201105211818.jar:/opt/rudder/jetty7/lib/jsp/javax.el-2.1.0.v201105211819.jar:/opt/rudder/jetty7/lib/jsp/javax.servlet.jsp.jstl-1.2.0.v201105211821.jar:/opt/rudder/jetty7/lib/jsp/javax.servlet.jsp-2.1.0.v201105211820.jar:/opt/rudder/jetty7/lib/jsp/org.apache.jasper.glassfish-2.1.0.v201110031002.jar:/opt/rudder/jetty7/lib/jsp/org.apache.taglibs.standard.glassfish-1.2.0.v201112081803.jar:/opt/rudder/jetty7/lib/jsp/org.eclipse.jdt.core-3.7.1.jar:/opt/rudder/jetty7/lib/jta/javax.transaction-1.1.1.v201105210645.jar:/opt/rudder/jetty7/lib/jta/atomikos/atomikos-util-3.7.0.jar:/opt/rudder/jetty7/lib/jta/atomikos/transactions-3.7.0.jar:/opt/rudder/jetty7/lib/jta/atomikos/transactions-api-3.7.0.jar:/opt/rudder/jetty7/lib/jta/atomikos/transactions-jdbc-3.7.0.jar:/opt/rudder/jetty7/lib/jta/atomikos/transactions-jta-3.7.0.jar:/opt/rudder/jetty7/lib/jetty-jndi-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-plus-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jndi/javax.activation-1.1.0.v201105071233.jar:/opt/rudder/jetty7/lib/jndi/javax.mail.glassfish-1.4.1.v201005082020.jar:/opt/rudder/jetty7/resources:/opt/rudder/jetty7/lib/jetty-websocket-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-util-7.6.14.v20131031.jar:/opt/rudder/jetty7/lib/jetty-io-7.6.14.v20131031.jar"
[2014-10-05 12:30:31] INFO  application - registered property: java.class.version="51.0"
[2014-10-05 12:30:31] INFO  application - registered property: java.endorsed.dirs="/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/endorsed"
[2014-10-05 12:30:31] INFO  application - registered property: java.ext.dirs="/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/ext:/usr/java/packages/lib/ext"
[2014-10-05 12:30:31] INFO  application - registered property: java.home="/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre"
[2014-10-05 12:30:31] INFO  application - registered property: java.io.tmpdir="/tmp"
[2014-10-05 12:30:31] INFO  application - registered property: java.library.path="/usr/java/packages/lib/amd64:/usr/lib64:/lib64:/lib:/usr/lib"
[2014-10-05 12:30:31] INFO  application - registered property: java.runtime.name="OpenJDK Runtime Environment"
[2014-10-05 12:30:31] INFO  application - registered property: java.runtime.version="1.7.0_65-mockbuild_2014_07_16_06_06-b00"
[2014-10-05 12:30:31] INFO  application - registered property: java.security.auth.login.config="/opt/rudder/jetty7/etc/login.conf"
[2014-10-05 12:30:31] INFO  application - registered property: java.specification.name="Java Platform API Specification"
[2014-10-05 12:30:31] INFO  application - registered property: java.specification.vendor="Oracle Corporation"
[2014-10-05 12:30:31] INFO  application - registered property: java.specification.version="1.7"
[2014-10-05 12:30:31] INFO  application - registered property: java.vendor.url.bug="http://bugreport.sun.com/bugreport/"
[2014-10-05 12:30:31] INFO  application - registered property: java.version="1.7.0_65"
[2014-10-05 12:30:31] INFO  application - registered property: java.vm.info="mixed mode"
[2014-10-05 12:30:31] INFO  application - registered property: java.vm.name="OpenJDK 64-Bit Server VM"
[2014-10-05 12:30:31] INFO  application - registered property: java.vm.specification.name="Java Virtual Machine Specification"
[2014-10-05 12:30:31] INFO  application - registered property: java.vm.specification.vendor="Oracle Corporation"
[2014-10-05 12:30:31] INFO  application - registered property: java.vm.specification.version="1.7"
[2014-10-05 12:30:31] INFO  application - registered property: java.vm.vendor="Oracle Corporation"
[2014-10-05 12:30:31] INFO  application - registered property: java.vm.version="24.65-b04"
[2014-10-05 12:30:31] INFO  application - registered property: jetty.home="/opt/rudder/jetty7"
[2014-10-05 12:30:31] INFO  application - registered property: jetty.logs="/var/log/rudder/webapp/"
[2014-10-05 12:30:31] INFO  application - registered property: jetty.state="/opt/rudder/jetty7/jetty.state"
[2014-10-05 12:30:31] INFO  application - registered property: ldap.authdn="cn=manager,cn=rudder-configuration"
[2014-10-05 12:30:31] INFO  application - registered property: ldap.authpw=**********
[2014-10-05 12:30:31] INFO  application - registered property: ldap.host="localhost"
[2014-10-05 12:30:31] INFO  application - registered property: ldap.inventories.accepted.basedn="ou=Accepted Inventories, ou=Inventories, cn=rudder-configuration"
[2014-10-05 12:30:31] INFO  application - registered property: ldap.inventories.pending.basedn="ou=Pending Inventories, ou=Inventories, cn=rudder-configuration"
[2014-10-05 12:30:31] INFO  application - registered property: ldap.inventories.removed.basedn="ou=Removed Inventories, ou=Inventories, cn=rudder-configuration"
[2014-10-05 12:30:31] INFO  application - registered property: ldap.inventories.software.basedn="ou=Inventories, cn=rudder-configuration"
[2014-10-05 12:30:31] INFO  application - registered property: ldap.node.base="cn=rudder-configuration"
[2014-10-05 12:30:31] INFO  application - registered property: ldap.port="389"
[2014-10-05 12:30:31] INFO  application - registered property: ldap.rudder.base="ou=Rudder, cn=rudder-configuration"
[2014-10-05 12:30:31] INFO  application - registered property: line.separator="\n"
[2014-10-05 12:30:31] INFO  application - registered property: logback.configurationFile="/opt/rudder/etc/logback.xml"
[2014-10-05 12:30:31] INFO  application - registered property: os.arch="amd64"
[2014-10-05 12:30:31] INFO  application - registered property: os.name="Linux"
[2014-10-05 12:30:31] INFO  application - registered property: os.version="2.6.32-431.23.3.el6.x86_64"
[2014-10-05 12:30:31] INFO  application - registered property: path.separator=":"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.auth.ldap.connection.bind.dn="cn=admin,dc=mycorp,dc=com"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.auth.ldap.connection.bind.password=**********
[2014-10-05 12:30:31] INFO  application - registered property: rudder.auth.ldap.connection.url="ldap://ldap.mycorp.com:389/dc=mycorp,dc=com"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.auth.ldap.enable="false"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.auth.ldap.filter="(&(uid={0})(objectclass=person))"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.auth.ldap.searchbase="ou=People"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.authFile="/opt/rudder/etc/rudder-users.xml"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.autoArchiveItems="true"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.databasecleaner.runtime.day="sunday"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.databasecleaner.runtime.hour="0"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.databasecleaner.runtime.minute="0"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.dyngroup.updateInterval="5"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.reports.logInterval="1"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.reportscleaner.archive.TTL="3"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.reportscleaner.delete.TTL="90"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.reportscleaner.frequency="daily"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.storeAgentRunTimes.maxDays="5"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.storeAgentRunTimes.updateInterval="5"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.batch.techniqueLibrary.updateInterval="5"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.community.checkpromises.command="/var/rudder/cfengine-community/bin/cf-promises"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.community.port="5309"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.configFile="/opt/rudder/etc/rudder-web.properties"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.debug.nodeconfiguration.path="/var/log/rudder/nodeConfigurations"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.dir.backup="/var/rudder/backup/"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.dir.dependencies="/var/rudder/tools"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.dir.gitRoot="/var/rudder/configuration-repository"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.dir.licensesFolder="/opt/rudder/etc/licenses"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.dir.lock="/var/rudder/lock/"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.dir.shared.files.folder="/var/rudder/configuration-repository/shared-files"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.dir.techniques="/var/rudder/configuration-repository/techniques"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.dir.uploaded.file.sharing="/var/rudder/files/"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.endpoint.cmdb="http://localhost:8080/endpoint/upload/"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.jdbc.driver="org.postgresql.Driver"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.jdbc.password=**********
[2014-10-05 12:30:31] INFO  application - registered property: rudder.jdbc.url="jdbc:postgresql://localhost:5432/rudder"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.jdbc.username="rudder"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.nova.checkpromises.command="/bin/true"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.rest.allowNonAuthenticatedUser="true"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.server-roles.db="autodetect"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.server-roles.inventory-endpoint="autodetect"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.server-roles.ldap="autodetect"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.server-roles.relay-top="autodetect"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.server-roles.web="autodetect"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.syslog.port="514"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.techniqueLibrary.git.refs.path="refs/heads/master"
[2014-10-05 12:30:31] INFO  application - registered property: rudder.webdav.password=**********
[2014-10-05 12:30:31] INFO  application - registered property: rudder.webdav.user="rudder"
[2014-10-05 12:30:31] INFO  application - registered property: run.mode="production"
[2014-10-05 12:30:31] INFO  application - registered property: sun.arch.data.model="64"
[2014-10-05 12:30:31] INFO  application - registered property: sun.boot.class.path="/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/resources.jar:/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/rt.jar:/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/sunrsasign.jar:/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/jsse.jar:/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/jce.jar:/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/charsets.jar:/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/rhino.jar:/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/jfr.jar:/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/classes"
[2014-10-05 12:30:31] INFO  application - registered property: sun.boot.library.path="/usr/lib/jvm/java-1.7.0-openjdk-1.7.0.65.x86_64/jre/lib/amd64"
[2014-10-05 12:30:31] INFO  application - registered property: sun.cpu.endian="little"
[2014-10-05 12:30:31] INFO  application - registered property: sun.cpu.isalist=""
[2014-10-05 12:30:31] INFO  application - registered property: sun.io.unicode.encoding="UnicodeLittle"
[2014-10-05 12:30:31] INFO  application - registered property: sun.java.command="/opt/rudder/jetty7/start.jar OPTIONS=Server etc/jetty-logging.xml etc/jetty-started.xml"
[2014-10-05 12:30:31] INFO  application - registered property: sun.java.launcher="SUN_STANDARD"
[2014-10-05 12:30:31] INFO  application - registered property: sun.jnu.encoding="ANSI_X3.4-1968"
[2014-10-05 12:30:31] INFO  application - registered property: sun.management.compiler="HotSpot 64-Bit Tiered Compilers"
[2014-10-05 12:30:31] INFO  application - registered property: sun.os.patch.level="unknown"
[2014-10-05 12:30:31] INFO  application - registered property: upload.root.directory="/var/rudder/files/"
[2014-10-05 12:30:31] INFO  application - registered property: user.country="US"
[2014-10-05 12:30:31] INFO  application - registered property: user.dir="/opt/rudder/jetty7"
[2014-10-05 12:30:31] INFO  application - registered property: user.home="/root"
[2014-10-05 12:30:31] INFO  application - registered property: user.language="en"
[2014-10-05 12:30:31] INFO  application - registered property: user.name="root"
[2014-10-05 12:30:31] INFO  application - registered property: user.timezone="Asia/Manila"
2014-10-05 12:30:31.917:INFO:/rudder:Initializing Spring root WebApplicationContext
[2014-10-05 12:30:32] INFO  application - Use configuration file defined by JVM property -Drudder.authFile : /opt/rudder/etc/rudder-users.xml
[2014-10-05 12:30:32] INFO  application - Use configuration file defined by JVM property -Drudder.authFile : /opt/rudder/etc/rudder-users.xml
2014-10-05 12:30:33.149:INFO:oejsh.ContextHandler:started o.e.j.w.WebAppContext{/rudder,file:/tmp/jetty-127.0.0.1-8080-rudder.war-_rudder-any-/webapp/},/opt/rudder/share/webapps/rudder.war
[2014-10-05 12:30:33] INFO  application - All the required DIT entries are present in the LDAP directory
[2014-10-05 12:30:33] INFO  migration - No migration detected by migration script (table 'migrationeventlog' is empty or does not exists)
[2014-10-05 12:30:33] INFO  bootstrap.liftweb.checks.CheckInitXmlExport - First full archive of configuration-repository items done
[2014-10-05 12:30:33] INFO  bootstrap.liftweb.checks.CheckRootRuleCategoryExport - Creating directory '/var/rudder/configuration-repository/ruleCategories' exists, done
[2014-10-05 12:30:33] INFO  migration - Migration of inline variables in Directives to 'rudder' namespace already done, skipping
[2014-10-05 12:30:33] INFO  migration - No variable name with dot defined in the generic CFEngine Variable Definition, skipping
[2014-10-05 12:30:33] INFO  bootstrap.liftweb.checks.CheckTechniqueLibraryReload - Flag file '/opt/rudder/etc/force_technique_reload' does not exists, do not Technique library will not be reloaded
[2014-10-05 12:30:33] INFO  application - Application Rudder started
2014-10-05 12:30:33.787:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/share/webapps/endpoint.xml
2014-10-05 12:30:33.803:INFO:oejw.WebInfConfiguration:Extract jar:file:/opt/rudder/share/webapps/endpoint.war!/ to /tmp/jetty-127.0.0.1-8080-endpoint.war-_endpoint-any-/webapp
Use configuration file defined by JVM property -Dlogback.configurationFile : /opt/rudder/etc/logback.xml
2014-10-05 12:30:36.667:INFO:oejsh.ContextHandler:started o.e.j.w.WebAppContext{/endpoint,file:/tmp/jetty-127.0.0.1-8080-endpoint.war-_endpoint-any-/webapp/},/opt/rudder/share/webapps/endpoint.war
2014-10-05 12:30:36.916:INFO:/endpoint:Initializing Spring FrameworkServlet 'dispatcher'
[2014-10-05 12:30:37] WARN  org.springframework.context.annotation.ConfigurationClassEnhancer - @Bean method PropertyPlaceholderConfig.propertyConfigurer is non-static and returns an object assignable to Spring's BeanFactoryPostProcessor interface. This will result in a failure to process annotations such as @Autowired, @Resource and @PostConstruct within the method's declaring @Configuration class. Add the 'static' modifier to this method to avoid these container lifecycle issues; see @Bean Javadoc for complete details
[2014-10-05 12:30:37] INFO  com.normation.inventory.provisioning.endpoint.config.PropertyPlaceholderConfig - Use configuration file defined by JVM property -Dinventoryweb.configFile : /opt/rudder/etc/inventory-web.properties
2014-10-05 12:30:38.325:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/jetty7/contexts/javadoc.xml
2014-10-05 12:30:38.340:INFO:oejsh.ContextHandler:started o.e.j.s.h.ContextHandler{/javadoc,file:/opt/rudder/jetty7/javadoc}
2014-10-05 12:30:38.341:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/jetty7/contexts/test.xml
2014-10-05 12:30:38.357:INFO:oejw.WebInfConfiguration:Extract jar:file:/opt/rudder/jetty7/webapps/test.war!/ to /tmp/jetty-127.0.0.1-8080-test.war-_test-any-/webapp
2014-10-05 12:30:38.716:INFO:oejsh.ContextHandler:started o.e.j.w.WebAppContext{/test,file:/tmp/jetty-127.0.0.1-8080-test.war-_test-any-/webapp/},/opt/rudder/jetty7/webapps/test.war
2014-10-05 12:30:38.807:INFO:oejs.TransparentProxy:TransparentProxy @ /test/javadoc-proxy to http://download.eclipse.org/jetty/stable-7/apidocs
2014-10-05 12:30:38.808:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/jetty7/contexts/hightide.xml
2014-10-05 12:30:38.820:INFO:oejsh.ContextHandler:started o.e.j.s.h.ContextHandler{/,file:/opt/rudder/jetty7/root}
2014-10-05 12:30:38.820:INFO:oejd.DeploymentManager:Deployable added: /opt/rudder/jetty7/contexts/test-annotations.xml
2014-10-05 12:30:39.056:INFO:oejsh.ContextHandler:started o.e.j.w.WebAppContext{/test-annotations,file:/opt/rudder/jetty7/webapps/test-annotations/},/opt/rudder/jetty7/webapps/test-annotations
2014-10-05 12:30:39.090:INFO:oejs.AbstractConnector:Started SelectChannelConnector at 127.0.0.1:8080
2014-10-05 12:45:18.574:INFO:oejs.Server:Graceful shutdown SelectChannelConnector at 127.0.0.1:8080
2014-10-05 12:45:18.579:INFO:oejs.Server:Graceful shutdown o.e.j.w.WebAppContext{/spdy,file:/tmp/jetty-127.0.0.1-8080-spdy.war-_spdy-any-/webapp/},/opt/rudder/jetty7/webapps/spdy.war
2014-10-05 12:45:18.579:INFO:oejs.Server:Graceful shutdown o.e.j.w.WebAppContext{/async-rest,file:/opt/rudder/jetty7/webapps/async-rest/},/opt/rudder/jetty7/webapps/async-rest
2014-10-05 12:45:18.579:INFO:oejs.Server:Graceful shutdown o.e.j.w.WebAppContext{/cometd,file:/tmp/jetty-127.0.0.1-8080-cometd.war-_cometd-any-/webapp/},/opt/rudder/jetty7/webapps/cometd.war
2014-10-05 12:45:18.579:INFO:oejs.Server:Graceful shutdown o.e.j.w.WebAppContext{/,file:/opt/rudder/jetty7/webapps/root/},/opt/rudder/jetty7/webapps/root
2014-10-05 12:45:18.579:INFO:oejs.Server:Graceful shutdown o.e.j.w.WebAppContext{/test-jndi,file:/opt/rudder/jetty7/webapps/test-jndi/},/opt/rudder/jetty7/webapps/test-jndi
2014-10-05 12:45:18.579:INFO:oejs.Server:Graceful shutdown o.e.j.w.WebAppContext{/test-jaas,file:/opt/rudder/jetty7/webapps/test-jaas/},/opt/rudder/jetty7/webapps/test-jaas
2014-10-05 12:45:18.580:INFO:oejs.Server:Graceful shutdown o.e.j.w.WebAppContext{/rudder,file:/tmp/jetty-127.0.0.1-8080-rudder.war-_rudder-any-/webapp/},/opt/rudder/share/webapps/rudder.war
2014-10-05 12:45:18.580:INFO:oejs.Server:Graceful shutdown o.e.j.w.WebAppContext{/endpoint,file:/tmp/jetty-127.0.0.1-8080-endpoint.war-_endpoint-any-/webapp/},/opt/rudder/share/webapps/endpoint.war
2014-10-05 12:45:18.580:INFO:oejs.Server:Graceful shutdown o.e.j.s.h.ContextHandler{/javadoc,file:/opt/rudder/jetty7/javadoc}
2014-10-05 12:45:18.580:INFO:oejs.Server:Graceful shutdown o.e.j.w.WebAppContext{/test,file:/tmp/jetty-127.0.0.1-8080-test.war-_test-any-/webapp/},/opt/rudder/jetty7/webapps/test.war
2014-10-05 12:45:18.580:INFO:oejs.Server:Graceful shutdown o.e.j.s.h.ContextHandler{/,file:/opt/rudder/jetty7/root}
2014-10-05 12:45:18.580:INFO:oejs.Server:Graceful shutdown o.e.j.w.WebAppContext{/test-annotations,file:/opt/rudder/jetty7/webapps/test-annotations/},/opt/rudder/jetty7/webapps/test-annotations
2014-10-05 12:45:24.622:INFO:oejsl.ELContextCleaner:javax.el.BeanELResolver purged
2014-10-05 12:45:24.622:INFO:oejsh.ContextHandler:stopped o.e.j.w.WebAppContext{/test-annotations,file:/opt/rudder/jetty7/webapps/test-annotations/},/opt/rudder/jetty7/webapps/test-annotations
2014-10-05 12:45:24.626:INFO:oejsh.ContextHandler:stopped o.e.j.s.h.ContextHandler{/,file:/opt/rudder/jetty7/root}
2014-10-05 12:45:24.691:INFO:oejsl.ELContextCleaner:javax.el.BeanELResolver purged
2014-10-05 12:45:24.692:INFO:oejsh.ContextHandler:stopped o.e.j.w.WebAppContext{/test,file:/tmp/jetty-127.0.0.1-8080-test.war-_test-any-/webapp/},/opt/rudder/jetty7/webapps/test.war
2014-10-05 12:45:24.699:INFO:oejsh.ContextHandler:stopped o.e.j.s.h.ContextHandler{/javadoc,file:/opt/rudder/jetty7/javadoc}
2014-10-05 12:45:24.699:INFO:/endpoint:Destroying Spring FrameworkServlet 'dispatcher'
2014-10-05 12:45:24.717:INFO:oejsl.ELContextCleaner:javax.el.BeanELResolver purged
2014-10-05 12:45:24.717:INFO:oejsh.ContextHandler:stopped o.e.j.w.WebAppContext{/endpoint,file:/tmp/jetty-127.0.0.1-8080-endpoint.war-_endpoint-any-/webapp/},/opt/rudder/share/webapps/endpoint.war
2014-10-05 12:45:24.742:INFO:/rudder:Closing Spring root WebApplicationContext
2014-10-05 12:45:24.754:INFO:oejsl.ELContextCleaner:javax.el.BeanELResolver purged
2014-10-05 12:45:24.754:INFO:oejsh.ContextHandler:stopped o.e.j.w.WebAppContext{/rudder,file:/tmp/jetty-127.0.0.1-8080-rudder.war-_rudder-any-/webapp/},/opt/rudder/share/webapps/rudder.war
2014-10-05 12:45:25.052:INFO:oejsl.ELContextCleaner:javax.el.BeanELResolver purged
2014-10-05 12:45:25.052:INFO:oejsh.ContextHandler:stopped o.e.j.w.WebAppContext{/test-jaas,file:/opt/rudder/jetty7/webapps/test-jaas/},/opt/rudder/jetty7/webapps/test-jaas
2014-10-05 12:45:25.055:INFO:oejsl.ELContextCleaner:javax.el.BeanELResolver purged
2014-10-05 12:45:25.055:INFO:oejsh.ContextHandler:stopped o.e.j.w.WebAppContext{/test-jndi,file:/opt/rudder/jetty7/webapps/test-jndi/},/opt/rudder/jetty7/webapps/test-jndi
2014-10-05 12:45:25.057:INFO:oejsl.ELContextCleaner:javax.el.BeanELResolver purged
2014-10-05 12:45:25.057:INFO:oejsh.ContextHandler:stopped o.e.j.w.WebAppContext{/,file:/opt/rudder/jetty7/webapps/root/},/opt/rudder/jetty7/webapps/root
[2014-10-05 12:45:25] ERROR net.liftweb.actor.ActorLogger - Actor threw an exception
net.liftweb.actor.PingerException: StartUpdate could not be scheduled on com.normation.rudder.batch.AbstractScheduler$StatusManager at 1e9e011d
	at net.liftweb.actor.LAPinger$.schedule(LAPinger.scala:72) ~[lift-actor_2.10-2.5.1.jar:2.5.1]
Caused by: java.util.concurrent.RejectedExecutionException: Task java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask at 753f0dc8 rejected from java.util.concurrent.ScheduledThreadPoolExecutor at 7ea2019a[Shutting down, pool size = 1, active threads = 0, queued tasks = 5, completed tasks = 224]
	at java.util.concurrent.ThreadPoolExecutor$AbortPolicy.rejectedExecution(ThreadPoolExecutor.java:2048) ~[na:1.7.0_65]
2014-10-05 12:45:26,175 Thread-1 [ WARN][QueuedThreadPool] 2 threads could not be stopped
2014-10-05 12:45:26,187 Thread-1 [ INFO][AnnotationCometdServlet] Deprocessed annotated service org.cometd.examples.ChatService at 28a92d4a
2014-10-05 12:45:26.189:INFO:oejsl.ELContextCleaner:javax.el.BeanELResolver purged
2014-10-05 12:45:26.189:INFO:oejsh.ContextHandler:stopped o.e.j.w.WebAppContext{/cometd,file:/tmp/jetty-127.0.0.1-8080-cometd.war-_cometd-any-/webapp/},/opt/rudder/jetty7/webapps/cometd.war
2014-10-05 12:45:26.378:INFO:oejsl.ELContextCleaner:javax.el.BeanELResolver purged
2014-10-05 12:45:26.379:INFO:oejsh.ContextHandler:stopped o.e.j.w.WebAppContext{/async-rest,file:/opt/rudder/jetty7/webapps/async-rest/},/opt/rudder/jetty7/webapps/async-rest
2014-10-05 12:45:26.379:INFO:oejsl.ELContextCleaner:javax.el.BeanELResolver purged
2014-10-05 12:45:26.380:INFO:oejsh.ContextHandler:stopped o.e.j.w.WebAppContext{/spdy,file:/tmp/jetty-127.0.0.1-8080-spdy.war-_spdy-any-/webapp/},/opt/rudder/jetty7/webapps/spdy.war
2014-10-05 12:45:26.436:INFO:oejj.DataSourceCloser:Close datasource AtomikosDataSoureBean 'mydatasource'


More information about the rudder-users mailing list