=== RUN TestFunctional/parallel/ServiceCmd
=== PAUSE TestFunctional/parallel/ServiceCmd
=== CONT TestFunctional/parallel/ServiceCmd
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1433: (dbg) Run: kubectl --context functional-174407 create deployment hello-node --image=k8s.gcr.io/echoserver:1.8
functional_test.go:1439: (dbg) Run: kubectl --context functional-174407 expose deployment hello-node --type=NodePort --port=8080
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1444: (dbg) TestFunctional/parallel/ServiceCmd: waiting 10m0s for pods matching "app=hello-node" in namespace "default" ...
helpers_test.go:342: "hello-node-5fcdfb5cc4-g86xs" [3e39f42a-6ec8-43df-a6e9-84df587ef63b] Pending / Ready:ContainersNotReady (containers with unready status: [echoserver]) / ContainersReady:ContainersNotReady (containers with unready status: [echoserver])
=== CONT TestFunctional/parallel/ServiceCmd
helpers_test.go:342: "hello-node-5fcdfb5cc4-g86xs" [3e39f42a-6ec8-43df-a6e9-84df587ef63b] Running
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1444: (dbg) TestFunctional/parallel/ServiceCmd: app=hello-node healthy within 30.1131902s
functional_test.go:1449: (dbg) Run: out/minikube-windows-amd64.exe -p functional-174407 service list
functional_test.go:1449: (dbg) Done: out/minikube-windows-amd64.exe -p functional-174407 service list: (2.2989783s)
functional_test.go:1463: (dbg) Run: out/minikube-windows-amd64.exe -p functional-174407 service --namespace=default --https --url hello-node
functional_test.go:1392: Failed to sent interrupt to proc not supported by windows
E1031 17:49:23.240054 12752 cert_rotation.go:168] key failed with : open C:\Users\jenkins.minikube3\minikube-integration\.minikube\profiles\addons-173130\client.crt: The system cannot find the path specified.
E1031 17:49:51.065240 12752 cert_rotation.go:168] key failed with : open C:\Users\jenkins.minikube3\minikube-integration\.minikube\profiles\addons-173130\client.crt: The system cannot find the path specified.
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1463: (dbg) Non-zero exit: out/minikube-windows-amd64.exe -p functional-174407 service --namespace=default --https --url hello-node: exit status 1 (35m13.1458192s)
-- stdout --
https://127.0.0.1:63538
-- /stdout --
** stderr **
! Because you are using a Docker driver on windows, the terminal needs to be open to run it.
** /stderr **
functional_test.go:1465: failed to get service url. args "out/minikube-windows-amd64.exe -p functional-174407 service --namespace=default --https --url hello-node" : exit status 1
functional_test.go:1402: service test failed - dumping debug information
functional_test.go:1403: -----------------------service failure post-mortem--------------------------------
functional_test.go:1406: (dbg) Run: kubectl --context functional-174407 describe po hello-node
functional_test.go:1410: hello-node pod describe:
Name: hello-node-5fcdfb5cc4-g86xs
Namespace: default
Priority: 0
Node: functional-174407/192.168.49.2
Start Time: Mon, 31 Oct 2022 17:48:21 +0000
Labels: app=hello-node
pod-template-hash=5fcdfb5cc4
Annotations: <none>
Status: Running
IP: 172.17.0.3
IPs:
IP: 172.17.0.3
Controlled By: ReplicaSet/hello-node-5fcdfb5cc4
Containers:
echoserver:
Container ID: docker://a310fd60ff6e5ea490425abaf9c40931dd969b0737d7b98f33ee5aac108b86e6
Image: k8s.gcr.io/echoserver:1.8
Image ID: docker-pullable://k8s.gcr.io/echoserver@sha256:cb3386f863f6a4b05f33c191361723f9d5927ac287463b1bea633bf859475969
Port: <none>
Host Port: <none>
State: Running
Started: Mon, 31 Oct 2022 17:48:45 +0000
Ready: True
Restart Count: 0
Environment: <none>
Mounts:
/var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-grjnv (ro)
Conditions:
Type Status
Initialized True
Ready True
ContainersReady True
PodScheduled True
Volumes:
kube-api-access-grjnv:
Type: Projected (a volume that contains injected data from multiple sources)
TokenExpirationSeconds: 3607
ConfigMapName: kube-root-ca.crt
ConfigMapOptional: <nil>
DownwardAPI: true
QoS Class: BestEffort
Node-Selectors: <none>
Tolerations: node.kubernetes.io/not-ready:NoExecute for 300s
node.kubernetes.io/unreachable:NoExecute for 300s
Events:
Type Reason Age From Message
---- ------ ---- ---- -------
Normal Scheduled <unknown> Successfully assigned default/hello-node-5fcdfb5cc4-g86xs to functional-174407
Normal Pulling 35m kubelet, functional-174407 Pulling image "k8s.gcr.io/echoserver:1.8"
Normal Pulled 35m kubelet, functional-174407 Successfully pulled image "k8s.gcr.io/echoserver:1.8" in 21.0779715s
Normal Created 35m kubelet, functional-174407 Created container echoserver
Normal Started 35m kubelet, functional-174407 Started container echoserver
Name: hello-node-connect-6458c8fb6f-dfnvk
Namespace: default
Priority: 0
Node: functional-174407/192.168.49.2
Start Time: Mon, 31 Oct 2022 17:50:43 +0000
Labels: app=hello-node-connect
pod-template-hash=6458c8fb6f
Annotations: <none>
Status: Running
IP: 172.17.0.7
IPs:
IP: 172.17.0.7
Controlled By: ReplicaSet/hello-node-connect-6458c8fb6f
Containers:
echoserver:
Container ID: docker://6d87ca38c1ed8147f8ffd5a21f83752625a2324084308d790d27714c00bfec8e
Image: k8s.gcr.io/echoserver:1.8
Image ID: docker-pullable://k8s.gcr.io/echoserver@sha256:cb3386f863f6a4b05f33c191361723f9d5927ac287463b1bea633bf859475969
Port: <none>
Host Port: <none>
State: Running
Started: Mon, 31 Oct 2022 17:50:45 +0000
Ready: True
Restart Count: 0
Environment: <none>
Mounts:
/var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-lt6ff (ro)
Conditions:
Type Status
Initialized True
Ready True
ContainersReady True
PodScheduled True
Volumes:
kube-api-access-lt6ff:
Type: Projected (a volume that contains injected data from multiple sources)
TokenExpirationSeconds: 3607
ConfigMapName: kube-root-ca.crt
ConfigMapOptional: <nil>
DownwardAPI: true
QoS Class: BestEffort
Node-Selectors: <none>
Tolerations: node.kubernetes.io/not-ready:NoExecute for 300s
node.kubernetes.io/unreachable:NoExecute for 300s
Events:
Type Reason Age From Message
---- ------ ---- ---- -------
Normal Scheduled <unknown> Successfully assigned default/hello-node-connect-6458c8fb6f-dfnvk to functional-174407
Normal Pulled 33m kubelet, functional-174407 Container image "k8s.gcr.io/echoserver:1.8" already present on machine
Normal Created 33m kubelet, functional-174407 Created container echoserver
Normal Started 33m kubelet, functional-174407 Started container echoserver
functional_test.go:1412: (dbg) Run: kubectl --context functional-174407 logs -l app=hello-node
functional_test.go:1416: hello-node logs:
functional_test.go:1418: (dbg) Run: kubectl --context functional-174407 describe svc hello-node
functional_test.go:1422: hello-node svc describe:
Name: hello-node
Namespace: default
Labels: app=hello-node
Annotations: <none>
Selector: app=hello-node
Type: NodePort
IP: 10.104.86.42
Port: <unset> 8080/TCP
TargetPort: 8080/TCP
NodePort: <unset> 30626/TCP
Endpoints: 172.17.0.3:8080
Session Affinity: None
External Traffic Policy: Cluster
Events: <none>
helpers_test.go:222: -----------------------post-mortem--------------------------------
helpers_test.go:230: ======> post-mortem[TestFunctional/parallel/ServiceCmd]: docker inspect <======
helpers_test.go:231: (dbg) Run: docker inspect functional-174407
helpers_test.go:235: (dbg) docker inspect functional-174407:
-- stdout --
[
{
"Id": "1808e0f28c536fcbea9d9e732ec317322a0b5b0df73d1b482d835e371ce2060b",
"Created": "2022-10-31T17:44:45.5554875Z",
"Path": "/usr/local/bin/entrypoint",
"Args": [
"/sbin/init"
],
"State": {
"Status": "running",
"Running": true,
"Paused": false,
"Restarting": false,
"OOMKilled": false,
"Dead": false,
"Pid": 27411,
"ExitCode": 0,
"Error": "",
"StartedAt": "2022-10-31T17:44:46.4747639Z",
"FinishedAt": "0001-01-01T00:00:00Z"
},
"Image": "sha256:866c1fe4e3f2d2bfd7e546c12f77c7ef1d94d65a891923ff6772712a9f20df40",
"ResolvConfPath": "/var/lib/docker/containers/1808e0f28c536fcbea9d9e732ec317322a0b5b0df73d1b482d835e371ce2060b/resolv.conf",
"HostnamePath": "/var/lib/docker/containers/1808e0f28c536fcbea9d9e732ec317322a0b5b0df73d1b482d835e371ce2060b/hostname",
"HostsPath": "/var/lib/docker/containers/1808e0f28c536fcbea9d9e732ec317322a0b5b0df73d1b482d835e371ce2060b/hosts",
"LogPath": "/var/lib/docker/containers/1808e0f28c536fcbea9d9e732ec317322a0b5b0df73d1b482d835e371ce2060b/1808e0f28c536fcbea9d9e732ec317322a0b5b0df73d1b482d835e371ce2060b-json.log",
"Name": "/functional-174407",
"RestartCount": 0,
"Driver": "overlay2",
"Platform": "linux",
"MountLabel": "",
"ProcessLabel": "",
"AppArmorProfile": "",
"ExecIDs": null,
"HostConfig": {
"Binds": [
"functional-174407:/var",
"/lib/modules:/lib/modules:ro"
],
"ContainerIDFile": "",
"LogConfig": {
"Type": "json-file",
"Config": {}
},
"NetworkMode": "functional-174407",
"PortBindings": {
"22/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "0"
}
],
"2376/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "0"
}
],
"32443/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "0"
}
],
"5000/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "0"
}
],
"8441/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "0"
}
]
},
"RestartPolicy": {
"Name": "no",
"MaximumRetryCount": 0
},
"AutoRemove": false,
"VolumeDriver": "",
"VolumesFrom": null,
"CapAdd": null,
"CapDrop": null,
"CgroupnsMode": "host",
"Dns": [],
"DnsOptions": [],
"DnsSearch": [],
"ExtraHosts": null,
"GroupAdd": null,
"IpcMode": "private",
"Cgroup": "",
"Links": null,
"OomScoreAdj": 0,
"PidMode": "",
"Privileged": true,
"PublishAllPorts": false,
"ReadonlyRootfs": false,
"SecurityOpt": [
"seccomp=unconfined",
"apparmor=unconfined",
"label=disable"
],
"Tmpfs": {
"/run": "",
"/tmp": ""
},
"UTSMode": "",
"UsernsMode": "",
"ShmSize": 67108864,
"Runtime": "runc",
"ConsoleSize": [
0,
0
],
"Isolation": "",
"CpuShares": 0,
"Memory": 4194304000,
"NanoCpus": 2000000000,
"CgroupParent": "",
"BlkioWeight": 0,
"BlkioWeightDevice": [],
"BlkioDeviceReadBps": null,
"BlkioDeviceWriteBps": null,
"BlkioDeviceReadIOps": null,
"BlkioDeviceWriteIOps": null,
"CpuPeriod": 0,
"CpuQuota": 0,
"CpuRealtimePeriod": 0,
"CpuRealtimeRuntime": 0,
"CpusetCpus": "",
"CpusetMems": "",
"Devices": [],
"DeviceCgroupRules": null,
"DeviceRequests": null,
"KernelMemory": 0,
"KernelMemoryTCP": 0,
"MemoryReservation": 0,
"MemorySwap": 4194304000,
"MemorySwappiness": null,
"OomKillDisable": false,
"PidsLimit": null,
"Ulimits": null,
"CpuCount": 0,
"CpuPercent": 0,
"IOMaximumIOps": 0,
"IOMaximumBandwidth": 0,
"MaskedPaths": null,
"ReadonlyPaths": null
},
"GraphDriver": {
"Data": {
"LowerDir": "/var/lib/docker/overlay2/f3694c7800d52387abc949f222f346864bdc1de3df2e1ff5a2f2d507fee71914-init/diff:/var/lib/docker/overlay2/57c743ceaabb12eb6d9b0f6cc214ca01c5ad94d1d13230c1006da6490086ae59/diff:/var/lib/docker/overlay2/bdf45c42710c252c1b8944b2aeffa381cb55ce81ed2494e0279a2012fc237744/diff:/var/lib/docker/overlay2/110ce6155d99294b18f90526d3c372fdccd6cff77a98cbe8eb75c2448a6d7082/diff:/var/lib/docker/overlay2/8db5cfbdc899cc584572d32608798ff0ccb3eeb3fcee067414c33a2abb2e1560/diff:/var/lib/docker/overlay2/7710bcacfb9f464b03f5d513d8172323300681477b071e541a6de310131d9d82/diff:/var/lib/docker/overlay2/22ddf489c277a93e61f902093082ca37e27a1fd64e79311f0158e30d03800e22/diff:/var/lib/docker/overlay2/11cc7e85f9197f227ac01fd49e39da953e4e76b0958c4d821bf19744c77870a8/diff:/var/lib/docker/overlay2/ec885729d11cadcc353020723e53ffff6c6a9d47e24f5a7e54f1ecb9e02d77aa/diff:/var/lib/docker/overlay2/eaac522dceac5e86c5c3b301d62ef5577bf6f9c9a26bbb8a4d50bb4a2d5e97f3/diff:/var/lib/docker/overlay2/472cf7
c546945bffb2c748a500d4d6577b2798aff184484104f07b6908b929af/diff:/var/lib/docker/overlay2/e123faeaeafda77ee6003972985f506df6d845f24cee23edcf253ed605fada51/diff:/var/lib/docker/overlay2/b00091230e5bd61754eae3e275810011ce8b4b11ee14639ddd9beb26e9dcd4c9/diff:/var/lib/docker/overlay2/5248414174a9bda014a802339cb31ec6f1e89a9ab02e6b65833406d1864f9fb9/diff:/var/lib/docker/overlay2/b16066c6453e4007eb387a3bbe3dc78db9fdfd7071303bdd1f4038de60cd9676/diff:/var/lib/docker/overlay2/2e8cbff988025589564212005ab920023cd9c4dbd54d6c7d0e187af170607ac8/diff:/var/lib/docker/overlay2/f8d84c683df0746ab6ee0dc59c8abd152aa971c2919b5844d8db4e330770ea78/diff:/var/lib/docker/overlay2/ec147d635302cb09ea0c4906a8dde5daf8aa3cc0df760cf5b710de46c5a53815/diff:/var/lib/docker/overlay2/3b9124d30f963011bd228980eff858041e15eee051ccfcd22d2450dddff8d683/diff:/var/lib/docker/overlay2/d1ff05557e6b5832429811725b59985dd02a9df863aff21564ff4f73682c1aa2/diff:/var/lib/docker/overlay2/f1a95f9b9a71b79f6c84ccfc90a3beb4531e7cd3e5ffecb340cb671f3e019b12/diff:/var/lib/d
ocker/overlay2/0fa9966487cbd96dc1bb1c9f122fc5334f75f051f06c7eed0b047a92cb865b34/diff:/var/lib/docker/overlay2/b73a9c0375be48dd3f4c33f886d0a48393e44cc113c7423dff5f2b871621ac3c/diff:/var/lib/docker/overlay2/51459e09edbaab92e7b600f1da92659f93f5a90d2555526c3a131c7749dc2924/diff:/var/lib/docker/overlay2/52e02fdb21bd66664af00e5f6ff3bbd9d5644389f9f95a5fce7b973e025f5969/diff:/var/lib/docker/overlay2/3c7f8f96594f12e5ab7aca179105956f40f1ae7533196f979e2d4795b495458a/diff:/var/lib/docker/overlay2/9ad51a87aeb4ac91ceb73458d0b5c4264aa0b4218730eb9f5993c386b2582679/diff:/var/lib/docker/overlay2/26ac6cc283c0377d0e013f2ce8ef7dc613dc13fc6a955949b85d5febc453f06c/diff:/var/lib/docker/overlay2/bb868de418e54b0cbf39c47b6e1c3fad39a72c5ff16ac5c1944b5f2d2717234f/diff:/var/lib/docker/overlay2/367028aa0d966103f06f71d2e73b5d7f213aaef5d56f389398f75567b5c08841/diff:/var/lib/docker/overlay2/9eb78c943176d5e39cecfe8136d35a730e0629a2c7e6a85dc219205d0fad2881/diff:/var/lib/docker/overlay2/836d5a3e695e3b35e66271f28c8ed65e4c8bcf79654a5dfe1a0a9a64f2d
3fc33/diff:/var/lib/docker/overlay2/acaaed3c9c944f6e28a87e8b62761c0cf08cd6e9b2b565b499c4ae587ee4d362/diff:/var/lib/docker/overlay2/3b561e8a83882401b6e1be778aa648045ea96ab6b7f56dae57b5fea09b792972/diff:/var/lib/docker/overlay2/66cff344b6951967761bc0bf14691ebd8f10acfbfbf7337d39df3a0ede46f75d/diff:/var/lib/docker/overlay2/ae62b4caf2b7de3a968cc2dae75b4b4deeddef6f2a981e80aca0dc805705a38f/diff:/var/lib/docker/overlay2/c6b254ae4a79317b5204d07d7eccbaf09f2c037f8e54131ea20f13f63c3bb361/diff:/var/lib/docker/overlay2/8a8b956e83e6f174c6903726e3f1df1ba1d55682e87138a2e7645994d0ad6197/diff:/var/lib/docker/overlay2/63d3498a12e5c5004b7fcdf739f698ed5650c7f4acf6b7b495f01f86f680bf2e/diff:/var/lib/docker/overlay2/4d85a951cb01693eeaa59c85b4c8dc4b1eedd8eefe6b0b3e155516d101fa3455/diff:/var/lib/docker/overlay2/9c01641a702ff7617d769718da0435fa086769ea50954db333c6923e8efd7e91/diff:/var/lib/docker/overlay2/2b01e9a3c7da7e528f3573d5898acc47ab3ddf783efef4f0aa3c2e45f0462cea/diff:/var/lib/docker/overlay2/e34175cf9346d45e60b992a992a3ebd7538d96
ff40ab4a9b1945e3f639b945e5/diff",
"MergedDir": "/var/lib/docker/overlay2/f3694c7800d52387abc949f222f346864bdc1de3df2e1ff5a2f2d507fee71914/merged",
"UpperDir": "/var/lib/docker/overlay2/f3694c7800d52387abc949f222f346864bdc1de3df2e1ff5a2f2d507fee71914/diff",
"WorkDir": "/var/lib/docker/overlay2/f3694c7800d52387abc949f222f346864bdc1de3df2e1ff5a2f2d507fee71914/work"
},
"Name": "overlay2"
},
"Mounts": [
{
"Type": "volume",
"Name": "functional-174407",
"Source": "/var/lib/docker/volumes/functional-174407/_data",
"Destination": "/var",
"Driver": "local",
"Mode": "z",
"RW": true,
"Propagation": ""
},
{
"Type": "bind",
"Source": "/lib/modules",
"Destination": "/lib/modules",
"Mode": "ro",
"RW": false,
"Propagation": "rprivate"
}
],
"Config": {
"Hostname": "functional-174407",
"Domainname": "",
"User": "root",
"AttachStdin": false,
"AttachStdout": false,
"AttachStderr": false,
"ExposedPorts": {
"22/tcp": {},
"2376/tcp": {},
"32443/tcp": {},
"5000/tcp": {},
"8441/tcp": {}
},
"Tty": true,
"OpenStdin": false,
"StdinOnce": false,
"Env": [
"container=docker",
"PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin"
],
"Cmd": null,
"Image": "gcr.io/k8s-minikube/kicbase-builds:v0.0.35-1666722858-15219@sha256:8debc1b6a335075c5f99bfbf131b4f5566f68c6500dc5991817832e55fcc9456",
"Volumes": null,
"WorkingDir": "",
"Entrypoint": [
"/usr/local/bin/entrypoint",
"/sbin/init"
],
"OnBuild": null,
"Labels": {
"created_by.minikube.sigs.k8s.io": "true",
"mode.minikube.sigs.k8s.io": "functional-174407",
"name.minikube.sigs.k8s.io": "functional-174407",
"role.minikube.sigs.k8s.io": ""
},
"StopSignal": "SIGRTMIN+3"
},
"NetworkSettings": {
"Bridge": "",
"SandboxID": "9ffdec95c7a4501f4e15302d498b3c1fe43bfefa711237fbf3956052e4f28441",
"HairpinMode": false,
"LinkLocalIPv6Address": "",
"LinkLocalIPv6PrefixLen": 0,
"Ports": {
"22/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "63270"
}
],
"2376/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "63271"
}
],
"32443/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "63272"
}
],
"5000/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "63273"
}
],
"8441/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "63274"
}
]
},
"SandboxKey": "/var/run/docker/netns/9ffdec95c7a4",
"SecondaryIPAddresses": null,
"SecondaryIPv6Addresses": null,
"EndpointID": "",
"Gateway": "",
"GlobalIPv6Address": "",
"GlobalIPv6PrefixLen": 0,
"IPAddress": "",
"IPPrefixLen": 0,
"IPv6Gateway": "",
"MacAddress": "",
"Networks": {
"functional-174407": {
"IPAMConfig": {
"IPv4Address": "192.168.49.2"
},
"Links": null,
"Aliases": [
"1808e0f28c53",
"functional-174407"
],
"NetworkID": "4e00f8b335eeb641a31b57f31800a1eb44cd66d1964ce7e75d31dbd21fd6bdb1",
"EndpointID": "49de21bd42aef7e1042a429de852d108a636dfced61a54c427223224144acb2e",
"Gateway": "192.168.49.1",
"IPAddress": "192.168.49.2",
"IPPrefixLen": 24,
"IPv6Gateway": "",
"GlobalIPv6Address": "",
"GlobalIPv6PrefixLen": 0,
"MacAddress": "02:42:c0:a8:31:02",
"DriverOpts": null
}
}
}
}
]
-- /stdout --
helpers_test.go:239: (dbg) Run: out/minikube-windows-amd64.exe status --format={{.Host}} -p functional-174407 -n functional-174407
helpers_test.go:239: (dbg) Done: out/minikube-windows-amd64.exe status --format={{.Host}} -p functional-174407 -n functional-174407: (1.7142787s)
helpers_test.go:244: <<< TestFunctional/parallel/ServiceCmd FAILED: start of post-mortem logs <<<
helpers_test.go:245: ======> post-mortem[TestFunctional/parallel/ServiceCmd]: minikube logs <======
helpers_test.go:247: (dbg) Run: out/minikube-windows-amd64.exe -p functional-174407 logs -n 25
helpers_test.go:247: (dbg) Done: out/minikube-windows-amd64.exe -p functional-174407 logs -n 25: (3.2506689s)
helpers_test.go:252: TestFunctional/parallel/ServiceCmd logs:
-- stdout --
*
* ==> Audit <==
* |----------------|------------------------------------------------------------------------|-------------------|-------------------|---------|---------------------|---------------------|
| Command | Args | Profile | User | Version | Start Time | End Time |
|----------------|------------------------------------------------------------------------|-------------------|-------------------|---------|---------------------|---------------------|
| start | -p functional-174407 --dry-run | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:50 GMT | |
| | --alsologtostderr -v=1 | | | | | |
| | --driver=docker | | | | | |
| start | -p functional-174407 | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:50 GMT | |
| | --dry-run --memory | | | | | |
| | 250MB --alsologtostderr | | | | | |
| | --driver=docker | | | | | |
| dashboard | --url --port 36195 | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:50 GMT | |
| | -p functional-174407 | | | | | |
| | --alsologtostderr -v=1 | | | | | |
| update-context | functional-174407 | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:50 GMT | 31 Oct 22 17:50 GMT |
| | update-context | | | | | |
| | --alsologtostderr -v=2 | | | | | |
| update-context | functional-174407 | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:50 GMT | 31 Oct 22 17:50 GMT |
| | update-context | | | | | |
| | --alsologtostderr -v=2 | | | | | |
| update-context | functional-174407 | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:50 GMT | 31 Oct 22 17:50 GMT |
| | update-context | | | | | |
| | --alsologtostderr -v=2 | | | | | |
| image | functional-174407 image load --daemon | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:50 GMT | 31 Oct 22 17:51 GMT |
| | gcr.io/google-containers/addon-resizer:functional-174407 | | | | | |
| image | functional-174407 image ls | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| image | functional-174407 image load --daemon | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | gcr.io/google-containers/addon-resizer:functional-174407 | | | | | |
| image | functional-174407 image ls | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| image | functional-174407 image load --daemon | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | gcr.io/google-containers/addon-resizer:functional-174407 | | | | | |
| image | functional-174407 image ls | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| image | functional-174407 image save | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | gcr.io/google-containers/addon-resizer:functional-174407 | | | | | |
| | C:\jenkins\workspace\Docker_Windows_integration\addon-resizer-save.tar | | | | | |
| image | functional-174407 image rm | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | gcr.io/google-containers/addon-resizer:functional-174407 | | | | | |
| image | functional-174407 image ls | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| image | functional-174407 image load | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | C:\jenkins\workspace\Docker_Windows_integration\addon-resizer-save.tar | | | | | |
| image | functional-174407 image ls | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| image | functional-174407 image save --daemon | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | gcr.io/google-containers/addon-resizer:functional-174407 | | | | | |
| image | functional-174407 image ls | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | --format yaml | | | | | |
| image | functional-174407 image ls | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | --format short | | | | | |
| image | functional-174407 image ls | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | --format json | | | | | |
| ssh | functional-174407 ssh pgrep | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | |
| | buildkitd | | | | | |
| image | functional-174407 image ls | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | --format table | | | | | |
| image | functional-174407 image build -t | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
| | localhost/my-image:functional-174407 | | | | | |
| | testdata\build | | | | | |
| image | functional-174407 image ls | functional-174407 | minikube3\jenkins | v1.27.1 | 31 Oct 22 17:51 GMT | 31 Oct 22 17:51 GMT |
|----------------|------------------------------------------------------------------------|-------------------|-------------------|---------|---------------------|---------------------|
*
* ==> Last Start <==
* Log file created at: 2022/10/31 17:50:51
Running on machine: minikube3
Binary: Built with gc go1.19.2 for windows/amd64
Log line format: [IWEF]mmdd hh:mm:ss.uuuuuu threadid file:line] msg
I1031 17:50:51.170290 14328 out.go:296] Setting OutFile to fd 676 ...
I1031 17:50:51.278165 14328 out.go:343] TERM=,COLORTERM=, which probably does not support color
I1031 17:50:51.278165 14328 out.go:309] Setting ErrFile to fd 976...
I1031 17:50:51.278165 14328 out.go:343] TERM=,COLORTERM=, which probably does not support color
I1031 17:50:51.304130 14328 out.go:303] Setting JSON to false
I1031 17:50:51.304820 14328 start.go:116] hostinfo: {"hostname":"minikube3","uptime":292944,"bootTime":1666945707,"procs":201,"os":"windows","platform":"Microsoft Windows 10 Enterprise N","platformFamily":"Standalone Workstation","platformVersion":"10.0.19045 Build 19045","kernelVersion":"10.0.19045 Build 19045","kernelArch":"x86_64","virtualizationSystem":"","virtualizationRole":"","hostId":"a0f355d5-8b6e-4346-9071-73232725d096"}
W1031 17:50:51.304820 14328 start.go:124] gopshost.Virtualization returned error: not implemented yet
I1031 17:50:51.309852 14328 out.go:177] * [functional-174407] minikube v1.27.1 sur Microsoft Windows 10 Enterprise N 10.0.19045 Build 19045
I1031 17:50:51.313234 14328 notify.go:220] Checking for updates...
I1031 17:50:51.315671 14328 out.go:177] - KUBECONFIG=C:\Users\jenkins.minikube3\minikube-integration\kubeconfig
I1031 17:50:51.320297 14328 out.go:177] - MINIKUBE_HOME=C:\Users\jenkins.minikube3\minikube-integration\.minikube
I1031 17:50:51.324767 14328 out.go:177] - MINIKUBE_LOCATION=15242
I1031 17:50:51.328044 14328 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I1031 17:50:51.331835 14328 config.go:180] Loaded profile config "functional-174407": Driver=docker, ContainerRuntime=docker, KubernetesVersion=v1.25.3
I1031 17:50:51.333239 14328 driver.go:365] Setting default libvirt URI to qemu:///system
I1031 17:50:51.789240 14328 docker.go:137] docker version: linux-20.10.20
I1031 17:50:51.807927 14328 cli_runner.go:164] Run: docker system info --format "{{json .}}"
I1031 17:50:52.723361 14328 info.go:266] docker info: {ID:TSZK:BILT:PRPM:VYD3:VAER:TKFK:77ZH:VWEB:QG4W:3HP3:3BMA:NCFX Containers:1 ContainersRunning:1 ContainersPaused:0 ContainersStopped:0 Images:1 Driver:overlay2 DriverStatus:[[Backing Filesystem extfs] [Supports d_type true] [Native Overlay Diff true] [userxattr false]] SystemStatus:<nil> Plugins:{Volume:[local] Network:[bridge host ipvlan macvlan null overlay] Authorization:<nil> Log:[awslogs fluentd gcplogs gelf journald json-file local logentries splunk syslog]} MemoryLimit:true SwapLimit:true KernelMemory:true KernelMemoryTCP:true CPUCfsPeriod:true CPUCfsQuota:true CPUShares:true CPUSet:true PidsLimit:true IPv4Forwarding:true BridgeNfIptables:true BridgeNfIP6Tables:true Debug:false NFd:61 OomKillDisable:true NGoroutines:59 SystemTime:2022-10-31 17:50:52.0292367 +0000 UTC LoggingDriver:json-file CgroupDriver:cgroupfs NEventsListener:4 KernelVersion:5.10.102.1-microsoft-standard-WSL2 OperatingSystem:Docker Desktop OSType:linux Architecture:x86
_64 IndexServerAddress:https://index.docker.io/v1/ RegistryConfig:{AllowNondistributableArtifactsCIDRs:[] AllowNondistributableArtifactsHostnames:[] InsecureRegistryCIDRs:[127.0.0.0/8] IndexConfigs:{DockerIo:{Name:docker.io Mirrors:[] Secure:true Official:true}} Mirrors:[]} NCPU:16 MemTotal:53902323712 GenericResources:<nil> DockerRootDir:/var/lib/docker HTTPProxy:http.docker.internal:3128 HTTPSProxy:http.docker.internal:3128 NoProxy:hubproxy.docker.internal Name:docker-desktop Labels:[] ExperimentalBuild:false ServerVersion:20.10.20 ClusterStore: ClusterAdvertise: Runtimes:{Runc:{Path:runc}} DefaultRuntime:runc Swarm:{NodeID: NodeAddr: LocalNodeState:inactive ControlAvailable:false Error: RemoteManagers:<nil>} LiveRestoreEnabled:false Isolation: InitBinary:docker-init ContainerdCommit:{ID:9cd3357b7fd7218e4aec3eae239db1f68a5a6ec6 Expected:9cd3357b7fd7218e4aec3eae239db1f68a5a6ec6} RuncCommit:{ID:v1.1.4-0-g5fd4c4d Expected:v1.1.4-0-g5fd4c4d} InitCommit:{ID:de40ad0 Expected:de40ad0} SecurityOptions:[name=seccomp
,profile=default] ProductLicense: Warnings:[WARNING: No blkio throttle.read_bps_device support WARNING: No blkio throttle.write_bps_device support WARNING: No blkio throttle.read_iops_device support WARNING: No blkio throttle.write_iops_device support] ServerErrors:[] ClientInfo:{Debug:false Plugins:[map[Name:buildx Path:C:\Program Files\Docker\cli-plugins\docker-buildx.exe SchemaVersion:0.1.0 ShortDescription:Docker Buildx Vendor:Docker Inc. Version:v0.9.1] map[Name:compose Path:C:\Program Files\Docker\cli-plugins\docker-compose.exe SchemaVersion:0.1.0 ShortDescription:Docker Compose Vendor:Docker Inc. Version:v2.12.1] map[Name:dev Path:C:\Program Files\Docker\cli-plugins\docker-dev.exe SchemaVersion:0.1.0 ShortDescription:Docker Dev Environments Vendor:Docker Inc. Version:v0.0.3] map[Name:extension Path:C:\Program Files\Docker\cli-plugins\docker-extension.exe SchemaVersion:0.1.0 ShortDescription:Manages Docker extensions Vendor:Docker Inc. Version:v0.2.13] map[Name:sbom Path:C:\Program Files\Docker\cli-plug
ins\docker-sbom.exe SchemaVersion:0.1.0 ShortDescription:View the packaged-based Software Bill Of Materials (SBOM) for an image URL:https://github.com/docker/sbom-cli-plugin Vendor:Anchore Inc. Version:0.6.0] map[Name:scan Path:C:\Program Files\Docker\cli-plugins\docker-scan.exe SchemaVersion:0.1.0 ShortDescription:Docker Scan Vendor:Docker Inc. Version:v0.21.0]] Warnings:<nil>}}
I1031 17:50:52.729076 14328 out.go:177] * Utilisation du pilote docker basé sur le profil existant
I1031 17:50:52.732018 14328 start.go:282] selected driver: docker
I1031 17:50:52.732052 14328 start.go:808] validating driver "docker" against &{Name:functional-174407 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.35-1666722858-15219@sha256:8debc1b6a335075c5f99bfbf131b4f5566f68c6500dc5991817832e55fcc9456 Memory:4000 CPUs:2 DiskSize:20000 VMDriver: Driver:docker HyperkitVpnKitSock: HyperkitVSockPorts:[] DockerEnv:[] ContainerVolumeMounts:[] InsecureRegistry:[] RegistryMirror:[] HostOnlyCIDR:192.168.59.1/24 HypervVirtualSwitch: HypervUseExternalSwitch:false HypervExternalAdapter: KVMNetwork:default KVMQemuURI:qemu:///system KVMGPU:false KVMHidden:false KVMNUMACount:1 APIServerPort:0 DockerOpt:[] DisableDriverMounts:false NFSShare:[] NFSSharesRoot:/nfsshares UUID: NoVTXCheck:false DNSProxy:false HostDNSResolver:true HostOnlyNicType:virtio NatNicType:virtio SSHIPAddress: SSHUser:root SSHKey: SSHPort:22 KubernetesConfig:{KubernetesVersion:v1.25.3 ClusterName:functional-174407 Namespace:default APIServerName:miniku
beCA APIServerNames:[] APIServerIPs:[] DNSDomain:cluster.local ContainerRuntime:docker CRISocket: NetworkPlugin: FeatureGates: ServiceCIDR:10.96.0.0/12 ImageRepository: LoadBalancerStartIP: LoadBalancerEndIP: CustomIngressCert: RegistryAliases: ExtraOptions:[{Component:apiserver Key:enable-admission-plugins Value:NamespaceAutoProvision}] ShouldLoadCachedImages:true EnableDefaultCNI:false CNI: NodeIP: NodePort:8441 NodeName:} Nodes:[{Name: IP:192.168.49.2 Port:8441 KubernetesVersion:v1.25.3 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[ambassador:false auto-pause:false cloud-spanner:false csi-hostpath-driver:false dashboard:false default-storageclass:true efk:false freshpod:false gcp-auth:false gvisor:false headlamp:false helm-tiller:false inaccel:false ingress:false ingress-dns:false istio:false istio-provisioner:false kong:false kubevirt:false logviewer:false metallb:false metrics-server:false nvidia-driver-installer:false nvidia-gpu-device-plugin:false olm:false pod-security-policy:fals
e portainer:false registry:false registry-aliases:false registry-creds:false storage-provisioner:true storage-provisioner-gluster:false volumesnapshots:false] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true] StartHostTimeout:6m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:C:\Users\jenkins.minikube3:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath: SocketVMnetClientPath:/opt/socket_vmnet/bin/socket_vmnet_client SocketVMnetPath:/var/run/socket_vmnet}
I1031 17:50:52.732052 14328 start.go:819] status for docker: {Installed:true Healthy:true Running:false NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I1031 17:50:52.815918 14328 out.go:177]
W1031 17:50:52.818766 14328 out.go:239] X Fermeture en raison de RSRC_INSUFFICIENT_REQ_MEMORY : L'allocation de mémoire demandée 250 Mio est inférieure au minimum utilisable de 1800 Mo
I1031 17:50:52.821099 14328 out.go:177]
*
* ==> Docker <==
* -- Logs begin at Mon 2022-10-31 17:44:47 UTC, end at Mon 2022-10-31 18:24:12 UTC. --
Oct 31 17:47:30 functional-174407 dockerd[8569]: time="2022-10-31T17:47:30.386034400Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint c026ef49f9727fdaef50c5a8be0c6f530744bdfccadc9460b9fb9003acdd8f6f 6038c74811386e46768a6bb9f28ffe0f16ab4ed5f7abe58a3b1f9adebf5e1159], retrying...."
Oct 31 17:47:30 functional-174407 dockerd[8569]: time="2022-10-31T17:47:30.497686000Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address"
Oct 31 17:47:30 functional-174407 dockerd[8569]: time="2022-10-31T17:47:30.626169000Z" level=info msg="Loading containers: done."
Oct 31 17:47:30 functional-174407 dockerd[8569]: time="2022-10-31T17:47:30.695608400Z" level=info msg="Docker daemon" commit=03df974 graphdriver(s)=overlay2 version=20.10.20
Oct 31 17:47:30 functional-174407 dockerd[8569]: time="2022-10-31T17:47:30.695797500Z" level=info msg="Daemon has completed initialization"
Oct 31 17:47:30 functional-174407 systemd[1]: Started Docker Application Container Engine.
Oct 31 17:47:30 functional-174407 dockerd[8569]: time="2022-10-31T17:47:30.761554700Z" level=info msg="API listen on [::]:2376"
Oct 31 17:47:30 functional-174407 dockerd[8569]: time="2022-10-31T17:47:30.770614900Z" level=info msg="API listen on /var/run/docker.sock"
Oct 31 17:47:41 functional-174407 dockerd[8569]: time="2022-10-31T17:47:41.528800000Z" level=info msg="ignoring event" container=a7b9fe5bf027ea61898fde850be98a6b62e4b5dbfa6e9dfd466de52e0c9526c6 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:41 functional-174407 dockerd[8569]: time="2022-10-31T17:47:41.615183400Z" level=info msg="ignoring event" container=94fd0fd40d4858c4a7fd2126fd40ab36f512247a57497878226031216cd54f8e module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:41 functional-174407 dockerd[8569]: time="2022-10-31T17:47:41.623698500Z" level=info msg="ignoring event" container=c5529b7a120bb2e29978a8e70feb501137d3a08f1036d4a9c25d63b3792eb5ab module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:41 functional-174407 dockerd[8569]: time="2022-10-31T17:47:41.724431400Z" level=info msg="ignoring event" container=35bfd8db17b1136d162371f9b4f5c36b83a973b02f49bcd0e62078c362a03b4e module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:41 functional-174407 dockerd[8569]: time="2022-10-31T17:47:41.724664200Z" level=info msg="ignoring event" container=60c67eac934119b9828b83c8b6957c78079153852adc78b8597fc0c5473e5412 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:41 functional-174407 dockerd[8569]: time="2022-10-31T17:47:41.724898100Z" level=info msg="ignoring event" container=2f0af998ae0775e986035cb90197ff1d4a6a37c7894600d1b6012e6aaa4f3dc6 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:41 functional-174407 dockerd[8569]: time="2022-10-31T17:47:41.815161200Z" level=info msg="ignoring event" container=4e2ad69be86fc4c7e96282440cbb43be9877d04b7baddbc5618538f942596145 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:41 functional-174407 dockerd[8569]: time="2022-10-31T17:47:41.818756500Z" level=info msg="ignoring event" container=f88668280d79b994a3ba57699c756d324d08e8195faa053cc1b103b4fed672ee module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:41 functional-174407 dockerd[8569]: time="2022-10-31T17:47:41.820214400Z" level=info msg="ignoring event" container=498b1353b69822c05f68612e855d51c592296f4671fba264b01ecd2ab003c3c4 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:41 functional-174407 dockerd[8569]: time="2022-10-31T17:47:41.820370000Z" level=info msg="ignoring event" container=8fc8c4ad1288e5a0fb5d4179a6c63376257dc7d8ecbde5bac17a0e5296a40f48 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:43 functional-174407 dockerd[8569]: time="2022-10-31T17:47:43.428826100Z" level=info msg="ignoring event" container=b2f79600282ba2c0915a795a7747772a6f92e156411ce69daa9ed594fed488b2 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:43 functional-174407 dockerd[8569]: time="2022-10-31T17:47:43.519437900Z" level=info msg="ignoring event" container=3d1f027ebb4368de825e63e73fb441c8739cfb4744456fe1d9f3581aab505eed module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:47:57 functional-174407 dockerd[8569]: time="2022-10-31T17:47:57.946091800Z" level=info msg="ignoring event" container=1c83c1625232910e9173f8ad96dd952f4aa9f5978fe24284f3b3caf155f27620 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:50:32 functional-174407 dockerd[8569]: time="2022-10-31T17:50:32.952720300Z" level=info msg="ignoring event" container=e076eff0b083765794414ae7e5c8c365e1e7b913551ffa333bd5d2dfe1f910ff module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:50:33 functional-174407 dockerd[8569]: time="2022-10-31T17:50:33.439466900Z" level=info msg="ignoring event" container=46be2710a5362cea315e806bb43b07f705f0a5b17d21f801be44f5cae5973662 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:51:56 functional-174407 dockerd[8569]: time="2022-10-31T17:51:56.311106000Z" level=info msg="ignoring event" container=a914d9f8870b2f8c44bf83543bc7627ea556cb6740995237b37a74f42221cf62 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Oct 31 17:51:56 functional-174407 dockerd[8569]: time="2022-10-31T17:51:56.859996900Z" level=info msg="Layer sha256:8d988d9cbd4c3812fb85f3c741a359985602af139e727005f4d4471ac42f9d1a cleaned up"
*
* ==> container status <==
* CONTAINER IMAGE CREATED STATE NAME ATTEMPT POD ID
6d87ca38c1ed8 82e4c8a736a4f 33 minutes ago Running echoserver 0 f84cf92edf7e2
b272f36fc5f77 nginx@sha256:943c25b4b66b332184d5ba6bb18234273551593016c0e0ae906bab111548239f 33 minutes ago Running myfrontend 0 c7b0b40cb0381
1dccc4696e733 nginx@sha256:2452715dd322b3273419652b7721b64aa60305f606ef7a674ae28b6f12d155a3 33 minutes ago Running nginx 0 c9085b61489a9
de32a9ebcaf4b mysql@sha256:f5e2d4d7dccdc3f2a1d592bd3f0eb472b2f72f9fb942a84ff5b5cc049fe63a04 34 minutes ago Running mysql 0 daba4da4651dd
a310fd60ff6e5 k8s.gcr.io/echoserver@sha256:cb3386f863f6a4b05f33c191361723f9d5927ac287463b1bea633bf859475969 35 minutes ago Running echoserver 0 32610544e85cd
596a882c801ab 5185b96f0becf 36 minutes ago Running coredns 4 c3522096b5aa7
311f7bffce197 beaaf00edd38a 36 minutes ago Running kube-proxy 4 c06126d4dfa82
c0a2fe2150cf4 6e38f40d628db 36 minutes ago Running storage-provisioner 4 d04e05692e0ea
38e183319b11a 0346dbd74bcb9 36 minutes ago Running kube-apiserver 0 3191a284235f4
bef2d234ba11b a8a176a5d5d69 36 minutes ago Running etcd 4 6a0122b3ed700
bd0976610ee51 6039992312758 36 minutes ago Running kube-controller-manager 4 c163f210e7561
a3ab9ebff2b87 6d23ec0e8b87e 36 minutes ago Running kube-scheduler 4 96d1f0102230e
2f0af998ae077 a8a176a5d5d69 36 minutes ago Exited etcd 3 60c67eac93411
8fc8c4ad1288e beaaf00edd38a 36 minutes ago Exited kube-proxy 3 4e2ad69be86fc
f88668280d79b 6039992312758 36 minutes ago Exited kube-controller-manager 3 498b1353b6982
3d1f027ebb436 6d23ec0e8b87e 36 minutes ago Exited kube-scheduler 3 94fd0fd40d485
ad2349895e788 5185b96f0becf 36 minutes ago Exited coredns 3 cdb738b240114
304eec0d9d050 6e38f40d628db 37 minutes ago Exited storage-provisioner 3 b1d6342de35ce
*
* ==> coredns [596a882c801a] <==
* .:53
[INFO] plugin/reload: Running configuration SHA512 = a1b5920ef1e8e10875eeec3214b810e7e404fdaf6cfe53f31cc42ae1e9ba5884ecf886330489b6b02fba5b37a31406fcb402b2501c7ab0318fc890d74b6fae55
CoreDNS-1.9.3
linux/amd64, go1.18.2, 45b0a11
*
* ==> coredns [ad2349895e78] <==
* [INFO] plugin/kubernetes: waiting for Kubernetes API before starting server
[INFO] plugin/ready: Still waiting on: "kubernetes"
[INFO] plugin/kubernetes: waiting for Kubernetes API before starting server
[INFO] plugin/kubernetes: waiting for Kubernetes API before starting server
[INFO] plugin/ready: Still waiting on: "kubernetes"
[INFO] plugin/kubernetes: waiting for Kubernetes API before starting server
[INFO] plugin/kubernetes: waiting for Kubernetes API before starting server
[INFO] plugin/kubernetes: waiting for Kubernetes API before starting server
[INFO] plugin/kubernetes: waiting for Kubernetes API before starting server
[INFO] plugin/kubernetes: waiting for Kubernetes API before starting server
[INFO] plugin/kubernetes: waiting for Kubernetes API before starting server
[INFO] SIGTERM: Shutting down servers then terminating
[WARNING] plugin/kubernetes: starting server with unsynced Kubernetes API
.:53
[INFO] plugin/reload: Running configuration SHA512 = a1b5920ef1e8e10875eeec3214b810e7e404fdaf6cfe53f31cc42ae1e9ba5884ecf886330489b6b02fba5b37a31406fcb402b2501c7ab0318fc890d74b6fae55
CoreDNS-1.9.3
linux/amd64, go1.18.2, 45b0a11
[INFO] plugin/health: Going into lameduck mode for 5s
[WARNING] plugin/kubernetes: Kubernetes API connection failure: Get "https://10.96.0.1:443/version": dial tcp 10.96.0.1:443: connect: connection refused
*
* ==> describe nodes <==
* Name: functional-174407
Roles: control-plane
Labels: beta.kubernetes.io/arch=amd64
beta.kubernetes.io/os=linux
kubernetes.io/arch=amd64
kubernetes.io/hostname=functional-174407
kubernetes.io/os=linux
minikube.k8s.io/commit=c34ec3182cacd96a3e168acffe335374d66b10cc
minikube.k8s.io/name=functional-174407
minikube.k8s.io/primary=true
minikube.k8s.io/updated_at=2022_10_31T17_45_24_0700
minikube.k8s.io/version=v1.27.1
node-role.kubernetes.io/control-plane=
node.kubernetes.io/exclude-from-external-load-balancers=
Annotations: kubeadm.alpha.kubernetes.io/cri-socket: unix:///var/run/cri-dockerd.sock
node.alpha.kubernetes.io/ttl: 0
volumes.kubernetes.io/controller-managed-attach-detach: true
CreationTimestamp: Mon, 31 Oct 2022 17:45:19 +0000
Taints: <none>
Unschedulable: false
Lease:
HolderIdentity: functional-174407
AcquireTime: <unset>
RenewTime: Mon, 31 Oct 2022 18:24:05 +0000
Conditions:
Type Status LastHeartbeatTime LastTransitionTime Reason Message
---- ------ ----------------- ------------------ ------ -------
MemoryPressure False Mon, 31 Oct 2022 18:23:08 +0000 Mon, 31 Oct 2022 17:45:18 +0000 KubeletHasSufficientMemory kubelet has sufficient memory available
DiskPressure False Mon, 31 Oct 2022 18:23:08 +0000 Mon, 31 Oct 2022 17:45:18 +0000 KubeletHasNoDiskPressure kubelet has no disk pressure
PIDPressure False Mon, 31 Oct 2022 18:23:08 +0000 Mon, 31 Oct 2022 17:45:18 +0000 KubeletHasSufficientPID kubelet has sufficient PID available
Ready True Mon, 31 Oct 2022 18:23:08 +0000 Mon, 31 Oct 2022 17:45:35 +0000 KubeletReady kubelet is posting ready status
Addresses:
InternalIP: 192.168.49.2
Hostname: functional-174407
Capacity:
cpu: 16
ephemeral-storage: 263174212Ki
hugepages-1Gi: 0
hugepages-2Mi: 0
memory: 52638988Ki
pods: 110
Allocatable:
cpu: 16
ephemeral-storage: 263174212Ki
hugepages-1Gi: 0
hugepages-2Mi: 0
memory: 52638988Ki
pods: 110
System Info:
Machine ID: 996614ec4c814b87b7ec8ebee3d0e8c9
System UUID: 996614ec4c814b87b7ec8ebee3d0e8c9
Boot ID: 85ed61db-24b5-4ef3-987d-7028127e7a77
Kernel Version: 5.10.102.1-microsoft-standard-WSL2
OS Image: Ubuntu 20.04.5 LTS
Operating System: linux
Architecture: amd64
Container Runtime Version: docker://20.10.20
Kubelet Version: v1.25.3
Kube-Proxy Version: v1.25.3
PodCIDR: 10.244.0.0/24
PodCIDRs: 10.244.0.0/24
Non-terminated Pods: (12 in total)
Namespace Name CPU Requests CPU Limits Memory Requests Memory Limits Age
--------- ---- ------------ ---------- --------------- ------------- ---
default hello-node-5fcdfb5cc4-g86xs 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 35m
default hello-node-connect-6458c8fb6f-dfnvk 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 33m
default mysql-596b7fcdbf-rwvlg 600m (3%!)(MISSING) 700m (4%!)(MISSING) 512Mi (0%!)(MISSING) 700Mi (1%!)(MISSING) 35m
default nginx-svc 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 35m
default sp-pod 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 33m
kube-system coredns-565d847f94-wdgzw 100m (0%!)(MISSING) 0 (0%!)(MISSING) 70Mi (0%!)(MISSING) 170Mi (0%!)(MISSING) 38m
kube-system etcd-functional-174407 100m (0%!)(MISSING) 0 (0%!)(MISSING) 100Mi (0%!)(MISSING) 0 (0%!)(MISSING) 38m
kube-system kube-apiserver-functional-174407 250m (1%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 36m
kube-system kube-controller-manager-functional-174407 200m (1%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 38m
kube-system kube-proxy-ntf2v 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 38m
kube-system kube-scheduler-functional-174407 100m (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 38m
kube-system storage-provisioner 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 38m
Allocated resources:
(Total limits may be over 100 percent, i.e., overcommitted.)
Resource Requests Limits
-------- -------- ------
cpu 1350m (8%!)(MISSING) 700m (4%!)(MISSING)
memory 682Mi (1%!)(MISSING) 870Mi (1%!)(MISSING)
ephemeral-storage 0 (0%!)(MISSING) 0 (0%!)(MISSING)
hugepages-1Gi 0 (0%!)(MISSING) 0 (0%!)(MISSING)
hugepages-2Mi 0 (0%!)(MISSING) 0 (0%!)(MISSING)
Events:
Type Reason Age From Message
---- ------ ---- ---- -------
Normal Starting 38m kube-proxy
Normal Starting 36m kube-proxy
Normal Starting 37m kube-proxy
Normal NodeHasSufficientMemory 39m (x7 over 39m) kubelet Node functional-174407 status is now: NodeHasSufficientMemory
Normal NodeHasNoDiskPressure 39m (x6 over 39m) kubelet Node functional-174407 status is now: NodeHasNoDiskPressure
Normal NodeHasSufficientPID 39m (x6 over 39m) kubelet Node functional-174407 status is now: NodeHasSufficientPID
Normal Starting 38m kubelet Starting kubelet.
Normal NodeHasSufficientMemory 38m kubelet Node functional-174407 status is now: NodeHasSufficientMemory
Normal NodeHasNoDiskPressure 38m kubelet Node functional-174407 status is now: NodeHasNoDiskPressure
Normal NodeHasSufficientPID 38m kubelet Node functional-174407 status is now: NodeHasSufficientPID
Normal NodeAllocatableEnforced 38m kubelet Updated Node Allocatable limit across pods
Normal NodeReady 38m kubelet Node functional-174407 status is now: NodeReady
Normal RegisteredNode 38m node-controller Node functional-174407 event: Registered Node functional-174407 in Controller
Normal RegisteredNode 37m node-controller Node functional-174407 event: Registered Node functional-174407 in Controller
Normal Starting 36m kubelet Starting kubelet.
Normal NodeHasSufficientMemory 36m (x8 over 36m) kubelet Node functional-174407 status is now: NodeHasSufficientMemory
Normal NodeHasNoDiskPressure 36m (x8 over 36m) kubelet Node functional-174407 status is now: NodeHasNoDiskPressure
Normal NodeHasSufficientPID 36m (x7 over 36m) kubelet Node functional-174407 status is now: NodeHasSufficientPID
Normal NodeAllocatableEnforced 36m kubelet Updated Node Allocatable limit across pods
Normal RegisteredNode 36m node-controller Node functional-174407 event: Registered Node functional-174407 in Controller
*
* ==> dmesg <==
* [Oct31 17:59] WSL2: Performing memory compaction.
[Oct31 18:00] WSL2: Performing memory compaction.
[Oct31 18:01] WSL2: Performing memory compaction.
[Oct31 18:02] WSL2: Performing memory compaction.
[Oct31 18:03] WSL2: Performing memory compaction.
[Oct31 18:04] WSL2: Performing memory compaction.
[Oct31 18:05] WSL2: Performing memory compaction.
[Oct31 18:06] WSL2: Performing memory compaction.
[Oct31 18:07] WSL2: Performing memory compaction.
[Oct31 18:08] WSL2: Performing memory compaction.
[Oct31 18:09] WSL2: Performing memory compaction.
[Oct31 18:10] WSL2: Performing memory compaction.
[Oct31 18:11] WSL2: Performing memory compaction.
[Oct31 18:12] WSL2: Performing memory compaction.
[Oct31 18:13] WSL2: Performing memory compaction.
[Oct31 18:14] WSL2: Performing memory compaction.
[Oct31 18:15] WSL2: Performing memory compaction.
[Oct31 18:16] WSL2: Performing memory compaction.
[Oct31 18:17] WSL2: Performing memory compaction.
[Oct31 18:18] WSL2: Performing memory compaction.
[Oct31 18:19] WSL2: Performing memory compaction.
[Oct31 18:20] WSL2: Performing memory compaction.
[Oct31 18:21] WSL2: Performing memory compaction.
[Oct31 18:22] WSL2: Performing memory compaction.
[Oct31 18:23] WSL2: Performing memory compaction.
*
* ==> etcd [2f0af998ae07] <==
* {"level":"info","ts":"2022-10-31T17:47:36.837Z","caller":"embed/etcd.go:581","msg":"serving peer traffic","address":"192.168.49.2:2380"}
{"level":"info","ts":"2022-10-31T17:47:36.837Z","caller":"embed/etcd.go:553","msg":"cmux::serve","address":"192.168.49.2:2380"}
{"level":"info","ts":"2022-10-31T17:47:38.519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aec36adc501070cc is starting a new election at term 4"}
{"level":"info","ts":"2022-10-31T17:47:38.520Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aec36adc501070cc became pre-candidate at term 4"}
{"level":"info","ts":"2022-10-31T17:47:38.520Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aec36adc501070cc received MsgPreVoteResp from aec36adc501070cc at term 4"}
{"level":"info","ts":"2022-10-31T17:47:38.520Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aec36adc501070cc became candidate at term 5"}
{"level":"info","ts":"2022-10-31T17:47:38.520Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aec36adc501070cc received MsgVoteResp from aec36adc501070cc at term 5"}
{"level":"info","ts":"2022-10-31T17:47:38.520Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aec36adc501070cc became leader at term 5"}
{"level":"info","ts":"2022-10-31T17:47:38.520Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aec36adc501070cc elected leader aec36adc501070cc at term 5"}
{"level":"info","ts":"2022-10-31T17:47:38.540Z","caller":"etcdserver/server.go:2042","msg":"published local member to cluster through raft","local-member-id":"aec36adc501070cc","local-member-attributes":"{Name:functional-174407 ClientURLs:[https://192.168.49.2:2379]}","request-path":"/0/members/aec36adc501070cc/attributes","cluster-id":"fa54960ea34d58be","publish-timeout":"7s"}
{"level":"info","ts":"2022-10-31T17:47:38.540Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"}
{"level":"info","ts":"2022-10-31T17:47:38.540Z","caller":"embed/serve.go:98","msg":"ready to serve client requests"}
{"level":"info","ts":"2022-10-31T17:47:38.614Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"}
{"level":"info","ts":"2022-10-31T17:47:38.614Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"}
{"level":"info","ts":"2022-10-31T17:47:38.616Z","caller":"embed/serve.go:188","msg":"serving client traffic securely","address":"127.0.0.1:2379"}
{"level":"info","ts":"2022-10-31T17:47:38.616Z","caller":"embed/serve.go:188","msg":"serving client traffic securely","address":"192.168.49.2:2379"}
{"level":"info","ts":"2022-10-31T17:47:41.135Z","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"}
{"level":"info","ts":"2022-10-31T17:47:41.135Z","caller":"embed/etcd.go:368","msg":"closing etcd server","name":"functional-174407","data-dir":"/var/lib/minikube/etcd","advertise-peer-urls":["https://192.168.49.2:2380"],"advertise-client-urls":["https://192.168.49.2:2379"]}
{"level":"warn","ts":"2022-10-31T17:47:41.136Z","caller":"embed/config_logging.go:169","msg":"rejected connection","remote-addr":"127.0.0.1:35318","server-name":"","error":"read tcp 127.0.0.1:2379->127.0.0.1:35318: use of closed network connection"}
WARNING: 2022/10/31 17:47:41 [core] grpc: addrConn.createTransport failed to connect to {127.0.0.1:2379 127.0.0.1:2379 <nil> 0 <nil>}. Err: connection error: desc = "transport: Error while dialing dial tcp 127.0.0.1:2379: connect: connection refused". Reconnecting...
WARNING: 2022/10/31 17:47:41 [core] grpc: addrConn.createTransport failed to connect to {192.168.49.2:2379 192.168.49.2:2379 <nil> 0 <nil>}. Err: connection error: desc = "transport: Error while dialing dial tcp 192.168.49.2:2379: connect: connection refused". Reconnecting...
{"level":"info","ts":"2022-10-31T17:47:41.224Z","caller":"etcdserver/server.go:1453","msg":"skipped leadership transfer for single voting member cluster","local-member-id":"aec36adc501070cc","current-leader-member-id":"aec36adc501070cc"}
{"level":"info","ts":"2022-10-31T17:47:41.328Z","caller":"embed/etcd.go:563","msg":"stopping serving peer traffic","address":"192.168.49.2:2380"}
{"level":"info","ts":"2022-10-31T17:47:41.414Z","caller":"embed/etcd.go:568","msg":"stopped serving peer traffic","address":"192.168.49.2:2380"}
{"level":"info","ts":"2022-10-31T17:47:41.415Z","caller":"embed/etcd.go:370","msg":"closed etcd server","name":"functional-174407","data-dir":"/var/lib/minikube/etcd","advertise-peer-urls":["https://192.168.49.2:2380"],"advertise-client-urls":["https://192.168.49.2:2379"]}
*
* ==> etcd [bef2d234ba11] <==
* {"level":"warn","ts":"2022-10-31T17:50:24.781Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"723.6726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/\" range_end:\"/registry/pods/default0\" ","response":"range_response_count:4 size:10836"}
{"level":"info","ts":"2022-10-31T17:50:24.781Z","caller":"traceutil/trace.go:171","msg":"trace[2039025052] range","detail":"{range_begin:/registry/pods/default/; range_end:/registry/pods/default0; response_count:4; response_revision:792; }","duration":"724.3191ms","start":"2022-10-31T17:50:24.057Z","end":"2022-10-31T17:50:24.781Z","steps":["trace[2039025052] 'agreement among raft nodes before linearized reading' (duration: 723.1521ms)"],"step_count":1}
{"level":"warn","ts":"2022-10-31T17:50:24.781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2022-10-31T17:50:24.057Z","time spent":"724.3863ms","remote":"127.0.0.1:35662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":10860,"request content":"key:\"/registry/pods/default/\" range_end:\"/registry/pods/default0\" "}
{"level":"warn","ts":"2022-10-31T17:50:36.026Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"110.6492ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8128016765568569365 username:\"kube-apiserver-etcd-client\" auth_revision:1 > lease_grant:<ttl:3660-second id:70cc842f28225014>","response":"size:42"}
{"level":"info","ts":"2022-10-31T17:50:36.027Z","caller":"traceutil/trace.go:171","msg":"trace[746936390] linearizableReadLoop","detail":"{readStateIndex:900; appliedIndex:899; }","duration":"109.362ms","start":"2022-10-31T17:50:35.917Z","end":"2022-10-31T17:50:36.027Z","steps":["trace[746936390] 'read index received' (duration: 14.4937ms)","trace[746936390] 'applied index is now lower than readState.Index' (duration: 94.7617ms)"],"step_count":2}
{"level":"warn","ts":"2022-10-31T17:50:36.028Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"109.3435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/sp-pod\" ","response":"range_response_count:1 size:1965"}
{"level":"info","ts":"2022-10-31T17:50:36.028Z","caller":"traceutil/trace.go:171","msg":"trace[694528779] range","detail":"{range_begin:/registry/pods/default/sp-pod; range_end:; response_count:1; response_revision:816; }","duration":"109.4176ms","start":"2022-10-31T17:50:35.918Z","end":"2022-10-31T17:50:36.028Z","steps":["trace[694528779] 'agreement among raft nodes before linearized reading' (duration: 109.0696ms)"],"step_count":1}
{"level":"warn","ts":"2022-10-31T17:50:36.028Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"110.3058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/\" range_end:\"/registry/pods/default0\" ","response":"range_response_count:4 size:10080"}
{"level":"info","ts":"2022-10-31T17:50:36.028Z","caller":"traceutil/trace.go:171","msg":"trace[521681701] range","detail":"{range_begin:/registry/pods/default/; range_end:/registry/pods/default0; response_count:4; response_revision:816; }","duration":"110.4422ms","start":"2022-10-31T17:50:35.917Z","end":"2022-10-31T17:50:36.028Z","steps":["trace[521681701] 'agreement among raft nodes before linearized reading' (duration: 109.7564ms)"],"step_count":1}
{"level":"warn","ts":"2022-10-31T17:50:36.028Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"107.3566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/default/myclaim\" ","response":"range_response_count:1 size:1610"}
{"level":"info","ts":"2022-10-31T17:50:36.028Z","caller":"traceutil/trace.go:171","msg":"trace[1546852245] range","detail":"{range_begin:/registry/persistentvolumeclaims/default/myclaim; range_end:; response_count:1; response_revision:816; }","duration":"107.4277ms","start":"2022-10-31T17:50:35.921Z","end":"2022-10-31T17:50:36.028Z","steps":["trace[1546852245] 'agreement among raft nodes before linearized reading' (duration: 107.0302ms)"],"step_count":1}
{"level":"info","ts":"2022-10-31T17:57:52.761Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":948}
{"level":"info","ts":"2022-10-31T17:57:52.762Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":948,"took":"1.161ms"}
{"level":"info","ts":"2022-10-31T18:02:52.920Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1158}
{"level":"info","ts":"2022-10-31T18:02:52.921Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1158,"took":"971.6µs"}
{"level":"info","ts":"2022-10-31T18:07:52.945Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1369}
{"level":"info","ts":"2022-10-31T18:07:52.946Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1369,"took":"961.1µs"}
{"level":"info","ts":"2022-10-31T18:12:52.959Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1579}
{"level":"info","ts":"2022-10-31T18:12:52.960Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1579,"took":"552.6µs"}
{"level":"info","ts":"2022-10-31T18:17:52.982Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1789}
{"level":"info","ts":"2022-10-31T18:17:52.984Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1789,"took":"1.0863ms"}
{"level":"warn","ts":"2022-10-31T18:20:51.227Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"192.6268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2022-10-31T18:20:51.227Z","caller":"traceutil/trace.go:171","msg":"trace[189339562] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2123; }","duration":"192.7781ms","start":"2022-10-31T18:20:51.034Z","end":"2022-10-31T18:20:51.227Z","steps":["trace[189339562] 'agreement among raft nodes before linearized reading' (duration: 93.3933ms)","trace[189339562] 'range keys from in-memory index tree' (duration: 99.2029ms)"],"step_count":2}
{"level":"info","ts":"2022-10-31T18:22:53.001Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1999}
{"level":"info","ts":"2022-10-31T18:22:53.002Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1999,"took":"622.7µs"}
*
* ==> kernel <==
* 18:24:12 up 1:38, 0 users, load average: 0.42, 0.37, 0.56
Linux functional-174407 5.10.102.1-microsoft-standard-WSL2 #1 SMP Wed Mar 2 00:30:59 UTC 2022 x86_64 x86_64 x86_64 GNU/Linux
PRETTY_NAME="Ubuntu 20.04.5 LTS"
*
* ==> kube-apiserver [38e183319b11] <==
* I1031 17:49:53.542496 1 trace.go:205] Trace[1117639814]: "List" url:/api/v1/namespaces/default/pods,user-agent:e2e-windows-amd64.exe/v0.0.0 (windows/amd64) kubernetes/$Format,audit-id:f3ba0f5e-f51c-422c-87af-2a6dd282e065,client:192.168.49.1,accept:application/json, */*,protocol:HTTP/2.0 (31-Oct-2022 17:49:52.938) (total time: 603ms):
Trace[1117639814]: ---"Listing from storage done" 603ms (17:49:53.541)
Trace[1117639814]: [603.9437ms] [603.9437ms] END
I1031 17:50:24.745548 1 trace.go:205] Trace[1448715339]: "GuaranteedUpdate etcd3" audit-id:55f487dd-6017-42b8-8968-33f2dca641cf,key:/leases/kube-node-lease/functional-174407,type:*coordination.Lease (31-Oct-2022 17:50:24.189) (total time: 555ms):
Trace[1448715339]: ---"Txn call finished" err:<nil> 555ms (17:50:24.745)
Trace[1448715339]: [555.8903ms] [555.8903ms] END
I1031 17:50:24.745885 1 trace.go:205] Trace[1067718572]: "Update" url:/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/functional-174407,user-agent:kubelet/v1.25.3 (linux/amd64) kubernetes/434bfd8,audit-id:55f487dd-6017-42b8-8968-33f2dca641cf,client:192.168.49.2,accept:application/vnd.kubernetes.protobuf,application/json,protocol:HTTP/2.0 (31-Oct-2022 17:50:24.189) (total time: 556ms):
Trace[1067718572]: ---"Write to database call finished" len:501,err:<nil> 556ms (17:50:24.745)
Trace[1067718572]: [556.5798ms] [556.5798ms] END
I1031 17:50:24.782051 1 trace.go:205] Trace[1837591483]: "List(recursive=true) etcd3" audit-id:48a3b74d-d890-4021-8c35-0fb747f2eac9,key:/services/specs,resourceVersion:,resourceVersionMatch:,limit:0,continue: (31-Oct-2022 17:50:23.526) (total time: 1255ms):
Trace[1837591483]: [1.2550559s] [1.2550559s] END
I1031 17:50:24.782287 1 trace.go:205] Trace[182769034]: "List(recursive=true) etcd3" audit-id:ef249df7-a0f4-4b34-83d2-dfb2b0c01515,key:/pods/default,resourceVersion:,resourceVersionMatch:,limit:0,continue: (31-Oct-2022 17:50:23.227) (total time: 1554ms):
Trace[182769034]: [1.5546641s] [1.5546641s] END
I1031 17:50:24.782896 1 trace.go:205] Trace[1795982985]: "List" url:/api/v1/namespaces/default/pods,user-agent:e2e-windows-amd64.exe/v0.0.0 (windows/amd64) kubernetes/$Format,audit-id:ef249df7-a0f4-4b34-83d2-dfb2b0c01515,client:192.168.49.1,accept:application/json, */*,protocol:HTTP/2.0 (31-Oct-2022 17:50:23.227) (total time: 1555ms):
Trace[1795982985]: ---"Listing from storage done" 1554ms (17:50:24.782)
Trace[1795982985]: [1.5553326s] [1.5553326s] END
I1031 17:50:24.782909 1 trace.go:205] Trace[542640012]: "List" url:/api/v1/services,user-agent:minikube-windows-amd64.exe/v0.0.0 (windows/amd64) kubernetes/$Format,audit-id:48a3b74d-d890-4021-8c35-0fb747f2eac9,client:192.168.49.1,accept:application/json, */*,protocol:HTTP/2.0 (31-Oct-2022 17:50:23.526) (total time: 1256ms):
Trace[542640012]: ---"Listing from storage done" 1255ms (17:50:24.782)
Trace[542640012]: [1.2560117s] [1.2560117s] END
I1031 17:50:24.783526 1 trace.go:205] Trace[260168331]: "List(recursive=true) etcd3" audit-id:fac731b6-9efb-4d2b-9625-00cd2ec00a76,key:/pods/default,resourceVersion:,resourceVersionMatch:,limit:0,continue: (31-Oct-2022 17:50:24.056) (total time: 727ms):
Trace[260168331]: [727.1035ms] [727.1035ms] END
I1031 17:50:24.785400 1 trace.go:205] Trace[897810747]: "List" url:/api/v1/namespaces/default/pods,user-agent:e2e-windows-amd64.exe/v0.0.0 (windows/amd64) kubernetes/$Format,audit-id:fac731b6-9efb-4d2b-9625-00cd2ec00a76,client:192.168.49.1,accept:application/json, */*,protocol:HTTP/2.0 (31-Oct-2022 17:50:24.056) (total time: 728ms):
Trace[897810747]: ---"Listing from storage done" 727ms (17:50:24.783)
Trace[897810747]: [728.8774ms] [728.8774ms] END
I1031 17:50:44.039960 1 alloc.go:327] "allocated clusterIPs" service="default/hello-node-connect" clusterIPs=map[IPv4:10.97.76.68]
*
* ==> kube-controller-manager [bd0976610ee5] <==
* I1031 17:48:12.714445 1 shared_informer.go:262] Caches are synced for TTL
I1031 17:48:12.714494 1 shared_informer.go:262] Caches are synced for taint
I1031 17:48:12.714196 1 shared_informer.go:262] Caches are synced for ClusterRoleAggregator
I1031 17:48:12.714756 1 shared_informer.go:262] Caches are synced for attach detach
I1031 17:48:12.714838 1 node_lifecycle_controller.go:1443] Initializing eviction metric for zone:
I1031 17:48:12.714848 1 shared_informer.go:262] Caches are synced for resource quota
I1031 17:48:12.714618 1 shared_informer.go:262] Caches are synced for resource quota
W1031 17:48:12.714907 1 node_lifecycle_controller.go:1058] Missing timestamp for Node functional-174407. Assuming now as a timestamp.
I1031 17:48:12.714961 1 node_lifecycle_controller.go:1259] Controller detected that zone is now in state Normal.
I1031 17:48:12.715596 1 event.go:294] "Event occurred" object="functional-174407" fieldPath="" kind="Node" apiVersion="v1" type="Normal" reason="RegisteredNode" message="Node functional-174407 event: Registered Node functional-174407 in Controller"
I1031 17:48:12.714319 1 shared_informer.go:262] Caches are synced for endpoint_slice
I1031 17:48:12.715894 1 shared_informer.go:262] Caches are synced for daemon sets
I1031 17:48:12.717737 1 taint_manager.go:204] "Starting NoExecuteTaintManager"
I1031 17:48:12.717886 1 taint_manager.go:209] "Sending events to api server"
I1031 17:48:12.814823 1 shared_informer.go:262] Caches are synced for persistent volume
I1031 17:48:13.118650 1 shared_informer.go:262] Caches are synced for garbage collector
I1031 17:48:13.118760 1 garbagecollector.go:163] Garbage collector: all resource monitors have synced. Proceeding to collect garbage
I1031 17:48:13.216238 1 shared_informer.go:262] Caches are synced for garbage collector
I1031 17:48:21.413981 1 event.go:294] "Event occurred" object="default/hello-node" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set hello-node-5fcdfb5cc4 to 1"
I1031 17:48:21.455573 1 event.go:294] "Event occurred" object="default/hello-node-5fcdfb5cc4" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: hello-node-5fcdfb5cc4-g86xs"
I1031 17:48:30.928522 1 event.go:294] "Event occurred" object="default/mysql" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set mysql-596b7fcdbf to 1"
I1031 17:48:30.934390 1 event.go:294] "Event occurred" object="default/mysql-596b7fcdbf" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: mysql-596b7fcdbf-rwvlg"
I1031 17:48:46.241372 1 event.go:294] "Event occurred" object="default/myclaim" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="ExternalProvisioning" message="waiting for a volume to be created, either by external provisioner \"k8s.io/minikube-hostpath\" or manually created by system administrator"
I1031 17:50:43.735809 1 event.go:294] "Event occurred" object="default/hello-node-connect" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set hello-node-connect-6458c8fb6f to 1"
I1031 17:50:43.755625 1 event.go:294] "Event occurred" object="default/hello-node-connect-6458c8fb6f" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: hello-node-connect-6458c8fb6f-dfnvk"
*
* ==> kube-controller-manager [f88668280d79] <==
* I1031 17:47:38.017767 1 serving.go:348] Generated self-signed cert in-memory
I1031 17:47:40.627152 1 controllermanager.go:178] Version: v1.25.3
I1031 17:47:40.627289 1 controllermanager.go:180] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK=""
I1031 17:47:40.630218 1 secure_serving.go:210] Serving securely on 127.0.0.1:10257
I1031 17:47:40.630321 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/var/lib/minikube/certs/front-proxy-ca.crt"
I1031 17:47:40.630434 1 tlsconfig.go:240] "Starting DynamicServingCertificateController"
I1031 17:47:40.630580 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/var/lib/minikube/certs/ca.crt"
*
* ==> kube-proxy [311f7bffce19] <==
* I1031 17:48:00.532942 1 proxier.go:666] "Failed to load kernel module with modprobe, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" moduleName="ip_vs"
I1031 17:48:00.535654 1 proxier.go:666] "Failed to load kernel module with modprobe, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" moduleName="ip_vs_rr"
I1031 17:48:00.538633 1 proxier.go:666] "Failed to load kernel module with modprobe, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" moduleName="ip_vs_wrr"
I1031 17:48:00.541297 1 proxier.go:666] "Failed to load kernel module with modprobe, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" moduleName="ip_vs_sh"
I1031 17:48:00.544462 1 proxier.go:666] "Failed to load kernel module with modprobe, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" moduleName="nf_conntrack"
I1031 17:48:00.557491 1 node.go:163] Successfully retrieved node IP: 192.168.49.2
I1031 17:48:00.557638 1 server_others.go:138] "Detected node IP" address="192.168.49.2"
I1031 17:48:00.557788 1 server_others.go:578] "Unknown proxy mode, assuming iptables proxy" proxyMode=""
I1031 17:48:00.715246 1 server_others.go:206] "Using iptables Proxier"
I1031 17:48:00.715392 1 server_others.go:213] "kube-proxy running in dual-stack mode" ipFamily=IPv4
I1031 17:48:00.715407 1 server_others.go:214] "Creating dualStackProxier for iptables"
I1031 17:48:00.715429 1 server_others.go:501] "Detect-local-mode set to ClusterCIDR, but no IPv6 cluster CIDR defined, , defaulting to no-op detect-local for IPv6"
I1031 17:48:00.715463 1 proxier.go:262] "Setting route_localnet=1, use nodePortAddresses to filter loopback addresses for NodePorts to skip it https://issues.k8s.io/90259"
I1031 17:48:00.717210 1 proxier.go:262] "Setting route_localnet=1, use nodePortAddresses to filter loopback addresses for NodePorts to skip it https://issues.k8s.io/90259"
I1031 17:48:00.719420 1 server.go:661] "Version info" version="v1.25.3"
I1031 17:48:00.719554 1 server.go:663] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK=""
I1031 17:48:00.720466 1 config.go:444] "Starting node config controller"
I1031 17:48:00.720599 1 shared_informer.go:255] Waiting for caches to sync for node config
I1031 17:48:00.720480 1 config.go:226] "Starting endpoint slice config controller"
I1031 17:48:00.720657 1 shared_informer.go:255] Waiting for caches to sync for endpoint slice config
I1031 17:48:00.720511 1 config.go:317] "Starting service config controller"
I1031 17:48:00.720711 1 shared_informer.go:255] Waiting for caches to sync for service config
I1031 17:48:00.821263 1 shared_informer.go:262] Caches are synced for service config
I1031 17:48:00.821417 1 shared_informer.go:262] Caches are synced for node config
I1031 17:48:00.821419 1 shared_informer.go:262] Caches are synced for endpoint slice config
*
* ==> kube-proxy [8fc8c4ad1288] <==
* E1031 17:47:36.122827 1 proxier.go:656] "Failed to read builtin modules file, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" err="open /lib/modules/5.10.102.1-microsoft-standard-WSL2/modules.builtin: no such file or directory" filePath="/lib/modules/5.10.102.1-microsoft-standard-WSL2/modules.builtin"
I1031 17:47:36.128094 1 proxier.go:666] "Failed to load kernel module with modprobe, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" moduleName="ip_vs"
I1031 17:47:36.215343 1 proxier.go:666] "Failed to load kernel module with modprobe, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" moduleName="ip_vs_rr"
I1031 17:47:36.222384 1 proxier.go:666] "Failed to load kernel module with modprobe, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" moduleName="ip_vs_wrr"
I1031 17:47:36.227079 1 proxier.go:666] "Failed to load kernel module with modprobe, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" moduleName="ip_vs_sh"
I1031 17:47:36.314400 1 proxier.go:666] "Failed to load kernel module with modprobe, you can ignore this message when kube-proxy is running inside container without mounting /lib/modules" moduleName="nf_conntrack"
*
* ==> kube-scheduler [3d1f027ebb43] <==
* I1031 17:47:37.640278 1 serving.go:348] Generated self-signed cert in-memory
*
* ==> kube-scheduler [a3ab9ebff2b8] <==
* I1031 17:47:52.320795 1 serving.go:348] Generated self-signed cert in-memory
W1031 17:47:57.122647 1 requestheader_controller.go:193] Unable to get configmap/extension-apiserver-authentication in kube-system. Usually fixed by 'kubectl create rolebinding -n kube-system ROLEBINDING_NAME --role=extension-apiserver-authentication-reader --serviceaccount=YOUR_NS:YOUR_SA'
W1031 17:47:57.122725 1 authentication.go:346] Error looking up in-cluster authentication configuration: configmaps "extension-apiserver-authentication" is forbidden: User "system:kube-scheduler" cannot get resource "configmaps" in API group "" in the namespace "kube-system": RBAC: [role.rbac.authorization.k8s.io "system::leader-locking-kube-scheduler" not found, role.rbac.authorization.k8s.io "extension-apiserver-authentication-reader" not found]
W1031 17:47:57.122750 1 authentication.go:347] Continuing without authentication configuration. This may treat all requests as anonymous.
W1031 17:47:57.122766 1 authentication.go:348] To require authentication configuration lookup to succeed, set --authentication-tolerate-lookup-failure=false
I1031 17:47:57.315812 1 server.go:148] "Starting Kubernetes Scheduler" version="v1.25.3"
I1031 17:47:57.315862 1 server.go:150] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK=""
I1031 17:47:57.319087 1 configmap_cafile_content.go:202] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I1031 17:47:57.319217 1 tlsconfig.go:240] "Starting DynamicServingCertificateController"
I1031 17:47:57.319233 1 shared_informer.go:255] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I1031 17:47:57.319182 1 secure_serving.go:210] Serving securely on 127.0.0.1:10259
I1031 17:47:57.419580 1 shared_informer.go:262] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
*
* ==> kubelet <==
* -- Logs begin at Mon 2022-10-31 17:44:47 UTC, end at Mon 2022-10-31 18:24:13 UTC. --
Oct 31 17:48:51 functional-174407 kubelet[10728]: I1031 17:48:51.220038 10728 pod_container_deletor.go:79] "Container not found in pod's containers" containerID="46be2710a5362cea315e806bb43b07f705f0a5b17d21f801be44f5cae5973662"
Oct 31 17:50:34 functional-174407 kubelet[10728]: I1031 17:50:34.149802 10728 reconciler.go:211] "operationExecutor.UnmountVolume started for volume \"mypd\" (UniqueName: \"kubernetes.io/host-path/f4bab37a-2075-489c-a81b-f8ac466e84e6-pvc-fffc607c-4e56-42d0-9d9d-40d21abec701\") pod \"f4bab37a-2075-489c-a81b-f8ac466e84e6\" (UID: \"f4bab37a-2075-489c-a81b-f8ac466e84e6\") "
Oct 31 17:50:34 functional-174407 kubelet[10728]: I1031 17:50:34.150186 10728 reconciler.go:211] "operationExecutor.UnmountVolume started for volume \"kube-api-access-jdnk8\" (UniqueName: \"kubernetes.io/projected/f4bab37a-2075-489c-a81b-f8ac466e84e6-kube-api-access-jdnk8\") pod \"f4bab37a-2075-489c-a81b-f8ac466e84e6\" (UID: \"f4bab37a-2075-489c-a81b-f8ac466e84e6\") "
Oct 31 17:50:34 functional-174407 kubelet[10728]: I1031 17:50:34.150409 10728 operation_generator.go:890] UnmountVolume.TearDown succeeded for volume "kubernetes.io/host-path/f4bab37a-2075-489c-a81b-f8ac466e84e6-pvc-fffc607c-4e56-42d0-9d9d-40d21abec701" (OuterVolumeSpecName: "mypd") pod "f4bab37a-2075-489c-a81b-f8ac466e84e6" (UID: "f4bab37a-2075-489c-a81b-f8ac466e84e6"). InnerVolumeSpecName "pvc-fffc607c-4e56-42d0-9d9d-40d21abec701". PluginName "kubernetes.io/host-path", VolumeGidValue ""
Oct 31 17:50:34 functional-174407 kubelet[10728]: I1031 17:50:34.155081 10728 operation_generator.go:890] UnmountVolume.TearDown succeeded for volume "kubernetes.io/projected/f4bab37a-2075-489c-a81b-f8ac466e84e6-kube-api-access-jdnk8" (OuterVolumeSpecName: "kube-api-access-jdnk8") pod "f4bab37a-2075-489c-a81b-f8ac466e84e6" (UID: "f4bab37a-2075-489c-a81b-f8ac466e84e6"). InnerVolumeSpecName "kube-api-access-jdnk8". PluginName "kubernetes.io/projected", VolumeGidValue ""
Oct 31 17:50:34 functional-174407 kubelet[10728]: I1031 17:50:34.251534 10728 reconciler.go:399] "Volume detached for volume \"pvc-fffc607c-4e56-42d0-9d9d-40d21abec701\" (UniqueName: \"kubernetes.io/host-path/f4bab37a-2075-489c-a81b-f8ac466e84e6-pvc-fffc607c-4e56-42d0-9d9d-40d21abec701\") on node \"functional-174407\" DevicePath \"\""
Oct 31 17:50:34 functional-174407 kubelet[10728]: I1031 17:50:34.251707 10728 reconciler.go:399] "Volume detached for volume \"kube-api-access-jdnk8\" (UniqueName: \"kubernetes.io/projected/f4bab37a-2075-489c-a81b-f8ac466e84e6-kube-api-access-jdnk8\") on node \"functional-174407\" DevicePath \"\""
Oct 31 17:50:35 functional-174407 kubelet[10728]: I1031 17:50:35.124756 10728 scope.go:115] "RemoveContainer" containerID="e076eff0b083765794414ae7e5c8c365e1e7b913551ffa333bd5d2dfe1f910ff"
Oct 31 17:50:35 functional-174407 kubelet[10728]: I1031 17:50:35.829204 10728 topology_manager.go:205] "Topology Admit Handler"
Oct 31 17:50:35 functional-174407 kubelet[10728]: E1031 17:50:35.829449 10728 cpu_manager.go:394] "RemoveStaleState: removing container" podUID="f4bab37a-2075-489c-a81b-f8ac466e84e6" containerName="myfrontend"
Oct 31 17:50:35 functional-174407 kubelet[10728]: I1031 17:50:35.829737 10728 memory_manager.go:345] "RemoveStaleState removing state" podUID="f4bab37a-2075-489c-a81b-f8ac466e84e6" containerName="myfrontend"
Oct 31 17:50:36 functional-174407 kubelet[10728]: I1031 17:50:36.132916 10728 kubelet_volumes.go:160] "Cleaned up orphaned pod volumes dir" podUID=f4bab37a-2075-489c-a81b-f8ac466e84e6 path="/var/lib/kubelet/pods/f4bab37a-2075-489c-a81b-f8ac466e84e6/volumes"
Oct 31 17:50:36 functional-174407 kubelet[10728]: I1031 17:50:36.217973 10728 reconciler.go:357] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-fffc607c-4e56-42d0-9d9d-40d21abec701\" (UniqueName: \"kubernetes.io/host-path/a18c8d20-6be3-4bfd-84fe-72f0aa76540d-pvc-fffc607c-4e56-42d0-9d9d-40d21abec701\") pod \"sp-pod\" (UID: \"a18c8d20-6be3-4bfd-84fe-72f0aa76540d\") " pod="default/sp-pod"
Oct 31 17:50:36 functional-174407 kubelet[10728]: I1031 17:50:36.218157 10728 reconciler.go:357] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-c9jx2\" (UniqueName: \"kubernetes.io/projected/a18c8d20-6be3-4bfd-84fe-72f0aa76540d-kube-api-access-c9jx2\") pod \"sp-pod\" (UID: \"a18c8d20-6be3-4bfd-84fe-72f0aa76540d\") " pod="default/sp-pod"
Oct 31 17:50:37 functional-174407 kubelet[10728]: I1031 17:50:37.649627 10728 pod_container_deletor.go:79] "Container not found in pod's containers" containerID="c7b0b40cb038195564b5fcfb5815965d21e6af2e58234a2967200a1064da05a8"
Oct 31 17:50:43 functional-174407 kubelet[10728]: I1031 17:50:43.762206 10728 topology_manager.go:205] "Topology Admit Handler"
Oct 31 17:50:43 functional-174407 kubelet[10728]: I1031 17:50:43.916924 10728 reconciler.go:357] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-lt6ff\" (UniqueName: \"kubernetes.io/projected/3b27de4f-462b-4668-aac4-b58320568f8c-kube-api-access-lt6ff\") pod \"hello-node-connect-6458c8fb6f-dfnvk\" (UID: \"3b27de4f-462b-4668-aac4-b58320568f8c\") " pod="default/hello-node-connect-6458c8fb6f-dfnvk"
Oct 31 17:50:44 functional-174407 kubelet[10728]: I1031 17:50:44.988481 10728 pod_container_deletor.go:79] "Container not found in pod's containers" containerID="f84cf92edf7e297a501f82be43033d77dad62bbdd9922c0289a508233bfc9980"
Oct 31 17:52:48 functional-174407 kubelet[10728]: W1031 17:52:48.138025 10728 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Oct 31 17:57:48 functional-174407 kubelet[10728]: W1031 17:57:48.134697 10728 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Oct 31 18:02:48 functional-174407 kubelet[10728]: W1031 18:02:48.137147 10728 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Oct 31 18:07:48 functional-174407 kubelet[10728]: W1031 18:07:48.141176 10728 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Oct 31 18:12:48 functional-174407 kubelet[10728]: W1031 18:12:48.142287 10728 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Oct 31 18:17:48 functional-174407 kubelet[10728]: W1031 18:17:48.144040 10728 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Oct 31 18:22:48 functional-174407 kubelet[10728]: W1031 18:22:48.146215 10728 sysinfo.go:203] Nodes topology is not available, providing CPU topology
*
* ==> storage-provisioner [304eec0d9d05] <==
* I1031 17:46:52.921180 1 storage_provisioner.go:116] Initializing the minikube storage provisioner...
I1031 17:46:53.023035 1 storage_provisioner.go:141] Storage provisioner initialized, now starting service!
I1031 17:46:53.023325 1 leaderelection.go:243] attempting to acquire leader lease kube-system/k8s.io-minikube-hostpath...
I1031 17:47:10.459399 1 leaderelection.go:253] successfully acquired lease kube-system/k8s.io-minikube-hostpath
I1031 17:47:10.460016 1 event.go:282] Event(v1.ObjectReference{Kind:"Endpoints", Namespace:"kube-system", Name:"k8s.io-minikube-hostpath", UID:"c6c0091b-85f8-4504-bad8-71ba50f96648", APIVersion:"v1", ResourceVersion:"537", FieldPath:""}): type: 'Normal' reason: 'LeaderElection' functional-174407_9570b114-ed04-4e7d-a534-4ee1ffe207df became leader
I1031 17:47:10.460052 1 controller.go:835] Starting provisioner controller k8s.io/minikube-hostpath_functional-174407_9570b114-ed04-4e7d-a534-4ee1ffe207df!
I1031 17:47:10.561166 1 controller.go:884] Started provisioner controller k8s.io/minikube-hostpath_functional-174407_9570b114-ed04-4e7d-a534-4ee1ffe207df!
*
* ==> storage-provisioner [c0a2fe2150cf] <==
* I1031 17:47:59.930249 1 storage_provisioner.go:116] Initializing the minikube storage provisioner...
I1031 17:48:00.116824 1 storage_provisioner.go:141] Storage provisioner initialized, now starting service!
I1031 17:48:00.116931 1 leaderelection.go:243] attempting to acquire leader lease kube-system/k8s.io-minikube-hostpath...
I1031 17:48:17.715677 1 leaderelection.go:253] successfully acquired lease kube-system/k8s.io-minikube-hostpath
I1031 17:48:17.716760 1 controller.go:835] Starting provisioner controller k8s.io/minikube-hostpath_functional-174407_1e98f517-1e70-46e7-b884-92dde9efb5be!
I1031 17:48:17.716868 1 event.go:282] Event(v1.ObjectReference{Kind:"Endpoints", Namespace:"kube-system", Name:"k8s.io-minikube-hostpath", UID:"c6c0091b-85f8-4504-bad8-71ba50f96648", APIVersion:"v1", ResourceVersion:"622", FieldPath:""}): type: 'Normal' reason: 'LeaderElection' functional-174407_1e98f517-1e70-46e7-b884-92dde9efb5be became leader
I1031 17:48:17.818395 1 controller.go:884] Started provisioner controller k8s.io/minikube-hostpath_functional-174407_1e98f517-1e70-46e7-b884-92dde9efb5be!
I1031 17:48:46.245624 1 controller.go:1332] provision "default/myclaim" class "standard": started
I1031 17:48:46.246121 1 storage_provisioner.go:61] Provisioning volume {&StorageClass{ObjectMeta:{standard 62c7847b-4789-46c0-aa2d-3498b284ff50 364 0 2022-10-31 17:45:43 +0000 UTC <nil> <nil> map[addonmanager.kubernetes.io/mode:EnsureExists] map[kubectl.kubernetes.io/last-applied-configuration:{"apiVersion":"storage.k8s.io/v1","kind":"StorageClass","metadata":{"annotations":{"storageclass.kubernetes.io/is-default-class":"true"},"labels":{"addonmanager.kubernetes.io/mode":"EnsureExists"},"name":"standard"},"provisioner":"k8s.io/minikube-hostpath"}
storageclass.kubernetes.io/is-default-class:true] [] [] [{kubectl-client-side-apply Update storage.k8s.io/v1 2022-10-31 17:45:43 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubectl.kubernetes.io/last-applied-configuration":{},"f:storageclass.kubernetes.io/is-default-class":{}},"f:labels":{".":{},"f:addonmanager.kubernetes.io/mode":{}}},"f:provisioner":{},"f:reclaimPolicy":{},"f:volumeBindingMode":{}}}]},Provisioner:k8s.io/minikube-hostpath,Parameters:map[string]string{},ReclaimPolicy:*Delete,MountOptions:[],AllowVolumeExpansion:nil,VolumeBindingMode:*Immediate,AllowedTopologies:[]TopologySelectorTerm{},} pvc-fffc607c-4e56-42d0-9d9d-40d21abec701 &PersistentVolumeClaim{ObjectMeta:{myclaim default fffc607c-4e56-42d0-9d9d-40d21abec701 689 0 2022-10-31 17:48:46 +0000 UTC <nil> <nil> map[] map[kubectl.kubernetes.io/last-applied-configuration:{"apiVersion":"v1","kind":"PersistentVolumeClaim","metadata":{"annotations":{},"name":"myclaim","namespace":"default"},"spec":{"accessModes":["Rea
dWriteOnce"],"resources":{"requests":{"storage":"500Mi"}},"volumeMode":"Filesystem"}}
volume.beta.kubernetes.io/storage-provisioner:k8s.io/minikube-hostpath volume.kubernetes.io/storage-provisioner:k8s.io/minikube-hostpath] [] [kubernetes.io/pvc-protection] [{kube-controller-manager Update v1 2022-10-31 17:48:46 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{"f:volume.beta.kubernetes.io/storage-provisioner":{},"f:volume.kubernetes.io/storage-provisioner":{}}}}} {kubectl.exe Update v1 2022-10-31 17:48:46 +0000 UTC FieldsV1 {"f:metadata":{"f:annotations":{".":{},"f:kubectl.kubernetes.io/last-applied-configuration":{}}},"f:spec":{"f:accessModes":{},"f:resources":{"f:requests":{".":{},"f:storage":{}}},"f:volumeMode":{}}}}]},Spec:PersistentVolumeClaimSpec{AccessModes:[ReadWriteOnce],Resources:ResourceRequirements{Limits:ResourceList{},Requests:ResourceList{storage: {{524288000 0} {<nil>} 500Mi BinarySI},},},VolumeName:,Selector:nil,StorageClassName:*standard,VolumeMode:*Filesystem,DataSource:nil,},Status:PersistentVolumeClaimStatus{Phase:Pending,AccessModes:[],Capacity:ResourceList{}
,Conditions:[]PersistentVolumeClaimCondition{},},} nil} to /tmp/hostpath-provisioner/default/myclaim
I1031 17:48:46.247398 1 controller.go:1439] provision "default/myclaim" class "standard": volume "pvc-fffc607c-4e56-42d0-9d9d-40d21abec701" provisioned
I1031 17:48:46.247588 1 controller.go:1456] provision "default/myclaim" class "standard": succeeded
I1031 17:48:46.247685 1 volume_store.go:212] Trying to save persistentvolume "pvc-fffc607c-4e56-42d0-9d9d-40d21abec701"
I1031 17:48:46.247752 1 event.go:282] Event(v1.ObjectReference{Kind:"PersistentVolumeClaim", Namespace:"default", Name:"myclaim", UID:"fffc607c-4e56-42d0-9d9d-40d21abec701", APIVersion:"v1", ResourceVersion:"689", FieldPath:""}): type: 'Normal' reason: 'Provisioning' External provisioner is provisioning volume for claim "default/myclaim"
I1031 17:48:46.323316 1 volume_store.go:219] persistentvolume "pvc-fffc607c-4e56-42d0-9d9d-40d21abec701" saved
I1031 17:48:46.323832 1 event.go:282] Event(v1.ObjectReference{Kind:"PersistentVolumeClaim", Namespace:"default", Name:"myclaim", UID:"fffc607c-4e56-42d0-9d9d-40d21abec701", APIVersion:"v1", ResourceVersion:"689", FieldPath:""}): type: 'Normal' reason: 'ProvisioningSucceeded' Successfully provisioned volume pvc-fffc607c-4e56-42d0-9d9d-40d21abec701
-- /stdout --
helpers_test.go:254: (dbg) Run: out/minikube-windows-amd64.exe status --format={{.APIServer}} -p functional-174407 -n functional-174407
helpers_test.go:254: (dbg) Done: out/minikube-windows-amd64.exe status --format={{.APIServer}} -p functional-174407 -n functional-174407: (1.8808489s)
helpers_test.go:261: (dbg) Run: kubectl --context functional-174407 get po -o=jsonpath={.items[*].metadata.name} -A --field-selector=status.phase!=Running
helpers_test.go:270: non-running pods:
helpers_test.go:272: ======> post-mortem[TestFunctional/parallel/ServiceCmd]: describe non-running pods <======
helpers_test.go:275: (dbg) Run: kubectl --context functional-174407 describe pod
helpers_test.go:275: (dbg) Non-zero exit: kubectl --context functional-174407 describe pod : exit status 1 (181.2813ms)
** stderr **
error: resource name may not be empty
** /stderr **
helpers_test.go:277: kubectl --context functional-174407 describe pod : exit status 1
--- FAIL: TestFunctional/parallel/ServiceCmd (2154.82s)