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 18:52
Elapsed25m25s
Revision
Buildergke-prow-ssd-pool-1a225945-sw6v
Refs master:001f2cd2
82209:89a70fa4
82261:d78b1a22
82279:e8b57814
82307:6e0878fb
82317:99430f51
82324:4c58dc3a
82329:b4638519
82330:4105fea6
82342:8cd98fbd
82360:eff4f79e
82367:6a433ee5
82391:637badc1
82411:7bdb66f8
82414:c53f2f30
82416:bd0691d1
links{u'resultstore': {u'url': u'https://source.cloud.google.com/results/invocations/b8826912-9141-4c8f-a0f6-184858f34217/targets/test'}}
pod1fdd196b-d4c5-11e9-ad08-968d9a0b984c
resultstorehttps://source.cloud.google.com/results/invocations/b8826912-9141-4c8f-a0f6-184858f34217/targets/test
infra-commit72663f1bb
job-versionv1.17.0-alpha.0.1298+75d782bacd919e
pod1fdd196b-d4c5-11e9-ad08-968d9a0b984c
repok8s.io/kubernetes
repo-commit75d782bacd919ec1040edb5ad45e7328d5b2883c
repos{u'k8s.io/kubernetes': u'master:001f2cd2b553d06028c8542c8817820ee05d657f,82209:89a70fa407b10329e5e71de35d94616e8d444b2d,82261:d78b1a22271bca507343af6ccb1f338140ed1e31,82279:e8b5781499dfb35809c4ede091fc9718f142265e,82307:6e0878fbcc12ba6dd534d68165f7074274644986,82317:99430f51fd406607529a188ddae30b333bd59667,82324:4c58dc3a567513aea9f3db204e71de65a3fd1ef1,82329:b4638519a9d82e2f92421f43dd2f881529c64864,82330:4105fea6eb0cf1e5dd56146ccf94755445988b9a,82342:8cd98fbd60d7cd69bd47187c3b6bcddf27a32d22,82360:eff4f79eda1399d9c10941d7bb591614723c40bc,82367:6a433ee5ba375e6f33fba4d17f8198ff9b7647f0,82391:637badc1f0de46915ec10808b6654ddfd042abea,82411:7bdb66f8d15a3521e1fa308131f530118136b533,82414:c53f2f306ae6f1ff4501720e1f1019fe8cbe4488,82416:bd0691d15915e35303c867d98d74f3e89aafeb75'}
revisionv1.17.0-alpha.0.1298+75d782bacd919e

Test Failures


Node Tests 23m46s

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 ...
W0911 18:54:11.202] I0911 18:54:11.088620    4615 build.go:42] Building k8s binaries...
W0911 18:54:11.209] I0911 18:54:11.208772    4615 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:0xc0005b20e0 machine: tests:[]} with service account "1046294573453-compute@developer.gserviceaccount.com"
W0911 18:54:11.212] I0911 18:54:11.211537    4615 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:0xc0005ca2a0 machine: tests:[]} with service account "1046294573453-compute@developer.gserviceaccount.com"
W0911 18:54:11.219] I0911 18:54:11.219288    4615 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:0xc0005ca1c0 machine: tests:[]} with service account "1046294573453-compute@developer.gserviceaccount.com"
W0911 18:54:11.235] I0911 18:54:11.234960    4615 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 18:54:12.173] I0911 18:54:12.172797    4615 run_remote.go:742] Deleting instance ""
W0911 18:54:12.175] E0911 18:54:12.175609    4615 run_remote.go:745] Error deleting instance "": googleapi: got HTTP response code 404 with body: <!DOCTYPE html>
W0911 18:54:12.176] <html lang=en>
W0911 18:54:12.176]   <meta charset=utf-8>
W0911 18:54:12.176]   <meta name=viewport content="initial-scale=1, minimum-scale=1, width=device-width">
W0911 18:54:12.176]   <title>Error 404 (Not Found)!!1</title>
W0911 18:54:12.176]   <style>
W0911 18:54:12.177]     *{margin:0;padding:0}html,code{font:15px/22px arial,sans-serif}html{background:#fff;color:#222;padding:15px}body{margin:7% auto 0;max-width:390px;min-height:180px;padding:30px 0 15px}* > body{background:url(//www.google.com/images/errors/robot.png) 100% 5px no-repeat;padding-right:205px}p{margin:11px 0 22px;overflow:hidden}ins{color:#777;text-decoration:none}a img{border:0}@media screen and (max-width:772px){body{background:none;margin-top:0;max-width:none;padding-right:0}}#logo{background:url(//www.google.com/images/branding/googlelogo/1x/googlelogo_color_150x54dp.png) no-repeat;margin-left:-5px}@media only screen and (min-resolution:192dpi){#logo{background:url(//www.google.com/images/branding/googlelogo/2x/googlelogo_color_150x54dp.png) no-repeat 0% 0%/100% 100%;-moz-border-image:url(//www.google.com/images/branding/googlelogo/2x/googlelogo_color_150x54dp.png) 0}}@media only screen and (-webkit-min-device-pixel-ratio:2){#logo{background:url(//www.google.com/images/branding/googlelogo/2x/googlelogo_color_150x54dp.png) no-repeat;-webkit-background-size:100% 100%}}#logo{display:inline-block;height:54px;width:150px}
W0911 18:54:12.177]   </style>
W0911 18:54:12.178]   <a href=//www.google.com/><span id=logo aria-label=Google></span></a>
W0911 18:54:12.178]   <p><b>404.</b> <ins>That’s an error.</ins>
W0911 18:54:12.178]   <p>The requested URL <code>/compute/beta/projects/k8s-jkns-pr-node-e2e/zones/us-west1-b/instances/?alt=json&amp;prettyPrint=false</code> was not found on this server.  <ins>That’s all we know.</ins>
I0911 18:54:12.279] 
I0911 18:54:12.279] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
I0911 18:54:12.279] >                              START TEST                                >
I0911 18:54:12.279] >>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>>
I0911 18:54:12.279] Start Test Suite on Host 
I0911 18:54:12.279] 
I0911 18:54:12.280] Failure Finished Test Suite on Host 
I0911 18:54:12.280] unable to create gce instance with running docker daemon for image coreos-beta-1911-1-1-v20181011.  could not create instance tmp-node-e2e-8a9fbf66-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 18:54:12.280] <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
I0911 18:54:12.280] <                              FINISH TEST                               <
I0911 18:54:12.280] <<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<<
I0911 18:54:12.280] 
I0911 18:54:21.859] +++ [0911 18:54:21] Building go targets for linux/amd64:
I0911 18:54:21.859]     ./vendor/k8s.io/code-generator/cmd/deepcopy-gen
... skipping 979 lines ...
I0911 19:15:32.240] STEP: submitting the pod to kubernetes
I0911 19:15:32.241] STEP: verifying the pod is in kubernetes
I0911 19:15:32.241] STEP: updating the pod
I0911 19:15:32.242] Sep 11 19:06:35.403: INFO: Successfully updated pod "pod-update-activedeadlineseconds-01e51f2f-f57f-4aff-b6fd-96bef34c6632"
I0911 19:15:32.242] Sep 11 19:06:35.403: INFO: Waiting up to 5m0s for pod "pod-update-activedeadlineseconds-01e51f2f-f57f-4aff-b6fd-96bef34c6632" in namespace "pods-8557" to be "terminated due to deadline exceeded"
I0911 19:15:32.243] Sep 11 19:06:35.404: INFO: Pod "pod-update-activedeadlineseconds-01e51f2f-f57f-4aff-b6fd-96bef34c6632": Phase="Running", Reason="", readiness=true. Elapsed: 1.403738ms
I0911 19:15:32.243] Sep 11 19:06:37.406: INFO: Pod "pod-update-activedeadlineseconds-01e51f2f-f57f-4aff-b6fd-96bef34c6632": Phase="Failed", Reason="DeadlineExceeded", readiness=false. Elapsed: 2.003314188s
I0911 19:15:32.243] Sep 11 19:06:37.406: INFO: Pod "pod-update-activedeadlineseconds-01e51f2f-f57f-4aff-b6fd-96bef34c6632" satisfied condition "terminated due to deadline exceeded"
I0911 19:15:32.243] [AfterEach] [k8s.io] Pods
I0911 19:15:32.244]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:15:32.244] Sep 11 19:06:37.406: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 19:15:32.244] STEP: Destroying namespace "pods-8557" for this suite.
I0911 19:15:32.244] Sep 11 19:06:43.418: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 375 lines ...
I0911 19:15:32.347]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:40
I0911 19:15:32.347] [It] should run the container with readonly rootfs when readOnlyRootFilesystem=true [LinuxOnly] [NodeConformance]
I0911 19:15:32.348]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:211
I0911 19:15:32.348] Sep 11 19:07:01.765: INFO: Waiting up to 5m0s for pod "busybox-readonly-true-01e92542-2653-43e6-a677-7250bb32c5dd" in namespace "security-context-test-6299" to be "success or failure"
I0911 19:15:32.348] Sep 11 19:07:01.772: INFO: Pod "busybox-readonly-true-01e92542-2653-43e6-a677-7250bb32c5dd": Phase="Pending", Reason="", readiness=false. Elapsed: 7.561834ms
I0911 19:15:32.348] Sep 11 19:07:03.774: INFO: Pod "busybox-readonly-true-01e92542-2653-43e6-a677-7250bb32c5dd": Phase="Running", Reason="", readiness=true. Elapsed: 2.009225944s
I0911 19:15:32.349] Sep 11 19:07:05.776: INFO: Pod "busybox-readonly-true-01e92542-2653-43e6-a677-7250bb32c5dd": Phase="Failed", Reason="", readiness=false. Elapsed: 4.010971003s
I0911 19:15:32.349] Sep 11 19:07:05.776: INFO: Pod "busybox-readonly-true-01e92542-2653-43e6-a677-7250bb32c5dd" satisfied condition "success or failure"
I0911 19:15:32.349] [AfterEach] [k8s.io] Security Context
I0911 19:15:32.349]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:15:32.349] Sep 11 19:07:05.776: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 19:15:32.349] STEP: Destroying namespace "security-context-test-6299" for this suite.
I0911 19:15:32.350] Sep 11 19:07:11.783: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 13 lines ...
I0911 19:15:32.351] STEP: Creating a kubernetes client
I0911 19:15:32.352] STEP: Building a namespace api object, basename container-runtime
I0911 19:15:32.352] Sep 11 19:07:08.818: INFO: Skipping waiting for service account
I0911 19:15:32.352] [It] should report termination message [LinuxOnly] from log output if TerminationMessagePolicy FallbackToLogsOnError is set [NodeConformance] [Conformance]
I0911 19:15:32.352]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:15:32.352] STEP: create the container
I0911 19:15:32.352] STEP: wait for the container to reach Failed
I0911 19:15:32.352] STEP: get the container status
I0911 19:15:32.353] STEP: the container should be terminated
I0911 19:15:32.353] STEP: the termination message should be set
I0911 19:15:32.353] Sep 11 19:07:09.880: INFO: Expected: &{DONE} to match Container's Termination Message: DONE --
I0911 19:15:32.353] STEP: delete the container
I0911 19:15:32.353] [AfterEach] [k8s.io] Container Runtime
... skipping 2902 lines ...
I0911 19:15:33.005]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 19:15:33.005] STEP: Creating a kubernetes client
I0911 19:15:33.005] STEP: Building a namespace api object, basename init-container
I0911 19:15:33.006] Sep 11 19:11:58.016: INFO: Skipping waiting for service account
I0911 19:15:33.006] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:15:33.006]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 19:15:33.007] [It] should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 19:15:33.007]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:15:33.008] STEP: creating the pod
I0911 19:15:33.008] Sep 11 19:11:58.016: INFO: PodSpec: initContainers in spec.initContainers
I0911 19:15:33.008] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:15:33.009]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:15:33.009] Sep 11 19:11:59.782: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 2 lines ...
I0911 19:15:33.010] Sep 11 19:12:05.834: INFO: namespace init-container-2589 deletion completed in 6.046190646s
I0911 19:15:33.010] 
I0911 19:15:33.011] 
I0911 19:15:33.011] • [SLOW TEST:7.821 seconds]
I0911 19:15:33.011] [k8s.io] InitContainer [NodeConformance]
I0911 19:15:33.011] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 19:15:33.012]   should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 19:15:33.012]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:15:33.012] ------------------------------
I0911 19:15:33.013] S
I0911 19:15:33.013] ------------------------------
I0911 19:15:33.013] [BeforeEach] [sig-storage] Projected downwardAPI
I0911 19:15:33.013]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
... skipping 831 lines ...
I0911 19:15:33.263]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 19:15:33.263] STEP: Creating a kubernetes client
I0911 19:15:33.264] STEP: Building a namespace api object, basename init-container
I0911 19:15:33.264] Sep 11 19:12:39.617: INFO: Skipping waiting for service account
I0911 19:15:33.264] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:15:33.265]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 19:15:33.265] [It] should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 19:15:33.265]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:15:33.265] STEP: creating the pod
I0911 19:15:33.266] Sep 11 19:12:39.617: INFO: PodSpec: initContainers in spec.initContainers
I0911 19:15:33.274] Sep 11 19:13:26.441: INFO: init container has failed twice: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"pod-init-543c637b-7721-48d5-af7f-083b187e17a9", GenerateName:"", Namespace:"init-container-2587", SelfLink:"/api/v1/namespaces/init-container-2587/pods/pod-init-543c637b-7721-48d5-af7f-083b187e17a9", UID:"33128842-af40-4656-83b5-d8098c314b60", ResourceVersion:"3365", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63703825959, loc:(*time.Location)(0xbe82a00)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"name":"foo", "time":"617886320"}, 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)(0xc000b93a50), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"Default", NodeSelector:map[string]string(nil), ServiceAccountName:"", DeprecatedServiceAccount:"", AutomountServiceAccountToken:(*bool)(nil), NodeName:"tmp-node-e2e-8a9fbf66-ubuntu-gke-1804-d1703-0-v20181113", HostNetwork:false, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc00108d0e0), 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)(0xc000b93ad0)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc000b93af0)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"", Priority:(*int32)(0xc000b93b20), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc000b93b24), 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:63703825959, 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:63703825959, 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:63703825959, 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:63703825959, loc:(*time.Location)(0xbe82a00)}}, Reason:"", Message:""}}, Message:"", Reason:"", NominatedNodeName:"", HostIP:"10.138.0.58", PodIP:"10.100.0.177", PodIPs:[]v1.PodIP{v1.PodIP{IP:"10.100.0.177"}}, StartTime:(*v1.Time)(0xc000894940), InitContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"init1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc0007a1f80)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc0007c6000)}, Ready:false, RestartCount:3, Image:"busybox:1.29", ImageID:"docker-pullable://busybox@sha256:8ccbac733d19c0dd4d70b4f0c1e12245b5fa3ad24758a11035ee505c629c0796", ContainerID:"docker://bc4e624db4b64901fa16fbfc8f7bfe4f9debf1417710e40ddf1fd3ed466cc403", Started:(*bool)(nil)}, v1.ContainerStatus{Name:"init2", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc000894980), 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)(0xc0008949c0), 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)(0xc000b93c0c)}}, QOSClass:"Burstable", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}
I0911 19:15:33.274] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:15:33.275]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:15:33.275] Sep 11 19:13:26.442: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 19:15:33.275] STEP: Destroying namespace "init-container-2587" for this suite.
I0911 19:15:33.276] Sep 11 19:13:54.462: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
I0911 19:15:33.276] Sep 11 19:13:54.505: INFO: namespace init-container-2587 deletion completed in 28.056971437s
I0911 19:15:33.276] 
I0911 19:15:33.276] 
I0911 19:15:33.276] • [SLOW TEST:74.892 seconds]
I0911 19:15:33.277] [k8s.io] InitContainer [NodeConformance]
I0911 19:15:33.277] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 19:15:33.277]   should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 19:15:33.278]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:15:33.278] ------------------------------
I0911 19:15:33.278] [BeforeEach] [k8s.io] Probing container
I0911 19:15:33.278]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 19:15:33.279] STEP: Creating a kubernetes client
I0911 19:15:33.279] STEP: Building a namespace api object, basename container-probe
... skipping 28 lines ...
I0911 19:15:33.287] Sep 11 19:09:45.860: INFO: Skipping waiting for service account
I0911 19:15:33.287] [It] should be able to pull from private registry with credential provider [NodeConformance]
I0911 19:15:33.288]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/runtime_conformance_test.go:68
I0911 19:15:33.288] STEP: create the container
I0911 19:15:33.288] STEP: check the container status
I0911 19:15:33.288] STEP: delete the container
I0911 19:15:33.289] Sep 11 19:14:46.675: INFO: No.1 attempt failed: expected container state: Running, got: "Waiting", retrying...
I0911 19:15:33.289] STEP: create the container
I0911 19:15:33.289] STEP: check the container status
I0911 19:15:33.289] STEP: delete the container
I0911 19:15:33.289] [AfterEach] [k8s.io] Container Runtime Conformance Test
I0911 19:15:33.290]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:15:33.290] Sep 11 19:14:48.716: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 55 lines ...
I0911 19:15:33.306] I0911 19:15:25.798232    2673 services.go:156] Get log file "kern.log" with journalctl command [-k].
I0911 19:15:33.307] I0911 19:15:25.827170    2673 services.go:156] Get log file "cloud-init.log" with journalctl command [-u cloud*].
I0911 19:15:33.307] I0911 19:15:25.834560    2673 e2e_node_suite_test.go:201] Tests Finished
I0911 19:15:33.307] 
I0911 19:15:33.307] 
I0911 19:15:33.308] Ran 157 of 313 Specs in 702.018 seconds
I0911 19:15:33.308] SUCCESS! -- 157 Passed | 0 Failed | 0 Flaked | 0 Pending | 156 Skipped
I0911 19:15:33.308] 
I0911 19:15:33.309] 
I0911 19:15:33.309] Ginkgo ran 1 suite in 11m43.876978183s
I0911 19:15:33.309] Test Suite Passed
I0911 19:15:33.309] 
I0911 19:15:33.309] Success Finished Test Suite on Host tmp-node-e2e-8a9fbf66-ubuntu-gke-1804-d1703-0-v20181113
... skipping 547 lines ...
I0911 19:16:55.169]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:40
I0911 19:16:55.169] [It] should run the container with readonly rootfs when readOnlyRootFilesystem=true [LinuxOnly] [NodeConformance]
I0911 19:16:55.169]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:211
I0911 19:16:55.169] Sep 11 19:05:38.360: INFO: Waiting up to 5m0s for pod "busybox-readonly-true-8e978f93-8193-4ac5-9e66-54bec848980b" in namespace "security-context-test-9657" to be "success or failure"
I0911 19:16:55.170] Sep 11 19:05:38.388: INFO: Pod "busybox-readonly-true-8e978f93-8193-4ac5-9e66-54bec848980b": Phase="Pending", Reason="", readiness=false. Elapsed: 28.074181ms
I0911 19:16:55.170] Sep 11 19:05:40.390: INFO: Pod "busybox-readonly-true-8e978f93-8193-4ac5-9e66-54bec848980b": Phase="Pending", Reason="", readiness=false. Elapsed: 2.030098589s
I0911 19:16:55.171] Sep 11 19:05:42.392: INFO: Pod "busybox-readonly-true-8e978f93-8193-4ac5-9e66-54bec848980b": Phase="Failed", Reason="", readiness=false. Elapsed: 4.03188777s
I0911 19:16:55.171] Sep 11 19:05:42.392: INFO: Pod "busybox-readonly-true-8e978f93-8193-4ac5-9e66-54bec848980b" satisfied condition "success or failure"
I0911 19:16:55.171] [AfterEach] [k8s.io] Security Context
I0911 19:16:55.171]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:16:55.172] Sep 11 19:05:42.392: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 19:16:55.172] STEP: Destroying namespace "security-context-test-9657" for this suite.
I0911 19:16:55.172] Sep 11 19:05:48.398: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 175 lines ...
I0911 19:16:55.211]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 19:16:55.211] STEP: Creating a kubernetes client
I0911 19:16:55.211] STEP: Building a namespace api object, basename init-container
I0911 19:16:55.211] Sep 11 19:05:54.908: INFO: Skipping waiting for service account
I0911 19:16:55.211] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:16:55.212]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 19:16:55.212] [It] should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 19:16:55.212]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:16:55.212] STEP: creating the pod
I0911 19:16:55.212] Sep 11 19:05:54.908: INFO: PodSpec: initContainers in spec.initContainers
I0911 19:16:55.212] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:16:55.212]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:16:55.213] Sep 11 19:05:57.501: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 2 lines ...
I0911 19:16:55.213] Sep 11 19:06:03.586: INFO: namespace init-container-8828 deletion completed in 6.050594062s
I0911 19:16:55.214] 
I0911 19:16:55.214] 
I0911 19:16:55.214] • [SLOW TEST:8.680 seconds]
I0911 19:16:55.214] [k8s.io] InitContainer [NodeConformance]
I0911 19:16:55.214] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 19:16:55.215]   should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 19:16:55.215]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:16:55.215] ------------------------------
I0911 19:16:55.215] [BeforeEach] [sig-api-machinery] Secrets
I0911 19:16:55.216]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 19:16:55.216] STEP: Creating a kubernetes client
I0911 19:16:55.216] STEP: Building a namespace api object, basename secrets
... skipping 1950 lines ...
I0911 19:16:55.700] STEP: verifying the pod is in kubernetes
I0911 19:16:55.700] STEP: updating the pod
I0911 19:16:55.700] Sep 11 19:08:49.311: INFO: Successfully updated pod "pod-update-activedeadlineseconds-1c4ab720-be1b-4c6a-9e69-353447b38555"
I0911 19:16:55.701] Sep 11 19:08:49.311: INFO: Waiting up to 5m0s for pod "pod-update-activedeadlineseconds-1c4ab720-be1b-4c6a-9e69-353447b38555" in namespace "pods-7661" to be "terminated due to deadline exceeded"
I0911 19:16:55.701] Sep 11 19:08:49.313: INFO: Pod "pod-update-activedeadlineseconds-1c4ab720-be1b-4c6a-9e69-353447b38555": Phase="Running", Reason="", readiness=true. Elapsed: 1.446843ms
I0911 19:16:55.701] Sep 11 19:08:51.319: INFO: Pod "pod-update-activedeadlineseconds-1c4ab720-be1b-4c6a-9e69-353447b38555": Phase="Running", Reason="", readiness=true. Elapsed: 2.007783056s
I0911 19:16:55.702] Sep 11 19:08:53.321: INFO: Pod "pod-update-activedeadlineseconds-1c4ab720-be1b-4c6a-9e69-353447b38555": Phase="Failed", Reason="DeadlineExceeded", readiness=false. Elapsed: 4.009486921s
I0911 19:16:55.702] Sep 11 19:08:53.321: INFO: Pod "pod-update-activedeadlineseconds-1c4ab720-be1b-4c6a-9e69-353447b38555" satisfied condition "terminated due to deadline exceeded"
I0911 19:16:55.702] [AfterEach] [k8s.io] Pods
I0911 19:16:55.702]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:16:55.703] Sep 11 19:08:53.321: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 19:16:55.703] STEP: Destroying namespace "pods-7661" for this suite.
I0911 19:16:55.703] Sep 11 19:09:01.327: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 1500 lines ...
I0911 19:16:56.060]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 19:16:56.060] STEP: Creating a kubernetes client
I0911 19:16:56.060] STEP: Building a namespace api object, basename init-container
I0911 19:16:56.060] Sep 11 19:10:03.708: INFO: Skipping waiting for service account
I0911 19:16:56.061] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:16:56.061]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 19:16:56.061] [It] should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 19:16:56.061]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:16:56.062] STEP: creating the pod
I0911 19:16:56.062] Sep 11 19:10:03.708: INFO: PodSpec: initContainers in spec.initContainers
I0911 19:16:56.069] Sep 11 19:10:46.508: INFO: init container has failed twice: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"pod-init-595e7343-402b-491f-9ebf-734c4e6994ec", GenerateName:"", Namespace:"init-container-6973", SelfLink:"/api/v1/namespaces/init-container-6973/pods/pod-init-595e7343-402b-491f-9ebf-734c4e6994ec", UID:"a526924d-0dc7-4da6-9900-dc94ef00305c", ResourceVersion:"2732", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63703825803, loc:(*time.Location)(0xbe82a00)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"name":"foo", "time":"708126871"}, 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)(0xc0011f36d0), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"Default", NodeSelector:map[string]string(nil), ServiceAccountName:"", DeprecatedServiceAccount:"", AutomountServiceAccountToken:(*bool)(nil), NodeName:"tmp-node-e2e-8a9fbf66-cos-stable-63-10032-71-0", HostNetwork:false, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc00123d500), 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)(0xc0011f3740)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc0011f3760)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"", Priority:(*int32)(0xc0011f3770), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc0011f3774), 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:63703825803, 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:63703825803, 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:63703825803, 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:63703825803, loc:(*time.Location)(0xbe82a00)}}, Reason:"", Message:""}}, Message:"", Reason:"", NominatedNodeName:"", HostIP:"10.138.0.47", PodIP:"10.100.0.135", PodIPs:[]v1.PodIP{v1.PodIP{IP:"10.100.0.135"}}, StartTime:(*v1.Time)(0xc00087cae0), InitContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"init1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc000d588c0)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc000d58930)}, Ready:false, RestartCount:3, Image:"busybox:1.29", ImageID:"docker-pullable://busybox@sha256:e004c2cc521c95383aebb1fb5893719aa7a8eae2e7a71f316a4410784edb00a9", ContainerID:"docker://153fdeca2e52e554dc2cb1ec5afb1e5a59ff7c6c5f6a70769d7b598f6ac37563", Started:(*bool)(nil)}, v1.ContainerStatus{Name:"init2", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc00087cb00), 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)(0xc00087cb20), 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)(0xc0011f385c)}}, QOSClass:"Burstable", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}
I0911 19:16:56.070] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:16:56.070]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:16:56.070] Sep 11 19:10:46.508: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 19:16:56.070] STEP: Destroying namespace "init-container-6973" for this suite.
I0911 19:16:56.070] Sep 11 19:11:00.525: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
I0911 19:16:56.071] Sep 11 19:11:00.834: INFO: namespace init-container-6973 deletion completed in 14.318718034s
I0911 19:16:56.071] 
I0911 19:16:56.071] 
I0911 19:16:56.071] • [SLOW TEST:57.129 seconds]
I0911 19:16:56.071] [k8s.io] InitContainer [NodeConformance]
I0911 19:16:56.071] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 19:16:56.072]   should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 19:16:56.072]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:16:56.072] ------------------------------
I0911 19:16:56.072] S
I0911 19:16:56.072] ------------------------------
I0911 19:16:56.072] [BeforeEach] [sig-storage] ConfigMap
I0911 19:16:56.073]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
... skipping 409 lines ...
I0911 19:16:56.166] STEP: Creating a kubernetes client
I0911 19:16:56.166] STEP: Building a namespace api object, basename container-runtime
I0911 19:16:56.166] Sep 11 19:11:31.763: INFO: Skipping waiting for service account
I0911 19:16:56.167] [It] should report termination message [LinuxOnly] from log output if TerminationMessagePolicy FallbackToLogsOnError is set [NodeConformance] [Conformance]
I0911 19:16:56.167]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:16:56.167] STEP: create the container
I0911 19:16:56.167] STEP: wait for the container to reach Failed
I0911 19:16:56.167] STEP: get the container status
I0911 19:16:56.167] STEP: the container should be terminated
I0911 19:16:56.167] STEP: the termination message should be set
I0911 19:16:56.168] Sep 11 19:11:33.842: INFO: Expected: &{DONE} to match Container's Termination Message: DONE --
I0911 19:16:56.168] STEP: delete the container
I0911 19:16:56.168] [AfterEach] [k8s.io] Container Runtime
... skipping 514 lines ...
I0911 19:16:56.272] Sep 11 19:11:38.093: INFO: Skipping waiting for service account
I0911 19:16:56.273] [It] should be able to pull from private registry with credential provider [NodeConformance]
I0911 19:16:56.273]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/runtime_conformance_test.go:68
I0911 19:16:56.273] STEP: create the container
I0911 19:16:56.273] STEP: check the container status
I0911 19:16:56.273] STEP: delete the container
I0911 19:16:56.273] Sep 11 19:16:38.675: INFO: No.1 attempt failed: expected container state: Running, got: "Waiting", retrying...
I0911 19:16:56.273] STEP: create the container
I0911 19:16:56.273] STEP: check the container status
I0911 19:16:56.274] STEP: delete the container
I0911 19:16:56.274] [AfterEach] [k8s.io] Container Runtime Conformance Test
I0911 19:16:56.274]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:16:56.274] Sep 11 19:16:40.734: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 12 lines ...
I0911 19:16:56.276]       should be able to pull from private registry with credential provider [NodeConformance]
I0911 19:16:56.276]       _output/local/go/src/k8s.io/kubernetes/test/e2e_node/runtime_conformance_test.go:68
I0911 19:16:56.277] ------------------------------
I0911 19:16:56.277] I0911 19:16:46.820408    1292 e2e_node_suite_test.go:196] Stopping node services...
I0911 19:16:56.277] I0911 19:16:46.820433    1292 server.go:257] Kill server "services"
I0911 19:16:56.277] I0911 19:16:46.820446    1292 server.go:294] Killing process 1903 (services) with -TERM
I0911 19:16:56.277] E0911 19:16:47.009045    1292 services.go:88] Failed to stop services: error stopping "services": waitid: no child processes
I0911 19:16:56.277] I0911 19:16:47.009063    1292 server.go:257] Kill server "kubelet"
I0911 19:16:56.277] I0911 19:16:47.018372    1292 services.go:147] Fetching log files...
I0911 19:16:56.277] I0911 19:16:47.018435    1292 services.go:156] Get log file "cloud-init.log" with journalctl command [-u cloud*].
I0911 19:16:56.278] I0911 19:16:47.746440    1292 services.go:156] Get log file "docker.log" with journalctl command [-u docker].
I0911 19:16:56.278] I0911 19:16:47.786228    1292 services.go:156] Get log file "kubelet.log" with journalctl command [-u kubelet-20190911T190328.service].
I0911 19:16:56.278] I0911 19:16:48.898340    1292 services.go:156] Get log file "kern.log" with journalctl command [-k].
I0911 19:16:56.278] I0911 19:16:48.951143    1292 e2e_node_suite_test.go:201] Tests Finished
I0911 19:16:56.278] 
I0911 19:16:56.278] 
I0911 19:16:56.278] Ran 157 of 313 Specs in 784.883 seconds
I0911 19:16:56.279] SUCCESS! -- 157 Passed | 0 Failed | 0 Flaked | 0 Pending | 156 Skipped
I0911 19:16:56.279] 
I0911 19:16:56.279] 
I0911 19:16:56.279] Ginkgo ran 1 suite in 13m8.023120467s
I0911 19:16:56.279] Test Suite Passed
I0911 19:16:56.279] 
I0911 19:16:56.279] Success Finished Test Suite on Host tmp-node-e2e-8a9fbf66-cos-stable-63-10032-71-0
... skipping 547 lines ...
I0911 19:17:09.225]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:40
I0911 19:17:09.225] [It] should run the container with readonly rootfs when readOnlyRootFilesystem=true [LinuxOnly] [NodeConformance]
I0911 19:17:09.225]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/security_context.go:211
I0911 19:17:09.225] Sep 11 19:05:39.177: INFO: Waiting up to 5m0s for pod "busybox-readonly-true-b6ade4ee-3f4b-4a13-b300-8cae774623e5" in namespace "security-context-test-4638" to be "success or failure"
I0911 19:17:09.225] Sep 11 19:05:39.183: INFO: Pod "busybox-readonly-true-b6ade4ee-3f4b-4a13-b300-8cae774623e5": Phase="Pending", Reason="", readiness=false. Elapsed: 5.43868ms
I0911 19:17:09.226] Sep 11 19:05:41.185: INFO: Pod "busybox-readonly-true-b6ade4ee-3f4b-4a13-b300-8cae774623e5": Phase="Pending", Reason="", readiness=false. Elapsed: 2.007206972s
I0911 19:17:09.226] Sep 11 19:05:43.187: INFO: Pod "busybox-readonly-true-b6ade4ee-3f4b-4a13-b300-8cae774623e5": Phase="Failed", Reason="", readiness=false. Elapsed: 4.009038693s
I0911 19:17:09.227] Sep 11 19:05:43.187: INFO: Pod "busybox-readonly-true-b6ade4ee-3f4b-4a13-b300-8cae774623e5" satisfied condition "success or failure"
I0911 19:17:09.227] [AfterEach] [k8s.io] Security Context
I0911 19:17:09.227]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:17:09.228] Sep 11 19:05:43.187: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 19:17:09.228] STEP: Destroying namespace "security-context-test-4638" for this suite.
I0911 19:17:09.228] Sep 11 19:05:49.192: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 177 lines ...
I0911 19:17:09.263]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 19:17:09.263] STEP: Creating a kubernetes client
I0911 19:17:09.264] STEP: Building a namespace api object, basename init-container
I0911 19:17:09.265] Sep 11 19:05:55.503: INFO: Skipping waiting for service account
I0911 19:17:09.265] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:17:09.265]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 19:17:09.265] [It] should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 19:17:09.265]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:17:09.266] STEP: creating the pod
I0911 19:17:09.267] Sep 11 19:05:55.503: INFO: PodSpec: initContainers in spec.initContainers
I0911 19:17:09.267] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:17:09.267]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:17:09.267] Sep 11 19:05:57.098: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 2 lines ...
I0911 19:17:09.268] Sep 11 19:06:03.138: INFO: namespace init-container-1072 deletion completed in 6.038135121s
I0911 19:17:09.268] 
I0911 19:17:09.268] 
I0911 19:17:09.268] • [SLOW TEST:7.638 seconds]
I0911 19:17:09.268] [k8s.io] InitContainer [NodeConformance]
I0911 19:17:09.268] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 19:17:09.269]   should not start app containers and fail the pod if init containers fail on a RestartNever pod [Conformance]
I0911 19:17:09.269]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:17:09.269] ------------------------------
I0911 19:17:09.269] [BeforeEach] [sig-api-machinery] Secrets
I0911 19:17:09.269]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 19:17:09.270] STEP: Creating a kubernetes client
I0911 19:17:09.270] STEP: Building a namespace api object, basename secrets
... skipping 1912 lines ...
I0911 19:17:09.774] STEP: verifying the pod is in kubernetes
I0911 19:17:09.774] STEP: updating the pod
I0911 19:17:09.775] Sep 11 19:09:00.923: INFO: Successfully updated pod "pod-update-activedeadlineseconds-dd58a98b-744e-4524-a6c4-adb4c6b2c8c3"
I0911 19:17:09.775] Sep 11 19:09:00.923: INFO: Waiting up to 5m0s for pod "pod-update-activedeadlineseconds-dd58a98b-744e-4524-a6c4-adb4c6b2c8c3" in namespace "pods-1224" to be "terminated due to deadline exceeded"
I0911 19:17:09.775] Sep 11 19:09:00.925: INFO: Pod "pod-update-activedeadlineseconds-dd58a98b-744e-4524-a6c4-adb4c6b2c8c3": Phase="Running", Reason="", readiness=true. Elapsed: 1.460049ms
I0911 19:17:09.775] Sep 11 19:09:02.927: INFO: Pod "pod-update-activedeadlineseconds-dd58a98b-744e-4524-a6c4-adb4c6b2c8c3": Phase="Running", Reason="", readiness=true. Elapsed: 2.003173491s
I0911 19:17:09.776] Sep 11 19:09:04.928: INFO: Pod "pod-update-activedeadlineseconds-dd58a98b-744e-4524-a6c4-adb4c6b2c8c3": Phase="Failed", Reason="DeadlineExceeded", readiness=false. Elapsed: 4.004942782s
I0911 19:17:09.776] Sep 11 19:09:04.928: INFO: Pod "pod-update-activedeadlineseconds-dd58a98b-744e-4524-a6c4-adb4c6b2c8c3" satisfied condition "terminated due to deadline exceeded"
I0911 19:17:09.776] [AfterEach] [k8s.io] Pods
I0911 19:17:09.777]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:17:09.777] Sep 11 19:09:04.928: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 19:17:09.777] STEP: Destroying namespace "pods-1224" for this suite.
I0911 19:17:09.778] Sep 11 19:09:10.934: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
... skipping 1683 lines ...
I0911 19:17:10.250]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
I0911 19:17:10.250] STEP: Creating a kubernetes client
I0911 19:17:10.250] STEP: Building a namespace api object, basename init-container
I0911 19:17:10.250] Sep 11 19:10:16.412: INFO: Skipping waiting for service account
I0911 19:17:10.250] [BeforeEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:17:10.251]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/common/init_container.go:44
I0911 19:17:10.251] [It] should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 19:17:10.251]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:17:10.251] STEP: creating the pod
I0911 19:17:10.251] Sep 11 19:10:16.412: INFO: PodSpec: initContainers in spec.initContainers
I0911 19:17:10.266] Sep 11 19:11:03.993: INFO: init container has failed twice: &v1.Pod{TypeMeta:v1.TypeMeta{Kind:"", APIVersion:""}, ObjectMeta:v1.ObjectMeta{Name:"pod-init-119db182-2c6c-4682-92ac-224419f71ec5", GenerateName:"", Namespace:"init-container-7040", SelfLink:"/api/v1/namespaces/init-container-7040/pods/pod-init-119db182-2c6c-4682-92ac-224419f71ec5", UID:"6842dc45-5b38-421f-9bbc-a030f6fa3da5", ResourceVersion:"2713", Generation:0, CreationTimestamp:v1.Time{Time:time.Time{wall:0x0, ext:63703825816, loc:(*time.Location)(0xbe82a00)}}, DeletionTimestamp:(*v1.Time)(nil), DeletionGracePeriodSeconds:(*int64)(nil), Labels:map[string]string{"name":"foo", "time":"412189997"}, 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)(0xc000784010), ActiveDeadlineSeconds:(*int64)(nil), DNSPolicy:"Default", NodeSelector:map[string]string(nil), ServiceAccountName:"", DeprecatedServiceAccount:"", AutomountServiceAccountToken:(*bool)(nil), NodeName:"tmp-node-e2e-8a9fbf66-cos-stable-60-9592-84-0", HostNetwork:false, HostPID:false, HostIPC:false, ShareProcessNamespace:(*bool)(nil), SecurityContext:(*v1.PodSecurityContext)(0xc00121cd20), 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)(0xc000784080)}, v1.Toleration{Key:"node.kubernetes.io/unreachable", Operator:"Exists", Value:"", Effect:"NoExecute", TolerationSeconds:(*int64)(0xc0007840a0)}}, HostAliases:[]v1.HostAlias(nil), PriorityClassName:"", Priority:(*int32)(0xc0007840b0), DNSConfig:(*v1.PodDNSConfig)(nil), ReadinessGates:[]v1.PodReadinessGate(nil), RuntimeClassName:(*string)(nil), EnableServiceLinks:(*bool)(0xc0007840b4), 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:63703825816, 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:63703825816, 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:63703825816, 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:63703825816, loc:(*time.Location)(0xbe82a00)}}, Reason:"", Message:""}}, Message:"", Reason:"", NominatedNodeName:"", HostIP:"10.138.0.59", PodIP:"10.100.0.134", PodIPs:[]v1.PodIP{v1.PodIP{IP:"10.100.0.134"}}, StartTime:(*v1.Time)(0xc0007e3520), InitContainerStatuses:[]v1.ContainerStatus{v1.ContainerStatus{Name:"init1", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc00082c460)}, LastTerminationState:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(nil), Running:(*v1.ContainerStateRunning)(nil), Terminated:(*v1.ContainerStateTerminated)(0xc00082c4d0)}, Ready:false, RestartCount:3, Image:"busybox:1.29", ImageID:"docker-pullable://busybox@sha256:e004c2cc521c95383aebb1fb5893719aa7a8eae2e7a71f316a4410784edb00a9", ContainerID:"docker://71c14dce63e602158b197b49ccbcd915f5e3ba7e612c8442c3707f2dc0752e1b", Started:(*bool)(nil)}, v1.ContainerStatus{Name:"init2", State:v1.ContainerState{Waiting:(*v1.ContainerStateWaiting)(0xc0007e3540), 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)(0xc0007e3560), 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)(0xc0007841ac)}}, QOSClass:"Burstable", EphemeralContainerStatuses:[]v1.ContainerStatus(nil)}}
I0911 19:17:10.267] [AfterEach] [k8s.io] InitContainer [NodeConformance]
I0911 19:17:10.267]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:17:10.267] Sep 11 19:11:03.993: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
I0911 19:17:10.268] STEP: Destroying namespace "init-container-7040" for this suite.
I0911 19:17:10.268] Sep 11 19:11:34.003: INFO: Waiting up to 30s for server preferred namespaced resources to be successfully discovered
I0911 19:17:10.268] Sep 11 19:11:34.039: INFO: namespace init-container-7040 deletion completed in 30.044069313s
I0911 19:17:10.268] 
I0911 19:17:10.268] 
I0911 19:17:10.269] • [SLOW TEST:77.630 seconds]
I0911 19:17:10.269] [k8s.io] InitContainer [NodeConformance]
I0911 19:17:10.269] /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:693
I0911 19:17:10.269]   should not start app containers if init containers fail on a RestartAlways pod [Conformance]
I0911 19:17:10.270]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:17:10.270] ------------------------------
I0911 19:17:10.270] S
I0911 19:17:10.270] ------------------------------
I0911 19:17:10.271] [BeforeEach] [sig-storage] Projected configMap
I0911 19:17:10.271]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:151
... skipping 185 lines ...
I0911 19:17:10.334] STEP: Creating a kubernetes client
I0911 19:17:10.337] STEP: Building a namespace api object, basename container-runtime
I0911 19:17:10.338] Sep 11 19:11:47.964: INFO: Skipping waiting for service account
I0911 19:17:10.338] [It] should report termination message [LinuxOnly] from log output if TerminationMessagePolicy FallbackToLogsOnError is set [NodeConformance] [Conformance]
I0911 19:17:10.339]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:698
I0911 19:17:10.339] STEP: create the container
I0911 19:17:10.339] STEP: wait for the container to reach Failed
I0911 19:17:10.340] STEP: get the container status
I0911 19:17:10.340] STEP: the container should be terminated
I0911 19:17:10.340] STEP: the termination message should be set
I0911 19:17:10.341] Sep 11 19:11:49.981: INFO: Expected: &{DONE} to match Container's Termination Message: DONE --
I0911 19:17:10.341] STEP: delete the container
I0911 19:17:10.341] [AfterEach] [k8s.io] Container Runtime
... skipping 581 lines ...
I0911 19:17:10.533] Sep 11 19:11:53.552: INFO: Skipping waiting for service account
I0911 19:17:10.533] [It] should be able to pull from private registry with credential provider [NodeConformance]
I0911 19:17:10.533]   _output/local/go/src/k8s.io/kubernetes/test/e2e_node/runtime_conformance_test.go:68
I0911 19:17:10.533] STEP: create the container
I0911 19:17:10.533] STEP: check the container status
I0911 19:17:10.534] STEP: delete the container
I0911 19:17:10.534] Sep 11 19:16:54.319: INFO: No.1 attempt failed: expected container state: Running, got: "Waiting", retrying...
I0911 19:17:10.534] STEP: create the container
I0911 19:17:10.534] STEP: check the container status
I0911 19:17:10.535] STEP: delete the container
I0911 19:17:10.535] [AfterEach] [k8s.io] Container Runtime Conformance Test
I0911 19:17:10.535]   /go/src/k8s.io/kubernetes/_output/local/go/src/k8s.io/kubernetes/test/e2e/framework/framework.go:152
I0911 19:17:10.536] Sep 11 19:16:55.372: INFO: Waiting up to 3m0s for all (but 0) nodes to be ready
... skipping 12 lines ...
I0911 19:17:10.539]       should be able to pull from private registry with credential provider [NodeConformance]
I0911 19:17:10.540]       _output/local/go/src/k8s.io/kubernetes/test/e2e_node/runtime_conformance_test.go:68
I0911 19:17:10.540] ------------------------------
I0911 19:17:10.540] I0911 19:17:01.449804    1296 e2e_node_suite_test.go:196] Stopping node services...
I0911 19:17:10.540] I0911 19:17:01.449833    1296 server.go:257] Kill server "services"
I0911 19:17:10.541] I0911 19:17:01.449847    1296 server.go:294] Killing process 1945 (services) with -TERM
I0911 19:17:10.541] E0911 19:17:01.622812    1296 services.go:88] Failed to stop services: error stopping "services": waitid: no child processes
I0911 19:17:10.541] I0911 19:17:01.622849    1296 server.go:257] Kill server "kubelet"
I0911 19:17:10.542] I0911 19:17:01.631449    1296 services.go:147] Fetching log files...
I0911 19:17:10.542] I0911 19:17:01.631566    1296 services.go:156] Get log file "kubelet.log" with journalctl command [-u kubelet-20190911T190328.service].
I0911 19:17:10.542] I0911 19:17:02.594422    1296 services.go:156] Get log file "kern.log" with journalctl command [-k].
I0911 19:17:10.542] I0911 19:17:02.629995    1296 services.go:156] Get log file "cloud-init.log" with journalctl command [-u cloud*].
I0911 19:17:10.543] I0911 19:17:03.044971    1296 services.go:156] Get log file "docker.log" with journalctl command [-u docker].
I0911 19:17:10.543] I0911 19:17:03.070950    1296 e2e_node_suite_test.go:201] Tests Finished
I0911 19:17:10.543] 
I0911 19:17:10.544] 
I0911 19:17:10.544] Ran 157 of 313 Specs in 798.695 seconds
I0911 19:17:10.544] SUCCESS! -- 157 Passed | 0 Failed | 0 Flaked | 0 Pending | 156 Skipped
I0911 19:17:10.545] 
I0911 19:17:10.545] 
I0911 19:17:10.545] Ginkgo ran 1 suite in 13m22.477367883s
I0911 19:17:10.545] Test Suite Passed
I0911 19:17:10.545] 
I0911 19:17:10.545] Success Finished Test Suite on Host tmp-node-e2e-8a9fbf66-cos-stable-60-9592-84-0
... skipping 6 lines ...
W0911 19:17:10.677] 2019/09/11 19:17:10 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 23m46.588740453s
W0911 19:17:10.677] 2019/09/11 19:17:10 node.go:42: Noop - Node DumpClusterLogs() - /workspace/_artifacts: 
W0911 19:17:10.677] 2019/09/11 19:17:10 node.go:52: Noop - Node Down()
W0911 19:17:10.677] 2019/09/11 19:17:10 process.go:96: Saved XML output to /workspace/_artifacts/junit_runner.xml.
W0911 19:17:10.677] 2019/09/11 19:17:10 process.go:153: Running: bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"
W0911 19:17:11.166] 2019/09/11 19:17:11 process.go:155: Step 'bash -c . hack/lib/version.sh && KUBE_ROOT=. kube::version::get_version_vars && echo "${KUBE_GIT_VERSION-}"' finished in 565.551573ms
W0911 19:17:11.168] 2019/09/11 19:17:11 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 19:17:11.170] Traceback (most recent call last):
W0911 19:17:11.171]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 778, in <module>
W0911 19:17:11.171]     main(parse_args())
W0911 19:17:11.172]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 626, in main
W0911 19:17:11.172]     mode.start(runner_args)
W0911 19:17:11.172]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 262, in start
W0911 19:17:11.173]     check_env(env, self.command, *args)
W0911 19:17:11.173]   File "/workspace/./test-infra/jenkins/../scenarios/kubernetes_e2e.py", line 111, in check_env
W0911 19:17:11.174]     subprocess.check_call(cmd, env=env)
W0911 19:17:11.175]   File "/usr/lib/python2.7/subprocess.py", line 186, in check_call
W0911 19:17:11.175]     raise CalledProcessError(retcode, cmd)
W0911 19:17:11.176] 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 19:17:11.192] Command failed
I0911 19:17:11.194] process 517 exited with code 1 after 23.8m
E0911 19:17:11.194] FAIL: pull-kubernetes-node-e2e
I0911 19:17:11.195] Call:  gcloud auth activate-service-account --key-file=/etc/service-account/service-account.json
W0911 19:17:11.956] Activated service account credentials for: [pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com]
I0911 19:17:12.061] process 39136 exited with code 0 after 0.0m
I0911 19:17:12.062] Call:  gcloud config get-value account
I0911 19:17:12.572] process 39148 exited with code 0 after 0.0m
I0911 19:17:12.573] Will upload results to gs://kubernetes-jenkins/pr-logs using pr-kubekins@kubernetes-jenkins-pull.iam.gserviceaccount.com
I0911 19:17:12.573] Upload result and artifacts...
I0911 19:17:12.573] Gubernator results at https://gubernator.k8s.io/build/kubernetes-jenkins/pr-logs/pull/batch/pull-kubernetes-node-e2e/1171858918855413760
I0911 19:17:12.574] Call:  gsutil ls gs://kubernetes-jenkins/pr-logs/pull/batch/pull-kubernetes-node-e2e/1171858918855413760/artifacts
W0911 19:17:14.200] CommandException: One or more URLs matched no objects.
E0911 19:17:14.350] Command failed
I0911 19:17:14.350] process 39160 exited with code 1 after 0.0m
W0911 19:17:14.350] Remote dir gs://kubernetes-jenkins/pr-logs/pull/batch/pull-kubernetes-node-e2e/1171858918855413760/artifacts not exist yet
I0911 19:17:14.351] 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/1171858918855413760/artifacts
I0911 19:17:18.471] process 39302 exited with code 0 after 0.1m
I0911 19:17:18.472] Call:  git rev-parse HEAD
I0911 19:17:18.486] process 39944 exited with code 0 after 0.0m
... skipping 21 lines ...