Attachment 946583 Details for Bug 1150287 – jenkins log from jolamb test instance showing successful run

jenkins log from jolamb test instance showing successful run

jenkins.log (text/plain), 13.67 KB, created by John W. Lamb on 2014-10-13 19:43:17 UTC

(hide)

Description:

Filename:

MIME Type:

Creator: John W. Lamb

Created: 2014-10-13 19:43:17 UTC

Size: 13.67 KB

patch

obsolete

>Running from: /usr/lib/jenkins/jenkins.war
>webroot: System.getProperty("JENKINS_HOME")
>Oct 13, 2014 3:04:27 PM winstone.Logger logInternal
>INFO: Beginning extraction from war file
>Oct 13, 2014 3:04:29 PM org.eclipse.jetty.util.log.JavaUtilLog info
>INFO: jetty-8.y.z-SNAPSHOT
>Oct 13, 2014 3:04:33 PM org.eclipse.jetty.util.log.JavaUtilLog info
>INFO: NO JSP Support for , did not find org.apache.jasper.servlet.JspServlet
>Jenkins home directory: /var/lib/openshift/543c2229c4ba086554000018/app-root/data found at: System.getProperty("JENKINS_HOME")
>Oct 13, 2014 3:04:37 PM org.eclipse.jetty.util.log.JavaUtilLog info
>INFO: Started SelectChannelConnector@127.1.244.129:8080
>Oct 13, 2014 3:04:37 PM winstone.Logger logInternal
>INFO: Winstone Servlet Engine v2.0 running: controlPort=disabled
>Oct 13, 2014 3:04:38 PM jenkins.InitReactorRunner$1 onAttained
>INFO: Started initialization
>Oct 13, 2014 3:04:58 PM jenkins.InitReactorRunner$1 onAttained
>INFO: Listed all plugins
>Oct 13, 2014 3:04:58 PM jenkins.InitReactorRunner$1 onAttained
>INFO: Prepared all plugins
>Oct 13, 2014 3:05:06 PM jenkins.InitReactorRunner$1 onAttained
>INFO: Started all plugins
>Oct 13, 2014 3:05:06 PM jenkins.InitReactorRunner$1 onAttained
>INFO: Augmented all extensions
>Oct 13, 2014 3:05:06 PM jenkins.InitReactorRunner$1 onAttained
>INFO: Loaded all jobs
>Oct 13, 2014 3:05:07 PM jenkins.InitReactorRunner$1 onAttained
>INFO: Completed initialization
>Oct 13, 2014 3:05:08 PM org.springframework.web.context.support.StaticWebApplicationContext prepareRefresh
>INFO: Refreshing org.springframework.web.context.support.StaticWebApplicationContext@3c777ad1: display name [Root WebApplicationContext]; startup date [Mon Oct 13 15:05:08 EDT 2014]; root of context hierarchy
>Oct 13, 2014 3:05:08 PM org.springframework.web.context.support.StaticWebApplicationContext obtainFreshBeanFactory
>INFO: Bean factory for application context [org.springframework.web.context.support.StaticWebApplicationContext@3c777ad1]: org.springframework.beans.factory.support.DefaultListableBeanFactory@47b01f4b
>Oct 13, 2014 3:05:08 PM org.springframework.beans.factory.support.DefaultListableBeanFactory preInstantiateSingletons
>INFO: Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@47b01f4b: defining beans [authenticationManager]; root of factory hierarchy
>Oct 13, 2014 3:05:08 PM org.springframework.web.context.support.StaticWebApplicationContext prepareRefresh
>INFO: Refreshing org.springframework.web.context.support.StaticWebApplicationContext@1a43b86b: display name [Root WebApplicationContext]; startup date [Mon Oct 13 15:05:08 EDT 2014]; root of context hierarchy
>Oct 13, 2014 3:05:08 PM org.springframework.web.context.support.StaticWebApplicationContext obtainFreshBeanFactory
>INFO: Bean factory for application context [org.springframework.web.context.support.StaticWebApplicationContext@1a43b86b]: org.springframework.beans.factory.support.DefaultListableBeanFactory@4b51cf0f
>Oct 13, 2014 3:05:08 PM org.springframework.beans.factory.support.DefaultListableBeanFactory preInstantiateSingletons
>INFO: Pre-instantiating singletons in org.springframework.beans.factory.support.DefaultListableBeanFactory@4b51cf0f: defining beans [filter,legacy]; root of factory hierarchy
>Oct 13, 2014 3:05:09 PM hudson.WebAppMain$3 run
>INFO: Jenkins is fully up and running
>Oct 13, 2014 3:05:09 PM jenkins.model.Jenkins <init>
>INFO: Effective SlaveRestarter on master: null
>Oct 13, 2014 3:15:13 PM hudson.plugins.openshift.OpenShiftCloud provision
>INFO: Provisioning new node for workload = 2 and label = pt1-build
>Oct 13, 2014 3:15:13 PM hudson.plugins.openshift.OpenShiftCloud getOpenShiftConnection
>INFO: Initiating Java Client Service - Configured for OpenShift Server https://broker.ose20zscl11.example.com
>Oct 13, 2014 3:15:13 PM com.openshift.internal.client.RestService request
>INFO: Requesting GET with protocol 1.2 on https://broker.ose20zscl11.example.com/broker/rest/api
>Oct 13, 2014 3:15:14 PM com.openshift.internal.client.RestService request
>INFO: Requesting GET with protocol 1.2 on https://broker.ose20zscl11.example.com/broker/rest/user
>Oct 13, 2014 3:15:14 PM com.openshift.internal.client.RestService request
>INFO: Requesting GET with protocol 1.2 on https://broker.ose20zscl11.example.com/broker/rest/domains
>Oct 13, 2014 3:15:15 PM com.openshift.internal.client.RestService request
>INFO: Requesting GET with protocol 1.2 on https://broker.ose20zscl11.example.com/broker/rest/domain/jlent20/applications?include=cartridges
>Oct 13, 2014 3:15:15 PM hudson.plugins.openshift.OpenShiftCloud hasCapacity
>INFO: Checking capacity
>Oct 13, 2014 3:15:15 PM hudson.plugins.openshift.OpenShiftCloud hasCapacity
>INFO: User has consumed 2 of 50 gears.
>Oct 13, 2014 3:15:15 PM hudson.plugins.openshift.OpenShiftCloud reloadConfig
>INFO: Reloading configuration for pt1-build...
>Oct 13, 2014 3:15:15 PM hudson.plugins.openshift.OpenShiftCloud reloadConfig
>INFO: Retrieving config XML from http://127.1.244.129:8080/job/pt1-build/config.xml
>Oct 13, 2014 3:15:15 PM hudson.plugins.openshift.OpenShiftCloud createConnection
>INFO: Using credentials system_builder:U7sYJIa2MZZn
>Oct 13, 2014 3:15:15 PM hudson.plugins.openshift.OpenShiftCloud reloadConfig
>INFO: Reloading config from XML: <?xml version='1.0' encoding='UTF-8'?>
><project>
>  <actions/>
>  <description></description>
>  <logRotator>
>    <daysToKeep>-1</daysToKeep>
>    <numToKeep>100</numToKeep>
>    <artifactDaysToKeep>-1</artifactDaysToKeep>
>    <artifactNumToKeep>10</artifactNumToKeep>
>  </logRotator>
>  <keepDependencies>false</keepDependencies>
>  <properties>
>    <hudson.plugins.openshift.OpenShiftBuilderSizeJobProperty>
>      <builderSize>small</builderSize>
>    </hudson.plugins.openshift.OpenShiftBuilderSizeJobProperty>
>    <hudson.plugins.openshift.OpenShiftBuilderTypeJobProperty>
>      <builderType>redhat-php-5.3</builderType>
>    </hudson.plugins.openshift.OpenShiftBuilderTypeJobProperty>
>    <hudson.plugins.openshift.OpenShiftBuilderTimeoutJobProperty>
>      <builderTimeout>300000</builderTimeout>
>    </hudson.plugins.openshift.OpenShiftBuilderTimeoutJobProperty>
>  </properties>
>  <scm class="hudson.plugins.git.GitSCM">
>    <configVersion>2</configVersion>
>    <userRemoteConfigs>
>      <hudson.plugins.git.UserRemoteConfig>
>        <name></name>
>        <refspec></refspec>
>        <url>ssh://543c2213c4ba086554000001@pt1-jlent20.ose20zscl11.example.com/~/git/pt1.git</url>
>      </hudson.plugins.git.UserRemoteConfig>
>    </userRemoteConfigs>
>    <branches>
>      <hudson.plugins.git.BranchSpec>
>        <name>**</name>
>      </hudson.plugins.git.BranchSpec>
>    </branches>
>    <recursiveSubmodules>false</recursiveSubmodules>
>    <doGenerateSubmoduleConfigurations>false</doGenerateSubmoduleConfigurations>
>    <authorOrCommitter>false</authorOrCommitter>
>    <clean>false</clean>
>    <wipeOutWorkspace>true</wipeOutWorkspace>
>    <pruneBranches>false</pruneBranches>
>    <remotePoll>false</remotePoll>
>    <buildChooser class="hudson.plugins.git.util.DefaultBuildChooser"/>
>    <gitTool>Default</gitTool>
>    <submoduleCfg class="list"/>
>    <relativeTargetDir></relativeTargetDir>
>    <excludedRegions></excludedRegions>
>    <excludedUsers></excludedUsers>
>    <gitConfigName></gitConfigName>
>    <gitConfigEmail></gitConfigEmail>
>    <skipTag>false</skipTag>
>    <scmName></scmName>
>  </scm>
>  <assignedNode>pt1-build</assignedNode>
>  <canRoam>false</canRoam>
>  <disabled>false</disabled>
>  <blockBuildWhenDownstreamBuilding>false</blockBuildWhenDownstreamBuilding>
>  <blockBuildWhenUpstreamBuilding>false</blockBuildWhenUpstreamBuilding>
>  <triggers class="vector"/>
>  <concurrentBuild>false</concurrentBuild>
>  <customWorkspace>$OPENSHIFT_REPO_DIR</customWorkspace>
>  <builders>
>    <hudson.tasks.Shell>
>      <command>
>source $OPENSHIFT_CARTRIDGE_SDK_BASH
>
>alias rsync="rsync --delete-after -az -e '$GIT_SSH'"
>
>upstream_ssh="543c2213c4ba086554000001@pt1-${OPENSHIFT_NAMESPACE}.ose20zscl11.example.com"
>
># remove previous metadata, if any
>rm -f $OPENSHIFT_HOMEDIR/app-deployments/current/metadata.json
>
>if ! marker_present "force_clean_build"; then
>  # don't fail if these rsyncs fail
>  set +e
>  rsync $upstream_ssh:'$OPENSHIFT_BUILD_DEPENDENCIES_DIR' $OPENSHIFT_BUILD_DEPENDENCIES_DIR
>  rsync $upstream_ssh:'$OPENSHIFT_DEPENDENCIES_DIR' $OPENSHIFT_DEPENDENCIES_DIR
>  set -e
>fi
>
># Build/update libs and run user pre_build and build
>gear build
>
># Run tests here
>
># Deploy new build
>
># Stop app
>$GIT_SSH $upstream_ssh "gear stop --conditional --exclude-web-proxy --git-ref $GIT_COMMIT"
>
>deployment_dir=`$GIT_SSH $upstream_ssh 'gear create-deployment-dir'`
>
># Push content back to application
>rsync $OPENSHIFT_HOMEDIR/app-deployments/current/metadata.json $upstream_ssh:app-deployments/$deployment_dir/metadata.json
>rsync --exclude .git $WORKSPACE/ $upstream_ssh:app-root/runtime/repo/
>rsync $OPENSHIFT_BUILD_DEPENDENCIES_DIR $upstream_ssh:app-root/runtime/build-dependencies/
>rsync $OPENSHIFT_DEPENDENCIES_DIR $upstream_ssh:app-root/runtime/dependencies/
>
># Configure / start app
>$GIT_SSH $upstream_ssh "gear remotedeploy --deployment-datetime $deployment_dir"
>
>      </command>
>    </hudson.tasks.Shell>
>  </builders>
>  <publishers>
>    <hudson.tasks.ArtifactArchiver>
>      <artifacts>**</artifacts>
>      <latestOnly>false</latestOnly>
>    </hudson.tasks.ArtifactArchiver>
>  </publishers>
>  <buildWrappers/>
></project>
>Oct 13, 2014 3:15:15 PM hudson.plugins.openshift.OpenShiftCloud createConnection
>INFO: Using credentials system_builder:U7sYJIa2MZZn
>Oct 13, 2014 3:15:16 PM hudson.plugins.openshift.OpenShiftCloud reloadConfig
>INFO: Reload ResponseCode: 200
>Oct 13, 2014 3:15:16 PM hudson.plugins.openshift.OpenShiftCloud reloadConfig
>INFO: Config reload result: 
>Oct 13, 2014 3:15:16 PM hudson.plugins.openshift.OpenShiftSlave <init>
>INFO: Creating slave with 15mins time-to-live
>Oct 13, 2014 3:15:16 PM com.openshift.internal.client.RestService request
>INFO: Requesting GET with protocol 1.2 on https://broker.ose20zscl11.example.com/broker/rest/cartridges
>Oct 13, 2014 3:15:16 PM hudson.plugins.openshift.OpenShiftSlave createApp
>INFO: Creating builder application php-5.3 pt1bldr jlent20 of size small ...
>Oct 13, 2014 3:15:16 PM com.openshift.internal.client.RestService request
>INFO: Requesting POST with protocol 1.2 on https://broker.ose20zscl11.example.com/broker/rest/domain/jlent20/applications?include=cartridges
>Oct 13, 2014 3:15:31 PM hudson.plugins.openshift.OpenShiftSlave createApp
>INFO: Stopping application on builder gear ...
>Oct 13, 2014 3:15:31 PM com.openshift.internal.client.RestService request
>INFO: Requesting POST with protocol 1.2 on https://broker.ose20zscl11.example.com/broker/rest/domain/jlent20/application/pt1bldr/events
>Oct 13, 2014 3:15:32 PM hudson.plugins.openshift.OpenShiftSlave connect
>INFO: Connecting to slave pt1bldr...
>Oct 13, 2014 3:15:32 PM com.openshift.internal.client.RestService request
>INFO: Requesting GET with protocol 1.2 on https://broker.ose20zscl11.example.com/broker/rest/domain/jlent20/application/pt1bldr/gear_groups
>Oct 13, 2014 3:15:33 PM hudson.plugins.openshift.OpenShiftSlave connect
>INFO: Established UUID = 543c24c4c4ba086554000046
>Oct 13, 2014 3:15:38 PM hudson.plugins.openshift.OpenShiftSlave connect
>INFO: Checking to see if slave DNS for pt1bldr-jlent20.ose20zscl11.example.com is resolvable ... (timeout: 300000ms)
>Oct 13, 2014 3:15:38 PM hudson.plugins.openshift.OpenShiftSlave connect
>INFO: Slave DNS resolved - pt1bldr-jlent20.ose20zscl11.example.com/172.16.4.22
>Oct 13, 2014 3:15:38 PM hudson.plugins.openshift.OpenShiftCloud provision
>INFO: Provisioned 1 new nodes
>Oct 13, 2014 3:15:38 PM hudson.slaves.NodeProvisioner update
>INFO: Started provisioning pt1-build from OpenShift Cloud with 2 executors. Remaining excess workload:-1.0
>Oct 13, 2014 3:15:38 PM hudson.plugins.openshift.OpenShiftComputer <init>
>INFO: Creating Computer
>Oct 13, 2014 3:15:38 PM hudson.plugins.openshift.OpenShiftComputerLauncher launch
>INFO: Launching slave...
>Oct 13, 2014 3:15:38 PM hudson.plugins.openshift.OpenShiftComputerLauncher launch
>INFO: Checking availability of computer hudson.plugins.openshift.OpenShiftSlave@ed8cc285
>Oct 13, 2014 3:15:38 PM hudson.plugins.openshift.OpenShiftComputerLauncher launch
>INFO: Checking SSH access to application pt1bldr-jlent20.ose20zscl11.example.com
>Oct 13, 2014 3:15:38 PM hudson.plugins.openshift.OpenShiftComputerLauncher launch
>INFO: Connecting via SSH '543c24c4c4ba086554000046' 'pt1bldr-jlent20.ose20zscl11.example.com' '/var/lib/openshift/543c2229c4ba086554000018/app-root/data/.ssh/jenkins_id_rsa'
>Oct 13, 2014 3:15:38 PM hudson.plugins.openshift.OpenShiftComputerLauncher launch
>INFO: Connected via SSH.
>Oct 13, 2014 3:15:38 PM hudson.plugins.openshift.OpenShiftComputerLauncher launch
>INFO: Exec mkdir -p $OPENSHIFT_DATA_DIR/jenkins && cd $OPENSHIFT_DATA_DIR/jenkins && rm -f slave.jar && wget -q --no-check-certificate https://jenkins-jlent20.ose20zscl11.example.com/jnlpJars/slave.jar
>Oct 13, 2014 3:15:38 PM hudson.slaves.NodeProvisioner update
>INFO: pt1-build provisioningE successfully completed. We have now 2 computer(s)
>Oct 13, 2014 3:15:45 PM hudson.plugins.openshift.OpenShiftComputerLauncher launch
>INFO: Slave connected.
>Oct 13, 2014 3:16:04 PM hudson.model.Run execute
>INFO: pt1-build #1 main build action completed: SUCCESS
>Oct 13, 2014 3:32:20 PM hudson.slaves.CloudRetentionStrategy check
>INFO: Disconnecting pt1bldr
>Oct 13, 2014 3:32:20 PM hudson.plugins.openshift.OpenShiftSlave _terminate
>INFO: Terminating slave pt1bldr (uuid: 543c24c4c4ba086554000046)
>Oct 13, 2014 3:32:20 PM hudson.plugins.openshift.OpenShiftSlave _terminate
>INFO: Closing the SSH channel...
>Oct 13, 2014 3:32:20 PM hudson.plugins.openshift.OpenShiftSlave _terminate
>INFO: Terminating OpenShift application...
>Oct 13, 2014 3:32:20 PM com.openshift.internal.client.RestService request
>INFO: Requesting DELETE with protocol 1.2 on https://broker.ose20zscl11.example.com/broker/rest/domain/jlent20/application/pt1bldr

Actions: View

Attachments on bug 1150287: 945468 | 946583