[It] should support remote command execution over websockets [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/pods.go:470
Feb 20 23:07:45.002: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: creating the pod
STEP: submitting the pod to kubernetes
[AfterEach] [k8s.io] Pods
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:07:51.114: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "e2e-tests-pods-dwtr8" for this suite.
Feb 20 23:08:31.133: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:08:31.255: INFO: namespace: e2e-tests-pods-dwtr8, resource: bindings, ignored listing per whitelist
Feb 20 23:08:31.287: INFO: namespace e2e-tests-pods-dwtr8 deletion completed in 40.167847873s
• [SLOW TEST:46.534 seconds]
[k8s.io] Pods
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:643
should support remote command execution over websockets [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/pods.go:470
------------------------------
[Feature:DeploymentConfig] deploymentconfigs with test deployments [Conformance]
should run a deployment to completion and then scale to zero [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:303
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [Feature:DeploymentConfig] deploymentconfigs
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:04:14.576: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:04:14.612: INFO: configPath is now "/tmp/extended-test-cli-deployment-2fqsl-8jspz-user.kubeconfig"
Feb 20 23:04:14.613: INFO: The user is now "extended-test-cli-deployment-2fqsl-8jspz-user"
Feb 20 23:04:14.613: INFO: Creating project "extended-test-cli-deployment-2fqsl-8jspz"
Feb 20 23:04:14.685: INFO: Waiting on permissions in project "extended-test-cli-deployment-2fqsl-8jspz" ...
STEP: Waiting for a default service account to be provisioned in namespace
[JustBeforeEach] [Feature:DeploymentConfig] deploymentconfigs
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:43
[It] should run a deployment to completion and then scale to zero [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:303
Feb 20 23:04:14.704: INFO: Running 'oc create --config=/tmp/extended-test-cli-deployment-2fqsl-8jspz-user.kubeconfig --namespace=extended-test-cli-deployment-2fqsl-8jspz -f /tmp/fixture-testdata-dir302855502/test/extended/testdata/deployments/test-deployment-test.yaml'
Feb 20 23:04:43.112: INFO: Running 'oc logs --config=/tmp/extended-test-cli-deployment-2fqsl-8jspz-user.kubeconfig --namespace=extended-test-cli-deployment-2fqsl-8jspz -f dc/deployment-test'
STEP: checking the logs for substrings
--> pre: Running hook pod ...
test pre hook executed
--> pre: Success
--> Scaling deployment-test-1 to 2
--> Success
STEP: verifying the deployment is marked complete and scaled to zero
Feb 20 23:05:48.165: INFO: Latest rollout of dc/deployment-test (rc/deployment-test-1) is complete.
STEP: verifying that scaling does not result in new pods
Feb 20 23:05:48.165: INFO: Running 'oc scale --config=/tmp/extended-test-cli-deployment-2fqsl-8jspz-user.kubeconfig --namespace=extended-test-cli-deployment-2fqsl-8jspz dc/deployment-test --replicas=1'
STEP: ensuring no scale up of the deployment happens
STEP: verifying the scale is updated on the deployment config
STEP: deploying a few more times
Feb 20 23:05:59.453: INFO: Running 'oc rollout --config=/tmp/extended-test-cli-deployment-2fqsl-8jspz-user.kubeconfig --namespace=extended-test-cli-deployment-2fqsl-8jspz latest deployment-test'
STEP: waiting for the rollout #2 to finish
Feb 20 23:06:41.695: INFO: Running 'oc logs --config=/tmp/extended-test-cli-deployment-2fqsl-8jspz-user.kubeconfig --namespace=extended-test-cli-deployment-2fqsl-8jspz -f pods/deployment-test-2-deploy'
Feb 20 23:07:21.653: INFO: Latest rollout of dc/deployment-test (rc/deployment-test-2) is complete.
STEP: checking the logs for substrings
--> pre: Running hook pod ...
test pre hook executed
--> pre: Success
--> Scaling up deployment-test-2 from 0 to 1, scaling down deployment-test-1 from 0 to 0 (keep 1 pods available, don't exceed 2 pods)
Scaling deployment-test-2 up to 1
--> Success
Feb 20 23:07:21.653: INFO: Running 'oc rollout --config=/tmp/extended-test-cli-deployment-2fqsl-8jspz-user.kubeconfig --namespace=extended-test-cli-deployment-2fqsl-8jspz latest deployment-test'
STEP: waiting for the rollout #3 to finish
Feb 20 23:07:28.695: INFO: Running 'oc logs --config=/tmp/extended-test-cli-deployment-2fqsl-8jspz-user.kubeconfig --namespace=extended-test-cli-deployment-2fqsl-8jspz -f pods/deployment-test-3-deploy'
Feb 20 23:07:46.285: INFO: Latest rollout of dc/deployment-test (rc/deployment-test-3) is complete.
STEP: checking the logs for substrings
--> pre: Running hook pod ...
test pre hook executed
--> pre: Success
--> Scaling up deployment-test-3 from 0 to 1, scaling down deployment-test-2 from 0 to 0 (keep 1 pods available, don't exceed 2 pods)
Scaling deployment-test-3 up to 1
--> Success
rpc error: code = Unknown desc = container with ID starting with ef4336b8262906fe7540a2fe7b6892cd77c699c2dcb344576bcc7dec4f35960d not found: ID does not exist
Feb 20 23:07:46.285: INFO: Running 'oc rollout --config=/tmp/extended-test-cli-deployment-2fqsl-8jspz-user.kubeconfig --namespace=extended-test-cli-deployment-2fqsl-8jspz latest deployment-test'
STEP: waiting for the rollout #4 to finish
Feb 20 23:07:51.313: INFO: Running 'oc logs --config=/tmp/extended-test-cli-deployment-2fqsl-8jspz-user.kubeconfig --namespace=extended-test-cli-deployment-2fqsl-8jspz -f pods/deployment-test-4-deploy'
Feb 20 23:08:28.247: INFO: Latest rollout of dc/deployment-test (rc/deployment-test-4) is complete.
STEP: checking the logs for substrings
--> pre: Running hook pod ...
test pre hook executed
--> pre: Success
--> Scaling up deployment-test-4 from 0 to 1, scaling down deployment-test-3 from 0 to 0 (keep 1 pods available, don't exceed 2 pods)
Scaling deployment-test-4 up to 1
--> Success
[AfterEach] with test deployments [Conformance]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:299
[AfterEach] [Feature:DeploymentConfig] deploymentconfigs
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:62
[AfterEach] [Feature:DeploymentConfig] deploymentconfigs
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:08:30.247: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-cli-deployment-2fqsl-8jspz" for this suite.
Feb 20 23:08:36.267: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:08:36.408: INFO: namespace: extended-test-cli-deployment-2fqsl-8jspz, resource: bindings, ignored listing per whitelist
Feb 20 23:08:36.470: INFO: namespace extended-test-cli-deployment-2fqsl-8jspz deletion completed in 6.216307265s
• [SLOW TEST:261.895 seconds]
[Feature:DeploymentConfig] deploymentconfigs
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:37
with test deployments [Conformance]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:298
should run a deployment to completion and then scale to zero [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/deployments/deployments.go:303
------------------------------
S
------------------------------
[sig-storage] Projected
should provide container's memory limit [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:08:01.960: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:08:02.050: 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] [sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/projected.go:858
[It] should provide container's memory limit [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
STEP: Creating a pod to test downward API volume plugin
Feb 20 23:08:02.275: INFO: Waiting up to 5m0s for pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86" in namespace "e2e-tests-projected-psctv" to be "success or failure"
Feb 20 23:08:02.278: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 2.904393ms
Feb 20 23:08:04.282: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 2.00695832s
Feb 20 23:08:06.285: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 4.010339312s
Feb 20 23:08:08.288: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 6.012706156s
Feb 20 23:08:10.291: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 8.015658317s
Feb 20 23:08:12.293: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 10.01853405s
Feb 20 23:08:14.299: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 12.023806736s
Feb 20 23:08:16.302: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 14.02668201s
Feb 20 23:08:18.304: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 16.029134752s
Feb 20 23:08:20.307: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 18.032068059s
Feb 20 23:08:22.310: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 20.034921304s
Feb 20 23:08:24.313: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 22.038215124s
Feb 20 23:08:26.316: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 24.041614547s
Feb 20 23:08:28.319: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 26.044594934s
Feb 20 23:08:30.323: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 28.048120349s
Feb 20 23:08:32.327: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86": Phase="Succeeded", Reason="", readiness=false. Elapsed: 30.051703756s
STEP: Saw pod success
Feb 20 23:08:32.327: INFO: Pod "downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86" satisfied condition "success or failure"
Feb 20 23:08:32.329: INFO: Trying to get logs from node ip-172-18-4-243.ec2.internal pod downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86 container client-container: <nil>
STEP: delete the pod
Feb 20 23:08:32.357: INFO: Waiting for pod downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86 to disappear
Feb 20 23:08:32.360: INFO: Pod downwardapi-volume-e67adabe-1692-11e8-bd1d-0eb4d2946e86 no longer exists
[AfterEach] [sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:08:32.360: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "e2e-tests-projected-psctv" for this suite.
Feb 20 23:08:38.379: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:08:38.448: INFO: namespace: e2e-tests-projected-psctv, resource: bindings, ignored listing per whitelist
Feb 20 23:08:38.556: INFO: namespace e2e-tests-projected-psctv deletion completed in 6.193782639s
• [SLOW TEST:36.597 seconds]
[sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/projected.go:34
should provide container's memory limit [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
------------------------------
[sig-storage] Downward API volume
should provide container's cpu request [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [sig-storage] Downward API volume
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:08:09.383: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:08:09.471: 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] [sig-storage] Downward API volume
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/downwardapi_volume.go:38
[It] should provide container's cpu request [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
STEP: Creating a pod to test downward API volume plugin
Feb 20 23:08:09.545: INFO: Waiting up to 5m0s for pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86" in namespace "e2e-tests-downward-api-wjfn7" to be "success or failure"
Feb 20 23:08:09.548: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 3.263058ms
Feb 20 23:08:11.551: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 2.006152898s
Feb 20 23:08:13.554: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 4.008735747s
Feb 20 23:08:15.557: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 6.011815199s
Feb 20 23:08:17.560: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 8.014774877s
Feb 20 23:08:19.563: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 10.017506774s
Feb 20 23:08:21.565: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 12.019944089s
Feb 20 23:08:23.567: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 14.022253493s
Feb 20 23:08:25.572: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 16.026757519s
Feb 20 23:08:27.577: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 18.031646291s
Feb 20 23:08:29.583: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 20.037633015s
Feb 20 23:08:31.586: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 22.040859181s
Feb 20 23:08:33.588: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86": Phase="Succeeded", Reason="", readiness=false. Elapsed: 24.043355459s
STEP: Saw pod success
Feb 20 23:08:33.589: INFO: Pod "downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86" satisfied condition "success or failure"
Feb 20 23:08:33.590: INFO: Trying to get logs from node ip-172-18-4-243.ec2.internal pod downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86 container client-container: <nil>
STEP: delete the pod
Feb 20 23:08:33.605: INFO: Waiting for pod downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86 to disappear
Feb 20 23:08:33.608: INFO: Pod downwardapi-volume-ead05b54-1692-11e8-b73e-0eb4d2946e86 no longer exists
[AfterEach] [sig-storage] Downward API volume
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:08:33.608: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "e2e-tests-downward-api-wjfn7" for this suite.
Feb 20 23:08:39.622: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:08:39.716: INFO: namespace: e2e-tests-downward-api-wjfn7, resource: bindings, ignored listing per whitelist
Feb 20 23:08:39.795: INFO: namespace e2e-tests-downward-api-wjfn7 deletion completed in 6.184166449s
• [SLOW TEST:30.412 seconds]
[sig-storage] Downward API volume
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/downwardapi_volume.go:33
should provide container's cpu request [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
------------------------------
SSSSSS
------------------------------
[sig-storage] Projected
should be consumable from pods in volume with mappings [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:08:31.288: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:08:31.383: 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] [sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/projected.go:858
[It] should be consumable from pods in volume with mappings [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
STEP: Creating configMap with name projected-configmap-test-volume-map-f7de6379-1692-11e8-975a-0eb4d2946e86
STEP: Creating a pod to test consume configMaps
Feb 20 23:08:31.449: INFO: Waiting up to 5m0s for pod "pod-projected-configmaps-f7ded889-1692-11e8-975a-0eb4d2946e86" in namespace "e2e-tests-projected-j49gr" to be "success or failure"
Feb 20 23:08:31.458: INFO: Pod "pod-projected-configmaps-f7ded889-1692-11e8-975a-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 8.810228ms
Feb 20 23:08:33.461: INFO: Pod "pod-projected-configmaps-f7ded889-1692-11e8-975a-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 2.012027624s
Feb 20 23:08:35.467: INFO: Pod "pod-projected-configmaps-f7ded889-1692-11e8-975a-0eb4d2946e86": Phase="Succeeded", Reason="", readiness=false. Elapsed: 4.018191079s
STEP: Saw pod success
Feb 20 23:08:35.467: INFO: Pod "pod-projected-configmaps-f7ded889-1692-11e8-975a-0eb4d2946e86" satisfied condition "success or failure"
Feb 20 23:08:35.476: INFO: Trying to get logs from node ip-172-18-4-243.ec2.internal pod pod-projected-configmaps-f7ded889-1692-11e8-975a-0eb4d2946e86 container projected-configmap-volume-test: <nil>
STEP: delete the pod
Feb 20 23:08:35.577: INFO: Waiting for pod pod-projected-configmaps-f7ded889-1692-11e8-975a-0eb4d2946e86 to disappear
Feb 20 23:08:35.627: INFO: Pod pod-projected-configmaps-f7ded889-1692-11e8-975a-0eb4d2946e86 no longer exists
[AfterEach] [sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:08:35.627: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "e2e-tests-projected-j49gr" for this suite.
Feb 20 23:08:41.704: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:08:41.891: INFO: namespace: e2e-tests-projected-j49gr, resource: bindings, ignored listing per whitelist
Feb 20 23:08:41.932: INFO: namespace e2e-tests-projected-j49gr deletion completed in 6.281223677s
• [SLOW TEST:10.643 seconds]
[sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/projected.go:34
should be consumable from pods in volume with mappings [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
------------------------------
S
------------------------------
[Conformance][templates] templateinstance impersonation tests
should pass impersonation creation tests [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/templates/templateinstance_impersonation.go:231
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [Conformance][templates] templateinstance impersonation tests
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:08:38.558: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:08:38.594: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-user.kubeconfig"
Feb 20 23:08:38.594: INFO: The user is now "extended-test-templates-rxfxp-th742-user"
Feb 20 23:08:38.594: INFO: Creating project "extended-test-templates-rxfxp-th742"
Feb 20 23:08:38.626: INFO: Waiting on permissions in project "extended-test-templates-rxfxp-th742" ...
STEP: Waiting for a default service account to be provisioned in namespace
[BeforeEach] [Conformance][templates] templateinstance impersonation tests
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/templates/templateinstance_impersonation.go:57
Feb 20 23:08:38.985: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-adminuser.kubeconfig"
Feb 20 23:08:39.016: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-impersonateuser.kubeconfig"
Feb 20 23:08:39.051: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-impersonatebygroupuser.kubeconfig"
Feb 20 23:08:39.085: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-edituser1.kubeconfig"
Feb 20 23:08:39.113: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-edituser2.kubeconfig"
Feb 20 23:08:39.142: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-viewuser.kubeconfig"
Feb 20 23:08:39.172: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-impersonatebygroupuser.kubeconfig"
[It] should pass impersonation creation tests [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/templates/templateinstance_impersonation.go:231
STEP: testing as system:admin user
STEP: testing as extended-test-templates-rxfxp-th742-adminuser user
Feb 20 23:08:39.221: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-adminuser.kubeconfig"
STEP: testing as extended-test-templates-rxfxp-th742-impersonateuser user
Feb 20 23:08:39.244: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-impersonateuser.kubeconfig"
STEP: testing as extended-test-templates-rxfxp-th742-impersonatebygroupuser user
Feb 20 23:08:39.275: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-impersonatebygroupuser.kubeconfig"
STEP: testing as extended-test-templates-rxfxp-th742-edituser1 user
Feb 20 23:08:39.305: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-edituser1.kubeconfig"
STEP: testing as extended-test-templates-rxfxp-th742-edituser2 user
Feb 20 23:08:39.337: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-edituser2.kubeconfig"
STEP: testing as extended-test-templates-rxfxp-th742-viewuser user
Feb 20 23:08:39.363: INFO: configPath is now "/tmp/extended-test-templates-rxfxp-th742-viewuser.kubeconfig"
[AfterEach] [Conformance][templates] templateinstance impersonation tests
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:08:39.365: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-templates-rxfxp-th742" for this suite.
Feb 20 23:08:45.377: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:08:45.461: INFO: namespace: extended-test-templates-rxfxp-th742, resource: bindings, ignored listing per whitelist
Feb 20 23:08:45.561: INFO: namespace extended-test-templates-rxfxp-th742 deletion completed in 6.193703878s
[AfterEach] [Conformance][templates] templateinstance impersonation tests
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/templates/templateinstance_impersonation.go:221
• [SLOW TEST:7.042 seconds]
[Conformance][templates] templateinstance impersonation tests
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/templates/templateinstance_impersonation.go:27
should pass impersonation creation tests [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/templates/templateinstance_impersonation.go:231
------------------------------
[k8s.io] Probing container
with readiness probe should not be ready before initial delay and never restart [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [k8s.io] Probing container
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:07:38.990: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:07:39.084: 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
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/container_probe.go:48
[It] with readiness probe should not be ready before initial delay and never restart [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
Feb 20 23:08:09.179: INFO: Container started at 2018-02-20 23:07:43 +0000 UTC, pod became ready at 2018-02-20 23:08:07 +0000 UTC
[AfterEach] [k8s.io] Probing container
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:08:09.179: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "e2e-tests-container-probe-hjl7b" for this suite.
Feb 20 23:08:49.191: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:08:49.283: INFO: namespace: e2e-tests-container-probe-hjl7b, resource: bindings, ignored listing per whitelist
Feb 20 23:08:49.374: INFO: namespace e2e-tests-container-probe-hjl7b deletion completed in 40.193117746s
• [SLOW TEST:70.384 seconds]
[k8s.io] Probing container
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:643
with readiness probe should not be ready before initial delay and never restart [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
------------------------------
[sig-storage] Downward API volume
should set mode on item file [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [sig-storage] Downward API volume
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:08:41.935: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:08:42.069: 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] [sig-storage] Downward API volume
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/downwardapi_volume.go:38
[It] should set mode on item file [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
STEP: Creating a pod to test downward API volume plugin
Feb 20 23:08:42.163: INFO: Waiting up to 5m0s for pod "downwardapi-volume-fe418b53-1692-11e8-975a-0eb4d2946e86" in namespace "e2e-tests-downward-api-2lw27" to be "success or failure"
Feb 20 23:08:42.171: INFO: Pod "downwardapi-volume-fe418b53-1692-11e8-975a-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 7.42227ms
Feb 20 23:08:44.176: INFO: Pod "downwardapi-volume-fe418b53-1692-11e8-975a-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 2.012424602s
Feb 20 23:08:46.206: INFO: Pod "downwardapi-volume-fe418b53-1692-11e8-975a-0eb4d2946e86": Phase="Pending", Reason="", readiness=false. Elapsed: 4.043038692s
Feb 20 23:08:48.210: INFO: Pod "downwardapi-volume-fe418b53-1692-11e8-975a-0eb4d2946e86": Phase="Succeeded", Reason="", readiness=false. Elapsed: 6.046368422s
STEP: Saw pod success
Feb 20 23:08:48.210: INFO: Pod "downwardapi-volume-fe418b53-1692-11e8-975a-0eb4d2946e86" satisfied condition "success or failure"
Feb 20 23:08:48.212: INFO: Trying to get logs from node ip-172-18-4-243.ec2.internal pod downwardapi-volume-fe418b53-1692-11e8-975a-0eb4d2946e86 container client-container: <nil>
STEP: delete the pod
Feb 20 23:08:48.231: INFO: Waiting for pod downwardapi-volume-fe418b53-1692-11e8-975a-0eb4d2946e86 to disappear
Feb 20 23:08:48.234: INFO: Pod downwardapi-volume-fe418b53-1692-11e8-975a-0eb4d2946e86 no longer exists
[AfterEach] [sig-storage] Downward API volume
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:08:48.234: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "e2e-tests-downward-api-2lw27" for this suite.
Feb 20 23:08:54.274: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:08:54.434: INFO: namespace: e2e-tests-downward-api-2lw27, resource: bindings, ignored listing per whitelist
Feb 20 23:08:54.462: INFO: namespace e2e-tests-downward-api-2lw27 deletion completed in 6.225663331s
• [SLOW TEST:12.527 seconds]
[sig-storage] Downward API volume
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/downwardapi_volume.go:33
should set mode on item file [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
------------------------------
S
------------------------------
Feb 20 23:08:54.464: INFO: Running AfterSuite actions on all node
[Conformance][Area:Networking][Feature:Router] openshift router metrics The HAProxy router
should expose a health check on the metrics port [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/router/metrics.go:83
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [Conformance][Area:Networking][Feature:Router] openshift router metrics
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:08:49.376: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:08:49.401: INFO: configPath is now "/tmp/extended-test-router-metrics-zwg7j-bx2bn-user.kubeconfig"
Feb 20 23:08:49.401: INFO: The user is now "extended-test-router-metrics-zwg7j-bx2bn-user"
Feb 20 23:08:49.401: INFO: Creating project "extended-test-router-metrics-zwg7j-bx2bn"
Feb 20 23:08:49.483: INFO: Waiting on permissions in project "extended-test-router-metrics-zwg7j-bx2bn" ...
STEP: Waiting for a default service account to be provisioned in namespace
[BeforeEach] [Conformance][Area:Networking][Feature:Router] openshift router metrics
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/router/metrics.go:36
[It] should expose a health check on the metrics port [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/router/metrics.go:83
Feb 20 23:08:49.531: INFO: Creating new exec pod
STEP: listening on the health port
Feb 20 23:08:51.552: INFO: Running '/data/src/github.com/openshift/origin/_output/local/bin/linux/amd64/kubectl --server=https://ip-172-18-4-243.ec2.internal:8443 --kubeconfig=/etc/origin/master/admin.kubeconfig exec --namespace=extended-test-router-metrics-zwg7j-bx2bn execpod -- /bin/sh -c curl -s -o /dev/null -w '%{http_code}' "http://172.18.4.243:1936/healthz"'
Feb 20 23:08:51.883: INFO: stderr: ""
[AfterEach] [Conformance][Area:Networking][Feature:Router] openshift router metrics
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:08:51.892: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-router-metrics-zwg7j-bx2bn" for this suite.
Feb 20 23:08:57.906: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:08:58.042: INFO: namespace: extended-test-router-metrics-zwg7j-bx2bn, resource: bindings, ignored listing per whitelist
Feb 20 23:08:58.075: INFO: namespace extended-test-router-metrics-zwg7j-bx2bn deletion completed in 6.180384851s
[AfterEach] [Conformance][Area:Networking][Feature:Router] openshift router metrics
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/router/metrics.go:76
• [SLOW TEST:8.700 seconds]
[Conformance][Area:Networking][Feature:Router] openshift router metrics
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/router/metrics.go:26
The HAProxy router
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/router/metrics.go:82
should expose a health check on the metrics port [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/router/metrics.go:83
------------------------------
Feb 20 23:08:58.077: INFO: Running AfterSuite actions on all node
[Feature:Builds][pruning] prune builds based on settings in the buildconfig
should prune errored builds based on the failedBuildsHistoryLimit setting [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_pruning.go:198
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [Feature:Builds][pruning] prune builds based on settings in the buildconfig
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:08:45.603: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:08:45.629: INFO: configPath is now "/tmp/extended-test-build-pruning-r25pt-f4vmj-user.kubeconfig"
Feb 20 23:08:45.629: INFO: The user is now "extended-test-build-pruning-r25pt-f4vmj-user"
Feb 20 23:08:45.629: INFO: Creating project "extended-test-build-pruning-r25pt-f4vmj"
Feb 20 23:08:45.712: INFO: Waiting on permissions in project "extended-test-build-pruning-r25pt-f4vmj" ...
STEP: Waiting for a default service account to be provisioned in namespace
[BeforeEach]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_pruning.go:37
Feb 20 23:08:45.968: INFO:
docker info output:
Containers: 1
Running: 0
Paused: 0
Stopped: 1
Images: 78
Server Version: 1.12.6
Storage Driver: devicemapper
Pool Name: docker-docker--pool
Pool Blocksize: 524.3 kB
Base Device Size: 10.74 GB
Backing Filesystem: xfs
Data file:
Metadata file:
Data Space Used: 8.686 GB
Data Space Total: 14.92 GB
Data Space Available: 6.237 GB
Metadata Space Used: 2.109 MB
Metadata Space Total: 54.53 MB
Metadata Space Available: 52.42 MB
Thin Pool Minimum Free Space: 1.492 GB
Udev Sync Supported: true
Deferred Removal Enabled: true
Deferred Deletion Enabled: true
Deferred Deleted Device Count: 0
Library Version: 1.02.140-RHEL7 (2017-05-03)
Logging Driver: json-file
Cgroup Driver: systemd
Plugins:
Volume: local
Network: bridge overlay host null
Authorization: rhel-push-plugin
Swarm: inactive
Runtimes: docker-runc runc
Default Runtime: docker-runc
Security Options: seccomp selinux
Kernel Version: 3.10.0-693.17.1.el7.x86_64
Operating System: Red Hat Enterprise Linux Server 7.4 (Maipo)
OSType: linux
Architecture: x86_64
Number of Docker Hooks: 3
CPUs: 4
Total Memory: 15.51 GiB
Name: ip-172-18-4-243.ec2.internal
ID: AZMC:SIUC:OWFM:4YR4:5BXE:S7GJ:5GN2:S7WD:W6F4:KHQU:HNQ7:LSUW
Docker Root Dir: /var/lib/containers/docker
Debug Mode (client): false
Debug Mode (server): false
Registry: https://registry.access.redhat.com/v1/
Insecure Registries:
ci.dev.openshift.redhat.com:5000
172.30.0.0/16
127.0.0.0/8
Registries: registry.access.redhat.com (secure), docker.io (secure)
[JustBeforeEach]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_pruning.go:41
STEP: waiting for builder service account
STEP: waiting for openshift namespace imagestreams
Feb 20 23:08:46.073: INFO: Running scan #0
Feb 20 23:08:46.073: INFO: Checking language ruby
Feb 20 23:08:46.080: INFO: Checking tag 2.4
Feb 20 23:08:46.080: INFO: Checking tag latest
Feb 20 23:08:46.080: INFO: Checking tag 2.0
Feb 20 23:08:46.080: INFO: Checking tag 2.2
Feb 20 23:08:46.080: INFO: Checking tag 2.3
Feb 20 23:08:46.080: INFO: Checking language nodejs
Feb 20 23:08:46.086: INFO: Checking tag 0.10
Feb 20 23:08:46.086: INFO: Checking tag 4
Feb 20 23:08:46.086: INFO: Checking tag 6
Feb 20 23:08:46.086: INFO: Checking tag 8
Feb 20 23:08:46.086: INFO: Checking tag latest
Feb 20 23:08:46.086: INFO: Checking language perl
Feb 20 23:08:46.091: INFO: Checking tag latest
Feb 20 23:08:46.091: INFO: Checking tag 5.16
Feb 20 23:08:46.091: INFO: Checking tag 5.20
Feb 20 23:08:46.091: INFO: Checking tag 5.24
Feb 20 23:08:46.091: INFO: Checking language php
Feb 20 23:08:46.096: INFO: Checking tag 5.5
Feb 20 23:08:46.096: INFO: Checking tag 5.6
Feb 20 23:08:46.096: INFO: Checking tag 7.0
Feb 20 23:08:46.096: INFO: Checking tag 7.1
Feb 20 23:08:46.096: INFO: Checking tag latest
Feb 20 23:08:46.096: INFO: Checking language python
Feb 20 23:08:46.101: INFO: Checking tag 3.4
Feb 20 23:08:46.101: INFO: Checking tag 3.5
Feb 20 23:08:46.101: INFO: Checking tag 3.6
Feb 20 23:08:46.101: INFO: Checking tag latest
Feb 20 23:08:46.101: INFO: Checking tag 2.7
Feb 20 23:08:46.101: INFO: Checking tag 3.3
Feb 20 23:08:46.101: INFO: Checking language wildfly
Feb 20 23:08:46.105: INFO: Checking tag 10.0
Feb 20 23:08:46.105: INFO: Checking tag 10.1
Feb 20 23:08:46.105: INFO: Checking tag 8.1
Feb 20 23:08:46.105: INFO: Checking tag 9.0
Feb 20 23:08:46.105: INFO: Checking tag latest
Feb 20 23:08:46.105: INFO: Checking language mysql
Feb 20 23:08:46.110: INFO: Checking tag 5.5
Feb 20 23:08:46.110: INFO: Checking tag 5.6
Feb 20 23:08:46.110: INFO: Checking tag 5.7
Feb 20 23:08:46.110: INFO: Checking tag latest
Feb 20 23:08:46.110: INFO: Checking language postgresql
Feb 20 23:08:46.114: INFO: Checking tag 9.5
Feb 20 23:08:46.114: INFO: Checking tag 9.6
Feb 20 23:08:46.114: INFO: Checking tag latest
Feb 20 23:08:46.114: INFO: Checking tag 9.2
Feb 20 23:08:46.114: INFO: Checking tag 9.4
Feb 20 23:08:46.114: INFO: Checking language mongodb
Feb 20 23:08:46.120: INFO: Checking tag latest
Feb 20 23:08:46.120: INFO: Checking tag 2.4
Feb 20 23:08:46.120: INFO: Checking tag 2.6
Feb 20 23:08:46.120: INFO: Checking tag 3.2
Feb 20 23:08:46.120: INFO: Checking tag 3.4
Feb 20 23:08:46.120: INFO: Checking language jenkins
Feb 20 23:08:46.124: INFO: Checking tag 1
Feb 20 23:08:46.124: INFO: Checking tag 2
Feb 20 23:08:46.124: INFO: Checking tag latest
Feb 20 23:08:46.124: INFO: Success!
STEP: creating test image stream
Feb 20 23:08:46.124: INFO: Running 'oc create --config=/tmp/extended-test-build-pruning-r25pt-f4vmj-user.kubeconfig --namespace=extended-test-build-pruning-r25pt-f4vmj -f /tmp/fixture-testdata-dir748677586/test/extended/testdata/builds/build-pruning/imagestream.yaml'
imagestream "myphp" created
[It] should prune errored builds based on the failedBuildsHistoryLimit setting [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_pruning.go:198
STEP: creating test failed build config
Feb 20 23:08:46.454: INFO: Running 'oc create --config=/tmp/extended-test-build-pruning-r25pt-f4vmj-user.kubeconfig --namespace=extended-test-build-pruning-r25pt-f4vmj -f /tmp/fixture-testdata-dir748677586/test/extended/testdata/builds/build-pruning/errored-build-config.yaml'
buildconfig "myphp" created
STEP: starting four test builds
Feb 20 23:08:46.799: INFO: Running 'oc start-build --config=/tmp/extended-test-build-pruning-r25pt-f4vmj-user.kubeconfig --namespace=extended-test-build-pruning-r25pt-f4vmj myphp -o=name'
Feb 20 23:08:47.304: INFO:
start-build output with args [myphp -o=name]:
Error><nil>
StdOut>
build/myphp-1
StdErr>
Feb 20 23:08:47.305: INFO: Waiting for myphp-1 to complete
Feb 20 23:08:53.313: INFO: WaitForABuild returning with error: The build "myphp-1" status is "Error"
Feb 20 23:08:53.313: INFO: Done waiting for myphp-1: util.BuildResult{BuildPath:"build/myphp-1", BuildName:"myphp-1", StartBuildStdErr:"", StartBuildStdOut:"build/myphp-1", StartBuildErr:error(nil), BuildConfigName:"", Build:(*build.Build)(0xc4217dbb00), BuildAttempt:true, BuildSuccess:false, BuildFailure:true, BuildCancelled:false, BuildTimeout:false, LogDumper:(util.LogDumperFunc)(nil), Oc:(*util.CLI)(0xc4212e4620)}
with error: The build "myphp-1" status is "Error"
Feb 20 23:08:53.313: INFO: Running 'oc start-build --config=/tmp/extended-test-build-pruning-r25pt-f4vmj-user.kubeconfig --namespace=extended-test-build-pruning-r25pt-f4vmj myphp -o=name'
Feb 20 23:08:53.779: INFO:
start-build output with args [myphp -o=name]:
Error><nil>
StdOut>
build/myphp-2
StdErr>
Feb 20 23:08:53.781: INFO: Waiting for myphp-2 to complete
Feb 20 23:08:59.793: INFO: WaitForABuild returning with error: The build "myphp-2" status is "Error"
Feb 20 23:08:59.793: INFO: Done waiting for myphp-2: util.BuildResult{BuildPath:"build/myphp-2", BuildName:"myphp-2", StartBuildStdErr:"", StartBuildStdOut:"build/myphp-2", StartBuildErr:error(nil), BuildConfigName:"", Build:(*build.Build)(0xc421c20900), BuildAttempt:true, BuildSuccess:false, BuildFailure:true, BuildCancelled:false, BuildTimeout:false, LogDumper:(util.LogDumperFunc)(nil), Oc:(*util.CLI)(0xc4212e4620)}
with error: The build "myphp-2" status is "Error"
Feb 20 23:08:59.793: INFO: Running 'oc start-build --config=/tmp/extended-test-build-pruning-r25pt-f4vmj-user.kubeconfig --namespace=extended-test-build-pruning-r25pt-f4vmj myphp -o=name'
Feb 20 23:09:00.199: INFO:
start-build output with args [myphp -o=name]:
Error><nil>
StdOut>
build/myphp-3
StdErr>
Feb 20 23:09:00.201: INFO: Waiting for myphp-3 to complete
Feb 20 23:09:06.212: INFO: WaitForABuild returning with error: The build "myphp-3" status is "Error"
Feb 20 23:09:06.212: INFO: Done waiting for myphp-3: util.BuildResult{BuildPath:"build/myphp-3", BuildName:"myphp-3", StartBuildStdErr:"", StartBuildStdOut:"build/myphp-3", StartBuildErr:error(nil), BuildConfigName:"", Build:(*build.Build)(0xc4218dd500), BuildAttempt:true, BuildSuccess:false, BuildFailure:true, BuildCancelled:false, BuildTimeout:false, LogDumper:(util.LogDumperFunc)(nil), Oc:(*util.CLI)(0xc4212e4620)}
with error: The build "myphp-3" status is "Error"
Feb 20 23:09:06.212: INFO: Running 'oc start-build --config=/tmp/extended-test-build-pruning-r25pt-f4vmj-user.kubeconfig --namespace=extended-test-build-pruning-r25pt-f4vmj myphp -o=name'
Feb 20 23:09:06.642: INFO:
start-build output with args [myphp -o=name]:
Error><nil>
StdOut>
build/myphp-4
StdErr>
Feb 20 23:09:06.644: INFO: Waiting for myphp-4 to complete
Feb 20 23:09:12.659: INFO: WaitForABuild returning with error: The build "myphp-4" status is "Error"
Feb 20 23:09:12.659: INFO: Done waiting for myphp-4: util.BuildResult{BuildPath:"build/myphp-4", BuildName:"myphp-4", StartBuildStdErr:"", StartBuildStdOut:"build/myphp-4", StartBuildErr:error(nil), BuildConfigName:"", Build:(*build.Build)(0xc4213f4600), BuildAttempt:true, BuildSuccess:false, BuildFailure:true, BuildCancelled:false, BuildTimeout:false, LogDumper:(util.LogDumperFunc)(nil), Oc:(*util.CLI)(0xc4212e4620)}
with error: The build "myphp-4" status is "Error"
STEP: waiting up to one minute for pruning to complete
2 builds exist, retrying...[AfterEach]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_pruning.go:56
[AfterEach] [Feature:Builds][pruning] prune builds based on settings in the buildconfig
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:09:12.668: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-build-pruning-r25pt-f4vmj" for this suite.
Feb 20 23:09:18.692: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:09:18.814: INFO: namespace: extended-test-build-pruning-r25pt-f4vmj, resource: bindings, ignored listing per whitelist
Feb 20 23:09:18.945: INFO: namespace extended-test-build-pruning-r25pt-f4vmj deletion completed in 6.273217116s
• [SLOW TEST:33.343 seconds]
[Feature:Builds][pruning] prune builds based on settings in the buildconfig
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_pruning.go:21
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_pruning.go:35
should prune errored builds based on the failedBuildsHistoryLimit setting [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/build_pruning.go:198
------------------------------
Feb 20 23:09:18.947: INFO: Running AfterSuite actions on all node
[Feature:Builds][Conformance][valueFrom] process valueFrom in build strategy environment variables
should successfully resolve valueFrom in s2i build environment variables [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/valuefrom.go:61
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [Feature:Builds][Conformance][valueFrom] process valueFrom in build strategy environment variables
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:08:36.475: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:08:36.506: INFO: configPath is now "/tmp/extended-test-build-valuefrom-dsfwc-6rvt9-user.kubeconfig"
Feb 20 23:08:36.506: INFO: The user is now "extended-test-build-valuefrom-dsfwc-6rvt9-user"
Feb 20 23:08:36.506: INFO: Creating project "extended-test-build-valuefrom-dsfwc-6rvt9"
Feb 20 23:08:36.610: INFO: Waiting on permissions in project "extended-test-build-valuefrom-dsfwc-6rvt9" ...
STEP: Waiting for a default service account to be provisioned in namespace
[BeforeEach]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/valuefrom.go:27
Feb 20 23:08:36.694: INFO:
docker info output:
Containers: 0
Running: 0
Paused: 0
Stopped: 0
Images: 78
Server Version: 1.12.6
Storage Driver: devicemapper
Pool Name: docker-docker--pool
Pool Blocksize: 524.3 kB
Base Device Size: 10.74 GB
Backing Filesystem: xfs
Data file:
Metadata file:
Data Space Used: 8.675 GB
Data Space Total: 14.92 GB
Data Space Available: 6.248 GB
Metadata Space Used: 2.073 MB
Metadata Space Total: 54.53 MB
Metadata Space Available: 52.45 MB
Thin Pool Minimum Free Space: 1.492 GB
Udev Sync Supported: true
Deferred Removal Enabled: true
Deferred Deletion Enabled: true
Deferred Deleted Device Count: 0
Library Version: 1.02.140-RHEL7 (2017-05-03)
Logging Driver: json-file
Cgroup Driver: systemd
Plugins:
Volume: local
Network: bridge host null overlay
Authorization: rhel-push-plugin
Swarm: inactive
Runtimes: docker-runc runc
Default Runtime: docker-runc
Security Options: seccomp selinux
Kernel Version: 3.10.0-693.17.1.el7.x86_64
Operating System: Red Hat Enterprise Linux Server 7.4 (Maipo)
OSType: linux
Architecture: x86_64
Number of Docker Hooks: 3
CPUs: 4
Total Memory: 15.51 GiB
Name: ip-172-18-4-243.ec2.internal
ID: AZMC:SIUC:OWFM:4YR4:5BXE:S7GJ:5GN2:S7WD:W6F4:KHQU:HNQ7:LSUW
Docker Root Dir: /var/lib/containers/docker
Debug Mode (client): false
Debug Mode (server): false
Registry: https://registry.access.redhat.com/v1/
Insecure Registries:
ci.dev.openshift.redhat.com:5000
172.30.0.0/16
127.0.0.0/8
Registries: registry.access.redhat.com (secure), docker.io (secure)
[JustBeforeEach]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/valuefrom.go:38
STEP: waiting for builder service account
STEP: waiting for openshift namespace imagestreams
Feb 20 23:08:36.802: INFO: Running scan #0
Feb 20 23:08:36.802: INFO: Checking language ruby
Feb 20 23:08:36.806: INFO: Checking tag 2.0
Feb 20 23:08:36.806: INFO: Checking tag 2.2
Feb 20 23:08:36.806: INFO: Checking tag 2.3
Feb 20 23:08:36.806: INFO: Checking tag 2.4
Feb 20 23:08:36.806: INFO: Checking tag latest
Feb 20 23:08:36.806: INFO: Checking language nodejs
Feb 20 23:08:36.811: INFO: Checking tag 6
Feb 20 23:08:36.811: INFO: Checking tag 8
Feb 20 23:08:36.811: INFO: Checking tag latest
Feb 20 23:08:36.811: INFO: Checking tag 0.10
Feb 20 23:08:36.811: INFO: Checking tag 4
Feb 20 23:08:36.811: INFO: Checking language perl
Feb 20 23:08:36.815: INFO: Checking tag 5.16
Feb 20 23:08:36.815: INFO: Checking tag 5.20
Feb 20 23:08:36.815: INFO: Checking tag 5.24
Feb 20 23:08:36.815: INFO: Checking tag latest
Feb 20 23:08:36.815: INFO: Checking language php
Feb 20 23:08:36.819: INFO: Checking tag 7.1
Feb 20 23:08:36.819: INFO: Checking tag latest
Feb 20 23:08:36.819: INFO: Checking tag 5.5
Feb 20 23:08:36.819: INFO: Checking tag 5.6
Feb 20 23:08:36.819: INFO: Checking tag 7.0
Feb 20 23:08:36.819: INFO: Checking language python
Feb 20 23:08:36.822: INFO: Checking tag 3.4
Feb 20 23:08:36.822: INFO: Checking tag 3.5
Feb 20 23:08:36.822: INFO: Checking tag 3.6
Feb 20 23:08:36.822: INFO: Checking tag latest
Feb 20 23:08:36.822: INFO: Checking tag 2.7
Feb 20 23:08:36.822: INFO: Checking tag 3.3
Feb 20 23:08:36.822: INFO: Checking language wildfly
Feb 20 23:08:36.826: INFO: Checking tag latest
Feb 20 23:08:36.826: INFO: Checking tag 10.0
Feb 20 23:08:36.826: INFO: Checking tag 10.1
Feb 20 23:08:36.826: INFO: Checking tag 8.1
Feb 20 23:08:36.826: INFO: Checking tag 9.0
Feb 20 23:08:36.826: INFO: Checking language mysql
Feb 20 23:08:36.829: INFO: Checking tag 5.5
Feb 20 23:08:36.829: INFO: Checking tag 5.6
Feb 20 23:08:36.829: INFO: Checking tag 5.7
Feb 20 23:08:36.829: INFO: Checking tag latest
Feb 20 23:08:36.829: INFO: Checking language postgresql
Feb 20 23:08:36.833: INFO: Checking tag 9.6
Feb 20 23:08:36.833: INFO: Checking tag latest
Feb 20 23:08:36.833: INFO: Checking tag 9.2
Feb 20 23:08:36.833: INFO: Checking tag 9.4
Feb 20 23:08:36.833: INFO: Checking tag 9.5
Feb 20 23:08:36.833: INFO: Checking language mongodb
Feb 20 23:08:36.836: INFO: Checking tag 2.4
Feb 20 23:08:36.836: INFO: Checking tag 2.6
Feb 20 23:08:36.836: INFO: Checking tag 3.2
Feb 20 23:08:36.836: INFO: Checking tag 3.4
Feb 20 23:08:36.836: INFO: Checking tag latest
Feb 20 23:08:36.836: INFO: Checking language jenkins
Feb 20 23:08:36.839: INFO: Checking tag 1
Feb 20 23:08:36.839: INFO: Checking tag 2
Feb 20 23:08:36.839: INFO: Checking tag latest
Feb 20 23:08:36.839: INFO: Success!
STEP: creating test image stream
Feb 20 23:08:36.839: INFO: Running 'oc create --config=/tmp/extended-test-build-valuefrom-dsfwc-6rvt9-user.kubeconfig --namespace=extended-test-build-valuefrom-dsfwc-6rvt9 -f /tmp/fixture-testdata-dir302855502/test/extended/testdata/builds/valuefrom/test-is.json'
imagestream "test" created
STEP: creating test secret
Feb 20 23:08:37.121: INFO: Running 'oc create --config=/tmp/extended-test-build-valuefrom-dsfwc-6rvt9-user.kubeconfig --namespace=extended-test-build-valuefrom-dsfwc-6rvt9 -f /tmp/fixture-testdata-dir302855502/test/extended/testdata/builds/valuefrom/test-secret.yaml'
secret "mysecret" created
STEP: creating test configmap
Feb 20 23:08:37.366: INFO: Running 'oc create --config=/tmp/extended-test-build-valuefrom-dsfwc-6rvt9-user.kubeconfig --namespace=extended-test-build-valuefrom-dsfwc-6rvt9 -f /tmp/fixture-testdata-dir302855502/test/extended/testdata/builds/valuefrom/test-configmap.yaml'
configmap "myconfigmap" created
[It] should successfully resolve valueFrom in s2i build environment variables [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/valuefrom.go:61
STEP: creating test successful build config
Feb 20 23:08:37.726: INFO: Running 'oc create --config=/tmp/extended-test-build-valuefrom-dsfwc-6rvt9-user.kubeconfig --namespace=extended-test-build-valuefrom-dsfwc-6rvt9 -f /tmp/fixture-testdata-dir302855502/test/extended/testdata/builds/valuefrom/successful-sti-build-value-from-config.yaml'
buildconfig "mys2itest" created
STEP: starting test build
Feb 20 23:08:38.071: INFO: Running 'oc start-build --config=/tmp/extended-test-build-valuefrom-dsfwc-6rvt9-user.kubeconfig --namespace=extended-test-build-valuefrom-dsfwc-6rvt9 mys2itest -o=name'
Feb 20 23:08:38.354: INFO:
start-build output with args [mys2itest -o=name]:
Error><nil>
StdOut>
build/mys2itest-1
StdErr>
Feb 20 23:08:38.355: INFO: Waiting for mys2itest-1 to complete
Feb 20 23:09:34.367: INFO: Done waiting for mys2itest-1: util.BuildResult{BuildPath:"build/mys2itest-1", BuildName:"mys2itest-1", StartBuildStdErr:"", StartBuildStdOut:"build/mys2itest-1", StartBuildErr:error(nil), BuildConfigName:"", Build:(*build.Build)(0xc421ad4000), BuildAttempt:true, BuildSuccess:true, BuildFailure:false, BuildCancelled:false, BuildTimeout:false, LogDumper:(util.LogDumperFunc)(nil), Oc:(*util.CLI)(0xc4212e6fc0)}
with error: <nil>
Feb 20 23:09:34.367: INFO: Running 'oc logs --config=/tmp/extended-test-build-valuefrom-dsfwc-6rvt9-user.kubeconfig --namespace=extended-test-build-valuefrom-dsfwc-6rvt9 -f build/mys2itest-1 --timestamps'
[AfterEach]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/valuefrom.go:31
[AfterEach] [Feature:Builds][Conformance][valueFrom] process valueFrom in build strategy environment variables
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:09:34.806: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "extended-test-build-valuefrom-dsfwc-6rvt9" for this suite.
Feb 20 23:09:40.823: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:09:40.884: INFO: namespace: extended-test-build-valuefrom-dsfwc-6rvt9, resource: bindings, ignored listing per whitelist
Feb 20 23:09:41.001: INFO: namespace extended-test-build-valuefrom-dsfwc-6rvt9 deletion completed in 6.191711595s
• [SLOW TEST:64.526 seconds]
[Feature:Builds][Conformance][valueFrom] process valueFrom in build strategy environment variables
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/valuefrom.go:13
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/valuefrom.go:26
should successfully resolve valueFrom in s2i build environment variables [Suite:openshift/conformance/parallel]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/builds/valuefrom.go:61
------------------------------
Feb 20 23:09:41.003: INFO: Running AfterSuite actions on all node
[sig-storage] Projected
optional updates should be reflected in volume [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
[BeforeEach] [Top Level]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/test/extended/util/test.go:53
[BeforeEach] [sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:134
STEP: Creating a kubernetes client
Feb 20 23:08:39.804: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
STEP: Building a namespace api object
Feb 20 23:08:39.869: 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] [sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/projected.go:858
[It] optional updates should be reflected in volume [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
Feb 20 23:08:39.934: INFO: Couldn't get node TTL annotation (using default value of 0): No TTL annotation found on the node
STEP: Creating secret with name s-test-opt-del-fceec86f-1692-11e8-b73e-0eb4d2946e86
STEP: Creating secret with name s-test-opt-upd-fceec8b2-1692-11e8-b73e-0eb4d2946e86
STEP: Creating the pod
STEP: Deleting secret s-test-opt-del-fceec86f-1692-11e8-b73e-0eb4d2946e86
STEP: Updating secret s-test-opt-upd-fceec8b2-1692-11e8-b73e-0eb4d2946e86
STEP: Creating secret with name s-test-opt-create-fceec8cd-1692-11e8-b73e-0eb4d2946e86
STEP: waiting to observe update in volume
[AfterEach] [sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:135
Feb 20 23:09:58.373: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
STEP: Destroying namespace "e2e-tests-projected-6xhsv" for this suite.
Feb 20 23:10:20.387: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
Feb 20 23:10:20.520: INFO: namespace: e2e-tests-projected-6xhsv, resource: bindings, ignored listing per whitelist
Feb 20 23:10:20.543: INFO: namespace e2e-tests-projected-6xhsv deletion completed in 22.168072612s
• [SLOW TEST:100.739 seconds]
[sig-storage] Projected
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/common/projected.go:34
optional updates should be reflected in volume [Conformance] [Suite:openshift/conformance/parallel] [Suite:k8s]
/go/src/github.com/openshift/origin/_output/local/go/src/github.com/openshift/origin/vendor/k8s.io/kubernetes/test/e2e/framework/framework.go:648
------------------------------
Feb 20 23:10:20.544: INFO: Running AfterSuite actions on all node
Feb 20 23:10:20.545: INFO: Running AfterSuite actions on node 1
Ran 216 of 444 Specs in 2319.483 seconds
SUCCESS! -- 216 Passed | 0 Failed | 0 Pending | 228 Skipped
Ginkgo ran 1 suite in 38m40.545400503s
Test Suite Passed
[INFO] Running serial tests
I0220 23:10:20.945824 57829 test.go:94] Extended test version v3.9.0-alpha.4+9fb6f85-409
I0220 23:10:23.100874 58790 test.go:94] Extended test version v3.9.0-alpha.4+9fb6f85-409
Running Suite: Extended
=======================
Random Seed: 1519168222 - Will randomize all specs
Will run 0 of 444 specs
I0220 23:10:23.182106 58790 e2e.go:56] The --provider flag is not set. Treating as a conformance test. Some tests may not be run.
Feb 20 23:10:23.182: INFO: >>> kubeConfig: /etc/origin/master/admin.kubeconfig
Feb 20 23:10:23.184: INFO: Waiting up to 4h0m0s for all (but 0) nodes to be schedulable
Feb 20 23:10:23.198: INFO: Waiting up to 10m0s for all pods (need at least 0) in namespace 'kube-system' to be running and ready
Feb 20 23:10:23.206: INFO: 1 / 1 pods in namespace 'kube-system' are running and ready (0 seconds elapsed)
Feb 20 23:10:23.206: INFO: expected 0 pod replicas in namespace 'kube-system', 0 are Running and Ready.
Feb 20 23:10:23.208: INFO: Waiting for pods to enter Success, but no pods in "kube-system" match label map[name:e2e-image-puller]
Feb 20 23:10:23.208: INFO: Dumping network health container logs from all nodes...
Feb 20 23:10:23.211: INFO: e2e test version: v1.9.1+a0ce1bc657
Feb 20 23:10:23.212: INFO: kube-apiserver version: v1.9.1+a0ce1bc657
I0220 23:10:23.212063 58790 e2e.go:56] The --provider flag is not set. Treating as a conformance test. Some tests may not be run.
SSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSSFeb 20 23:10:23.215: INFO: Running AfterSuite actions on all node
Feb 20 23:10:23.215: INFO: Running AfterSuite actions on node 1
Ran 0 of 444 Specs in 0.034 seconds
SUCCESS! -- 0 Passed | 0 Failed | 0 Pending | 444 Skipped Feb 20 23:10:23.219: 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
Feb 20 23:10:23.260: INFO: Error running cluster/log-dump/log-dump.sh: exit status 127
PASS
Ginkgo ran 1 suite in 462.632664ms
Test Suite Passed
[INFO] [CLEANUP] Beginning cleanup routines...
[INFO] [CLEANUP] Dumping cluster events to _output/scripts/conformance/artifacts/events.txt
Logged into "https://ip-172-18-4-243.ec2.internal: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-service-catalog
kube-system
logging
management-infra
openshift
openshift-ansible-service-broker
openshift-infra
openshift-node
openshift-template-service-broker
openshift-web-console
Using project "default".
[INFO] [CLEANUP] Dumping container logs to _output/scripts/conformance/logs/containers
[INFO] [CLEANUP] Truncating log files over 200M
[INFO] [CLEANUP] Stopping docker containers
[INFO] [CLEANUP] Removing docker containers
[INFO] [CLEANUP] Killing child processes
[INFO] [CLEANUP] Pruning etcd data directory
rm: cannot remove ‘/tmp/etcd/member’: Permission denied
[INFO] test/extended/conformance.sh exited with code 0 after 00h 38m 47s
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RUN EXTENDED TESTS [00h 48m 00s] ##########
[PostBuildScript] - Execution post build scripts.
[workspace@7] $ /bin/bash /tmp/jenkins7168624975794343598.sh
########## STARTING STAGE: DOWNLOAD ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ export PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/gathered
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/gathered
+ mkdir -p /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/gathered
+ ssh -F ./.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: 126 Blocks: 0 IO Block: 4096 directory
Device: ca02h/51714d Inode: 92885885 Links: 8
Access: (2755/drwxr-sr-x) Uid: ( 1001/ origin) Gid: ( 1003/origin-git)
Context: unconfined_u:object_r:default_t:s0
Access: 2018-02-20 22:22:19.730584695 +0000
Modify: 2018-02-20 22:31:37.855251460 +0000
Change: 2018-02-20 22:31:37.855251460 +0000
Birth: -
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /data/src/github.com/openshift/origin/_output/scripts
+ scp -r -F ./.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_crio/workspace@7/artifacts/gathered
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /var/log/pods
File: ‘/var/log/pods’
Size: 4096 Blocks: 8 IO Block: 4096 directory
Device: ca02h/51714d Inode: 138414758 Links: 13
Access: (0755/drwxr-xr-x) Uid: ( 0/ root) Gid: ( 0/ root)
Context: system_u:object_r:var_log_t:s0
Access: 2018-02-20 23:09:47.727281509 +0000
Modify: 2018-02-20 23:09:47.727281509 +0000
Change: 2018-02-20 23:09:47.727281509 +0000
Birth: -
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /var/log/pods
+ scp -r -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/var/log/pods /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/gathered
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /etc/crio
File: ‘/etc/crio’
Size: 87 Blocks: 0 IO Block: 4096 directory
Device: ca02h/51714d Inode: 184689687 Links: 2
Access: (0755/drwxr-xr-x) Uid: ( 0/ root) Gid: ( 0/ root)
Context: system_u:object_r:container_config_t:s0
Access: 2018-02-20 22:12:16.964277731 +0000
Modify: 2018-02-20 22:12:17.903248620 +0000
Change: 2018-02-20 22:12:17.903248620 +0000
Birth: -
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /etc/crio
+ scp -r -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/etc/crio /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/gathered
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo stat /etc/systemd/system
File: ‘/etc/systemd/system’
Size: 4096 Blocks: 8 IO Block: 4096 directory
Device: ca02h/51714d Inode: 374907 Links: 15
Access: (0755/drwxr-xr-x) Uid: ( 0/ root) Gid: ( 0/ root)
Context: system_u:object_r:systemd_unit_file_t:s0
Access: 2018-02-20 22:17:59.108669883 +0000
Modify: 2018-02-20 22:17:55.933768318 +0000
Change: 2018-02-20 22:17:55.933768318 +0000
Birth: -
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod -R o+rX /etc/systemd/system
+ scp -r -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/etc/systemd/system /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/gathered
scp: /etc/systemd/system/firewalld.service: not a regular file
scp: /etc/systemd/system/origin-master.service: not a regular file
++ export status=FAILURE
++ status=FAILURE
+ exit 0
[workspace@7] $ /bin/bash /tmp/jenkins2680091047890723985.sh
########## STARTING STAGE: GENERATE ARTIFACTS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ export PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/generated
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/generated
+ mkdir /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/generated
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo cat /etc/crio/crio.conf 2>&1'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo docker version && sudo docker info && sudo docker images && sudo docker ps -a 2>&1'
WARNING: bridge-nf-call-iptables is disabled
WARNING: bridge-nf-call-ip6tables is disabled
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo runc exec cri-o crio --version 2>&1'
+ ssh -F ./.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 ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo cat /var/log/audit/audit.log 2>&1'
+ ssh -F ./.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 ./.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'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo ausearch -m AVC -m SELINUX_ERR -m USER_AVC 2>&1'
+ true
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo ausearch -m avc -ts recent 2>&1'
+ true
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'oc get --raw /metrics --config=/etc/origin/master/admin.kubeconfig 2>&1'
+ ssh -F ./.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 ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo journalctl -xe 2>&1'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'sudo yum list installed 2>&1'
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'dmesg 2>&1'
+ ssh -F ./.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_crio/workspace@7/artifacts/generated
/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/generated
├── auditd.log
├── avc_denials.log
├── avc_selinux_denials.log
├── containers.log
├── crio.commit
├── crio.conf
├── dmesg.log
├── docker.config
├── docker.info
├── filesystem.info
├── installed_packages.log
├── journal_xe.log
├── master-metrics.log
├── node-metrics.log
└── pid1.journal
0 directories, 15 files
+ exit 0
[workspace@7] $ /bin/bash /tmp/jenkins4154458080286403968.sh
########## STARTING STAGE: FETCH SYSTEMD JOURNALS FROM THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ export PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
+ trap 'exit 0' EXIT
++ pwd
+ ARTIFACT_DIR=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/journals
+ rm -rf /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/journals
+ mkdir /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/journals
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit docker.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit dnsmasq.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit systemd-journald.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit origin-master.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit origin-master-api.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit origin-master-controllers.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit origin-node.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit openvswitch.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit ovs-vswitchd.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit ovsdb-server.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit etcd.service --no-pager --all --lines=all
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo journalctl --unit cri-o.service --no-pager --all --lines=all
+ ssh -F ./.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_crio/workspace@7/artifacts/journals
/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/artifacts/journals
├── cri-o.service
├── dnsmasq.service
├── docker.service
├── etcd.service
├── openvswitch.service
├── origin-master-api.service
├── origin-master-controllers.service
├── origin-master.service
├── origin-node.service
├── ovsdb-server.service
├── ovs-vswitchd.service
└── systemd-journald.service
0 directories, 12 files
+ exit 0
[workspace@7] $ /bin/bash /tmp/jenkins3385642538972577206.sh
########## STARTING STAGE: FORWARD PARAMETERS TO THE REMOTE HOST ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ export PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel sudo chmod o+rw /etc/environment
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel 'echo '\''BUILD_URL=https://ci.openshift.redhat.com/jenkins/job/test_pull_request_origin_extended_conformance_crio/4616/'\'' >> /etc/environment'
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: FORWARD PARAMETERS TO THE REMOTE HOST [00h 00m 01s] ##########
[workspace@7] $ /bin/bash /tmp/jenkins5471204928079846918.sh
########## STARTING STAGE: RECORD THE ENDING METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ export PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
++ mktemp
+ script=/tmp/tmp.DFahAHQNtx
+ cat
+ chmod +x /tmp/tmp.DFahAHQNtx
+ scp -F ./.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.DFahAHQNtx openshiftdevel:/tmp/tmp.DFahAHQNtx
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.DFahAHQNtx"'
+ cd /data/src/github.com/openshift/aos-cd-jobs
+ trap 'exit 0' EXIT
+ sjb/gcs/finished.py
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: RECORD THE ENDING METADATA [00h 00m 00s] ##########
[workspace@7] $ /bin/bash /tmp/jenkins8998835699961584469.sh
########## STARTING STAGE: ASSEMBLE GCS OUTPUT ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ export PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
+ trap 'exit 0' EXIT
+ mkdir -p gcs/artifacts gcs/artifacts/generated gcs/artifacts/journals gcs/artifacts/gathered
+ scp -F ./.config/origin-ci-tool/inventory/.ssh_config openshiftdevel:/data/finished.json gcs/
+ cat /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/builds/4616/log
+ cp artifacts/generated/auditd.log artifacts/generated/avc_denials.log artifacts/generated/avc_selinux_denials.log artifacts/generated/containers.log artifacts/generated/crio.commit artifacts/generated/crio.conf artifacts/generated/dmesg.log artifacts/generated/docker.config artifacts/generated/docker.info artifacts/generated/filesystem.info artifacts/generated/installed_packages.log artifacts/generated/journal_xe.log artifacts/generated/master-metrics.log artifacts/generated/node-metrics.log artifacts/generated/pid1.journal gcs/artifacts/generated/
+ cp artifacts/journals/cri-o.service artifacts/journals/dnsmasq.service artifacts/journals/docker.service artifacts/journals/etcd.service artifacts/journals/openvswitch.service artifacts/journals/origin-master-api.service artifacts/journals/origin-master-controllers.service artifacts/journals/origin-master.service artifacts/journals/origin-node.service artifacts/journals/ovsdb-server.service artifacts/journals/ovs-vswitchd.service artifacts/journals/systemd-journald.service gcs/artifacts/journals/
+ cp -r artifacts/gathered/crio artifacts/gathered/pods artifacts/gathered/scripts artifacts/gathered/system gcs/artifacts/
++ pwd
+ scp -F ./.config/origin-ci-tool/inventory/.ssh_config -r /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/gcs openshiftdevel:/data
+ scp -F ./.config/origin-ci-tool/inventory/.ssh_config /var/lib/jenkins/.config/gcloud/gcs-publisher-credentials.json openshiftdevel:/data/credentials.json
+ exit 0
[workspace@7] $ /bin/bash /tmp/jenkins1815335475490769934.sh
########## STARTING STAGE: PUSH THE ARTIFACTS AND METADATA ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ export PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
++ mktemp
+ script=/tmp/tmp.8mr1euytTw
+ cat
+ chmod +x /tmp/tmp.8mr1euytTw
+ scp -F ./.config/origin-ci-tool/inventory/.ssh_config /tmp/tmp.8mr1euytTw openshiftdevel:/tmp/tmp.8mr1euytTw
+ ssh -F ./.config/origin-ci-tool/inventory/.ssh_config -t openshiftdevel 'bash -l -c "timeout 300 /tmp/tmp.8mr1euytTw"'
+ cd /home/origin
+ trap 'exit 0' EXIT
+ [[ -n {"type":"presubmit","job":"test_pull_request_origin_extended_conformance_crio","buildid":"6f57f560-1683-11e8-9ee3-0a58ac100ecc","refs":{"org":"openshift","repo":"origin","base_ref":"master","base_sha":"3fc05224aef1bdfa1fb15b8ead428cc5cc27a283","pulls":[{"number":18686,"author":"smarterclayton","sha":"bd22261f2e0a705b428919406c18781864c203f6"}]}} ]]
++ jq --compact-output .buildid
+ [[ "6f57f560-1683-11e8-9ee3-0a58ac100ecc" =~ ^"[0-9]+"$ ]]
Using BUILD_NUMBER
+ echo 'Using BUILD_NUMBER'
++ jq --compact-output '.buildid |= "4616"'
+ JOB_SPEC='{"type":"presubmit","job":"test_pull_request_origin_extended_conformance_crio","buildid":"4616","refs":{"org":"openshift","repo":"origin","base_ref":"master","base_sha":"3fc05224aef1bdfa1fb15b8ead428cc5cc27a283","pulls":[{"number":18686,"author":"smarterclayton","sha":"bd22261f2e0a705b428919406c18781864c203f6"}]}}'
+ docker run -e 'JOB_SPEC={"type":"presubmit","job":"test_pull_request_origin_extended_conformance_crio","buildid":"4616","refs":{"org":"openshift","repo":"origin","base_ref":"master","base_sha":"3fc05224aef1bdfa1fb15b8ead428cc5cc27a283","pulls":[{"number":18686,"author":"smarterclayton","sha":"bd22261f2e0a705b428919406c18781864c203f6"}]}}' -v /data:/data:z registry.svc.ci.openshift.org/ci/gcsupload:latest --dry-run=false --gcs-bucket=origin-ci-test --gcs-credentials-file=/data/credentials.json --path-strategy=single --default-org=openshift --default-repo=origin /data/gcs/
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
6d987f6f4279: Pulling fs layer
186fc760c1fb: Pulling fs layer
1c5839a97a69: Pulling fs layer
186fc760c1fb: Verifying Checksum
186fc760c1fb: Download complete
6d987f6f4279: Verifying Checksum
6d987f6f4279: Download complete
1c5839a97a69: Verifying Checksum
1c5839a97a69: Download complete
6d987f6f4279: Pull complete
186fc760c1fb: Pull complete
1c5839a97a69: Pull complete
Digest: sha256:155975586399aafa90b4827194aa49b145dac376dafce50a74a28e10ffaded46
time="2018-02-20T23:14:40Z" level=info msg="Gathering artifacts from artifact directory: /data/gcs/"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/crio/crio.conf in artifact directory. Uploading as artifacts/crio/crio.conf\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/crio/crio.conf.11865.2018-02-20@22:12:17~ in artifact directory. Uploading as artifacts/crio/crio.conf.11865.2018-02-20@22:12:17~\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/crio/seccomp.json in artifact directory. Uploading as artifacts/crio/seccomp.json\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/auditd.log in artifact directory. Uploading as artifacts/generated/auditd.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/avc_denials.log in artifact directory. Uploading as artifacts/generated/avc_denials.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/avc_selinux_denials.log in artifact directory. Uploading as artifacts/generated/avc_selinux_denials.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/containers.log in artifact directory. Uploading as artifacts/generated/containers.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/crio.commit in artifact directory. Uploading as artifacts/generated/crio.commit\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/crio.conf in artifact directory. Uploading as artifacts/generated/crio.conf\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/dmesg.log in artifact directory. Uploading as artifacts/generated/dmesg.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/docker.config in artifact directory. Uploading as artifacts/generated/docker.config\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/docker.info in artifact directory. Uploading as artifacts/generated/docker.info\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/filesystem.info in artifact directory. Uploading as artifacts/generated/filesystem.info\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/installed_packages.log in artifact directory. Uploading as artifacts/generated/installed_packages.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/journal_xe.log in artifact directory. Uploading as artifacts/generated/journal_xe.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/master-metrics.log in artifact directory. Uploading as artifacts/generated/master-metrics.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/node-metrics.log in artifact directory. Uploading as artifacts/generated/node-metrics.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/generated/pid1.journal in artifact directory. Uploading as artifacts/generated/pid1.journal\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/cri-o.service in artifact directory. Uploading as artifacts/journals/cri-o.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/dnsmasq.service in artifact directory. Uploading as artifacts/journals/dnsmasq.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/docker.service in artifact directory. Uploading as artifacts/journals/docker.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/etcd.service in artifact directory. Uploading as artifacts/journals/etcd.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/openvswitch.service in artifact directory. Uploading as artifacts/journals/openvswitch.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/origin-master-api.service in artifact directory. Uploading as artifacts/journals/origin-master-api.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/origin-master-controllers.service in artifact directory. Uploading as artifacts/journals/origin-master-controllers.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/origin-master.service in artifact directory. Uploading as artifacts/journals/origin-master.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/origin-node.service in artifact directory. Uploading as artifacts/journals/origin-node.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/ovs-vswitchd.service in artifact directory. Uploading as artifacts/journals/ovs-vswitchd.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/ovsdb-server.service in artifact directory. Uploading as artifacts/journals/ovsdb-server.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/journals/systemd-journald.service in artifact directory. Uploading as artifacts/journals/systemd-journald.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/022f6dcd-168c-11e8-8b52-0eb4d2946e86/256b9c6269974ab513ea72417f64318b449fedfd2e3a5b111dfe007f7092e5c0.log in artifact directory. Uploading as artifacts/pods/022f6dcd-168c-11e8-8b52-0eb4d2946e86/256b9c6269974ab513ea72417f64318b449fedfd2e3a5b111dfe007f7092e5c0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/022f6dcd-168c-11e8-8b52-0eb4d2946e86/router_0.log in artifact directory. Uploading as artifacts/pods/022f6dcd-168c-11e8-8b52-0eb4d2946e86/router_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/0a823caa-168c-11e8-8b52-0eb4d2946e86/bb48e442365ce4791db775f82d6a952ffa1d3e3cc8bc0d9c636d3a8262bb5367.log in artifact directory. Uploading as artifacts/pods/0a823caa-168c-11e8-8b52-0eb4d2946e86/bb48e442365ce4791db775f82d6a952ffa1d3e3cc8bc0d9c636d3a8262bb5367.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/0a823caa-168c-11e8-8b52-0eb4d2946e86/registry_0.log in artifact directory. Uploading as artifacts/pods/0a823caa-168c-11e8-8b52-0eb4d2946e86/registry_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/1807f01d-168c-11e8-8b52-0eb4d2946e86/c186fbb2af04e0b2f4c734d5018f5ce41bd8056308dd302b0dbfcb55e2cf0626.log in artifact directory. Uploading as artifacts/pods/1807f01d-168c-11e8-8b52-0eb4d2946e86/c186fbb2af04e0b2f4c734d5018f5ce41bd8056308dd302b0dbfcb55e2cf0626.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/1807f01d-168c-11e8-8b52-0eb4d2946e86/registry-console_0.log in artifact directory. Uploading as artifacts/pods/1807f01d-168c-11e8-8b52-0eb4d2946e86/registry-console_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alert-buffer_0.log in artifact directory. Uploading as artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alert-buffer_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alertmanager-proxy_0.log in artifact directory. Uploading as artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alertmanager-proxy_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alertmanager_0.log in artifact directory. Uploading as artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alertmanager_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alerts-proxy_0.log in artifact directory. Uploading as artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alerts-proxy_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/d07795d8b7a80a0f433e24dbf4b66fbadbb7550d7ac86fb268026ba08c554f5b.log in artifact directory. Uploading as artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/d07795d8b7a80a0f433e24dbf4b66fbadbb7550d7ac86fb268026ba08c554f5b.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/prom-proxy_0.log in artifact directory. Uploading as artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/prom-proxy_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/prometheus_0.log in artifact directory. Uploading as artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/prometheus_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/5471b7f0-168c-11e8-8b52-0eb4d2946e86/2922613087c937c1cfc18736a9340f9cfaae48264ea6fc7c66f0ba8de7f9f63b.log in artifact directory. Uploading as artifacts/pods/5471b7f0-168c-11e8-8b52-0eb4d2946e86/2922613087c937c1cfc18736a9340f9cfaae48264ea6fc7c66f0ba8de7f9f63b.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/5471b7f0-168c-11e8-8b52-0eb4d2946e86/apiserver_0.log in artifact directory. Uploading as artifacts/pods/5471b7f0-168c-11e8-8b52-0eb4d2946e86/apiserver_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/5471fe78-168c-11e8-8b52-0eb4d2946e86/controller-manager_0.log in artifact directory. Uploading as artifacts/pods/5471fe78-168c-11e8-8b52-0eb4d2946e86/controller-manager_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/5471fe78-168c-11e8-8b52-0eb4d2946e86/d21df58a357f88836ff1ed9aca54330bfbd8d3db5aa6363202f1b8a13971cd68.log in artifact directory. Uploading as artifacts/pods/5471fe78-168c-11e8-8b52-0eb4d2946e86/d21df58a357f88836ff1ed9aca54330bfbd8d3db5aa6363202f1b8a13971cd68.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/6541647e-168c-11e8-8b52-0eb4d2946e86/27741c527a726061a35bfd582cef0993bfd77383092bff125f5dc540064e6634.log in artifact directory. Uploading as artifacts/pods/6541647e-168c-11e8-8b52-0eb4d2946e86/27741c527a726061a35bfd582cef0993bfd77383092bff125f5dc540064e6634.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/6541647e-168c-11e8-8b52-0eb4d2946e86/deployment_0.log in artifact directory. Uploading as artifacts/pods/6541647e-168c-11e8-8b52-0eb4d2946e86/deployment_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/6622f1cb-168c-11e8-8b52-0eb4d2946e86/18e6e2ad8d451f8f86f5544f27dcfcc61d657d892dcefb8247de7f872a6a7961.log in artifact directory. Uploading as artifacts/pods/6622f1cb-168c-11e8-8b52-0eb4d2946e86/18e6e2ad8d451f8f86f5544f27dcfcc61d657d892dcefb8247de7f872a6a7961.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/6622f1cb-168c-11e8-8b52-0eb4d2946e86/deployment_0.log in artifact directory. Uploading as artifacts/pods/6622f1cb-168c-11e8-8b52-0eb4d2946e86/deployment_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/6ba176ac-168c-11e8-8b52-0eb4d2946e86/a8eca96bf8fe0bdaa60563d3b022734d09216dda89c4596070eaa01e48fd3877.log in artifact directory. Uploading as artifacts/pods/6ba176ac-168c-11e8-8b52-0eb4d2946e86/a8eca96bf8fe0bdaa60563d3b022734d09216dda89c4596070eaa01e48fd3877.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/6ba176ac-168c-11e8-8b52-0eb4d2946e86/c_0.log in artifact directory. Uploading as artifacts/pods/6ba176ac-168c-11e8-8b52-0eb4d2946e86/c_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/81326fcb-168c-11e8-8b52-0eb4d2946e86/27454db06ab5736941658e35712ab9a95eefc7292ea1688ed079ec2d55b890eb.log in artifact directory. Uploading as artifacts/pods/81326fcb-168c-11e8-8b52-0eb4d2946e86/27454db06ab5736941658e35712ab9a95eefc7292ea1688ed079ec2d55b890eb.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/81326fcb-168c-11e8-8b52-0eb4d2946e86/webconsole_0.log in artifact directory. Uploading as artifacts/pods/81326fcb-168c-11e8-8b52-0eb4d2946e86/webconsole_0.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/pods/fcf0b5b9-1692-11e8-8b52-0eb4d2946e86/54a940690ff18429843901e3741bf2c7871811e9e520a74ad80a36b6dba1fcf2.log in artifact directory. Uploading as artifacts/pods/fcf0b5b9-1692-11e8-8b52-0eb4d2946e86/54a940690ff18429843901e3741bf2c7871811e9e520a74ad80a36b6dba1fcf2.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/ansible_junit/cDyFQoYEVz.xml in artifact directory. Uploading as artifacts/scripts/ansible_junit/cDyFQoYEVz.xml\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/ansible_junit/kHRTevekai.xml in artifact directory. Uploading as artifacts/scripts/ansible_junit/kHRTevekai.xml\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/ansible_junit/wQYdxEMDkN.xml in artifact directory. Uploading as artifacts/scripts/ansible_junit/wQYdxEMDkN.xml\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/build-images/logs/scripts.log in artifact directory. Uploading as artifacts/scripts/build-images/logs/scripts.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/conformance/artifacts/events.txt in artifact directory. Uploading as artifacts/scripts/conformance/artifacts/events.txt\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_01.xml in artifact directory. Uploading as artifacts/scripts/conformance/artifacts/junit/conformance_parallel_01.xml\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_02.xml in artifact directory. Uploading as artifacts/scripts/conformance/artifacts/junit/conformance_parallel_02.xml\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_03.xml in artifact directory. Uploading as artifacts/scripts/conformance/artifacts/junit/conformance_parallel_03.xml\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_04.xml in artifact directory. Uploading as artifacts/scripts/conformance/artifacts/junit/conformance_parallel_04.xml\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_05.xml in artifact directory. Uploading as artifacts/scripts/conformance/artifacts/junit/conformance_parallel_05.xml\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/conformance/artifacts/junit/conformance_serial_01.xml in artifact directory. Uploading as artifacts/scripts/conformance/artifacts/junit/conformance_serial_01.xml\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/conformance/logs/scripts.log in artifact directory. Uploading as artifacts/scripts/conformance/logs/scripts.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/shell/logs/6b7c683be03f386c33ec1048a1a6e86d81a18ba1f019bd75c9fdf9cbae503679.json in artifact directory. Uploading as artifacts/scripts/shell/logs/6b7c683be03f386c33ec1048a1a6e86d81a18ba1f019bd75c9fdf9cbae503679.json\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/shell/logs/8b99a344a120412610818f89223e4221dbb752ecad32d51c07ecac5b7b013015.json in artifact directory. Uploading as artifacts/scripts/shell/logs/8b99a344a120412610818f89223e4221dbb752ecad32d51c07ecac5b7b013015.json\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/scripts/shell/logs/scripts.log in artifact directory. Uploading as artifacts/scripts/shell/logs/scripts.log\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/basic.target.wants/iptables.service in artifact directory. Uploading as artifacts/system/basic.target.wants/iptables.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/basic.target.wants/microcode.service in artifact directory. Uploading as artifacts/system/basic.target.wants/microcode.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/cri-o.service in artifact directory. Uploading as artifacts/system/cri-o.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/dbus-org.freedesktop.NetworkManager.service in artifact directory. Uploading as artifacts/system/dbus-org.freedesktop.NetworkManager.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/dbus-org.freedesktop.nm-dispatcher.service in artifact directory. Uploading as artifacts/system/dbus-org.freedesktop.nm-dispatcher.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/default.target in artifact directory. Uploading as artifacts/system/default.target\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/default.target.wants/systemd-readahead-collect.service in artifact directory. Uploading as artifacts/system/default.target.wants/systemd-readahead-collect.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/default.target.wants/systemd-readahead-replay.service in artifact directory. Uploading as artifacts/system/default.target.wants/systemd-readahead-replay.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/dev-virtio\\x2dports-org.qemu.guest_agent.0.device.wants/qemu-guest-agent.service in artifact directory. Uploading as artifacts/system/dev-virtio\\x2dports-org.qemu.guest_agent.0.device.wants/qemu-guest-agent.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/docker.service.d/custom.conf in artifact directory. Uploading as artifacts/system/docker.service.d/custom.conf\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/getty.target.wants/getty@tty1.service in artifact directory. Uploading as artifacts/system/getty.target.wants/getty@tty1.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/local-fs.target.wants/ostree-remount.service in artifact directory. Uploading as artifacts/system/local-fs.target.wants/ostree-remount.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/NetworkManager.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/NetworkManager.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/atd.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/atd.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/auditd.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/auditd.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/chronyd.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/chronyd.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/cloud-config.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/cloud-config.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/cloud-final.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/cloud-final.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/cloud-init-local.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/cloud-init-local.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/cloud-init.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/cloud-init.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/cri-o.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/cri-o.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/crond.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/crond.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/dnsmasq.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/dnsmasq.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/docker.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/docker.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/etcd.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/etcd.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/irqbalance.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/irqbalance.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/kdump.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/kdump.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/nfs-client.target in artifact directory. Uploading as artifacts/system/multi-user.target.wants/nfs-client.target\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/origin-master-api.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/origin-master-api.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/origin-master-controllers.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/origin-master-controllers.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/origin-node.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/origin-node.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/postfix.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/postfix.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/remote-fs.target in artifact directory. Uploading as artifacts/system/multi-user.target.wants/remote-fs.target\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/rsyslog.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/rsyslog.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/sshd.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/sshd.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/sysstat.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/sysstat.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/multi-user.target.wants/tuned.service in artifact directory. Uploading as artifacts/system/multi-user.target.wants/tuned.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/openvswitch.service.d/01-avoid-oom.conf in artifact directory. Uploading as artifacts/system/openvswitch.service.d/01-avoid-oom.conf\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/origin-node.service in artifact directory. Uploading as artifacts/system/origin-node.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/origin-node.service.wants/origin-master-api.service in artifact directory. Uploading as artifacts/system/origin-node.service.wants/origin-master-api.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/remote-fs.target.wants/nfs-client.target in artifact directory. Uploading as artifacts/system/remote-fs.target.wants/nfs-client.target\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/sockets.target.wants/dm-event.socket in artifact directory. Uploading as artifacts/system/sockets.target.wants/dm-event.socket\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/sockets.target.wants/iscsid.socket in artifact directory. Uploading as artifacts/system/sockets.target.wants/iscsid.socket\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/sockets.target.wants/iscsiuio.socket in artifact directory. Uploading as artifacts/system/sockets.target.wants/iscsiuio.socket\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/sockets.target.wants/rpcbind.socket in artifact directory. Uploading as artifacts/system/sockets.target.wants/rpcbind.socket\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/sysinit.target.wants/iscsi.service in artifact directory. Uploading as artifacts/system/sysinit.target.wants/iscsi.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/sysinit.target.wants/lvm2-lvmetad.socket in artifact directory. Uploading as artifacts/system/sysinit.target.wants/lvm2-lvmetad.socket\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/sysinit.target.wants/lvm2-lvmpolld.socket in artifact directory. Uploading as artifacts/system/sysinit.target.wants/lvm2-lvmpolld.socket\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/sysinit.target.wants/lvm2-monitor.service in artifact directory. Uploading as artifacts/system/sysinit.target.wants/lvm2-monitor.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/sysinit.target.wants/multipathd.service in artifact directory. Uploading as artifacts/system/sysinit.target.wants/multipathd.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/artifacts/system/system-update.target.wants/systemd-readahead-drop.service in artifact directory. Uploading as artifacts/system/system-update.target.wants/systemd-readahead-drop.service\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/build-log.txt in artifact directory. Uploading as build-log.txt\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/finished.json in artifact directory. Uploading as finished.json\n"
time="2018-02-20T23:14:40Z" level=info msg="Found /data/gcs/started.json in artifact directory. Uploading as started.json\n"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/0a823caa-168c-11e8-8b52-0eb4d2946e86/bb48e442365ce4791db775f82d6a952ffa1d3e3cc8bc0d9c636d3a8262bb5367.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/sockets.target.wants/dm-event.socket"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/auditd.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/chronyd.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/irqbalance.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/auditd.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/docker.info"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/origin-master-controllers.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alerts-proxy_0.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/dbus-org.freedesktop.nm-dispatcher.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/sockets.target.wants/iscsid.socket"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/started.json"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/atd.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/crio.conf"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/cri-o.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/6541647e-168c-11e8-8b52-0eb4d2946e86/deployment_0.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/ansible_junit/kHRTevekai.xml"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/conformance/artifacts/junit/conformance_serial_01.xml"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/ovs-vswitchd.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/nfs-client.target"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/directory/test_pull_request_origin_extended_conformance_crio/4616"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/crio.commit"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/docker.service.d/custom.conf"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/sysinit.target.wants/lvm2-monitor.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/node-metrics.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_01.xml"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/installed_packages.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/5471b7f0-168c-11e8-8b52-0eb4d2946e86/apiserver_0.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/sshd.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/d07795d8b7a80a0f433e24dbf4b66fbadbb7550d7ac86fb268026ba08c554f5b.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/81326fcb-168c-11e8-8b52-0eb4d2946e86/27454db06ab5736941658e35712ab9a95eefc7292ea1688ed079ec2d55b890eb.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/fcf0b5b9-1692-11e8-8b52-0eb4d2946e86/54a940690ff18429843901e3741bf2c7871811e9e520a74ad80a36b6dba1fcf2.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/origin-node.service.wants/origin-master-api.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/remote-fs.target.wants/nfs-client.target"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/containers.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/journal_xe.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/5471b7f0-168c-11e8-8b52-0eb4d2946e86/2922613087c937c1cfc18736a9340f9cfaae48264ea6fc7c66f0ba8de7f9f63b.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/finished.json"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/sockets.target.wants/iscsiuio.socket"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/pid1.journal"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/default.target.wants/systemd-readahead-replay.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/postfix.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/filesystem.info"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/docker.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/openvswitch.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/origin-master-api.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/conformance/artifacts/events.txt"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/sysstat.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/crio/crio.conf.11865.2018-02-20@22:12:17~"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/022f6dcd-168c-11e8-8b52-0eb4d2946e86/256b9c6269974ab513ea72417f64318b449fedfd2e3a5b111dfe007f7092e5c0.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/6ba176ac-168c-11e8-8b52-0eb4d2946e86/c_0.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/dev-virtio\\x2dports-org.qemu.guest_agent.0.device.wants/qemu-guest-agent.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/getty.target.wants/getty@tty1.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/docker.config"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/6541647e-168c-11e8-8b52-0eb4d2946e86/27741c527a726061a35bfd582cef0993bfd77383092bff125f5dc540064e6634.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/6ba176ac-168c-11e8-8b52-0eb4d2946e86/a8eca96bf8fe0bdaa60563d3b022734d09216dda89c4596070eaa01e48fd3877.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_05.xml"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/basic.target.wants/microcode.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_03.xml"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/crond.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/origin-master-controllers.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/remote-fs.target"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/crio/crio.conf"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/avc_selinux_denials.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/avc_denials.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/NetworkManager.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/cri-o.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/etcd.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/origin-node.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/origin-node.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/default.target"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/0a823caa-168c-11e8-8b52-0eb4d2946e86/registry_0.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/5471fe78-168c-11e8-8b52-0eb4d2946e86/d21df58a357f88836ff1ed9aca54330bfbd8d3db5aa6363202f1b8a13971cd68.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/default.target.wants/systemd-readahead-collect.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/openvswitch.service.d/01-avoid-oom.conf"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alertmanager_0.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/6622f1cb-168c-11e8-8b52-0eb4d2946e86/deployment_0.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/basic.target.wants/iptables.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/sockets.target.wants/rpcbind.socket"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/sysinit.target.wants/multipathd.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/dbus-org.freedesktop.NetworkManager.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/dnsmasq.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/origin-node.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_02.xml"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/origin-master-api.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/master-metrics.log"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/etcd.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/origin-master.service"
time="2018-02-20T23:14:40Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/1807f01d-168c-11e8-8b52-0eb4d2946e86/c186fbb2af04e0b2f4c734d5018f5ce41bd8056308dd302b0dbfcb55e2cf0626.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/prom-proxy_0.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alert-buffer_0.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/cloud-init.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/tuned.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/system-update.target.wants/systemd-readahead-drop.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/build-log.txt"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/ansible_junit/cDyFQoYEVz.xml"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/build-images/logs/scripts.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/conformance/logs/scripts.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/sysinit.target.wants/iscsi.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/6622f1cb-168c-11e8-8b52-0eb4d2946e86/18e6e2ad8d451f8f86f5544f27dcfcc61d657d892dcefb8247de7f872a6a7961.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/kdump.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/systemd-journald.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/cri-o.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/local-fs.target.wants/ostree-remount.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/cloud-init-local.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/docker.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/crio/seccomp.json"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/generated/dmesg.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/prometheus_0.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/shell/logs/8b99a344a120412610818f89223e4221dbb752ecad32d51c07ecac5b7b013015.json"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/sysinit.target.wants/lvm2-lvmetad.socket"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/ovsdb-server.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/ansible_junit/wQYdxEMDkN.xml"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/shell/logs/scripts.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/cloud-final.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/rsyslog.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/journals/dnsmasq.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/022f6dcd-168c-11e8-8b52-0eb4d2946e86/router_0.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/conformance/artifacts/junit/conformance_parallel_04.xml"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/sysinit.target.wants/lvm2-lvmpolld.socket"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/system/multi-user.target.wants/cloud-config.service"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/1807f01d-168c-11e8-8b52-0eb4d2946e86/registry-console_0.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/21a40d22-168f-11e8-8b52-0eb4d2946e86/alertmanager-proxy_0.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/5471fe78-168c-11e8-8b52-0eb4d2946e86/controller-manager_0.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/pods/81326fcb-168c-11e8-8b52-0eb4d2946e86/webconsole_0.log"
time="2018-02-20T23:14:41Z" level=info msg="Queued for upload" dest="pr-logs/pull/18686/test_pull_request_origin_extended_conformance_crio/4616/artifacts/scripts/shell/logs/6b7c683be03f386c33ec1048a1a6e86d81a18ba1f019bd75c9fdf9cbae503679.json"
+ exit 0
+ set +o xtrace
########## FINISHED STAGE: SUCCESS: PUSH THE ARTIFACTS AND METADATA [00h 00m 40s] ##########
[workspace@7] $ /bin/bash /tmp/jenkins3609388313893890491.sh
########## STARTING STAGE: DEPROVISION CLOUD RESOURCES ##########
+ [[ -s /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate ]]
+ source /var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/activate
++ export VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ VIRTUAL_ENV=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704
++ export PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ PATH=/var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/bin:/sbin:/usr/sbin:/bin:/usr/bin
++ unset PYTHON_HOME
++ export OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
++ OCT_CONFIG_HOME=/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config
+ oct deprovision
PLAYBOOK: main.yml *************************************************************
4 plays in /var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/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/7fa507a4bc591e690754be8f19277886f5151704/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-02-20 18:15:00.951193",
"item": "origin_ci_inventory_dir",
"skip_reason": "Conditional check failed",
"skipped": true
}
skipping: [localhost] => (item=origin_ci_aws_region) => {
"changed": false,
"generated_timestamp": "2018-02-20 18:15:00.955297",
"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/7fa507a4bc591e690754be8f19277886f5151704/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:28
included: /var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/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/7fa507a4bc591e690754be8f19277886f5151704/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:2
ok: [localhost] => {
"changed": false,
"generated_timestamp": "2018-02-20 18:15:01.782853",
"msg": ""
}
TASK [rename EC2 instance for termination reaper] ******************************
task path: /var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:8
changed: [localhost] => {
"changed": true,
"generated_timestamp": "2018-02-20 18:15:02.361234",
"msg": "Tags {'Name': 'oct-terminate'} created for resource i-03eff24d76c46d22d."
}
TASK [tear down the EC2 instance] **********************************************
task path: /var/lib/jenkins/origin-ci-tool/7fa507a4bc591e690754be8f19277886f5151704/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:15
changed: [localhost] => {
"changed": true,
"generated_timestamp": "2018-02-20 18:15:03.164482",
"instance_ids": [
"i-03eff24d76c46d22d"
],
"instances": [
{
"ami_launch_index": "0",
"architecture": "x86_64",
"block_device_mapping": {
"/dev/sda1": {
"delete_on_termination": true,
"status": "attached",
"volume_id": "vol-0dea55caa120a76e9"
},
"/dev/sdb": {
"delete_on_termination": true,
"status": "attached",
"volume_id": "vol-0a6dcd8816bba61c3"
}
},
"dns_name": "ec2-52-90-180-209.compute-1.amazonaws.com",
"ebs_optimized": false,
"groups": {
"sg-7e73221a": "default"
},
"hypervisor": "xen",
"id": "i-03eff24d76c46d22d",
"image_id": "ami-b76e6ecd",
"instance_type": "m4.xlarge",
"kernel": null,
"key_name": "libra",
"launch_time": "2018-02-20T21:18:37.000Z",
"placement": "us-east-1d",
"private_dns_name": "ip-172-18-4-243.ec2.internal",
"private_ip": "172.18.4.243",
"public_dns_name": "ec2-52-90-180-209.compute-1.amazonaws.com",
"public_ip": "52.90.180.209",
"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/7fa507a4bc591e690754be8f19277886f5151704/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/roles/aws-down/tasks/main.yml:22
changed: [localhost] => {
"changed": true,
"generated_timestamp": "2018-02-20 18:15:03.411207",
"path": "/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.config/origin-ci-tool/inventory/host_vars/172.18.4.243.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/7fa507a4bc591e690754be8f19277886f5151704/lib/python2.7/site-packages/oct/ansible/oct/playbooks/deprovision/main.yml:61
changed: [localhost] => {
"changed": true,
"generated_timestamp": "2018-02-20 18:15:03.870202",
"path": "/var/lib/jenkins/jobs/test_pull_request_origin_extended_conformance_crio/workspace@7/.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
[WS-CLEANUP] Deleting project workspace...[WS-CLEANUP] done
Finished: SUCCESS