SuccessConsole Output

Skipping 2,145 KB.. Full Log
urce: bindings, ignored listing per whitelist
Jun 28 14:44:10.351: INFO: namespace extended-test-build-timing-47cnk-mk4nj deletion completed in 7.578453709s


• [SLOW TEST:54.747 seconds]
[Feature:Builds][timing] capture build stages and durations
/tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_timing.go:29
  
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_timing.go:40
    should record build stages and durations for docker [Suite:openshift/conformance/parallel]
    /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_timing.go:82
------------------------------
Jun 28 14:44:10.352: INFO: Running AfterSuite actions on all node


[k8s.io] InitContainer 
  should not start app containers if init containers fail on a RestartAlways pod [Suite:openshift/conformance/parallel] [Suite:k8s]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/init_container.go:166

[BeforeEach] [Top Level]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [k8s.io] InitContainer
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Jun 28 14:42:17.340: INFO: >>> kubeConfig: /tmp/cluster-admin.kubeconfig
STEP: Building a namespace api object
Jun 28 14:42:17.562: INFO: About to run a Kube e2e test, ensuring namespace is privileged
STEP: Waiting for a default service account to be provisioned in namespace
[BeforeEach] [k8s.io] InitContainer
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/init_container.go:40
[It] should not start app containers if init containers fail on a RestartAlways pod [Suite:openshift/conformance/parallel] [Suite:k8s]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/init_container.go:166
STEP: creating the pod
Jun 28 14:42:18.307: INFO: PodSpec: initContainers in spec.initContainers
Jun 28 14:43:22.028: INFO: init container has failed twice: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"pod-init-74efe4b3-7ae1-11e8-ad23-0e5ba9d28c94", GenerateName:"", Namespace:"e2e-tests-init-container-2xwfm", SelfLink:"/api/v1/namespaces/e2e-tests-init-container-2xwfm/pods/pod-init-74efe4b3-7ae1-11e8-ad23-0e5ba9d28c94", UID:"74ffe967-7ae1-11e8-baf7-42010a8e0002", ResourceVersion:"25336", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63665793738, loc:(*time.Location)(0x6921e80)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"name":"foo", "time":"290918948"}, Annotations:map[string]string{"openshift.io/scc":"anyuid"}, OwnerReferences:[]v1.OwnerReference(nil), Initializers:(*v1.Initializers)(nil), Finalizers:[]string(nil), ClusterName:""}, Spec:v1.PodSpec{Volumes:[]v1.Volume{v1.Volume{Name:"default-token-2m2dl", VolumeSource:v1.VolumeSource{HostPath:(*v1.HostPathVolumeSource)(nil), EmptyDir:(*v1.EmptyDirVolumeSource)(nil), GCEPersistentDisk:(*v1.GCEPersistentDiskVolumeSource)(nil), AWSElasticBlockStore:(*v1.AWSElasticBlockStoreVolumeSource)(nil), GitRepo:(*v1.GitRepoVolumeSource)(nil), Secret:(*v1.SecretVolumeSource)(0xc4214d3640), NFS:(*v1.NFSVolumeSource)(nil), ISCSI:(*v1.ISCSIVolumeSource)(nil), Glusterfs:(*v1.GlusterfsVolumeSource)(nil), PersistentVolumeClaim:(*v1.PersistentVolumeClaimVolumeSource)(nil), RBD:(*v1.RBDVolumeSource)(nil), FlexVolume:(*v1.FlexVolumeSource)(nil), Cinder:(*v1.CinderVolumeSource)(nil), CephFS:(*v1.CephFSVolumeSource)(nil), Flocker:(*v1.FlockerVolumeSource)(nil), DownwardAPI:(*v1.DownwardAPIVolumeSource)(nil), FC:(*v1.FCVolumeSource)(nil), AzureFile:(*v1.AzureFileVolumeSource)(nil), ConfigMap:(*v1.ConfigMapVolumeSource)(nil), VsphereVolume:(*v1.VsphereVirtualDiskVolumeSource)(nil), Quobyte:(*v1.QuobyteVolumeSource)(nil), AzureDisk:(*v1.AzureDiskVolumeSource)(nil), PhotonPersistentDisk:(*v1.PhotonPersistentDiskVolumeSource)(nil), Projected:(*v1.ProjectedVolumeSource)(nil), PortworxVolume:(*v1.PortworxVolumeSource)(nil), ScaleIO:(*v1.ScaleIOVolumeSource)(nil), StorageOS:(*v1.StorageOSVolumeSource)(nil)}}}, InitContainers:[]v1.Container{v1.Container{Name:"init1", Image:"busybox", Command:[]string{"/bin/false"}, Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList(nil), Requests:v1.ResourceList(nil)}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"default-token-2m2dl", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil)}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"Always", SecurityContext:(*v1.SecurityContext)(0xc4214d37c0), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"init2", Image:"busybox", Command:[]string{"/bin/true"}, Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList(nil), Requests:v1.ResourceList(nil)}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"default-token-2m2dl", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil)}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"Always", SecurityContext:(*v1.SecurityContext)(0xc4214d3840), Stdin:false, StdinOnce:false, TTY:false}}, Containers:[]v1.Container{v1.Container{Name:"run1", Image:"gcr.io/google_containers/pause-amd64:3.0", Command:[]string(nil), Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:100, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:31457280, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"31457280", Format:"DecimalSI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:100, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:31457280, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"31457280", Format:"DecimalSI"}}}, VolumeMounts:[]v1.VolumeMount{v1.VolumeMount{Name:"default-token-2m2dl", ReadOnly:true, MountPath:"/var/run/secrets/kubernetes.io/serviceaccount", SubPath:"", MountPropagation:(*v1.MountPropagationMode)(nil)}}, VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(0xc4214d36c0), Stdin:false, StdinOnce:false, TTY:false}}, RestartPolicy:"Always", TerminationGracePeriodSeconds:(*int64)(0xc421a3d178), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"ClusterFirst", NodeSelector:map[string]string(nil), ServiceAccountName:"default", DeprecatedServiceAccount:"default", AutomountServiceAccountToken:(*bool)(nil), NodeName:"prtest-20891fe-298-ig-n-pm12", HostNetwork:false, HostPID:false, HostIPC:false, SecurityContext:(*v1.PodSecurityContext)(0xc4214d3700), ImagePullSecrets:[]v1.LocalObjectReference{v1.LocalObjectReference{Name:"default-dockercfg-5882l"}}, Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"default-scheduler", Tolerations:[]v1.Toleration{v1.Toleration{Key:"node.kubernetes.io/memory-pressure", Operator:"Exists", Value:"", Effect:"NoSchedule", TolerationSeconds:(*int64)(nil)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"", Priority:(*int32)(nil), DNSConfig:(*v1.PodDNSConfig)(nil)}, Status:v1.PodStatus{Phase:"Pending", Conditions:[]v1.PodCondition{v1.PodCondition{Type:"Initialized", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63665793738, loc:(*time.Location)(0x6921e80)}}, Reason:"ContainersNotInitialized", Message:"containers with incomplete status: [init1 init2]"}, v1.PodCondition{Type:"Ready", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63665793738, loc:(*time.Location)(0x6921e80)}}, Reason:"ContainersNotReady", Message:"containers with unready status: [run1]"}, v1.PodCondition{Type:"PodScheduled", Status:"True", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63665793738, loc:(*time.Location)(0x6921e80)}}, Reason:"", Message:""}}, Message:"", Reason:"", HostIP:"10.142.0.5", PodIP:"172.16.6.125", StartTime:(*v1.Time)(0xc420896960), InitContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"init1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc420eb6460)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc420eb64d0)}, Ready:false, RestartCount:3, Image:"docker.io/busybox:latest", ImageID:"docker-pullable://docker.io/busybox@sha256:141c253bc4c3fd0a201d32dc1f493bcf3fff003b6df416dea4f41046e0f37d47", ContainerID:"docker://e64103c9aee524108e874ba3ea58951117eae6e0fc877b12bb714761efb0942e"}, v1.ContainerStatus{Name:"init2", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc420896a00), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, Ready:false, RestartCount:0, Image:"busybox", ImageID:"", ContainerID:""}}, ContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"run1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc4208969a0), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, Ready:false, RestartCount:0, Image:"gcr.io/google_containers/pause-amd64:3.0", ImageID:"", ContainerID:""}}, QOSClass:"Guaranteed"}}
[AfterEach] [k8s.io] InitContainer
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Jun 28 14:43:22.028: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "e2e-tests-init-container-2xwfm" for this suite.
Jun 28 14:44:16.213: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Jun 28 14:44:17.037: INFO: namespace: e2e-tests-init-container-2xwfm, resource: bindings, ignored listing per whitelist
Jun 28 14:44:17.720: INFO: namespace e2e-tests-init-container-2xwfm deletion completed in 55.650756813s


• [SLOW TEST:120.381 seconds]
[k8s.io] InitContainer
/tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:643
  should not start app containers if init containers fail on a RestartAlways pod [Suite:openshift/conformance/parallel] [Suite:k8s]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/init_container.go:166
------------------------------
Jun 28 14:44:17.722: INFO: Running AfterSuite actions on all node


[k8s.io] Probing container 
  with readiness probe that fails should never be ready and never restart  [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648

[BeforeEach] [Top Level]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [k8s.io] Probing container
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Jun 28 14:43:11.997: INFO: >>> kubeConfig: /tmp/cluster-admin.kubeconfig
STEP: Building a namespace api object
Jun 28 14:43:12.199: INFO: About to run a Kube e2e test, ensuring namespace is privileged
STEP: Waiting for a default service account to be provisioned in namespace
[BeforeEach] [k8s.io] Probing container
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/container_probe.go:48
[It] with readiness probe that fails should never be ready and never restart  [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
[AfterEach] [k8s.io] Probing container
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Jun 28 14:44:13.060: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "e2e-tests-container-probe-8j2sq" for this suite.
Jun 28 14:44:35.139: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Jun 28 14:44:35.749: INFO: namespace: e2e-tests-container-probe-8j2sq, resource: bindings, ignored listing per whitelist
Jun 28 14:44:36.560: INFO: namespace e2e-tests-container-probe-8j2sq deletion completed in 23.470345844s


• [SLOW TEST:84.563 seconds]
[k8s.io] Probing container
/tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:643
  with readiness probe that fails should never be ready and never restart  [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
------------------------------
Jun 28 14:44:36.561: INFO: Running AfterSuite actions on all node


[Feature:Builds][Conformance] oc new-app  
  should succeed with a --name of 58 characters [Suite:openshift/conformance/parallel]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/new_app.go:49

[BeforeEach] [Top Level]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [Feature:Builds][Conformance] oc new-app
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Jun 28 14:43:15.026: INFO: >>> kubeConfig: /tmp/cluster-admin.kubeconfig
STEP: Building a namespace api object
Jun 28 14:43:15.147: INFO: configPath is now "/tmp/extended-test-new-app-g42r4-mblhx-user.kubeconfig"
Jun 28 14:43:15.147: INFO: The user is now "extended-test-new-app-g42r4-mblhx-user"
Jun 28 14:43:15.147: INFO: Creating project "extended-test-new-app-g42r4-mblhx"
Jun 28 14:43:15.285: INFO: Waiting on permissions in project "extended-test-new-app-g42r4-mblhx" ...
STEP: Waiting for a default service account to be provisioned in namespace
[BeforeEach] 
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/new_app.go:26
Jun 28 14:43:15.351: INFO: 

 docker info output: 
Containers: 2
 Running: 0
 Paused: 0
 Stopped: 2
Images: 32
Server Version: 1.13.1
Storage Driver: overlay2
 Backing Filesystem: xfs
 Supports d_type: true
 Native Overlay Diff: true
Logging Driver: json-file
Cgroup Driver: systemd
Plugins: 
 Volume: local
 Network: bridge host macvlan null overlay
 Authorization: rhel-push-plugin
Swarm: inactive
Runtimes: docker-runc runc
Default Runtime: docker-runc
Init Binary: /usr/libexec/docker/docker-init-current
containerd version:  (expected: aa8187dbd3b7ad67d8e5e3a15115d3eef43a7ed1)
runc version: e9c345b3f906d5dc5e8100b05ce37073a811c74a (expected: 9df8b306d01f59d3a8029be411de015b7304dd8f)
init version: 5b117de7f824f3d3825737cf09581645abbe35d4 (expected: 949e6facb77383876aeff8a6944dde66b3089574)
Security Options:
 seccomp
  Profile: /etc/docker/seccomp.json
 selinux
Kernel Version: 3.10.0-862.3.3.el7.x86_64
Operating System: Red Hat Enterprise Linux Server 7.5 (Maipo)
OSType: linux
Architecture: x86_64
Number of Docker Hooks: 3
CPUs: 4
Total Memory: 15.51 GiB
Name: ip-172-18-1-201.ec2.internal
ID: 6WRR:FJU2:46WT:RR52:7YZX:NEJ2:L22M:D5KY:3JL4:DPKI:QS4L:JCJ6
Docker Root Dir: /var/lib/docker
Debug Mode (client): false
Debug Mode (server): true
 File Descriptors: 16
 Goroutines: 26
 System Time: 2018-06-28T14:43:15.344091015Z
 EventsListeners: 0
Registry: https://registry.access.redhat.com/v1/
Experimental: false
Insecure Registries:
 ci.dev.openshift.redhat.com:5000
 172.30.0.0/16
 127.0.0.0/8
Live Restore Enabled: false
Registries: registry.access.redhat.com (secure), docker.io (secure)



[JustBeforeEach] 
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/new_app.go:30
STEP: waiting for builder service account
STEP: waiting for openshift namespace imagestreams
Jun 28 14:43:15.669: INFO: Running scan #0 

Jun 28 14:43:15.669: INFO: Checking language ruby 

Jun 28 14:43:15.713: INFO: Checking tag 2.0 

Jun 28 14:43:15.714: INFO: Checking tag 2.2 

Jun 28 14:43:15.714: INFO: Checking tag 2.3 

Jun 28 14:43:15.714: INFO: Checking tag 2.4 

Jun 28 14:43:15.714: INFO: Checking tag latest 

Jun 28 14:43:15.714: INFO: Checking language nodejs 

Jun 28 14:43:15.734: INFO: Checking tag 0.10 

Jun 28 14:43:15.734: INFO: Checking tag 4 

Jun 28 14:43:15.734: INFO: Checking tag 6 

Jun 28 14:43:15.734: INFO: Checking tag 8 

Jun 28 14:43:15.734: INFO: Checking tag latest 

Jun 28 14:43:15.734: INFO: Checking language perl 

Jun 28 14:43:15.757: INFO: Checking tag latest 

Jun 28 14:43:15.757: INFO: Checking tag 5.16 

Jun 28 14:43:15.757: INFO: Checking tag 5.20 

Jun 28 14:43:15.757: INFO: Checking tag 5.24 

Jun 28 14:43:15.757: INFO: Checking language php 

Jun 28 14:43:15.776: INFO: Checking tag 5.6 

Jun 28 14:43:15.776: INFO: Checking tag 7.0 

Jun 28 14:43:15.776: INFO: Checking tag 7.1 

Jun 28 14:43:15.776: INFO: Checking tag latest 

Jun 28 14:43:15.776: INFO: Checking tag 5.5 

Jun 28 14:43:15.776: INFO: Checking language python 

Jun 28 14:43:15.796: INFO: Checking tag 3.6 

Jun 28 14:43:15.796: INFO: Checking tag latest 

Jun 28 14:43:15.796: INFO: Checking tag 2.7 

Jun 28 14:43:15.796: INFO: Checking tag 3.3 

Jun 28 14:43:15.796: INFO: Checking tag 3.4 

Jun 28 14:43:15.796: INFO: Checking tag 3.5 

Jun 28 14:43:15.796: INFO: Checking language wildfly 

Jun 28 14:43:15.820: INFO: Checking tag 8.1 

Jun 28 14:43:15.820: INFO: Checking tag 9.0 

Jun 28 14:43:15.820: INFO: Checking tag latest 

Jun 28 14:43:15.820: INFO: Checking tag 10.0 

Jun 28 14:43:15.820: INFO: Checking tag 10.1 

Jun 28 14:43:15.820: INFO: Checking language mysql 

Jun 28 14:43:15.845: INFO: Checking tag 5.5 

Jun 28 14:43:15.845: INFO: Checking tag 5.6 

Jun 28 14:43:15.845: INFO: Checking tag 5.7 

Jun 28 14:43:15.845: INFO: Checking tag latest 

Jun 28 14:43:15.845: INFO: Checking language postgresql 

Jun 28 14:43:15.903: INFO: Checking tag 9.2 

Jun 28 14:43:15.903: INFO: Checking tag 9.4 

Jun 28 14:43:15.903: INFO: Checking tag 9.5 

Jun 28 14:43:15.903: INFO: Checking tag 9.6 

Jun 28 14:43:15.903: INFO: Checking tag latest 

Jun 28 14:43:15.903: INFO: Checking language mongodb 

Jun 28 14:43:15.922: INFO: Checking tag 2.4 

Jun 28 14:43:15.922: INFO: Checking tag 2.6 

Jun 28 14:43:15.922: INFO: Checking tag 3.2 

Jun 28 14:43:15.922: INFO: Checking tag 3.4 

Jun 28 14:43:15.922: INFO: Checking tag latest 

Jun 28 14:43:15.922: INFO: Checking language jenkins 

Jun 28 14:43:15.945: INFO: Checking tag 1 

Jun 28 14:43:15.945: INFO: Checking tag 2 

Jun 28 14:43:15.945: INFO: Checking tag latest 

Jun 28 14:43:15.945: INFO: Success! 

[It] should succeed with a --name of 58 characters [Suite:openshift/conformance/parallel]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/new_app.go:49
STEP: calling oc new-app
Jun 28 14:43:15.945: INFO: Running 'oc new-app --config=/tmp/extended-test-new-app-g42r4-mblhx-user.kubeconfig --namespace=extended-test-new-app-g42r4-mblhx https://github.com/openshift/nodejs-ex --name a234567890123456789012345678901234567890123456789012345678'
--> Found image 5c36a77 (9 days old) in image stream "openshift/nodejs" under tag "8" for "nodejs"

    Node.js 8 
    --------- 
    Node.js 8 available as container is a base platform for building and running various Node.js 8 applications and frameworks. Node.js is a platform built on Chrome's JavaScript runtime for easily building fast, scalable network applications. Node.js uses an event-driven, non-blocking I/O model that makes it lightweight and efficient, perfect for data-intensive real-time applications that run across distributed devices.

    Tags: builder, nodejs, nodejs8

    * The source repository appears to match: nodejs
    * A source build using source code from https://github.com/openshift/nodejs-ex will be created
      * The resulting image will be pushed to image stream "a234567890123456789012345678901234567890123456789012345678:latest"
      * Use 'start-build' to trigger a new build
    * This image will be deployed in deployment config "a234567890123456789012345678901234567890123456789012345678"
    * Port 8080/tcp will be load balanced by service "a234567890123456789012345678901234567890123456789012345678"
      * Other containers can access this service through the hostname "a234567890123456789012345678901234567890123456789012345678"

--> Creating resources ...
    imagestream "a234567890123456789012345678901234567890123456789012345678" created
    buildconfig "a234567890123456789012345678901234567890123456789012345678" created
    deploymentconfig "a234567890123456789012345678901234567890123456789012345678" created
    service "a234567890123456789012345678901234567890123456789012345678" created
--> Success
    Build scheduled, use 'oc logs -f bc/a234567890123456789012345678901234567890123456789012345678' to track its progress.
    Application is not exposed. You can expose services to the outside world by executing one or more of the commands below:
     'oc expose svc/a234567890123456789012345678901234567890123456789012345678' 
    Run 'oc status' to view your app.
STEP: waiting for the build to complete
STEP: waiting for the deployment to complete
Jun 28 14:44:13.480: INFO: waiting for deploymentconfig extended-test-new-app-g42r4-mblhx/a234567890123456789012345678901234567890123456789012345678 to be available with version 1

Jun 28 14:44:16.522: INFO: deploymentconfig extended-test-new-app-g42r4-mblhx/a234567890123456789012345678901234567890123456789012345678 available after 3.042799656s
pods: a234567890123456789012345678901234567890123456789012345678v5k25

[AfterEach] 
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/new_app.go:40
[AfterEach] [Feature:Builds][Conformance] oc new-app
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Jun 28 14:44:16.522: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-new-app-g42r4-mblhx" for this suite.
Jun 28 14:44:38.615: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Jun 28 14:44:39.186: INFO: namespace: extended-test-new-app-g42r4-mblhx, resource: bindings, ignored listing per whitelist
Jun 28 14:44:40.069: INFO: namespace extended-test-new-app-g42r4-mblhx deletion completed in 23.503486216s


• [SLOW TEST:85.042 seconds]
[Feature:Builds][Conformance] oc new-app
/tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/new_app.go:16
  
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/new_app.go:24
    should succeed with a --name of 58 characters [Suite:openshift/conformance/parallel]
    /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/builds/new_app.go:49
------------------------------
Jun 28 14:44:40.070: INFO: Running AfterSuite actions on all node


[Feature:DeploymentConfig] deploymentconfigs with minimum ready seconds set [Conformance] 
  should not transition the deployment to Complete before satisfied [Suite:openshift/conformance/parallel]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:965

[BeforeEach] [Top Level]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [Feature:DeploymentConfig] deploymentconfigs
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Jun 28 14:42:27.165: INFO: >>> kubeConfig: /tmp/cluster-admin.kubeconfig
STEP: Building a namespace api object
Jun 28 14:42:27.455: INFO: configPath is now "/tmp/extended-test-cli-deployment-p7tcb-fzrr2-user.kubeconfig"
Jun 28 14:42:27.455: INFO: The user is now "extended-test-cli-deployment-p7tcb-fzrr2-user"
Jun 28 14:42:27.455: INFO: Creating project "extended-test-cli-deployment-p7tcb-fzrr2"
Jun 28 14:42:28.108: INFO: Waiting on permissions in project "extended-test-cli-deployment-p7tcb-fzrr2" ...
STEP: Waiting for a default service account to be provisioned in namespace
[JustBeforeEach] [Feature:DeploymentConfig] deploymentconfigs
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:43
[It] should not transition the deployment to Complete before satisfied [Suite:openshift/conformance/parallel]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:965
STEP: verifying the deployment is created
STEP: verifying that all pods are ready
Jun 28 14:42:42.683: INFO: All replicas are ready.
STEP: verifying that the deployment is still running
STEP: waiting for the deployment to finish
Jun 28 14:44:36.760: INFO: Finished waiting for deployment.
[AfterEach] with minimum ready seconds set [Conformance]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:961
[AfterEach] [Feature:DeploymentConfig] deploymentconfigs
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:62
[AfterEach] [Feature:DeploymentConfig] deploymentconfigs
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Jun 28 14:44:39.084: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-cli-deployment-p7tcb-fzrr2" for this suite.
Jun 28 14:44:45.161: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Jun 28 14:44:46.301: INFO: namespace: extended-test-cli-deployment-p7tcb-fzrr2, resource: bindings, ignored listing per whitelist
Jun 28 14:44:46.628: INFO: namespace extended-test-cli-deployment-p7tcb-fzrr2 deletion completed in 7.514381515s


• [SLOW TEST:139.463 seconds]
[Feature:DeploymentConfig] deploymentconfigs
/tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:37
  with minimum ready seconds set [Conformance]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:958
    should not transition the deployment to Complete before satisfied [Suite:openshift/conformance/parallel]
    /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:965
------------------------------
Jun 28 14:44:46.629: INFO: Running AfterSuite actions on all node


[Area:Networking] multicast when using a plugin that does not isolate namespaces by default 
  should block multicast traffic [Suite:openshift/conformance/parallel]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/networking/multicast.go:25

[BeforeEach] [Top Level]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] when using a plugin that does not isolate namespaces by default
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/networking/util.go:369
[BeforeEach] when using a plugin that does not isolate namespaces by default
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Jun 28 14:40:01.859: INFO: >>> kubeConfig: /tmp/cluster-admin.kubeconfig
STEP: Building a namespace api object
Jun 28 14:40:02.019: INFO: configPath is now "/tmp/extended-test-multicast-gfflc-jspkx-user.kubeconfig"
Jun 28 14:40:02.019: INFO: The user is now "extended-test-multicast-gfflc-jspkx-user"
Jun 28 14:40:02.019: INFO: Creating project "extended-test-multicast-gfflc-jspkx"
Jun 28 14:40:02.381: INFO: Waiting on permissions in project "extended-test-multicast-gfflc-jspkx" ...
STEP: Waiting for a default service account to be provisioned in namespace
[It] should block multicast traffic [Suite:openshift/conformance/parallel]
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/networking/multicast.go:25
Jun 28 14:40:02.527: INFO: Waiting up to 5m0s for pod multicast-0                                             status to be running
Jun 28 14:40:02.547: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Pending", readiness: false) (19.300288ms elapsed)
Jun 28 14:40:07.569: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (5.041659106s elapsed)
Jun 28 14:40:12.597: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (10.069474041s elapsed)
Jun 28 14:40:17.644: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (15.116731434s elapsed)
Jun 28 14:40:22.670: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (20.142638358s elapsed)
Jun 28 14:40:27.686: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (25.158707938s elapsed)
Jun 28 14:40:32.702: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (30.174453741s elapsed)
Jun 28 14:40:37.723: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (35.195204908s elapsed)
Jun 28 14:40:42.790: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (40.262446823s elapsed)
Jun 28 14:40:47.809: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (45.281049653s elapsed)
Jun 28 14:40:52.827: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (50.299171392s elapsed)
Jun 28 14:40:57.888: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (55.360524102s elapsed)
Jun 28 14:41:02.922: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m0.39447644s elapsed)
Jun 28 14:41:07.938: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m5.410700252s elapsed)
Jun 28 14:41:12.963: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m10.43570252s elapsed)
Jun 28 14:41:17.985: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m15.457750863s elapsed)
Jun 28 14:41:23.068: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m20.540048325s elapsed)
Jun 28 14:41:28.086: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m25.558876652s elapsed)
Jun 28 14:41:33.104: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m30.576100587s elapsed)
Jun 28 14:41:38.166: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m35.638736558s elapsed)
Jun 28 14:41:43.218: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m40.690153302s elapsed)
Jun 28 14:41:48.233: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m45.705673228s elapsed)
Jun 28 14:41:53.264: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m50.736703467s elapsed)
Jun 28 14:41:58.283: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (1m55.755179031s elapsed)
Jun 28 14:42:03.322: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m0.794228377s elapsed)
Jun 28 14:42:08.354: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m5.826166118s elapsed)
Jun 28 14:42:13.373: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m10.845942181s elapsed)
Jun 28 14:42:18.394: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m15.866374648s elapsed)
Jun 28 14:42:23.413: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m20.885561402s elapsed)
Jun 28 14:42:28.459: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m25.931902171s elapsed)
Jun 28 14:42:33.605: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m31.077620069s elapsed)
Jun 28 14:42:38.638: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m36.110491204s elapsed)
Jun 28 14:42:43.704: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m41.176925367s elapsed)
Jun 28 14:42:48.722: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m46.194905855s elapsed)
Jun 28 14:42:53.761: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m51.233595604s elapsed)
Jun 28 14:42:58.821: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (2m56.293285324s elapsed)
Jun 28 14:43:03.874: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m1.346919879s elapsed)
Jun 28 14:43:08.892: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m6.364834347s elapsed)
Jun 28 14:43:13.957: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m11.430005085s elapsed)
Jun 28 14:43:18.977: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m16.449435418s elapsed)
Jun 28 14:43:24.002: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m21.47408771s elapsed)
Jun 28 14:43:29.020: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m26.492366834s elapsed)
Jun 28 14:43:34.050: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m31.522684042s elapsed)
Jun 28 14:43:39.071: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m36.543688625s elapsed)
Jun 28 14:43:44.100: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m41.572876265s elapsed)
Jun 28 14:43:49.128: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m46.600330481s elapsed)
Jun 28 14:43:54.144: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m51.616046971s elapsed)
Jun 28 14:43:59.159: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (3m56.63178773s elapsed)
Jun 28 14:44:04.178: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m1.650253072s elapsed)
Jun 28 14:44:09.194: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m6.666409874s elapsed)
Jun 28 14:44:14.210: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m11.682710233s elapsed)
Jun 28 14:44:19.227: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m16.699078207s elapsed)
Jun 28 14:44:24.242: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m21.714853723s elapsed)
Jun 28 14:44:29.258: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m26.730727731s elapsed)
Jun 28 14:44:34.274: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m31.746719152s elapsed)
Jun 28 14:44:39.290: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m36.76212471s elapsed)
Jun 28 14:44:44.305: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m41.777554205s elapsed)
Jun 28 14:44:49.321: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m46.793580329s elapsed)
Jun 28 14:44:54.337: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m51.809408043s elapsed)
Jun 28 14:44:59.352: INFO: Waiting for pod multicast-0                                             in namespace 'extended-test-multicast-gfflc-jspkx' status to be 'running'(found phase: "Failed", readiness: false) (4m56.82497833s elapsed)
[AfterEach] when using a plugin that does not isolate namespaces by default
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Jun 28 14:45:04.353: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-multicast-gfflc-jspkx" for this suite.
Jun 28 14:45:10.432: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Jun 28 14:45:11.165: INFO: namespace: extended-test-multicast-gfflc-jspkx, resource: bindings, ignored listing per whitelist
Jun 28 14:45:11.866: INFO: namespace extended-test-multicast-gfflc-jspkx deletion completed in 7.483384074s


• [SLOW TEST:310.007 seconds]
[Area:Networking] multicast
/tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/networking/multicast.go:20
  when using a plugin that does not isolate namespaces by default
  /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/networking/util.go:368
    should block multicast traffic [Suite:openshift/conformance/parallel]
    /tmp/openshift/build-rpms/rpm/BUILD/origin-3.9.0/_output/local/go/src/github.com/openshift/origin/test/extended/networking/multicast.go:25
------------------------------
Jun 28 14:45:11.868: INFO: Running AfterSuite actions on all node


Jun 28 14:43:42.902: INFO: Running AfterSuite actions on all node
Jun 28 14:45:11.928: INFO: Running AfterSuite actions on node 1


Ran 220 of 445 Specs in 522.402 seconds
SUCCESS! -- 220 Passed | 0 Failed | 0 Pending | 225 Skipped 

Ginkgo ran 1 suite in 8m46.480855287s
Test Suite Passed
[INFO] [14:45:11+0000] Running serial tests
I0628 14:45:12.257089   16042 test.go:94] Extended test version v3.9.0+f81489f-34
I0628 14:45:14.190774   17001 test.go:94] Extended test version v3.9.0+f81489f-34
Running Suite: Extended
=======================
Random Seed: 1530197113 - Will randomize all specs
Will run 0 of 445 specs

Jun 28 14:45:14.276: INFO: Fetching cloud provider for "gce"

I0628 14:45:14.276707   17001 gce.go:843] Using DefaultTokenSource &oauth2.reuseTokenSource{new:jwt.jwtSource{ctx:(*context.emptyCtx)(0xc4200181b0), conf:(*jwt.Config)(0xc4201ac280)}, mu:sync.Mutex{state:0, sema:0x0}, t:(*oauth2.Token)(nil)}
I0628 14:45:14.375517   17001 gce.go:843] Using DefaultTokenSource &oauth2.reuseTokenSource{new:jwt.jwtSource{ctx:(*context.emptyCtx)(0xc4200181b0), conf:(*jwt.Config)(0xc4202b8000)}, mu:sync.Mutex{state:0, sema:0x0}, t:(*oauth2.Token)(nil)}
I0628 14:45:14.435984   17001 gce.go:843] Using DefaultTokenSource &oauth2.reuseTokenSource{new:jwt.jwtSource{ctx:(*context.emptyCtx)(0xc4200181b0), conf:(*jwt.Config)(0xc420206500)}, mu:sync.Mutex{state:0, sema:0x0}, t:(*oauth2.Token)(nil)}
W0628 14:45:14.512227   17001 gce.go:432] No network name or URL specified.
Jun 28 14:45:14.512: INFO: lookupDiskImageSources: gcloud error with [[]string{"instance-groups", "list-instances", "", "--format=get(instance)"}]; err:exec: "gcloud": executable file not found in $PATH
Jun 28 14:45:14.512: INFO:  > 
Jun 28 14:45:14.512: INFO: Cluster image sources lookup failed: exec: "gcloud": executable file not found in $PATH

Jun 28 14:45:14.512: INFO: >>> kubeConfig: /tmp/cluster-admin.kubeconfig
Jun 28 14:45:14.514: INFO: Waiting up to 4h0m0s for all (but 0) nodes to be schedulable
Jun 28 14:45:14.680: INFO: Waiting up to 10m0s for all pods (need at least 0) in namespace 'kube-system' to be running and ready
Jun 28 14:45:14.728: INFO: 1 / 1 pods in namespace 'kube-system' are running and ready (0 seconds elapsed)
Jun 28 14:45:14.728: INFO: expected 0 pod replicas in namespace 'kube-system', 0 are Running and Ready.
Jun 28 14:45:14.744: INFO: Waiting for pods to enter Success, but no pods in "kube-system" match label map[name:e2e-image-puller]
Jun 28 14:45:14.744: INFO: Dumping network health container logs from all nodes...
Jun 28 14:45:14.760: INFO: e2e test version: v1.9.1+a0ce1bc657
Jun 28 14:45:14.774: INFO: kube-apiserver version: v1.9.1+a0ce1bc657
SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSJun 28 14:45:14.779: INFO: Running AfterSuite actions on all node
Jun 28 14:45:14.779: INFO: Running AfterSuite actions on node 1

Ran 0 of 445 Specs in 0.503 seconds
SUCCESS! -- 0 Passed | 0 Failed | 0 Pending | 445 Skipped Jun 28 14:45:14.782: INFO: Dumping logs locally to: /data/src/github.com/openshift/origin/_output/scripts/conformance/artifacts/junit
Checking for custom logdump instances, if any
Sourcing kube-util.sh
Detecting project
/data/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/cluster/log-dump/../../cluster/../cluster/gce/util.sh: line 147: gcloud: command not found
Jun 28 14:45:14.821: INFO: Error running cluster/log-dump/log-dump.sh: exit status 127
PASS

Ginkgo ran 1 suite in 918.223352ms
Test Suite Passed
[INFO] [14:45:14+0000] [CLEANUP] Beginning cleanup routines...
[INFO] [14:45:14+0000] [CLEANUP] Dumping cluster events to _output/scripts/conformance/artifacts/events.txt
Logged into "https://internal-api.prtest-20891fe-298.origin-ci-int-gce.dev.rhcloud.com:8443" as "system:admin" using existing credentials.

You have access to the following projects and can switch between them with 'oc project <projectname>':

  * default
    kube-public
    kube-system
    logging
    management-infra
    openshift
    openshift-infra
    openshift-node
    openshift-web-console

Using project "default".
[INFO] [14:45:15+0000] [CLEANUP] Dumping container logs to _output/scripts/conformance/logs/containers
[INFO] [14:45:16+0000] [CLEANUP] Truncating log files over 200M
[INFO] [14:45:16+0000] [CLEANUP] Stopping docker containers
[INFO] [14:45:16+0000] [CLEANUP] Removing docker containers
[INFO] [14:45:16+0000] [CLEANUP] Killing child processes
[INFO] [14:45:16+0000] [CLEANUP] Pruning etcd data directory
rm: cannot remove ‘/tmp/etcd’: Operation not permitted
[INFO] [14:45:16+0000] test/extended/conformance.sh exited with code 0 after 00h 08m 53s
+ gather
+ set +e
++ pwd
+ export PATH=/data/src/github.com/openshift/origin/_output/local/bin/linux/amd64:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/home/origin/.local/bin:/home/origin/bin
+ PATH=/data/src/github.com/openshift/origin/_output/local/bin/linux/amd64:/usr/local/bin:/usr/bin:/usr/local/sbin:/usr/sbin:/home/origin/.local/bin:/home/origin/bin
+ oc get nodes --template '{{ range .items }}{{ .metadata.name }}{{ "\n" }}{{ end }}'
+ xargs -L 1 -I X bash -c 'oc get --raw /api/v1/nodes/X/proxy/metrics > /tmp/artifacts/X.metrics' ''
+ oc get --raw /metrics
+ set -e
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RUN EXTENDED TESTS [00h 09m 58s] ##########
[PostBuildScript] - Executing post build scripts.
[workspace] $ /bin/bash /tmp/jenkins345473730601153629.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ export PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /data/src/github.com/openshift/origin/_output/scripts
  File: ‘/data/src/github.com/openshift/origin/_output/scripts’
  Size: 83        	Blocks: 0          IO Block: 4096   directory
Device: ca02h/51714d	Inode: 16911529    Links: 6
Access: (2755/drwxr-sr-x)  Uid: ( 1001/  origin)   Gid: ( 1003/origin-git)
Context: unconfined_u:object_r:container_file_t:s0
Access: 2018-06-28 13:44:51.422486678 +0000
Modify: 2018-06-28 14:36:23.389951195 +0000
Change: 2018-06-28 14:36:23.389951195 +0000
 Birth: -
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /data/src/github.com/openshift/origin/_output/scripts
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/data/src/github.com/openshift/origin/_output/scripts /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/gathered
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /tmp/artifacts
  File: ‘/tmp/artifacts’
  Size: 160       	Blocks: 0          IO Block: 4096   directory
Device: 27h/39d	Inode: 282097      Links: 3
Access: (0755/drwxr-xr-x)  Uid: ( 1001/  origin)   Gid: ( 1002/  docker)
Context: unconfined_u:object_r:user_tmp_t:s0
Access: 2018-06-28 14:35:20.825114686 +0000
Modify: 2018-06-28 14:45:17.796994715 +0000
Change: 2018-06-28 14:45:17.796994715 +0000
 Birth: -
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /tmp/artifacts
+ scp -r -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/tmp/artifacts /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/gathered
+ tree /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/gathered
/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/gathered
├── artifacts
│   ├── junit
│   ├── master.metrics
│   ├── prtest-20891fe-298-ig-m-9blt.metrics
│   ├── prtest-20891fe-298-ig-n-2dk9.metrics
│   ├── prtest-20891fe-298-ig-n-msvk.metrics
│   └── prtest-20891fe-298-ig-n-pm12.metrics
└── scripts
    ├── build-base-images
    │   ├── artifacts
    │   ├── logs
    │   └── openshift.local.home
    ├── conformance
    │   ├── artifacts
    │   │   ├── events.txt
    │   │   └── junit
    │   │       ├── conformance_parallel_01.xml
    │   │       ├── conformance_parallel_02.xml
    │   │       ├── conformance_parallel_03.xml
    │   │       ├── conformance_parallel_04.xml
    │   │       ├── conformance_parallel_05.xml
    │   │       ├── conformance_parallel_06.xml
    │   │       ├── conformance_parallel_07.xml
    │   │       ├── conformance_parallel_08.xml
    │   │       ├── conformance_parallel_09.xml
    │   │       ├── conformance_parallel_10.xml
    │   │       ├── conformance_parallel_11.xml
    │   │       ├── conformance_parallel_12.xml
    │   │       ├── conformance_parallel_13.xml
    │   │       ├── conformance_parallel_14.xml
    │   │       ├── conformance_parallel_15.xml
    │   │       ├── conformance_parallel_16.xml
    │   │       ├── conformance_parallel_17.xml
    │   │       ├── conformance_parallel_18.xml
    │   │       ├── conformance_parallel_19.xml
    │   │       ├── conformance_parallel_20.xml
    │   │       ├── conformance_parallel_21.xml
    │   │       ├── conformance_parallel_22.xml
    │   │       ├── conformance_parallel_23.xml
    │   │       ├── conformance_parallel_24.xml
    │   │       ├── conformance_parallel_25.xml
    │   │       └── conformance_serial_01.xml
    │   ├── logs
    │   │   ├── containers
    │   │   └── scripts.log
    │   └── openshift.local.home
    ├── push-release
    │   ├── artifacts
    │   ├── logs
    │   │   └── scripts.log
    │   └── openshift.local.home
    └── shell
        ├── artifacts
        ├── logs
        │   ├── 4f088d11ab7a19459db57b2444071e7fba67aa7372bcaa2adc09f8e7560d8b78.json
        │   ├── a8de6b1513ba85652e83d27d645cf004df6d6714fad16e149b6848dd17508159.json
        │   ├── eaefc015f86e7d63aacd3a751c7e284ce611bd577823da6bb935686b3bdb0c2a.json
        │   └── scripts.log
        └── openshift.local.home

21 directories, 38 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins4789119265079915261.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ export PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/generated
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo docker version && sudo docker info && sudo docker images && sudo docker ps -a 2>&1'
  WARNING: You're not using the default seccomp profile
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo cat /etc/sysconfig/docker /etc/sysconfig/docker-network /etc/sysconfig/docker-storage /etc/sysconfig/docker-storage-setup /etc/systemd/system/docker.service 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo find /var/lib/docker/containers -name *.log | sudo xargs tail -vn +1 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'oc get --raw /metrics --server=https://$( uname --nodename ):10250 --config=/etc/origin/master/admin.kubeconfig 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo ausearch -m AVC -m SELINUX_ERR -m USER_AVC 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'oc get --raw /metrics --config=/etc/origin/master/admin.kubeconfig 2>&1'
+ true
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo df -T -h && sudo pvs && sudo vgs && sudo lvs && sudo findmnt --all 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo yum list installed 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl --dmesg --no-pager --all --lines=all 2>&1'
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl _PID=1 --no-pager --all --lines=all 2>&1'
+ tree /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/generated
/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/generated
├── avc_denials.log
├── containers.log
├── dmesg.log
├── docker.config
├── docker.info
├── filesystem.info
├── installed_packages.log
├── master-metrics.log
├── node-metrics.log
└── pid1.journal

0 directories, 10 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins1226490993538334139.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ export PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/journals
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit docker.service --no-pager --all --lines=all
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit dnsmasq.service --no-pager --all --lines=all
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
+ tree /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/journals
/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/journals
├── dnsmasq.service
├── docker.service
└── systemd-journald.service

0 directories, 3 files
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins4362085707894133127.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ export PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
+ trap 'exit 0' EXIT
+ mkdir -p gcs/artifacts gcs/artifacts/generated gcs/artifacts/journals gcs/artifacts/gathered
++ python -c 'import json; import urllib; print json.load(urllib.urlopen('\''https://ci.openshift.redhat.com/jenkins/job/test_pull_request_origin_extended_conformance_gce_39/298/api/json'\''))['\''result'\'']'
+ result=SUCCESS
+ cat
++ date +%s
+ cat /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/builds/298/log
+ cp artifacts/generated/avc_denials.log artifacts/generated/containers.log artifacts/generated/dmesg.log artifacts/generated/docker.config artifacts/generated/docker.info artifacts/generated/filesystem.info artifacts/generated/installed_packages.log artifacts/generated/master-metrics.log artifacts/generated/node-metrics.log artifacts/generated/pid1.journal gcs/artifacts/generated/
+ cp artifacts/journals/dnsmasq.service artifacts/journals/docker.service artifacts/journals/systemd-journald.service gcs/artifacts/journals/
+ cp -r artifacts/gathered/artifacts artifacts/gathered/scripts gcs/artifacts/
++ pwd
+ scp -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/gcs openshiftdevel:/data
+ scp -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config /var/lib/jenkins/.config/gcloud/gcs-publisher-credentials.json openshiftdevel:/data/credentials.json
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins4106042638191100165.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ export PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ mktemp
+ script=/tmp/tmp.rc8txypCHh
+ cat
+ chmod +x /tmp/tmp.rc8txypCHh
+ scp -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.rc8txypCHh openshiftdevel:/tmp/tmp.rc8txypCHh
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.rc8txypCHh"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"presubmit","job":"test_pull_request_origin_extended_conformance_gce_39","buildid":"c735918b-7ad8-11e8-86b5-0a58ac10127e","refs":{"org":"openshift","repo":"origin","base_ref":"release-3.9","base_sha":"71543b2d15e53f4ae56272988a6604bf2f790dfd","pulls":[{"number":20128,"author":"mfojtik","sha":"f81489f47d9f2439a2bf538a2eaee160f51fa033"}]}} ]]
++ jq --compact-output .buildid
+ [[ "c735918b-7ad8-11e8-86b5-0a58ac10127e" =~ ^"[0-9]+"$ ]]
Using BUILD_NUMBER
+ echo 'Using BUILD_NUMBER'
++ jq --compact-output '.buildid |= "298"'
+ JOB_SPEC='{"type":"presubmit","job":"test_pull_request_origin_extended_conformance_gce_39","buildid":"298","refs":{"org":"openshift","repo":"origin","base_ref":"release-3.9","base_sha":"71543b2d15e53f4ae56272988a6604bf2f790dfd","pulls":[{"number":20128,"author":"mfojtik","sha":"f81489f47d9f2439a2bf538a2eaee160f51fa033"}]}}'
+ docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_origin_extended_conformance_gce_39","buildid":"298","refs":{"org":"openshift","repo":"origin","base_ref":"release-3.9","base_sha":"71543b2d15e53f4ae56272988a6604bf2f790dfd","pulls":[{"number":20128,"author":"mfojtik","sha":"f81489f47d9f2439a2bf538a2eaee160f51fa033"}]}}' -v /data:/data:z registry.svc.ci.openshift.org/ci/gcsupload:latest --dry-run=false --gcs-path=gs://origin-ci-test --gcs-credentials-file=/data/credentials.json --path-strategy=single --default-org=openshift --default-repo=origin /data/gcs/artifacts /data/gcs/build-log.txt /data/gcs/finished.json
Unable to find image 'registry.svc.ci.openshift.org/ci/gcsupload:latest' locally
Trying to pull repository registry.svc.ci.openshift.org/ci/gcsupload ... 
latest: Pulling from registry.svc.ci.openshift.org/ci/gcsupload
605ce1bd3f31: Already exists
dc6346da9948: Already exists
7377da2e59db: Pulling fs layer
7377da2e59db: Verifying Checksum
7377da2e59db: Download complete
7377da2e59db: Pull complete
Digest: sha256:79093e281efd0c67e4e5b67ef4bde8559c6e49f691cf4ed6663f95789ec7e934
Status: Downloaded newer image for registry.svc.ci.openshift.org/ci/gcsupload:latest
{"component":"gcsupload","level":"info","msg":"Gathering artifacts from artifact directory: /data/gcs/artifacts","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/artifacts/master.metrics in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/master.metrics\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/artifacts/prtest-20891fe-298-ig-m-9blt.metrics in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-m-9blt.metrics\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/artifacts/prtest-20891fe-298-ig-n-2dk9.metrics in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-n-2dk9.metrics\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/artifacts/prtest-20891fe-298-ig-n-msvk.metrics in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-n-msvk.metrics\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/artifacts/prtest-20891fe-298-ig-n-pm12.metrics in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-n-pm12.metrics\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/avc_denials.log in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/avc_denials.log\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/containers.log in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/containers.log\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/dmesg.log in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/dmesg.log\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/docker.config in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/docker.config\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/docker.info in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/docker.info\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/filesystem.info in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/filesystem.info\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/installed_packages.log in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/installed_packages.log\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/master-metrics.log in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/master-metrics.log\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/node-metrics.log in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/node-metrics.log\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/generated/pid1.journal in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/pid1.journal\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/dnsmasq.service in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/journals/dnsmasq.service\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/docker.service in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/journals/docker.service\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/journals/systemd-journald.service in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/journals/systemd-journald.service\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/events.txt in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/events.txt\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_01.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_01.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_02.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_02.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_03.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_03.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_04.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_04.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_05.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_05.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_06.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_06.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_07.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_07.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_08.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_08.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_09.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_09.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_10.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_10.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_11.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_11.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_12.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_12.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_13.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_13.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_14.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_14.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_15.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_15.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_16.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_16.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_17.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_17.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_18.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_18.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_19.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_19.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_20.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_20.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_21.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_21.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_22.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_22.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_23.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_23.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_24.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_24.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_25.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_25.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_serial_01.xml in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_serial_01.xml\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/conformance/logs/scripts.log in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/logs/scripts.log\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/push-release/logs/scripts.log in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/push-release/logs/scripts.log\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/shell/logs/4f088d11ab7a19459db57b2444071e7fba67aa7372bcaa2adc09f8e7560d8b78.json in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/4f088d11ab7a19459db57b2444071e7fba67aa7372bcaa2adc09f8e7560d8b78.json\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/shell/logs/a8de6b1513ba85652e83d27d645cf004df6d6714fad16e149b6848dd17508159.json in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/a8de6b1513ba85652e83d27d645cf004df6d6714fad16e149b6848dd17508159.json\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/shell/logs/eaefc015f86e7d63aacd3a751c7e284ce611bd577823da6bb935686b3bdb0c2a.json in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/eaefc015f86e7d63aacd3a751c7e284ce611bd577823da6bb935686b3bdb0c2a.json\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","level":"info","msg":"Found /data/gcs/artifacts/scripts/shell/logs/scripts.log in artifact directory. Uploading as pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/scripts.log\n","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_origin_extended_conformance_gce_39/latest-build.txt","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_09.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_15.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_04.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_08.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_14.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_16.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/push-release/logs/scripts.log","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_origin_extended_conformance_gce_39/298.txt","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/journals/systemd-journald.service","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_17.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-n-pm12.metrics","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/docker.config","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/master-metrics.log","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_12.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/eaefc015f86e7d63aacd3a751c7e284ce611bd577823da6bb935686b3bdb0c2a.json","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/build-log.txt","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_07.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_03.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_19.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_24.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/4f088d11ab7a19459db57b2444071e7fba67aa7372bcaa2adc09f8e7560d8b78.json","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_20.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_23.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/dmesg.log","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/node-metrics.log","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_02.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_10.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/pid1.journal","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_25.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/finished.json","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_11.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_13.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_22.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/master.metrics","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-m-9blt.metrics","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-n-2dk9.metrics","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/journals/dnsmasq.service","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/a8de6b1513ba85652e83d27d645cf004df6d6714fad16e149b6848dd17508159.json","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/latest-build.txt","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-n-msvk.metrics","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/containers.log","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/docker.info","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_05.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_serial_01.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_06.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/scripts.log","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_01.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_18.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_21.xml","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/avc_denials.log","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/filesystem.info","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/installed_packages.log","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/journals/docker.service","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/events.txt","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/logs/scripts.log","level":"info","msg":"Queued for upload","time":"2018-06-28T14:45:40Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/events.txt","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_04.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_20.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_16.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_18.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/scripts.log","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_21.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/eaefc015f86e7d63aacd3a751c7e284ce611bd577823da6bb935686b3bdb0c2a.json","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/installed_packages.log","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_03.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_25.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/logs/scripts.log","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/node-metrics.log","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_24.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_17.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_06.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/docker.config","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_23.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/finished.json","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/master-metrics.log","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/docker.info","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_13.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/journals/systemd-journald.service","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_19.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_02.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/containers.log","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_origin_extended_conformance_gce_39/latest-build.txt","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_14.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/filesystem.info","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_05.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_09.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_10.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_15.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/a8de6b1513ba85652e83d27d645cf004df6d6714fad16e149b6848dd17508159.json","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/avc_denials.log","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_11.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/directory/test_pull_request_origin_extended_conformance_gce_39/298.txt","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/pid1.journal","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_serial_01.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_08.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/generated/dmesg.log","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_07.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/push-release/logs/scripts.log","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/journals/dnsmasq.service","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/shell/logs/4f088d11ab7a19459db57b2444071e7fba67aa7372bcaa2adc09f8e7560d8b78.json","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_22.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-n-msvk.metrics","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_01.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/latest-build.txt","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_12.xml","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-n-2dk9.metrics","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-m-9blt.metrics","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/prtest-20891fe-298-ig-n-pm12.metrics","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/build-log.txt","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/artifacts/master.metrics","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","dest":"pr-logs/pull/20128/test_pull_request_origin_extended_conformance_gce_39/298/artifacts/journals/docker.service","level":"info","msg":"Finished upload","time":"2018-06-28T14:45:41Z"}
{"component":"gcsupload","level":"info","msg":"Finished upload to GCS","time":"2018-06-28T14:45:41Z"}
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 06s] ##########
[workspace] $ /bin/bash /tmp/jenkins1236541451380526847.sh
########## STARTING STAGE: GATHER ARTIFACTS FROM TEST CLUSTER ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ export PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
+ trap 'exit 0' EXIT
++ pwd
+ base_artifact_dir=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts
+ source ./INSTANCE_PREFIX
++ INSTANCE_PREFIX=prtest-20891fe-298
++ OS_TAG=f81489f
++ OS_PUSH_BASE_REPO=ci-pr-images/prtest-20891fe-298-
++ gcloud compute instances list --regexp '.*prtest-20891fe-298.*' --uri
+ for instance in '$( gcloud compute instances list --regexp ".*${INSTANCE_PREFIX}.*" --uri )'
++ mktemp
+ info=/tmp/tmp.UfK1nfYJ0O
+ gcloud compute instances describe https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt --format json
++ jq .name --raw-output /tmp/tmp.UfK1nfYJ0O
++ tail -c 5
+ name=9blt
+ jq '.tags.items | contains(["ocp-master"])' --exit-status /tmp/tmp.UfK1nfYJ0O
true
+ artifact_dir=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/masters/9blt
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/masters/9blt /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/masters/9blt/generated /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/masters/9blt/journals
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit origin-master.service --no-pager --all --lines=all
Warning: Permanently added 'compute.8323752325329538726' (ECDSA) to the list of known hosts.
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit origin-master-api.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit origin-master-controllers.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit etcd.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- oc get --raw /metrics --config=/etc/origin/master/admin.kubeconfig
error: Error loading config file "/etc/origin/master/admin.kubeconfig": open /etc/origin/master/admin.kubeconfig: permission denied
+ true
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit origin-node.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit openvswitch.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit ovs-vswitchd.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit ovsdb-server.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit docker.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit dnsmasq.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
++ uname --nodename
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- oc get --raw /metrics --server=https://ip-172-18-8-64.ec2.internal:10250
Unable to connect to the server: dial tcp: lookup ip-172-18-8-64.ec2.internal on 10.142.0.2:53: no such host
+ true
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- 'sudo docker version && sudo docker info && sudo docker images && sudo docker ps -a'
  WARNING: You're not using the default seccomp profile
WARNING: bridge-nf-call-iptables is disabled
WARNING: bridge-nf-call-ip6tables is disabled
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo yum history info origin
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- 'sudo df -h && sudo pvs && sudo vgs && sudo lvs'
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo yum list installed
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo ausearch -m AVC -m SELINUX_ERR -m USER_AVC
<no matches>
+ true
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- sudo journalctl _PID=1 --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-m-9blt -- 'sudo find /var/lib/docker/containers -name *.log | sudo xargs tail -vn +1'
+ for instance in '$( gcloud compute instances list --regexp ".*${INSTANCE_PREFIX}.*" --uri )'
++ mktemp
+ info=/tmp/tmp.XivH7OW501
+ gcloud compute instances describe https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 --format json
++ jq .name --raw-output /tmp/tmp.XivH7OW501
++ tail -c 5
+ name=2dk9
+ jq '.tags.items | contains(["ocp-master"])' --exit-status /tmp/tmp.XivH7OW501
false
+ jq '.tags.items | contains(["ocp-node"])' --exit-status /tmp/tmp.XivH7OW501
true
+ artifact_dir=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/2dk9
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/2dk9 /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/2dk9/generated /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/2dk9/journals
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo journalctl --unit origin-node.service --no-pager --all --lines=all
Warning: Permanently added 'compute.4501341730944667300' (ECDSA) to the list of known hosts.
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo journalctl --unit openvswitch.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo journalctl --unit ovs-vswitchd.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo journalctl --unit ovsdb-server.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo journalctl --unit docker.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo journalctl --unit dnsmasq.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
++ uname --nodename
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- oc get --raw /metrics --server=https://ip-172-18-8-64.ec2.internal:10250
Unable to connect to the server: dial tcp: lookup ip-172-18-8-64.ec2.internal on 10.142.0.4:53: no such host
+ true
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- 'sudo docker version && sudo docker info && sudo docker images && sudo docker ps -a'
  WARNING: You're not using the default seccomp profile
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo yum history info origin
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- 'sudo df -h && sudo pvs && sudo vgs && sudo lvs'
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo yum list installed
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo ausearch -m AVC -m SELINUX_ERR -m USER_AVC
<no matches>
+ true
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- sudo journalctl _PID=1 --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-2dk9 -- 'sudo find /var/lib/docker/containers -name *.log | sudo xargs tail -vn +1'
+ for instance in '$( gcloud compute instances list --regexp ".*${INSTANCE_PREFIX}.*" --uri )'
++ mktemp
+ info=/tmp/tmp.UiqafZnec8
+ gcloud compute instances describe https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk --format json
++ jq .name --raw-output /tmp/tmp.UiqafZnec8
++ tail -c 5
+ name=msvk
+ jq '.tags.items | contains(["ocp-master"])' --exit-status /tmp/tmp.UiqafZnec8
false
+ jq '.tags.items | contains(["ocp-node"])' --exit-status /tmp/tmp.UiqafZnec8
true
+ artifact_dir=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/msvk
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/msvk /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/msvk/generated /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/msvk/journals
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo journalctl --unit origin-node.service --no-pager --all --lines=all
Warning: Permanently added 'compute.8545988596242927268' (ECDSA) to the list of known hosts.
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo journalctl --unit openvswitch.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo journalctl --unit ovs-vswitchd.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo journalctl --unit ovsdb-server.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo journalctl --unit docker.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo journalctl --unit dnsmasq.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
++ uname --nodename
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- oc get --raw /metrics --server=https://ip-172-18-8-64.ec2.internal:10250
Unable to connect to the server: dial tcp: lookup ip-172-18-8-64.ec2.internal on 10.142.0.3:53: no such host
+ true
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- 'sudo docker version && sudo docker info && sudo docker images && sudo docker ps -a'
  WARNING: You're not using the default seccomp profile
WARNING: bridge-nf-call-iptables is disabled
WARNING: bridge-nf-call-ip6tables is disabled
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo yum history info origin
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- 'sudo df -h && sudo pvs && sudo vgs && sudo lvs'
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo yum list installed
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo ausearch -m AVC -m SELINUX_ERR -m USER_AVC
<no matches>
+ true
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- sudo journalctl _PID=1 --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-msvk -- 'sudo find /var/lib/docker/containers -name *.log | sudo xargs tail -vn +1'
+ for instance in '$( gcloud compute instances list --regexp ".*${INSTANCE_PREFIX}.*" --uri )'
++ mktemp
+ info=/tmp/tmp.yT0KTJwCDM
+ gcloud compute instances describe https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 --format json
++ jq .name --raw-output /tmp/tmp.yT0KTJwCDM
++ tail -c 5
+ name=pm12
+ jq '.tags.items | contains(["ocp-master"])' --exit-status /tmp/tmp.yT0KTJwCDM
false
+ jq '.tags.items | contains(["ocp-node"])' --exit-status /tmp/tmp.yT0KTJwCDM
true
+ artifact_dir=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/pm12
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/pm12 /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/pm12/generated /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/artifacts/nodes/pm12/journals
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo journalctl --unit origin-node.service --no-pager --all --lines=all
Warning: Permanently added 'compute.5800721036229562020' (ECDSA) to the list of known hosts.
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo journalctl --unit openvswitch.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo journalctl --unit ovs-vswitchd.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo journalctl --unit ovsdb-server.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo journalctl --unit docker.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo journalctl --unit dnsmasq.service --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
++ uname --nodename
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- oc get --raw /metrics --server=https://ip-172-18-8-64.ec2.internal:10250
Unable to connect to the server: dial tcp: lookup ip-172-18-8-64.ec2.internal on 10.142.0.5:53: no such host
+ true
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- 'sudo docker version && sudo docker info && sudo docker images && sudo docker ps -a'
  WARNING: You're not using the default seccomp profile
WARNING: bridge-nf-call-iptables is disabled
WARNING: bridge-nf-call-ip6tables is disabled
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo yum history info origin
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- 'sudo df -h && sudo pvs && sudo vgs && sudo lvs'
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo yum list installed
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo ausearch -m AVC -m SELINUX_ERR -m USER_AVC
<no matches>
+ true
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- sudo journalctl _PID=1 --no-pager --all --lines=all
+ gcloud compute ssh https://www.googleapis.com/compute/v1/projects/openshift-gce-devel-ci/zones/us-east1-c/instances/prtest-20891fe-298-ig-n-pm12 -- 'sudo find /var/lib/docker/containers -name *.log | sudo xargs tail -vn +1'
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins2302464807183542524.sh
########## STARTING STAGE: DEPROVISION TEST CLUSTER ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ export PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ mktemp
+ script=/tmp/tmp.yxsjav9VT1
+ cat
+ chmod +x /tmp/tmp.yxsjav9VT1
+ scp -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.yxsjav9VT1 openshiftdevel:/tmp/tmp.yxsjav9VT1
+ ssh -F /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 900 /tmp/tmp.yxsjav9VT1"'
+ cd /data/src/github.com/openshift/release
+ trap 'exit 0' EXIT
+ cd cluster/test-deploy/gcp
+ ../../bin/ansible.sh ansible-playbook playbooks/gcp/openshift-cluster/deprovision.yml
Activated service account credentials for: [jenkins-ci-provisioner@openshift-gce-devel.iam.gserviceaccount.com]

PLAY [Terminate running cluster and remove all supporting resources in GCE] ****

TASK [Gathering Facts] *********************************************************
Thursday 28 June 2018  14:47:28 +0000 (0:00:00.068)       0:00:00.068 ********* 
ok: [localhost]

TASK [include_role] ************************************************************
Thursday 28 June 2018  14:47:34 +0000 (0:00:06.085)       0:00:06.153 ********* 

TASK [openshift_gcp : Templatize DNS script] ***********************************
Thursday 28 June 2018  14:47:34 +0000 (0:00:00.110)       0:00:06.264 ********* 
changed: [localhost]

TASK [openshift_gcp : Templatize provision script] *****************************
Thursday 28 June 2018  14:47:34 +0000 (0:00:00.524)       0:00:06.788 ********* 
changed: [localhost]

TASK [openshift_gcp : Templatize de-provision script] **************************
Thursday 28 June 2018  14:47:35 +0000 (0:00:00.338)       0:00:07.126 ********* 
changed: [localhost]

TASK [openshift_gcp : Provision GCP DNS domain] ********************************
Thursday 28 June 2018  14:47:35 +0000 (0:00:00.319)       0:00:07.446 ********* 
skipping: [localhost]

TASK [openshift_gcp : Ensure that DNS resolves to the hosted zone] *************
Thursday 28 June 2018  14:47:35 +0000 (0:00:00.025)       0:00:07.471 ********* 
skipping: [localhost]

TASK [openshift_gcp : Templatize SSH key provision script] *********************
Thursday 28 June 2018  14:47:35 +0000 (0:00:00.025)       0:00:07.497 ********* 
changed: [localhost]

TASK [openshift_gcp : Provision GCP SSH key resources] *************************
Thursday 28 June 2018  14:47:35 +0000 (0:00:00.293)       0:00:07.790 ********* 
skipping: [localhost]

TASK [openshift_gcp : Provision GCP resources] *********************************
Thursday 28 June 2018  14:47:35 +0000 (0:00:00.027)       0:00:07.818 ********* 
skipping: [localhost]

TASK [openshift_gcp : De-provision GCP resources] ******************************
Thursday 28 June 2018  14:47:35 +0000 (0:00:00.025)       0:00:07.844 ********* 
changed: [localhost]

PLAY RECAP *********************************************************************
localhost                  : ok=6    changed=5    unreachable=0    failed=0   

Thursday 28 June 2018  14:52:00 +0000 (0:04:25.118)       0:04:32.962 ********* 
=============================================================================== 
openshift_gcp : De-provision GCP resources ---------------------------- 265.12s
Gathering Facts --------------------------------------------------------- 6.09s
openshift_gcp : Templatize DNS script ----------------------------------- 0.52s
openshift_gcp : Templatize provision script ----------------------------- 0.34s
openshift_gcp : Templatize de-provision script -------------------------- 0.32s
openshift_gcp : Templatize SSH key provision script --------------------- 0.29s
include_role ------------------------------------------------------------ 0.11s
openshift_gcp : Provision GCP SSH key resources ------------------------- 0.03s
openshift_gcp : Provision GCP resources --------------------------------- 0.03s
openshift_gcp : Provision GCP DNS domain -------------------------------- 0.03s
openshift_gcp : Ensure that DNS resolves to the hosted zone ------------- 0.03s
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: DEPROVISION TEST CLUSTER [00h 04m 40s] ##########
[workspace] $ /bin/bash /tmp/jenkins3348286011162592742.sh
########## STARTING STAGE: DELETE PR IMAGES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ export PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
+ trap 'exit 0' EXIT
+ source ./INSTANCE_PREFIX
++ INSTANCE_PREFIX=prtest-20891fe-298
++ OS_TAG=f81489f
++ OS_PUSH_BASE_REPO=ci-pr-images/prtest-20891fe-298-
+ export KUBECONFIG=/var/lib/jenkins/secrets/image-pr-push.kubeconfig
+ KUBECONFIG=/var/lib/jenkins/secrets/image-pr-push.kubeconfig
+ oc get is -o name -n ci-pr-images
+ grep prtest-20891fe-298
+ xargs -r oc delete
imagestream "prtest-20891fe-298-hello-openshift" deleted
imagestream "prtest-20891fe-298-node" deleted
imagestream "prtest-20891fe-298-openvswitch" deleted
imagestream "prtest-20891fe-298-origin" deleted
imagestream "prtest-20891fe-298-origin-base" deleted
imagestream "prtest-20891fe-298-origin-cluster-capacity" deleted
imagestream "prtest-20891fe-298-origin-deployer" deleted
imagestream "prtest-20891fe-298-origin-docker-builder" deleted
imagestream "prtest-20891fe-298-origin-docker-registry" deleted
imagestream "prtest-20891fe-298-origin-egress-http-proxy" deleted
imagestream "prtest-20891fe-298-origin-egress-router" deleted
imagestream "prtest-20891fe-298-origin-f5-router" deleted
imagestream "prtest-20891fe-298-origin-haproxy-router" deleted
imagestream "prtest-20891fe-298-origin-keepalived-ipfailover" deleted
imagestream "prtest-20891fe-298-origin-metrics-server" deleted
imagestream "prtest-20891fe-298-origin-pod" deleted
imagestream "prtest-20891fe-298-origin-recycler" deleted
imagestream "prtest-20891fe-298-origin-service-catalog" deleted
imagestream "prtest-20891fe-298-origin-sti-builder" deleted
imagestream "prtest-20891fe-298-origin-template-service-broker" deleted
imagestream "prtest-20891fe-298-origin-web-console" deleted
+ exit 0
[workspace] $ /bin/bash /tmp/jenkins1310901667952804410.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e
++ export PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config
+ oct deprovision

PLAYBOOK: main.yml *************************************************************
4 plays in /var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml

PLAY [ensure we have the parameters necessary to deprovision virtual hosts] ****

TASK [ensure all required variables are set] ***********************************
task path: /var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:9
skipping: [localhost] => (item=origin_ci_inventory_dir)  => {
    "changed": false, 
    "generated_timestamp": "2018-06-28 10:52:05.284290", 
    "item": "origin_ci_inventory_dir", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region)  => {
    "changed": false, 
    "generated_timestamp": "2018-06-28 10:52:05.288937", 
    "item": "origin_ci_aws_region", 
    "skip_reason": "Conditional check failed", 
    "skipped": true
}

PLAY [deprovision virtual hosts in EC2] ****************************************

TASK [Gathering Facts] *********************************************************
ok: [localhost]

TASK [deprovision a virtual EC2 host] ******************************************
task path: /var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:28
included: /var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml for localhost

TASK [update the SSH configuration to remove AWS EC2 specifics] ****************
task path: /var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:2
ok: [localhost] => {
    "changed": false, 
    "generated_timestamp": "2018-06-28 10:52:06.071150", 
    "msg": ""
}

TASK [rename EC2 instance for termination reaper] ******************************
task path: /var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:8
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-06-28 10:52:06.639760", 
    "msg": "Tags {'Name': 'oct-terminate'} created for resource i-0c79a1e8aec673de1."
}

TASK [tear down the EC2 instance] **********************************************
task path: /var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:15
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-06-28 10:52:07.455226", 
    "instance_ids": [
        "i-0c79a1e8aec673de1"
    ], 
    "instances": [
        {
            "ami_launch_index": "0", 
            "architecture": "x86_64", 
            "block_device_mapping": {
                "/dev/sda1": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-0047e4204aca1f96b"
                }, 
                "/dev/sdb": {
                    "delete_on_termination": true, 
                    "status": "attached", 
                    "volume_id": "vol-07c68157e1905198a"
                }
            }, 
            "dns_name": "ec2-54-161-23-253.compute-1.amazonaws.com", 
            "ebs_optimized": false, 
            "groups": {
                "sg-7e73221a": "default"
            }, 
            "hypervisor": "xen", 
            "id": "i-0c79a1e8aec673de1", 
            "image_id": "ami-0b77b87a37c3e662c", 
            "instance_type": "m4.xlarge", 
            "kernel": null, 
            "key_name": "libra", 
            "launch_time": "2018-06-28T13:40:49.000Z", 
            "placement": "us-east-1d", 
            "private_dns_name": "ip-172-18-1-201.ec2.internal", 
            "private_ip": "172.18.1.201", 
            "public_dns_name": "ec2-54-161-23-253.compute-1.amazonaws.com", 
            "public_ip": "54.161.23.253", 
            "ramdisk": null, 
            "region": "us-east-1", 
            "root_device_name": "/dev/sda1", 
            "root_device_type": "ebs", 
            "state": "running", 
            "state_code": 16, 
            "tags": {
                "Name": "oct-terminate", 
                "openshift_etcd": "", 
                "openshift_master": "", 
                "openshift_node": ""
            }, 
            "tenancy": "default", 
            "virtualization_type": "hvm"
        }
    ], 
    "tagged_instances": []
}

TASK [remove the serialized host variables] ************************************
task path: /var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:22
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-06-28 10:52:07.717270", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory/host_vars/172.18.1.201.yml", 
    "state": "absent"
}

PLAY [deprovision virtual hosts locally manged by Vagrant] *********************

TASK [Gathering Facts] *********************************************************
ok: [localhost]

PLAY [clean up local configuration for deprovisioned instances] ****************

TASK [remove inventory configuration directory] ********************************
task path: /var/lib/jenkins/origin-ci-tool/4b405957477ba1b70cfacd1cf43c6d41a605fc8e/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:61
changed: [localhost] => {
    "changed": true, 
    "generated_timestamp": "2018-06-28 10:52:08.181082", 
    "path": "/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_gce_39/workspace/.config/origin-ci-tool/inventory", 
    "state": "absent"
}

PLAY RECAP *********************************************************************
localhost                  : ok=8    changed=4    unreachable=0    failed=0   

+ set +o xtrace
########## FINISHED STAGE: SUCCESS: DEPROVISION CLOUD RESOURCES [00h 00m 04s] ##########
Archiving artifacts
Recording test results
[WS-CLEANUP] Deleting project workspace...[WS-CLEANUP] done
Finished: SUCCESS