This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 1 failed / 478 succeeded
Started2019-09-11 17:47
Elapsed24m53s
Revision
Buildergke-prow-ssd-pool-1a225945-n4mt
Refs master:001f2cd2
81667:9f19665e
82032:17c64141
82053:07ba65df
82261:d78b1a22
82279:e8b57814
82307:6e0878fb
82317:99430f51
82324:4c58dc3a
82329:b4638519
82330:4105fea6
82342:8cd98fbd
82360:eff4f79e
82367:6a433ee5
82391:637badc1
82411:7bdb66f8
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/9b932a1e-d2e9-4b70-9805-056f6dcbe144/targets/test'}}
pod0acea251-d4bc-11e9-ad08-968d9a0b984c
resultstorehttps://source.cloud.google.com/results/invocations/9b932a1e-d2e9-4b70-9805-056f6dcbe144/targets/test
infra-commit069bf1fee
job-versionv1.17.0-alpha.0.1298+f193d2651e0cd9
pod0acea251-d4bc-11e9-ad08-968d9a0b984c
repok8s.io/kubernetes
repo-commitf193d2651e0cd9e803d8fdaca45eee8e68753544
repos{u'k8s.io/kubernetes': u'master:001f2cd2b553d06028c8542c8817820ee05d657f,81667:9f19665eb6b98a62d29a36d5b87ffc9bb0a98264,82032:17c6414135d88d42827afd111c4b71d469bc3866,82053:07ba65df6d69cf951063f08e52eafe218be21481,82261:d78b1a22271bca507343af6ccb1f338140ed1e31,82279:e8b5781499dfb35809c4ede091fc9718f142265e,82307:6e0878fbcc12ba6dd534d68165f7074274644986,82317:99430f51fd406607529a188ddae30b333bd59667,82324:4c58dc3a567513aea9f3db204e71de65a3fd1ef1,82329:b4638519a9d82e2f92421f43dd2f881529c64864,82330:4105fea6eb0cf1e5dd56146ccf94755445988b9a,82342:8cd98fbd60d7cd69bd47187c3b6bcddf27a32d22,82360:eff4f79eda1399d9c10941d7bb591614723c40bc,82367:6a433ee5ba375e6f33fba4d17f8198ff9b7647f0,82391:637badc1f0de46915ec10808b6654ddfd042abea,82411:7bdb66f8d15a3521e1fa308131f530118136b533'}
revisionv1.17.0-alpha.0.1298+f193d2651e0cd9

Test Failures


Node Tests 23m7s

error during go run /go/src/k8s.io/kubernetes/test/e2e_node/runner/remote/run_remote.go --cleanup --logtostderr --vmodule=*=4 --ssh-env=gce --results-dir=/workspace/_artifacts --project=k8s-jkns-pr-node-e2e --zone=us-west1-b --ssh-user=prow --ssh-key=/workspace/.ssh/google_compute_engine --ginkgo-flags=--nodes=8 --focus="\[NodeConformance\]" --skip="\[Flaky\]|\[Slow\]|\[Serial\]" --flakeAttempts=2 --test_args=--kubelet-flags="--cgroups-per-qos=true --cgroup-root=/" --test-timeout=1h5m0s --image-config-file=/workspace/test-infra/jobs/e2e_node/image-config.yaml: exit status 1
				from junit_runner.xml

Filter through log files


Show 478 Passed Tests

Show 468 Skipped Tests

Error lines from build-log.txt

... skipping 359 lines ...
I0911 17:50:52.980] make[1]: Entering directory '/go/src/k8s.io/kubernetes'
W0911 17:50:53.081] I0911 17:50:52.999099    4671 run_remote.go:567] Creating instance {image:coreos-beta-1911-1-1-v20181011 imageDesc:coreos-beta-1911-1-1-v20181011 project:coreos-cloud resources:{Accelerators:[]} metadata:0xc00020a620 machine: tests:[]} with service account "1046294573453-compute@developer.gserviceaccount.com"
W0911 17:50:53.082] I0911 17:50:53.001763    4671 run_remote.go:567] Creating instance {image:cos-stable-63-10032-71-0 imageDesc:cos-stable-63-10032-71-0 project:cos-cloud resources:{Accelerators:[]} metadata:0xc00021c0e0 machine: tests:[]} with service account "1046294573453-compute@developer.gserviceaccount.com"
W0911 17:50:53.083] I0911 17:50:53.009728    4671 run_remote.go:567] Creating instance {image:cos-stable-60-9592-84-0 imageDesc:cos-stable-60-9592-84-0 project:cos-cloud resources:{Accelerators:[]} metadata:0xc00052e0e0 machine: tests:[]} with service account "1046294573453-compute@developer.gserviceaccount.com"
W0911 17:50:53.083] I0911 17:50:53.040829    4671 run_remote.go:567] Creating instance {image:ubuntu-gke-1804-d1703-0-v20181113 imageDesc:ubuntu-gke-1804-d1703-0-v20181113 project:ubuntu-os-gke-cloud resources:{Accelerators:[]} metadata:<nil> machine: tests:[]} with service account "1046294573453-compute@developer.gserviceaccount.com"
W0911 17:50:54.053] I0911 17:50:54.053346    4671 run_remote.go:742] Deleting instance ""
W0911 17:50:54.086] E0911 17:50:54.086246    4671 run_remote.go:745] Error deleting instance "": googleapi: got HTTP response code 404 with body: Not Found
I0911 17:50:54.187] 
I0911 17:50:54.188] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
I0911 17:50:54.188] >                              START TEST                                >
I0911 17:50:54.188] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
I0911 17:50:54.188] Start Test Suite on Host 
I0911 17:50:54.188] 
I0911 17:50:54.189] Failure Finished Test Suite on Host 
I0911 17:50:54.189] unable to create gce instance with running docker daemon for image coreos-beta-1911-1-1-v20181011.  could not create instance tmp-node-e2e-b2b63d58-coreos-beta-1911-1-1-v20181011: API error: googleapi: Error 400: Invalid value for field 'resource.disks[0].initializeParams.sourceImage': 'projects/coreos-cloud/global/images/coreos-beta-1911-1-1-v20181011'. The referenced image resource cannot be found., invalid
I0911 17:50:54.190] <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
I0911 17:50:54.190] <                              FINISH TEST                               <
I0911 17:50:54.190] <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
I0911 17:50:54.190] 
I0911 17:51:06.057] +++ [0911 17:51:06] Building go targets for linux/amd64:
I0911 17:51:06.057]     ./vendor/k8s.io/code-generator/cmd/deepcopy-gen
... skipping 2624 lines ...
I0911 18:12:14.664]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:14.664] STEP: Creating a kubernetes client
I0911 18:12:14.664] STEP: Building a namespace api object, basename init-container
I0911 18:12:14.665] Sep 11 18:05:04.277: INFO: Skipping waiting for service account
I0911 18:12:14.665] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:14.665]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 18:12:14.665] [It] should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 18:12:14.665]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:14.665] STEP: creating the pod
I0911 18:12:14.666] Sep 11 18:05:04.277: INFO: PodSpec: initContainers in spec.initContainers
I0911 18:12:14.672] Sep 11 18:05:45.065: INFO: init container has failed twice: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"pod-init-c895913a-5de3-4d11-8ea5-c5ecf0323345", GenerateName:"", Namespace:"init-container-1905", SelfLink:"/api/v1/namespaces/init-container-1905/pods/pod-init-c895913a-5de3-4d11-8ea5-c5ecf0323345", UID:"83172637-c194-46d5-821d-93a82a48874c", ResourceVersion:"1679", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63703821904, loc:(*time.Location)(0xbe82a00)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"name":"foo", "time":"277226968"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Finalizers:[]string(nil), ClusterName:"", ManagedFields:[]v1.ManagedFieldsEntry(nil)}, Spec:v1.PodSpec{Volumes:[]v1.Volume(nil), InitContainers:[]v1.Container{v1.Container{Name:"init1", Image:"docker.io/library/busybox:1.29", Command:[]string{"/bin/false"}, Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList(nil), Requests:v1.ResourceList(nil)}, VolumeMounts:[]v1.VolumeMount(nil), VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"init2", Image:"docker.io/library/busybox:1.29", Command:[]string{"/bin/true"}, Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList(nil), Requests:v1.ResourceList(nil)}, VolumeMounts:[]v1.VolumeMount(nil), VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}}, Containers:[]v1.Container{v1.Container{Name:"run1", Image:"k8s.gcr.io/pause:3.1", Command:[]string(nil), Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:100, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:52428800, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"52428800", Format:"DecimalSI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:100, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:52428800, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"52428800", Format:"DecimalSI"}}}, VolumeMounts:[]v1.VolumeMount(nil), VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"Never", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}}, EphemeralContainers:[]v1.EphemeralContainer(nil), RestartPolicy:"Always", TerminationGracePeriodSeconds:(*int64)(0xc0008d0e40), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"Default", NodeSelector:map[string]string(nil), ServiceAccountName:"", DeprecatedServiceAccount:"", AutomountServiceAccountToken:(*bool)(nil), NodeName:"tmp-node-e2e-b2b63d58-cos-stable-63-10032-71-0", HostNetwork:false, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc000915680), ImagePullSecrets:[]v1.LocalObjectReference(nil), Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"default-scheduler", Tolerations:[]v1.Toleration{v1.Toleration{Key:"node.kubernetes.io/not-ready", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc0008d0f50)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc0008d0fa0)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"", Priority:(*int32)(0xc0008d0fb0), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc0008d0fb4), PreemptionPolicy:(*v1.PreemptionPolicy)(nil), Overhead:v1.ResourceList(nil), TopologySpreadConstraints:[]v1.TopologySpreadConstraint(nil)}, Status:v1.PodStatus{Phase:"Pending", Conditions:[]v1.PodCondition{v1.PodCondition{Type:"Initialized", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821904, loc:(*time.Location)(0xbe82a00)}}, Reason:"ContainersNotInitialized", Message:"containers with incomplete status: [init1 init2]"}, v1.PodCondition{Type:"Ready", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821904, loc:(*time.Location)(0xbe82a00)}}, Reason:"ContainersNotReady", Message:"containers with unready status: [run1]"}, v1.PodCondition{Type:"ContainersReady", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821904, loc:(*time.Location)(0xbe82a00)}}, Reason:"ContainersNotReady", Message:"containers with unready status: [run1]"}, v1.PodCondition{Type:"PodScheduled", Status:"True", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821904, loc:(*time.Location)(0xbe82a00)}}, Reason:"", Message:""}}, Message:"", Reason:"", NominatedNodeName:"", HostIP:"10.138.0.14", PodIP:"10.100.0.86", PodIPs:[]v1.PodIP{v1.PodIP{IP:"10.100.0.86"}}, StartTime:(*v1.Time)(0xc000b39a20), InitContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"init1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc000978e00)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc000978ee0)}, Ready:false, RestartCount:3, Image:"busybox:1.29", ImageID:"docker-pullable://busybox@sha256:e004c2cc521c95383aebb1fb5893719aa7a8eae2e7a71f316a4410784edb00a9", ContainerID:"docker://d3d3312aff92eb7df46baeb5a8ab9820f5ed7facaaa5b17db9badcca54334545", Started:(*bool)(nil)}, v1.ContainerStatus{Name:"init2", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc000b39a40), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, Ready:false, RestartCount:0, Image:"docker.io/library/busybox:1.29", ImageID:"", ContainerID:"", Started:(*bool)(nil)}}, ContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"run1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc000b39aa0), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, Ready:false, RestartCount:0, Image:"k8s.gcr.io/pause:3.1", ImageID:"", ContainerID:"", Started:(*bool)(0xc0008d10fc)}}, QOSClass:"Burstable", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}
I0911 18:12:14.672] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:14.672]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:14.672] Sep 11 18:05:45.066: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 18:12:14.673] STEP: Destroying namespace "init-container-1905" for this suite.
I0911 18:12:14.673] Sep 11 18:05:57.110: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
I0911 18:12:14.673] Sep 11 18:05:57.316: INFO: namespace init-container-1905 deletion completed in 12.232472648s
I0911 18:12:14.673] 
I0911 18:12:14.673] 
I0911 18:12:14.673] • [SLOW TEST:53.043 seconds]
I0911 18:12:14.673] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:14.674] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 18:12:14.674]   should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 18:12:14.674]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:14.674] ------------------------------
I0911 18:12:14.674] [BeforeEach] [k8s.io] Container Lifecycle Hook
I0911 18:12:14.675]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:14.675] STEP: Creating a kubernetes client
I0911 18:12:14.675] STEP: Building a namespace api object, basename container-lifecycle-hook
... skipping 226 lines ...
I0911 18:12:14.715]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:14.715] STEP: Creating a kubernetes client
I0911 18:12:14.715] STEP: Building a namespace api object, basename init-container
I0911 18:12:14.715] Sep 11 18:06:05.546: INFO: Skipping waiting for service account
I0911 18:12:14.715] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:14.716]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 18:12:14.716] [It] should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 18:12:14.716]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:14.716] STEP: creating the pod
I0911 18:12:14.716] Sep 11 18:06:05.546: INFO: PodSpec: initContainers in spec.initContainers
I0911 18:12:14.716] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:14.717]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:14.717] Sep 11 18:06:07.727: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 2 lines ...
I0911 18:12:14.717] Sep 11 18:06:13.814: INFO: namespace init-container-1422 deletion completed in 6.085029765s
I0911 18:12:14.717] 
I0911 18:12:14.718] 
I0911 18:12:14.718] • [SLOW TEST:8.270 seconds]
I0911 18:12:14.718] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:14.718] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 18:12:14.718]   should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 18:12:14.718]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:14.719] ------------------------------
I0911 18:12:14.719] [BeforeEach] [sig-storage] Secrets
I0911 18:12:14.719]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:14.719] STEP: Creating a kubernetes client
I0911 18:12:14.719] STEP: Building a namespace api object, basename secrets
... skipping 384 lines ...
I0911 18:12:14.784] [BeforeEach] [k8s.io] Security Context
I0911 18:12:14.785]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:40
I0911 18:12:14.785] [It] should run the container with readonly rootfs when readOnlyRootFilesystem=true [LinuxOnly] [NodeConformance]
I0911 18:12:14.785]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:211
I0911 18:12:14.785] Sep 11 18:06:36.988: INFO: Waiting up to 5m0s for pod "busybox-readonly-true-f13ec17b-22ca-4a79-945c-249cc8026422" in namespace "security-context-test-6275" to be "success or failure"
I0911 18:12:14.786] Sep 11 18:06:37.005: INFO: Pod "busybox-readonly-true-f13ec17b-22ca-4a79-945c-249cc8026422": Phase="Pending", Reason="", readiness=false. Elapsed: 16.585967ms
I0911 18:12:14.786] Sep 11 18:06:39.019: INFO: Pod "busybox-readonly-true-f13ec17b-22ca-4a79-945c-249cc8026422": Phase="Failed", Reason="", readiness=false. Elapsed: 2.030206441s
I0911 18:12:14.786] Sep 11 18:06:39.019: INFO: Pod "busybox-readonly-true-f13ec17b-22ca-4a79-945c-249cc8026422" satisfied condition "success or failure"
I0911 18:12:14.786] [AfterEach] [k8s.io] Security Context
I0911 18:12:14.786]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:14.787] Sep 11 18:06:39.019: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 18:12:14.787] STEP: Destroying namespace "security-context-test-6275" for this suite.
I0911 18:12:14.787] Sep 11 18:06:45.032: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 149 lines ...
I0911 18:12:14.813] STEP: verifying the pod is in kubernetes
I0911 18:12:14.813] STEP: updating the pod
I0911 18:12:14.814] Sep 11 18:06:47.783: INFO: Successfully updated pod "pod-update-activedeadlineseconds-742d1181-e35e-4659-80e8-ba01aa027af1"
I0911 18:12:14.814] Sep 11 18:06:47.783: INFO: Waiting up to 5m0s for pod "pod-update-activedeadlineseconds-742d1181-e35e-4659-80e8-ba01aa027af1" in namespace "pods-61" to be "terminated due to deadline exceeded"
I0911 18:12:14.814] Sep 11 18:06:47.785: INFO: Pod "pod-update-activedeadlineseconds-742d1181-e35e-4659-80e8-ba01aa027af1": Phase="Running", Reason="", readiness=true. Elapsed: 2.041327ms
I0911 18:12:14.814] Sep 11 18:06:49.787: INFO: Pod "pod-update-activedeadlineseconds-742d1181-e35e-4659-80e8-ba01aa027af1": Phase="Running", Reason="", readiness=true. Elapsed: 2.00368999s
I0911 18:12:14.815] Sep 11 18:06:51.788: INFO: Pod "pod-update-activedeadlineseconds-742d1181-e35e-4659-80e8-ba01aa027af1": Phase="Failed", Reason="DeadlineExceeded", readiness=false. Elapsed: 4.005296065s
I0911 18:12:14.815] Sep 11 18:06:51.788: INFO: Pod "pod-update-activedeadlineseconds-742d1181-e35e-4659-80e8-ba01aa027af1" satisfied condition "terminated due to deadline exceeded"
I0911 18:12:14.815] [AfterEach] [k8s.io] Pods
I0911 18:12:14.815]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:14.815] Sep 11 18:06:51.788: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 18:12:14.815] STEP: Destroying namespace "pods-61" for this suite.
I0911 18:12:14.816] Sep 11 18:06:57.794: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 769 lines ...
I0911 18:12:14.942] STEP: Creating a kubernetes client
I0911 18:12:14.942] STEP: Building a namespace api object, basename container-runtime
I0911 18:12:14.943] Sep 11 18:08:09.346: INFO: Skipping waiting for service account
I0911 18:12:14.943] [It] should report termination message [LinuxOnly] from log output if TerminationMessagePolicy FallbackToLogsOnError is set [NodeConformance] [Conformance]
I0911 18:12:14.943]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:14.943] STEP: create the container
I0911 18:12:14.943] STEP: wait for the container to reach Failed
I0911 18:12:14.943] STEP: get the container status
I0911 18:12:14.944] STEP: the container should be terminated
I0911 18:12:14.944] STEP: the termination message should be set
I0911 18:12:14.944] Sep 11 18:08:10.398: INFO: Expected: &{DONE} to match Container's Termination Message: DONE --
I0911 18:12:14.944] STEP: delete the container
I0911 18:12:14.944] [AfterEach] [k8s.io] Container Runtime
... skipping 998 lines ...
I0911 18:12:15.112]   should *not* be restarted with a exec "cat /tmp/health" liveness probe [NodeConformance] [Conformance]
I0911 18:12:15.113]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:15.113] ------------------------------
I0911 18:12:15.113] I0911 18:12:06.372917    1314 e2e_node_suite_test.go:196] Stopping node services...
I0911 18:12:15.113] I0911 18:12:06.372937    1314 server.go:257] Kill server "services"
I0911 18:12:15.113] I0911 18:12:06.372947    1314 server.go:294] Killing process 1921 (services) with -TERM
I0911 18:12:15.113] E0911 18:12:06.485540    1314 services.go:88] Failed to stop services: error stopping "services": waitid: no child processes
I0911 18:12:15.114] I0911 18:12:06.485558    1314 server.go:257] Kill server "kubelet"
I0911 18:12:15.114] I0911 18:12:06.495374    1314 services.go:147] Fetching log files...
I0911 18:12:15.114] I0911 18:12:06.495432    1314 services.go:156] Get log file "kern.log" with journalctl command [-k].
I0911 18:12:15.114] I0911 18:12:06.638485    1314 services.go:156] Get log file "cloud-init.log" with journalctl command [-u cloud*].
I0911 18:12:15.114] I0911 18:12:07.254911    1314 services.go:156] Get log file "docker.log" with journalctl command [-u docker].
I0911 18:12:15.115] I0911 18:12:07.290258    1314 services.go:156] Get log file "kubelet.log" with journalctl command [-u kubelet-20190911T180013.service].
I0911 18:12:15.115] I0911 18:12:08.438113    1314 e2e_node_suite_test.go:201] Tests Finished
I0911 18:12:15.115] 
I0911 18:12:15.115] 
I0911 18:12:15.115] Ran 157 of 313 Specs in 699.762 seconds
I0911 18:12:15.115] SUCCESS! -- 157 Passed | 0 Failed | 0 Flaked | 0 Pending | 156 Skipped
I0911 18:12:15.115] 
I0911 18:12:15.115] 
I0911 18:12:15.116] Ginkgo ran 1 suite in 11m42.787809867s
I0911 18:12:15.116] Test Suite Passed
I0911 18:12:15.116] 
I0911 18:12:15.116] Success Finished Test Suite on Host tmp-node-e2e-b2b63d58-cos-stable-63-10032-71-0
... skipping 2541 lines ...
I0911 18:12:15.554]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:15.554] STEP: Creating a kubernetes client
I0911 18:12:15.554] STEP: Building a namespace api object, basename init-container
I0911 18:12:15.555] Sep 11 18:05:15.572: INFO: Skipping waiting for service account
I0911 18:12:15.555] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:15.555]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 18:12:15.555] [It] should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 18:12:15.555]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:15.556] STEP: creating the pod
I0911 18:12:15.556] Sep 11 18:05:15.572: INFO: PodSpec: initContainers in spec.initContainers
I0911 18:12:15.564] Sep 11 18:05:58.714: INFO: init container has failed twice: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"pod-init-7e9d2c4f-dbfc-4d62-8557-2eacce6a2c58", GenerateName:"", Namespace:"init-container-3688", SelfLink:"/api/v1/namespaces/init-container-3688/pods/pod-init-7e9d2c4f-dbfc-4d62-8557-2eacce6a2c58", UID:"96a401bf-e641-4afe-8f8f-4d5e4a1d3704", ResourceVersion:"1713", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63703821915, loc:(*time.Location)(0xbe82a00)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"name":"foo", "time":"572696576"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Finalizers:[]string(nil), ClusterName:"", ManagedFields:[]v1.ManagedFieldsEntry(nil)}, Spec:v1.PodSpec{Volumes:[]v1.Volume(nil), InitContainers:[]v1.Container{v1.Container{Name:"init1", Image:"docker.io/library/busybox:1.29", Command:[]string{"/bin/false"}, Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList(nil), Requests:v1.ResourceList(nil)}, VolumeMounts:[]v1.VolumeMount(nil), VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"init2", Image:"docker.io/library/busybox:1.29", Command:[]string{"/bin/true"}, Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList(nil), Requests:v1.ResourceList(nil)}, VolumeMounts:[]v1.VolumeMount(nil), VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}}, Containers:[]v1.Container{v1.Container{Name:"run1", Image:"k8s.gcr.io/pause:3.1", Command:[]string(nil), Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:100, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:52428800, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"52428800", Format:"DecimalSI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:100, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:52428800, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"52428800", Format:"DecimalSI"}}}, VolumeMounts:[]v1.VolumeMount(nil), VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"Never", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}}, EphemeralContainers:[]v1.EphemeralContainer(nil), RestartPolicy:"Always", TerminationGracePeriodSeconds:(*int64)(0xc001401dd0), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"Default", NodeSelector:map[string]string(nil), ServiceAccountName:"", DeprecatedServiceAccount:"", AutomountServiceAccountToken:(*bool)(nil), NodeName:"tmp-node-e2e-b2b63d58-cos-stable-60-9592-84-0", HostNetwork:false, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc0013fe2a0), ImagePullSecrets:[]v1.LocalObjectReference(nil), Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"default-scheduler", Tolerations:[]v1.Toleration{v1.Toleration{Key:"node.kubernetes.io/not-ready", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc001401e40)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc001401e60)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"", Priority:(*int32)(0xc001401e70), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc001401e74), PreemptionPolicy:(*v1.PreemptionPolicy)(nil), Overhead:v1.ResourceList(nil), TopologySpreadConstraints:[]v1.TopologySpreadConstraint(nil)}, Status:v1.PodStatus{Phase:"Pending", Conditions:[]v1.PodCondition{v1.PodCondition{Type:"Initialized", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821915, loc:(*time.Location)(0xbe82a00)}}, Reason:"ContainersNotInitialized", Message:"containers with incomplete status: [init1 init2]"}, v1.PodCondition{Type:"Ready", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821915, loc:(*time.Location)(0xbe82a00)}}, Reason:"ContainersNotReady", Message:"containers with unready status: [run1]"}, v1.PodCondition{Type:"ContainersReady", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821915, loc:(*time.Location)(0xbe82a00)}}, Reason:"ContainersNotReady", Message:"containers with unready status: [run1]"}, v1.PodCondition{Type:"PodScheduled", Status:"True", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821915, loc:(*time.Location)(0xbe82a00)}}, Reason:"", Message:""}}, Message:"", Reason:"", NominatedNodeName:"", HostIP:"10.138.0.36", PodIP:"10.100.0.83", PodIPs:[]v1.PodIP{v1.PodIP{IP:"10.100.0.83"}}, StartTime:(*v1.Time)(0xc00100c8a0), InitContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"init1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc00108ed20)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc00108ed90)}, Ready:false, RestartCount:3, Image:"busybox:1.29", ImageID:"docker-pullable://busybox@sha256:e004c2cc521c95383aebb1fb5893719aa7a8eae2e7a71f316a4410784edb00a9", ContainerID:"docker://ff3c64281e704e6f803544aa986a067de9a802c805a2600e2368ccf0206ef301", Started:(*bool)(nil)}, v1.ContainerStatus{Name:"init2", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc00100c8c0), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, Ready:false, RestartCount:0, Image:"docker.io/library/busybox:1.29", ImageID:"", ContainerID:"", Started:(*bool)(nil)}}, ContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"run1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc00100c8e0), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, Ready:false, RestartCount:0, Image:"k8s.gcr.io/pause:3.1", ImageID:"", ContainerID:"", Started:(*bool)(0xc001401f5c)}}, QOSClass:"Burstable", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}
I0911 18:12:15.565] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:15.565]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:15.565] Sep 11 18:05:58.714: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 18:12:15.566] STEP: Destroying namespace "init-container-3688" for this suite.
I0911 18:12:15.566] Sep 11 18:06:10.723: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
I0911 18:12:15.566] Sep 11 18:06:10.765: INFO: namespace init-container-3688 deletion completed in 12.046948258s
I0911 18:12:15.566] 
I0911 18:12:15.566] 
I0911 18:12:15.567] • [SLOW TEST:55.196 seconds]
I0911 18:12:15.567] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:15.567] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 18:12:15.567]   should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 18:12:15.567]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:15.568] ------------------------------
I0911 18:12:15.568] S
I0911 18:12:15.568] ------------------------------
I0911 18:12:15.568] [BeforeEach] [sig-storage] ConfigMap
I0911 18:12:15.568]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
... skipping 292 lines ...
I0911 18:12:15.628]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:15.628] STEP: Creating a kubernetes client
I0911 18:12:15.628] STEP: Building a namespace api object, basename init-container
I0911 18:12:15.628] Sep 11 18:06:18.911: INFO: Skipping waiting for service account
I0911 18:12:15.628] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:15.629]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 18:12:15.629] [It] should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 18:12:15.629]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:15.629] STEP: creating the pod
I0911 18:12:15.629] Sep 11 18:06:18.911: INFO: PodSpec: initContainers in spec.initContainers
I0911 18:12:15.630] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:15.630]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:15.630] Sep 11 18:06:21.792: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 2 lines ...
I0911 18:12:15.631] Sep 11 18:06:27.921: INFO: namespace init-container-2038 deletion completed in 6.090567445s
I0911 18:12:15.631] 
I0911 18:12:15.631] 
I0911 18:12:15.631] • [SLOW TEST:9.013 seconds]
I0911 18:12:15.631] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:15.631] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 18:12:15.632]   should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 18:12:15.632]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:15.632] ------------------------------
I0911 18:12:15.632] [BeforeEach] [sig-storage] Secrets
I0911 18:12:15.632]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:15.632] STEP: Creating a kubernetes client
I0911 18:12:15.633] STEP: Building a namespace api object, basename secrets
... skipping 378 lines ...
I0911 18:12:15.703] [BeforeEach] [k8s.io] Security Context
I0911 18:12:15.703]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:40
I0911 18:12:15.704] [It] should run the container with readonly rootfs when readOnlyRootFilesystem=true [LinuxOnly] [NodeConformance]
I0911 18:12:15.704]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:211
I0911 18:12:15.704] Sep 11 18:06:53.619: INFO: Waiting up to 5m0s for pod "busybox-readonly-true-8b8ed6e6-6f10-4470-aba5-5917447f76b5" in namespace "security-context-test-6138" to be "success or failure"
I0911 18:12:15.704] Sep 11 18:06:53.619: INFO: Pod "busybox-readonly-true-8b8ed6e6-6f10-4470-aba5-5917447f76b5": Phase="Pending", Reason="", readiness=false. Elapsed: 925.857µs
I0911 18:12:15.705] Sep 11 18:06:55.622: INFO: Pod "busybox-readonly-true-8b8ed6e6-6f10-4470-aba5-5917447f76b5": Phase="Failed", Reason="", readiness=false. Elapsed: 2.003126624s
I0911 18:12:15.705] Sep 11 18:06:55.622: INFO: Pod "busybox-readonly-true-8b8ed6e6-6f10-4470-aba5-5917447f76b5" satisfied condition "success or failure"
I0911 18:12:15.705] [AfterEach] [k8s.io] Security Context
I0911 18:12:15.705]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:15.705] Sep 11 18:06:55.622: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 18:12:15.706] STEP: Destroying namespace "security-context-test-6138" for this suite.
I0911 18:12:15.706] Sep 11 18:07:01.628: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 182 lines ...
I0911 18:12:15.737] STEP: verifying the pod is in kubernetes
I0911 18:12:15.737] STEP: updating the pod
I0911 18:12:15.737] Sep 11 18:07:03.024: INFO: Successfully updated pod "pod-update-activedeadlineseconds-eeca8246-82c9-408a-99de-cb37d9ba9703"
I0911 18:12:15.738] Sep 11 18:07:03.024: INFO: Waiting up to 5m0s for pod "pod-update-activedeadlineseconds-eeca8246-82c9-408a-99de-cb37d9ba9703" in namespace "pods-3528" to be "terminated due to deadline exceeded"
I0911 18:12:15.738] Sep 11 18:07:03.026: INFO: Pod "pod-update-activedeadlineseconds-eeca8246-82c9-408a-99de-cb37d9ba9703": Phase="Running", Reason="", readiness=true. Elapsed: 1.61223ms
I0911 18:12:15.738] Sep 11 18:07:05.028: INFO: Pod "pod-update-activedeadlineseconds-eeca8246-82c9-408a-99de-cb37d9ba9703": Phase="Running", Reason="", readiness=true. Elapsed: 2.003367316s
I0911 18:12:15.738] Sep 11 18:07:07.029: INFO: Pod "pod-update-activedeadlineseconds-eeca8246-82c9-408a-99de-cb37d9ba9703": Phase="Failed", Reason="DeadlineExceeded", readiness=false. Elapsed: 4.004981385s
I0911 18:12:15.739] Sep 11 18:07:07.029: INFO: Pod "pod-update-activedeadlineseconds-eeca8246-82c9-408a-99de-cb37d9ba9703" satisfied condition "terminated due to deadline exceeded"
I0911 18:12:15.739] [AfterEach] [k8s.io] Pods
I0911 18:12:15.739]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:15.739] Sep 11 18:07:07.029: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 18:12:15.739] STEP: Destroying namespace "pods-3528" for this suite.
I0911 18:12:15.739] Sep 11 18:07:13.035: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 733 lines ...
I0911 18:12:15.871] STEP: Creating a kubernetes client
I0911 18:12:15.871] STEP: Building a namespace api object, basename container-runtime
I0911 18:12:15.871] Sep 11 18:08:07.195: INFO: Skipping waiting for service account
I0911 18:12:15.872] [It] should report termination message [LinuxOnly] from log output if TerminationMessagePolicy FallbackToLogsOnError is set [NodeConformance] [Conformance]
I0911 18:12:15.872]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:15.872] STEP: create the container
I0911 18:12:15.872] STEP: wait for the container to reach Failed
I0911 18:12:15.872] STEP: get the container status
I0911 18:12:15.872] STEP: the container should be terminated
I0911 18:12:15.873] STEP: the termination message should be set
I0911 18:12:15.873] Sep 11 18:08:08.205: INFO: Expected: &{DONE} to match Container's Termination Message: DONE --
I0911 18:12:15.873] STEP: delete the container
I0911 18:12:15.873] [AfterEach] [k8s.io] Container Runtime
... skipping 981 lines ...
I0911 18:12:16.054]   should *not* be restarted with a exec "cat /tmp/health" liveness probe [NodeConformance] [Conformance]
I0911 18:12:16.054]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:16.054] ------------------------------
I0911 18:12:16.054] I0911 18:12:07.703142    1289 e2e_node_suite_test.go:196] Stopping node services...
I0911 18:12:16.055] I0911 18:12:07.703178    1289 server.go:257] Kill server "services"
I0911 18:12:16.055] I0911 18:12:07.703188    1289 server.go:294] Killing process 1926 (services) with -TERM
I0911 18:12:16.055] E0911 18:12:07.828763    1289 services.go:88] Failed to stop services: error stopping "services": waitid: no child processes
I0911 18:12:16.055] I0911 18:12:07.828793    1289 server.go:257] Kill server "kubelet"
I0911 18:12:16.056] I0911 18:12:07.838300    1289 services.go:147] Fetching log files...
I0911 18:12:16.056] I0911 18:12:07.838384    1289 services.go:156] Get log file "kern.log" with journalctl command [-k].
I0911 18:12:16.056] I0911 18:12:07.926918    1289 services.go:156] Get log file "cloud-init.log" with journalctl command [-u cloud*].
I0911 18:12:16.056] I0911 18:12:08.386504    1289 services.go:156] Get log file "docker.log" with journalctl command [-u docker].
I0911 18:12:16.056] I0911 18:12:08.414292    1289 services.go:156] Get log file "kubelet.log" with journalctl command [-u kubelet-20190911T180013.service].
I0911 18:12:16.057] I0911 18:12:09.292443    1289 e2e_node_suite_test.go:201] Tests Finished
I0911 18:12:16.057] 
I0911 18:12:16.057] 
I0911 18:12:16.057] Ran 157 of 313 Specs in 699.689 seconds
I0911 18:12:16.057] SUCCESS! -- 157 Passed | 0 Failed | 0 Flaked | 0 Pending | 156 Skipped
I0911 18:12:16.057] 
I0911 18:12:16.058] 
I0911 18:12:16.058] Ginkgo ran 1 suite in 11m43.418766944s
I0911 18:12:16.058] Test Suite Passed
I0911 18:12:16.058] 
I0911 18:12:16.058] Success Finished Test Suite on Host tmp-node-e2e-b2b63d58-cos-stable-60-9592-84-0
... skipping 782 lines ...
I0911 18:12:39.101]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:39.101] STEP: Creating a kubernetes client
I0911 18:12:39.101] STEP: Building a namespace api object, basename init-container
I0911 18:12:39.101] Sep 11 18:02:29.087: INFO: Skipping waiting for service account
I0911 18:12:39.101] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:39.101]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 18:12:39.102] [It] should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 18:12:39.102]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:39.102] STEP: creating the pod
I0911 18:12:39.102] Sep 11 18:02:29.087: INFO: PodSpec: initContainers in spec.initContainers
I0911 18:12:39.110] Sep 11 18:03:12.797: INFO: init container has failed twice: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"pod-init-5f739e7c-a5ec-43e3-aed4-f83b0df9fa30", GenerateName:"", Namespace:"init-container-4375", SelfLink:"/api/v1/namespaces/init-container-4375/pods/pod-init-5f739e7c-a5ec-43e3-aed4-f83b0df9fa30", UID:"afc2906a-1da3-4935-b9cb-0eeb8aa7636e", ResourceVersion:"467", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63703821749, loc:(*time.Location)(0xbe82a00)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"name":"foo", "time":"87663069"}, Annotations:map[string]string(nil), OwnerReferences:[]v1.OwnerReference(nil), Finalizers:[]string(nil), ClusterName:"", ManagedFields:[]v1.ManagedFieldsEntry(nil)}, Spec:v1.PodSpec{Volumes:[]v1.Volume(nil), InitContainers:[]v1.Container{v1.Container{Name:"init1", Image:"docker.io/library/busybox:1.29", Command:[]string{"/bin/false"}, Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList(nil), Requests:v1.ResourceList(nil)}, VolumeMounts:[]v1.VolumeMount(nil), VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}, v1.Container{Name:"init2", Image:"docker.io/library/busybox:1.29", Command:[]string{"/bin/true"}, Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList(nil), Requests:v1.ResourceList(nil)}, VolumeMounts:[]v1.VolumeMount(nil), VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"IfNotPresent", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}}, Containers:[]v1.Container{v1.Container{Name:"run1", Image:"k8s.gcr.io/pause:3.1", Command:[]string(nil), Args:[]string(nil), WorkingDir:"", Ports:[]v1.ContainerPort(nil), EnvFrom:[]v1.EnvFromSource(nil), Env:[]v1.EnvVar(nil), Resources:v1.ResourceRequirements{Limits:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:100, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:52428800, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"52428800", Format:"DecimalSI"}}, Requests:v1.ResourceList{"cpu":resource.Quantity{i:resource.int64Amount{value:100, scale:-3}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"100m", Format:"DecimalSI"}, "memory":resource.Quantity{i:resource.int64Amount{value:52428800, scale:0}, d:resource.infDecAmount{Dec:(*inf.Dec)(nil)}, s:"52428800", Format:"DecimalSI"}}}, VolumeMounts:[]v1.VolumeMount(nil), VolumeDevices:[]v1.VolumeDevice(nil), LivenessProbe:(*v1.Probe)(nil), ReadinessProbe:(*v1.Probe)(nil), StartupProbe:(*v1.Probe)(nil), Lifecycle:(*v1.Lifecycle)(nil), TerminationMessagePath:"/dev/termination-log", TerminationMessagePolicy:"File", ImagePullPolicy:"Never", SecurityContext:(*v1.SecurityContext)(nil), Stdin:false, StdinOnce:false, TTY:false}}, EphemeralContainers:[]v1.EphemeralContainer(nil), RestartPolicy:"Always", TerminationGracePeriodSeconds:(*int64)(0xc000b06d20), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"Default", NodeSelector:map[string]string(nil), ServiceAccountName:"", DeprecatedServiceAccount:"", AutomountServiceAccountToken:(*bool)(nil), NodeName:"tmp-node-e2e-b2b63d58-ubuntu-gke-1804-d1703-0-v20181113", HostNetwork:false, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc000864c60), ImagePullSecrets:[]v1.LocalObjectReference(nil), Hostname:"", Subdomain:"", Affinity:(*v1.Affinity)(nil), SchedulerName:"default-scheduler", Tolerations:[]v1.Toleration{v1.Toleration{Key:"node.kubernetes.io/not-ready", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc000b06e90)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc000b06ec0)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"", Priority:(*int32)(0xc000b06ed0), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc000b06ed4), PreemptionPolicy:(*v1.PreemptionPolicy)(nil), Overhead:v1.ResourceList(nil), TopologySpreadConstraints:[]v1.TopologySpreadConstraint(nil)}, Status:v1.PodStatus{Phase:"Pending", Conditions:[]v1.PodCondition{v1.PodCondition{Type:"Initialized", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821749, loc:(*time.Location)(0xbe82a00)}}, Reason:"ContainersNotInitialized", Message:"containers with incomplete status: [init1 init2]"}, v1.PodCondition{Type:"Ready", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821749, loc:(*time.Location)(0xbe82a00)}}, Reason:"ContainersNotReady", Message:"containers with unready status: [run1]"}, v1.PodCondition{Type:"ContainersReady", Status:"False", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821749, loc:(*time.Location)(0xbe82a00)}}, Reason:"ContainersNotReady", Message:"containers with unready status: [run1]"}, v1.PodCondition{Type:"PodScheduled", Status:"True", LastProbeTime:v1.Time{Time:time.Time{wall:0x0, ext:0, loc:(*time.Location)(nil)}}, LastTransitionTime:v1.Time{Time:time.Time{wall:0x0, ext:63703821749, loc:(*time.Location)(0xbe82a00)}}, Reason:"", Message:""}}, Message:"", Reason:"", NominatedNodeName:"", HostIP:"10.138.0.40", PodIP:"10.100.0.13", PodIPs:[]v1.PodIP{v1.PodIP{IP:"10.100.0.13"}}, StartTime:(*v1.Time)(0xc000bc4660), InitContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"init1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc000d39dc0)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc000d39e30)}, Ready:false, RestartCount:3, Image:"busybox:1.29", ImageID:"docker-pullable://busybox@sha256:8ccbac733d19c0dd4d70b4f0c1e12245b5fa3ad24758a11035ee505c629c0796", ContainerID:"docker://011ebcd1aadbdb7f69c1301c0a8d5a3c8024feadefb01645eed3197b50f9be76", Started:(*bool)(nil)}, v1.ContainerStatus{Name:"init2", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc000bc4680), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, Ready:false, RestartCount:0, Image:"docker.io/library/busybox:1.29", ImageID:"", ContainerID:"", Started:(*bool)(nil)}}, ContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"run1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc000bc46c0), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(nil)}, Ready:false, RestartCount:0, Image:"k8s.gcr.io/pause:3.1", ImageID:"", ContainerID:"", Started:(*bool)(0xc000b0704c)}}, QOSClass:"Burstable", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}
I0911 18:12:39.110] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:39.110]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:39.111] Sep 11 18:03:12.798: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 18:12:39.111] STEP: Destroying namespace "init-container-4375" for this suite.
I0911 18:12:39.111] Sep 11 18:03:40.817: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
I0911 18:12:39.111] Sep 11 18:03:40.856: INFO: namespace init-container-4375 deletion completed in 28.049412994s
I0911 18:12:39.111] 
I0911 18:12:39.111] 
I0911 18:12:39.112] • [SLOW TEST:71.772 seconds]
I0911 18:12:39.112] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:39.112] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 18:12:39.112]   should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 18:12:39.112]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:39.113] ------------------------------
I0911 18:12:39.113] [BeforeEach] [sig-api-machinery] Secrets
I0911 18:12:39.113]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:39.113] STEP: Creating a kubernetes client
I0911 18:12:39.113] STEP: Building a namespace api object, basename secrets
... skipping 324 lines ...
I0911 18:12:39.178] STEP: submitting the pod to kubernetes
I0911 18:12:39.179] STEP: verifying the pod is in kubernetes
I0911 18:12:39.179] STEP: updating the pod
I0911 18:12:39.179] Sep 11 18:03:59.431: INFO: Successfully updated pod "pod-update-activedeadlineseconds-9480590e-8ddc-4aed-b978-bdc1053c57aa"
I0911 18:12:39.179] Sep 11 18:03:59.431: INFO: Waiting up to 5m0s for pod "pod-update-activedeadlineseconds-9480590e-8ddc-4aed-b978-bdc1053c57aa" in namespace "pods-6551" to be "terminated due to deadline exceeded"
I0911 18:12:39.179] Sep 11 18:03:59.441: INFO: Pod "pod-update-activedeadlineseconds-9480590e-8ddc-4aed-b978-bdc1053c57aa": Phase="Running", Reason="", readiness=true. Elapsed: 9.558948ms
I0911 18:12:39.180] Sep 11 18:04:01.445: INFO: Pod "pod-update-activedeadlineseconds-9480590e-8ddc-4aed-b978-bdc1053c57aa": Phase="Failed", Reason="DeadlineExceeded", readiness=false. Elapsed: 2.014067279s
I0911 18:12:39.180] Sep 11 18:04:01.445: INFO: Pod "pod-update-activedeadlineseconds-9480590e-8ddc-4aed-b978-bdc1053c57aa" satisfied condition "terminated due to deadline exceeded"
I0911 18:12:39.180] [AfterEach] [k8s.io] Pods
I0911 18:12:39.180]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:39.180] Sep 11 18:04:01.445: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 18:12:39.181] STEP: Destroying namespace "pods-6551" for this suite.
I0911 18:12:39.181] Sep 11 18:04:07.459: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 1413 lines ...
I0911 18:12:39.394] [BeforeEach] [k8s.io] Security Context
I0911 18:12:39.394]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:40
I0911 18:12:39.394] [It] should run the container with readonly rootfs when readOnlyRootFilesystem=true [LinuxOnly] [NodeConformance]
I0911 18:12:39.395]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:211
I0911 18:12:39.395] Sep 11 18:05:29.169: INFO: Waiting up to 5m0s for pod "busybox-readonly-true-fc96b558-8db6-4577-9e16-e585247e691e" in namespace "security-context-test-1499" to be "success or failure"
I0911 18:12:39.395] Sep 11 18:05:29.175: INFO: Pod "busybox-readonly-true-fc96b558-8db6-4577-9e16-e585247e691e": Phase="Pending", Reason="", readiness=false. Elapsed: 5.275306ms
I0911 18:12:39.395] Sep 11 18:05:31.182: INFO: Pod "busybox-readonly-true-fc96b558-8db6-4577-9e16-e585247e691e": Phase="Failed", Reason="", readiness=false. Elapsed: 2.012371386s
I0911 18:12:39.395] Sep 11 18:05:31.182: INFO: Pod "busybox-readonly-true-fc96b558-8db6-4577-9e16-e585247e691e" satisfied condition "success or failure"
I0911 18:12:39.396] [AfterEach] [k8s.io] Security Context
I0911 18:12:39.396]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:39.396] Sep 11 18:05:31.183: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 18:12:39.396] STEP: Destroying namespace "security-context-test-1499" for this suite.
I0911 18:12:39.397] Sep 11 18:05:37.195: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 724 lines ...
I0911 18:12:39.495]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:39.495] STEP: Creating a kubernetes client
I0911 18:12:39.495] STEP: Building a namespace api object, basename init-container
I0911 18:12:39.495] Sep 11 18:06:43.365: INFO: Skipping waiting for service account
I0911 18:12:39.495] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:39.495]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 18:12:39.496] [It] should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 18:12:39.496]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:39.496] STEP: creating the pod
I0911 18:12:39.496] Sep 11 18:06:43.365: INFO: PodSpec: initContainers in spec.initContainers
I0911 18:12:39.496] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:39.496]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:39.496] Sep 11 18:06:45.988: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 2 lines ...
I0911 18:12:39.497] Sep 11 18:06:54.038: INFO: namespace init-container-9800 deletion completed in 8.042007773s
I0911 18:12:39.497] 
I0911 18:12:39.497] 
I0911 18:12:39.497] • [SLOW TEST:10.685 seconds]
I0911 18:12:39.497] [k8s.io] InitContainer [NodeConformance]
I0911 18:12:39.497] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 18:12:39.497]   should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 18:12:39.497]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:39.497] ------------------------------
I0911 18:12:39.498] [BeforeEach] [k8s.io] Security Context
I0911 18:12:39.498]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 18:12:39.498] STEP: Creating a kubernetes client
I0911 18:12:39.498] STEP: Building a namespace api object, basename security-context-test
... skipping 665 lines ...
I0911 18:12:39.581] STEP: Creating a kubernetes client
I0911 18:12:39.581] STEP: Building a namespace api object, basename container-runtime
I0911 18:12:39.581] Sep 11 18:07:38.447: INFO: Skipping waiting for service account
I0911 18:12:39.581] [It] should report termination message [LinuxOnly] from log output if TerminationMessagePolicy FallbackToLogsOnError is set [NodeConformance] [Conformance]
I0911 18:12:39.581]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 18:12:39.581] STEP: create the container
I0911 18:12:39.582] STEP: wait for the container to reach Failed
I0911 18:12:39.582] STEP: get the container status
I0911 18:12:39.582] STEP: the container should be terminated
I0911 18:12:39.582] STEP: the termination message should be set
I0911 18:12:39.582] Sep 11 18:07:39.513: INFO: Expected: &{DONE} to match Container's Termination Message: DONE --
I0911 18:12:39.582] STEP: delete the container
I0911 18:12:39.582] [AfterEach] [k8s.io] Container Runtime
... skipping 728 lines ...
I0911 18:12:39.715] Sep 11 18:04:15.687: INFO: Skipping waiting for service account
I0911 18:12:39.715] [It] should be able to pull from private registry with credential provider [NodeConformance]
I0911 18:12:39.715]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/runtime_conformance_test.go:68
I0911 18:12:39.715] STEP: create the container
I0911 18:12:39.716] STEP: check the container status
I0911 18:12:39.716] STEP: delete the container
I0911 18:12:39.716] Sep 11 18:09:16.373: INFO: No.1 attempt failed: expected container state: Running, got: "Waiting", retrying...
I0911 18:12:39.716] STEP: create the container
I0911 18:12:39.716] STEP: check the container status
I0911 18:12:39.716] STEP: delete the container
I0911 18:12:39.717] [AfterEach] [k8s.io] Container Runtime Conformance Test
I0911 18:12:39.717]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 18:12:39.717] Sep 11 18:09:18.413: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 504 lines ...
I0911 18:12:39.808] I0911 18:12:32.647807    2660 services.go:156] Get log file "kubelet.log" with journalctl command [-u kubelet-20190911T180013.service].
I0911 18:12:39.808] I0911 18:12:33.184879    2660 services.go:156] Get log file "kern.log" with journalctl command [-k].
I0911 18:12:39.809] I0911 18:12:33.213932    2660 e2e_node_suite_test.go:201] Tests Finished
I0911 18:12:39.809] 
I0911 18:12:39.809] 
I0911 18:12:39.809] Ran 157 of 313 Specs in 723.590 seconds
I0911 18:12:39.809] SUCCESS! -- 157 Passed | 0 Failed | 0 Flaked | 0 Pending | 156 Skipped
I0911 18:12:39.809] 
I0911 18:12:39.809] 
I0911 18:12:39.810] Ginkgo ran 1 suite in 12m5.445228975s
I0911 18:12:39.810] Test Suite Passed
I0911 18:12:39.810] 
I0911 18:12:39.810] Success Finished Test Suite on Host tmp-node-e2e-b2b63d58-ubuntu-gke-1804-d1703-0-v20181113
... skipping 6 lines ...
W0911 18:12:39.916] 2019/09/11 18:12:39 process.go:155: Step 'go run /go/src/k8s.io/kubernetes/test/e2e_node/runner/remote/run_remote.go --cleanup --logtostderr --vmodule=*=4 --ssh-env=gce --results-dir=/workspace/_artifacts --project=k8s-jkns-pr-node-e2e --zone=us-west1-b --ssh-user=prow --ssh-key=/workspace/.ssh/google_compute_engine --ginkgo-flags=--nodes=8 --focus="\[NodeConformance\]" --skip="\[Flaky\]|\[Slow\]|\[Serial\]" --flakeAttempts=2 --test_args=--kubelet-flags="--cgroups-per-qos=true --cgroup-root=/" --test-timeout=1h5m0s --image-config-file=/workspace/test-infra/jobs/e2e_node/image-config.yaml' finished in 23m7.27195792s
W0911 18:12:39.917] 2019/09/11 18:12:39 node.go:42: Noop - Node DumpClusterLogs() - /workspace/_artifacts: 
W0911 18:12:39.917] 2019/09/11 18:12:39 node.go:52: Noop - Node Down()
W0911 18:12:39.917] 2019/09/11 18:12:39 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W0911 18:12:39.917] 2019/09/11 18:12:39 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"
W0911 18:12:40.314] 2019/09/11 18:12:40 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 398.316679ms
W0911 18:12:40.315] 2019/09/11 18:12:40 main.go:319: Something went wrong: encountered 1 errors: [error during go run /go/src/k8s.io/kubernetes/test/e2e_node/runner/remote/run_remote.go --cleanup --logtostderr --vmodule=*=4 --ssh-env=gce --results-dir=/workspace/_artifacts --project=k8s-jkns-pr-node-e2e --zone=us-west1-b --ssh-user=prow --ssh-key=/workspace/.ssh/google_compute_engine --ginkgo-flags=--nodes=8 --focus="\[NodeConformance\]" --skip="\[Flaky\]|\[Slow\]|\[Serial\]" --flakeAttempts=2 --test_args=--kubelet-flags="--cgroups-per-qos=true --cgroup-root=/" --test-timeout=1h5m0s --image-config-file=/workspace/test-infra/jobs/e2e_node/image-config.yaml: exit status 1]
W0911 18:12:40.319] Traceback (most recent call last):
W0911 18:12:40.319]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in <module>
W0911 18:12:40.319]     main(parse_args())
W0911 18:12:40.319]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main
W0911 18:12:40.320]     mode.start(runner_args)
W0911 18:12:40.320]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start
W0911 18:12:40.320]     check_env(env, self.command, *args)
W0911 18:12:40.320]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0911 18:12:40.320]     subprocess.check_call(cmd, env=env)
W0911 18:12:40.321]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0911 18:12:40.321]     raise CalledProcessError(retcode, cmd)
W0911 18:12:40.322] subprocess.CalledProcessError: Command '('kubetest', '--dump=/workspace/_artifacts', '--gcp-service-account=/etc/service-account/service-account.json', '--up', '--down', '--test', '--deployment=node', '--provider=gce', '--cluster=bootstrap-e2e', '--gcp-network=bootstrap-e2e', '--gcp-project=k8s-jkns-pr-node-e2e', '--gcp-zone=us-west1-b', '--node-test-args=--kubelet-flags="--cgroups-per-qos=true --cgroup-root=/"', '--node-tests=true', '--test_args=--nodes=8 --focus="\\[NodeConformance\\]" --skip="\\[Flaky\\]|\\[Slow\\]|\\[Serial\\]" --flakeAttempts=2', '--timeout=65m', '--node-args=--image-config-file=/workspace/test-infra/jobs/e2e_node/image-config.yaml')' returned non-zero exit status 1
E0911 18:12:40.328] Command failed
I0911 18:12:40.328] process 518 exited with code 1 after 23.2m
E0911 18:12:40.328] FAIL: pull-kubernetes-node-e2e
I0911 18:12:40.329] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 18:12:40.895] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 18:12:40.955] process 38786 exited with code 0 after 0.0m
I0911 18:12:40.955] Call:  gcloud config get-value account
I0911 18:12:41.303] process 38798 exited with code 0 after 0.0m
I0911 18:12:41.303] Will upload results to gs://kubernetes-jenkins/pr-logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 18:12:41.303] Upload result and artifacts...
I0911 18:12:41.304] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/pr-logs/pull/batch/pull-kubernetes-node-e2e/1171842567034114048
I0911 18:12:41.304] Call:  gsutil ls gs://kubernetes-jenkins/pr-logs/pull/batch/pull-kubernetes-node-e2e/1171842567034114048/artifacts
W0911 18:12:42.375] CommandException: One or more URLs matched no objects.
E0911 18:12:42.479] Command failed
I0911 18:12:42.480] process 38810 exited with code 1 after 0.0m
W0911 18:12:42.480] Remote dir gs://kubernetes-jenkins/pr-logs/pull/batch/pull-kubernetes-node-e2e/1171842567034114048/artifacts not exist yet
I0911 18:12:42.480] Call:  gsutil -m -q -o GSUtil:use_magicfile=True cp -r -c -z log,txt,xml /workspace/_artifacts gs://kubernetes-jenkins/pr-logs/pull/batch/pull-kubernetes-node-e2e/1171842567034114048/artifacts
I0911 18:12:45.474] process 38952 exited with code 0 after 0.0m
I0911 18:12:45.475] Call:  git rev-parse HEAD
I0911 18:12:45.479] process 39594 exited with code 0 after 0.0m
... skipping 21 lines ...