=== RUN TestFunctional/parallel/ServiceCmd
=== PAUSE TestFunctional/parallel/ServiceCmd
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1432: (dbg) Run: kubectl --context functional-20220531173104-2108 create deployment hello-node --image=k8s.gcr.io/echoserver:1.8
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1438: (dbg) Run: kubectl --context functional-20220531173104-2108 expose deployment hello-node --type=NodePort --port=8080
functional_test.go:1438: (dbg) Done: kubectl --context functional-20220531173104-2108 expose deployment hello-node --type=NodePort --port=8080: (1.7943778s)
functional_test.go:1443: (dbg) TestFunctional/parallel/ServiceCmd: waiting 10m0s for pods matching "app=hello-node" in namespace "default" ...
helpers_test.go:342: "hello-node-54fbb85-c6cbz" [cb26a5f8-1d38-4f26-a335-6c49185e047a] 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-54fbb85-c6cbz" [cb26a5f8-1d38-4f26-a335-6c49185e047a] Running
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1443: (dbg) TestFunctional/parallel/ServiceCmd: app=hello-node healthy within 12.085074s
functional_test.go:1448: (dbg) Run: out/minikube-windows-amd64.exe -p functional-20220531173104-2108 service list
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1448: (dbg) Done: out/minikube-windows-amd64.exe -p functional-20220531173104-2108 service list: (6.8622051s)
functional_test.go:1462: (dbg) Run: out/minikube-windows-amd64.exe -p functional-20220531173104-2108 service --namespace=default --https --url hello-node
functional_test.go:1391: Failed to sent interrupt to proc not supported by windows
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1462: (dbg) Non-zero exit: out/minikube-windows-amd64.exe -p functional-20220531173104-2108 service --namespace=default --https --url hello-node: exit status 1 (33m42.3573256s)
-- stdout --
https://127.0.0.1:51551
-- /stdout --
** stderr **
! Because you are using a Docker driver on windows, the terminal needs to be open to run it.
** /stderr **
functional_test.go:1464: failed to get service url. args "out/minikube-windows-amd64.exe -p functional-20220531173104-2108 service --namespace=default --https --url hello-node" : exit status 1
functional_test.go:1401: service test failed - dumping debug information
functional_test.go:1402: -----------------------service failure post-mortem--------------------------------
functional_test.go:1405: (dbg) Run: kubectl --context functional-20220531173104-2108 describe po hello-node
functional_test.go:1409: hello-node pod describe:
Name: hello-node-54fbb85-c6cbz
Namespace: default
Priority: 0
Node: functional-20220531173104-2108/192.168.49.2
Start Time: Tue, 31 May 2022 17:37:02 +0000
Labels: app=hello-node
pod-template-hash=54fbb85
Annotations: <none>
Status: Running
IP: 172.17.0.6
IPs:
IP: 172.17.0.6
Controlled By: ReplicaSet/hello-node-54fbb85
Containers:
echoserver:
Container ID: docker://6adb5fb1de30080d3ea7a23717d2cf5cedc66e5a49250f40c68daf17e777c836
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: Tue, 31 May 2022 17:37:06 +0000
Ready: True
Restart Count: 0
Environment: <none>
Mounts:
/var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-wfj6f (ro)
Conditions:
Type Status
Initialized True
Ready True
ContainersReady True
PodScheduled True
Volumes:
kube-api-access-wfj6f:
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-54fbb85-c6cbz to functional-20220531173104-2108
Normal Pulling 33m kubelet, functional-20220531173104-2108 Pulling image "k8s.gcr.io/echoserver:1.8"
Normal Pulled 33m kubelet, functional-20220531173104-2108 Successfully pulled image "k8s.gcr.io/echoserver:1.8" in 517.5097ms
Normal Created 33m kubelet, functional-20220531173104-2108 Created container echoserver
Normal Started 33m kubelet, functional-20220531173104-2108 Started container echoserver
Name: hello-node-connect-74cf8bc446-5wbb6
Namespace: default
Priority: 0
Node: functional-20220531173104-2108/192.168.49.2
Start Time: Tue, 31 May 2022 17:36:37 +0000
Labels: app=hello-node-connect
pod-template-hash=74cf8bc446
Annotations: <none>
Status: Running
IP: 172.17.0.5
IPs:
IP: 172.17.0.5
Controlled By: ReplicaSet/hello-node-connect-74cf8bc446
Containers:
echoserver:
Container ID: docker://1182335c773e478c9890bdd83b406b436f7adcf53e8f4d349c0688be8bb65ef9
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: Tue, 31 May 2022 17:37:06 +0000
Ready: True
Restart Count: 0
Environment: <none>
Mounts:
/var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-tf44x (ro)
Conditions:
Type Status
Initialized True
Ready True
ContainersReady True
PodScheduled True
Volumes:
kube-api-access-tf44x:
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-74cf8bc446-5wbb6 to functional-20220531173104-2108
Normal Pulling 34m kubelet, functional-20220531173104-2108 Pulling image "k8s.gcr.io/echoserver:1.8"
Normal Pulled 33m kubelet, functional-20220531173104-2108 Successfully pulled image "k8s.gcr.io/echoserver:1.8" in 23.0353974s
Normal Created 33m kubelet, functional-20220531173104-2108 Created container echoserver
Normal Started 33m kubelet, functional-20220531173104-2108 Started container echoserver
functional_test.go:1411: (dbg) Run: kubectl --context functional-20220531173104-2108 logs -l app=hello-node
functional_test.go:1415: hello-node logs:
functional_test.go:1417: (dbg) Run: kubectl --context functional-20220531173104-2108 describe svc hello-node
functional_test.go:1421: hello-node svc describe:
Name: hello-node
Namespace: default
Labels: app=hello-node
Annotations: <none>
Selector: app=hello-node
Type: NodePort
IP: 10.99.219.246
Port: <unset> 8080/TCP
TargetPort: 8080/TCP
NodePort: <unset> 30045/TCP
Endpoints: 172.17.0.6: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-20220531173104-2108
helpers_test.go:231: (dbg) Done: docker inspect functional-20220531173104-2108: (1.035364s)
helpers_test.go:235: (dbg) docker inspect functional-20220531173104-2108:
-- stdout --
[
{
"Id": "ac9800570c9ffae9b635aac2624d98b3eb69b6a125527175288721176f4e2ea2",
"Created": "2022-05-31T17:31:57.5400252Z",
"Path": "/usr/local/bin/entrypoint",
"Args": [
"/sbin/init"
],
"State": {
"Status": "running",
"Running": true,
"Paused": false,
"Restarting": false,
"OOMKilled": false,
"Dead": false,
"Pid": 20855,
"ExitCode": 0,
"Error": "",
"StartedAt": "2022-05-31T17:31:58.5923319Z",
"FinishedAt": "0001-01-01T00:00:00Z"
},
"Image": "sha256:aedbaa58534633065a66af6f01ba15f6c7dc1b8a285b6938f9d04325ceab9ed4",
"ResolvConfPath": "/var/lib/docker/containers/ac9800570c9ffae9b635aac2624d98b3eb69b6a125527175288721176f4e2ea2/resolv.conf",
"HostnamePath": "/var/lib/docker/containers/ac9800570c9ffae9b635aac2624d98b3eb69b6a125527175288721176f4e2ea2/hostname",
"HostsPath": "/var/lib/docker/containers/ac9800570c9ffae9b635aac2624d98b3eb69b6a125527175288721176f4e2ea2/hosts",
"LogPath": "/var/lib/docker/containers/ac9800570c9ffae9b635aac2624d98b3eb69b6a125527175288721176f4e2ea2/ac9800570c9ffae9b635aac2624d98b3eb69b6a125527175288721176f4e2ea2-json.log",
"Name": "/functional-20220531173104-2108",
"RestartCount": 0,
"Driver": "overlay2",
"Platform": "linux",
"MountLabel": "",
"ProcessLabel": "",
"AppArmorProfile": "",
"ExecIDs": null,
"HostConfig": {
"Binds": [
"functional-20220531173104-2108:/var",
"/lib/modules:/lib/modules:ro"
],
"ContainerIDFile": "",
"LogConfig": {
"Type": "json-file",
"Config": {}
},
"NetworkMode": "functional-20220531173104-2108",
"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/0baaca0513be4bf258a1f50e3173d958d093976d0a3a9664ac04d87ab09e3671-init/diff:/var/lib/docker/overlay2/42ebd8012a176a6c9bc83a2b81ffb1eb5c8e01d5410cb5d59346522bbaddf2cc/diff:/var/lib/docker/overlay2/59dce173ea661e9679f479af711a101ab0e97afb60abfd3c5b7a199b5c3e2b3b/diff:/var/lib/docker/overlay2/0328b60a223ca9f8bab93e6b86106d8b64d16fa559a56e88abbdee372b3b6a70/diff:/var/lib/docker/overlay2/b781f2620a052ee02138337819bde18c09122be2f20b7cfefaf7688f18d0c559/diff:/var/lib/docker/overlay2/af966c145b90b1748180b9ffcb1521d6fa9914e1d0ca582b239123591ffd1527/diff:/var/lib/docker/overlay2/5cd2b511f6f3bc93855ed77b5510ca4c67426eea433ccda53ea8e864342a413e/diff:/var/lib/docker/overlay2/f896d291d0c004470c3e38ea0d3be8e2b2a48ea36d45662c40fe3e105cbf4dec/diff:/var/lib/docker/overlay2/9e8994dcf5b1692245d5e40982d040298bfa7f7977892cf4be8ba3697f2c1283/diff:/var/lib/docker/overlay2/a7da4130c1b629e2a737b34701c6d4dfe6c48f92771856a887e06a1edc5456f8/diff:/var/lib/docker/overlay2/4c2573
4b9c8459489256b5f70dbb446897b9510d1cf9187e903f845ffa2a7ec2/diff:/var/lib/docker/overlay2/5c6cef49a0d0d1a36777fa7e0955ecdffb41ce354b7984f232e9cd51916416f7/diff:/var/lib/docker/overlay2/b79c799ed97edb702ed4c4ccb55ef9c645ae162e30e8f297ca5dd1152c29de41/diff:/var/lib/docker/overlay2/c84b7bc7c79ffdedf2d1265e21eec011dc3215811fb0569f7eb7d6b9aec884e8/diff:/var/lib/docker/overlay2/df8e2c3af362fd04ee17cb8d67105cf489427b2ae7cec77b79a2778e6c8c0234/diff:/var/lib/docker/overlay2/e56e356f8425868b31ada978267de73f074f211985ff1849ece7ab8341c33bae/diff:/var/lib/docker/overlay2/82c032066e83d3297742c83dd29132974e9db73a0b0b0a8edd3bcbbdb29cd53c/diff:/var/lib/docker/overlay2/15532131f3e6d0b2faf705733b06ae0c869147f2ca9592e3a80b6eaadad23544/diff:/var/lib/docker/overlay2/73fa456f504732f46cbe49368167247ca47b3099a6a75a7023ba16e7f598aee5/diff:/var/lib/docker/overlay2/e5635e020aadcc8dd1e5e3cd2eaa45cb97147f47bf406211fc61d7cbfc531193/diff:/var/lib/docker/overlay2/40b76b3249d3f7a8a737e2db80ebc1ed3b76d59724641217e8aae414ad832781/diff:/var/lib/d
ocker/overlay2/50ea2ce78d4fe52f626b2755a14f71a3c4f9b5a4f929646d9200876bdb1652c1/diff:/var/lib/docker/overlay2/d0a6e94d1f4aa73824d39c6e655bc4bdcd6568cea821b5d0f71174591c9cbbb3/diff:/var/lib/docker/overlay2/20c8fbe37a8c89a03b7bffe8cbc507e888cd5886f86f43b551d6a09fee1ce5e7/diff:/var/lib/docker/overlay2/48942b31cfe24e44c65a8be1785cd90488444f8c420a79b72a123034b01dd3f8/diff:/var/lib/docker/overlay2/c90124ab97e02facd949bfbd45815d6d73a40303b47ba4a4bc035788f5ee2dc3/diff:/var/lib/docker/overlay2/38c82aeabee1c8f46551413ecabb24f2f22680bb623f79e40c751558747a03f5/diff:/var/lib/docker/overlay2/4fa8894d1c1d773bc2e0511f273eab03fb7b8be7489eab5cd3eb57cc0d12e855/diff:/var/lib/docker/overlay2/23319fcddb47e50928e2044bac662de8153728f3a2eefa9c6ad5a5f413efec88/diff:/var/lib/docker/overlay2/b7ecd073b5b747c21ecbd1ca61887899f7e227fac3e383e24f868549b7929d74/diff:/var/lib/docker/overlay2/29a5674b4bbabfd07c4ce0b2a8b84ce98af380bf984043a4a9a6cd0743e4630c/diff:/var/lib/docker/overlay2/86a10266979ed72dc4372ade724e64741de35702626642ba60a15cca143
3682e/diff:/var/lib/docker/overlay2/03a1af7f82f1cb2b6eadbd1f13c8e9f6ca281ef3a8968d6aa45d284f286aefca/diff:/var/lib/docker/overlay2/f36cce4566278d24128326f8ef6ea446884c0c6941ccdb763ddf936e178afbff/diff:/var/lib/docker/overlay2/e54a2a61ba3597af53ec65a822821ffca97788e4b1dbfeedf98bf4d12e78973d/diff:/var/lib/docker/overlay2/dd54a25b898b0d7952f0bcb99a0450ee3d6b4269599e9355b4ae5e0c540c2caa/diff:/var/lib/docker/overlay2/ae6c1d1e9e79e03382217f21886420e3118a3f18f7c44f76c19262a84a43e219/diff:/var/lib/docker/overlay2/82faa00f86c1fa99063466464f71cdd6d510aa3e45c6c43301b2119b5bd5285a/diff:/var/lib/docker/overlay2/9f54999972b485642f042b9ed4d00316be0a1d35c060e619aca79b1583180446/diff:/var/lib/docker/overlay2/b467240c20564ba44d0946c716cf18ab5be973b43b02c37ee3ddd8f94502f41b/diff:/var/lib/docker/overlay2/21217d4ff1c5cf81dd53cfd831e0961189fb9f86812e1f53843f0022383345e6/diff",
"MergedDir": "/var/lib/docker/overlay2/0baaca0513be4bf258a1f50e3173d958d093976d0a3a9664ac04d87ab09e3671/merged",
"UpperDir": "/var/lib/docker/overlay2/0baaca0513be4bf258a1f50e3173d958d093976d0a3a9664ac04d87ab09e3671/diff",
"WorkDir": "/var/lib/docker/overlay2/0baaca0513be4bf258a1f50e3173d958d093976d0a3a9664ac04d87ab09e3671/work"
},
"Name": "overlay2"
},
"Mounts": [
{
"Type": "volume",
"Name": "functional-20220531173104-2108",
"Source": "/var/lib/docker/volumes/functional-20220531173104-2108/_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-20220531173104-2108",
"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.31-1653596720-14230@sha256:e953786303ac8350802546ee187d34e89f0007072a54fdbcc2f86a1fb8575418",
"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-20220531173104-2108",
"name.minikube.sigs.k8s.io": "functional-20220531173104-2108",
"role.minikube.sigs.k8s.io": ""
},
"StopSignal": "SIGRTMIN+3"
},
"NetworkSettings": {
"Bridge": "",
"SandboxID": "8f5ec6b3a98d73d85b19c3e80da3877e22e400bd553323f9d3272184e546a351",
"HairpinMode": false,
"LinkLocalIPv6Address": "",
"LinkLocalIPv6PrefixLen": 0,
"Ports": {
"22/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "51287"
}
],
"2376/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "51288"
}
],
"32443/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "51289"
}
],
"5000/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "51285"
}
],
"8441/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "51286"
}
]
},
"SandboxKey": "/var/run/docker/netns/8f5ec6b3a98d",
"SecondaryIPAddresses": null,
"SecondaryIPv6Addresses": null,
"EndpointID": "",
"Gateway": "",
"GlobalIPv6Address": "",
"GlobalIPv6PrefixLen": 0,
"IPAddress": "",
"IPPrefixLen": 0,
"IPv6Gateway": "",
"MacAddress": "",
"Networks": {
"functional-20220531173104-2108": {
"IPAMConfig": {
"IPv4Address": "192.168.49.2"
},
"Links": null,
"Aliases": [
"ac9800570c9f",
"functional-20220531173104-2108"
],
"NetworkID": "740a4157baec428672fe430eeb2c354ea9bd01fcc4b0eff5f0aed585a405d7f0",
"EndpointID": "566335ecd16642ab3b131d5b72b708a374c0c8614edea0f8a954ac95c28b18bc",
"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-20220531173104-2108 -n functional-20220531173104-2108
helpers_test.go:239: (dbg) Done: out/minikube-windows-amd64.exe status --format={{.Host}} -p functional-20220531173104-2108 -n functional-20220531173104-2108: (6.4055546s)
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-20220531173104-2108 logs -n 25
helpers_test.go:247: (dbg) Done: out/minikube-windows-amd64.exe -p functional-20220531173104-2108 logs -n 25: (8.3837397s)
helpers_test.go:252: TestFunctional/parallel/ServiceCmd logs:
-- stdout --
*
* ==> Audit <==
* |----------------|-----------------------------------------------------------------------------------------------------|--------------------------------|-------------------|----------------|---------------------|---------------------|
| Command | Args | Profile | User | Version | Start Time | End Time |
|----------------|-----------------------------------------------------------------------------------------------------|--------------------------------|-------------------|----------------|---------------------|---------------------|
| image | functional-20220531173104-2108 image load --daemon | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:38 GMT | 31 May 22 17:38 GMT |
| | gcr.io/google-containers/addon-resizer:functional-20220531173104-2108 | | | | | |
| image | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:38 GMT | 31 May 22 17:38 GMT |
| | image ls | | | | | |
| image | functional-20220531173104-2108 image load --daemon | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:38 GMT | 31 May 22 17:38 GMT |
| | gcr.io/google-containers/addon-resizer:functional-20220531173104-2108 | | | | | |
| image | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:38 GMT | 31 May 22 17:38 GMT |
| | image ls | | | | | |
| image | functional-20220531173104-2108 image load --daemon | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:38 GMT | 31 May 22 17:38 GMT |
| | gcr.io/google-containers/addon-resizer:functional-20220531173104-2108 | | | | | |
| image | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:38 GMT | 31 May 22 17:39 GMT |
| | image ls | | | | | |
| image | functional-20220531173104-2108 image save | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:39 GMT | 31 May 22 17:39 GMT |
| | gcr.io/google-containers/addon-resizer:functional-20220531173104-2108 | | | | | |
| | C:\jenkins\workspace\Docker_Windows_integration\addon-resizer-save.tar | | | | | |
| image | functional-20220531173104-2108 image rm | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:39 GMT | 31 May 22 17:39 GMT |
| | gcr.io/google-containers/addon-resizer:functional-20220531173104-2108 | | | | | |
| image | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:39 GMT | 31 May 22 17:39 GMT |
| | image ls | | | | | |
| image | functional-20220531173104-2108 image load | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:39 GMT | 31 May 22 17:39 GMT |
| | C:\jenkins\workspace\Docker_Windows_integration\addon-resizer-save.tar | | | | | |
| image | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:39 GMT | 31 May 22 17:39 GMT |
| | image ls | | | | | |
| image | functional-20220531173104-2108 image save --daemon | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:39 GMT | 31 May 22 17:39 GMT |
| | gcr.io/google-containers/addon-resizer:functional-20220531173104-2108 | | | | | |
| cp | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:39 GMT | 31 May 22 17:40 GMT |
| | cp testdata\cp-test.txt | | | | | |
| | /home/docker/cp-test.txt | | | | | |
| ssh | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | ssh -n | | | | | |
| | functional-20220531173104-2108 | | | | | |
| | sudo cat | | | | | |
| | /home/docker/cp-test.txt | | | | | |
| cp | functional-20220531173104-2108 cp functional-20220531173104-2108:/home/docker/cp-test.txt | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | C:\Users\jenkins.minikube7\AppData\Local\Temp\TestFunctionalparallelCpCmd2199164473\001\cp-test.txt | | | | | |
| ssh | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | ssh -n | | | | | |
| | functional-20220531173104-2108 | | | | | |
| | sudo cat | | | | | |
| | /home/docker/cp-test.txt | | | | | |
| update-context | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | update-context | | | | | |
| | --alsologtostderr -v=2 | | | | | |
| update-context | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | update-context | | | | | |
| | --alsologtostderr -v=2 | | | | | |
| update-context | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | update-context | | | | | |
| | --alsologtostderr -v=2 | | | | | |
| image | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | image ls --format yaml | | | | | |
| image | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | image ls --format table | | | | | |
| image | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | image ls --format json | | | | | |
| image | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | image ls --format short | | | | | |
| image | functional-20220531173104-2108 image build -t | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:40 GMT |
| | localhost/my-image:functional-20220531173104-2108 | | | | | |
| | testdata\build | | | | | |
| image | functional-20220531173104-2108 | functional-20220531173104-2108 | minikube7\jenkins | v1.26.0-beta.1 | 31 May 22 17:40 GMT | 31 May 22 17:41 GMT |
| | image ls | | | | | |
|----------------|-----------------------------------------------------------------------------------------------------|--------------------------------|-------------------|----------------|---------------------|---------------------|
*
* ==> Last Start <==
* Log file created at: 2022/05/31 17:37:21
Running on machine: minikube7
Binary: Built with gc go1.18.2 for windows/amd64
Log line format: [IWEF]mmdd hh:mm:ss.uuuuuu threadid file:line] msg
I0531 17:37:21.384219 6484 out.go:296] Setting OutFile to fd 716 ...
I0531 17:37:21.440222 6484 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0531 17:37:21.440222 6484 out.go:309] Setting ErrFile to fd 644...
I0531 17:37:21.440222 6484 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0531 17:37:21.452218 6484 out.go:303] Setting JSON to false
I0531 17:37:21.454218 6484 start.go:115] hostinfo: {"hostname":"minikube7","uptime":76911,"bootTime":1653941730,"procs":159,"os":"windows","platform":"Microsoft Windows 10 Enterprise N","platformFamily":"Standalone Workstation","platformVersion":"10.0.19044 Build 19044","kernelVersion":"10.0.19044 Build 19044","kernelArch":"x86_64","virtualizationSystem":"","virtualizationRole":"","hostId":"f66ed2ea-6c04-4a6b-8eea-b2fb0953e990"}
W0531 17:37:21.454218 6484 start.go:123] gopshost.Virtualization returned error: not implemented yet
I0531 17:37:21.471229 6484 out.go:177] * [functional-20220531173104-2108] minikube v1.26.0-beta.1 on Microsoft Windows 10 Enterprise N 10.0.19044 Build 19044
I0531 17:37:21.480227 6484 out.go:177] - KUBECONFIG=C:\Users\jenkins.minikube7\minikube-integration\kubeconfig
I0531 17:37:21.483217 6484 out.go:177] - MINIKUBE_HOME=C:\Users\jenkins.minikube7\minikube-integration\.minikube
I0531 17:37:21.486235 6484 out.go:177] - MINIKUBE_LOCATION=14079
I0531 17:37:21.487219 6484 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I0531 17:37:21.487219 6484 config.go:178] Loaded profile config "functional-20220531173104-2108": Driver=docker, ContainerRuntime=docker, KubernetesVersion=v1.23.6
I0531 17:37:21.487219 6484 driver.go:358] Setting default libvirt URI to qemu:///system
I0531 17:37:24.141487 6484 docker.go:137] docker version: linux-20.10.14
I0531 17:37:24.150854 6484 cli_runner.go:164] Run: docker system info --format "{{json .}}"
I0531 17:37:26.278518 6484 cli_runner.go:217] Completed: docker system info --format "{{json .}}": (2.1274722s)
I0531 17:37:26.279048 6484 info.go:265] docker info: {ID:JKWR:L4LW:XYJC:G6AI:GZFU:RUGW:CCH6:OD2M:V572:4FTB:B7YC:DTUC 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:true NFd:58 OomKillDisable:true NGoroutines:52 SystemTime:2022-05-31 17:37:25.201793 +0000 UTC LoggingDriver:json-file CgroupDriver:cgroupfs NEventsListener:3 KernelVersion:5.10.102.1-microsoft-standard-WSL2 OperatingSystem:Docker Desktop OSType:linux Architecture:x86_6
4 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.14 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:3df54a852345ae127d1fa3092b95168e4a88e2f8 Expected:3df54a852345ae127d1fa3092b95168e4a88e2f8} RuncCommit:{ID:v1.0.3-0-gf46b6ba Expected:v1.0.3-0-gf46b6ba} InitCommit:{ID:de40ad0 Expected:de40ad0} SecurityOptions:[name=seccomp,p
rofile=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.8.2] 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.5.1] map[Name:sbom Path:C:\Program Files\Docker\cli-plugins\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.17.0]] Warnings:<nil>}}
I0531 17:37:26.284116 6484 out.go:177] * Using the docker driver based on existing profile
I0531 17:37:26.288089 6484 start.go:284] selected driver: docker
I0531 17:37:26.288089 6484 start.go:806] validating driver "docker" against &{Name:functional-20220531173104-2108 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.31-1653596720-14230@sha256:e953786303ac8350802546ee187d34e89f0007072a54fdbcc2f86a1fb8575418 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.23.6 ClusterName:functional-20220531173104-2108 Namespace:de
fault APIServerName:minikubeCA 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.23.6 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[ambassador:false auto-pause:false csi-hostpath-driver:false dashboard:false default-storageclass:true efk:false freshpod:false gcp-auth:false gvisor:false helm-tiller: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:false portainer:false regis
try: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.minikube7:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false}
I0531 17:37:26.288376 6484 start.go:817] status for docker: {Installed:true Healthy:true Running:false NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I0531 17:37:26.310470 6484 cli_runner.go:164] Run: docker system info --format "{{json .}}"
I0531 17:37:28.402370 6484 cli_runner.go:217] Completed: docker system info --format "{{json .}}": (2.0918897s)
I0531 17:37:28.402370 6484 info.go:265] docker info: {ID:JKWR:L4LW:XYJC:G6AI:GZFU:RUGW:CCH6:OD2M:V572:4FTB:B7YC:DTUC 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:true NFd:58 OomKillDisable:true NGoroutines:52 SystemTime:2022-05-31 17:37:27.3595171 +0000 UTC LoggingDriver:json-file CgroupDriver:cgroupfs NEventsListener:3 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.14 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:3df54a852345ae127d1fa3092b95168e4a88e2f8 Expected:3df54a852345ae127d1fa3092b95168e4a88e2f8} RuncCommit:{ID:v1.0.3-0-gf46b6ba Expected:v1.0.3-0-gf46b6ba} 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.8.2] 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.5.1] map[Name:sbom Path:C:\Program Files\Docker\cli-plugins\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.17.0]] Warnings:<nil>}}
I0531 17:37:28.447389 6484 cni.go:95] Creating CNI manager for ""
I0531 17:37:28.447389 6484 cni.go:169] CNI unnecessary in this configuration, recommending no CNI
I0531 17:37:28.447389 6484 start_flags.go:306] config:
{Name:functional-20220531173104-2108 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.31-1653596720-14230@sha256:e953786303ac8350802546ee187d34e89f0007072a54fdbcc2f86a1fb8575418 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.23.6 ClusterName:functional-20220531173104-2108 Namespace:default APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:clust
er.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.23.6 ContainerRuntime:docker ControlPlane:true Worker:true}] Addons:map[ambassador:false auto-pause:false csi-hostpath-driver:false dashboard:false default-storageclass:true efk:false freshpod:false gcp-auth:false gvisor:false helm-tiller: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:false portainer:false registry:false registry-aliases:false registry-creds:false storage-provisioner:true s
torage-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.minikube7:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false}
I0531 17:37:28.453380 6484 out.go:177] * dry-run validation complete!
*
* ==> Docker <==
* -- Logs begin at Tue 2022-05-31 17:31:59 UTC, end at Tue 2022-05-31 18:11:18 UTC. --
May 31 17:32:16 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:32:16.680751800Z" level=info msg="API listen on [::]:2376"
May 31 17:32:16 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:32:16.689768600Z" level=info msg="API listen on /var/run/docker.sock"
May 31 17:33:14 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:33:14.642799700Z" level=info msg="ignoring event" container=98e3aa1f1296f25e41ca656952022f984ab049f068d93686284c38a494fe3b39 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:33:14 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:33:14.808182700Z" level=info msg="ignoring event" container=315f694ed7ff001175914f292f26e0bca8bf0ec3c19f5e4695b56a660e7ab976 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:19 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:19.487805300Z" level=info msg="ignoring event" container=aa7f15a988995a6fa85f719ea833d5b834d26e7aa2b3844d38192e27a15c9ab0 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:19 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:19.487884500Z" level=info msg="ignoring event" container=af4786384c492cf1a455f410500e518d7d0e4decde59c579559a2f79cf287bf1 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:19 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:19.690452400Z" level=info msg="ignoring event" container=3c1115c1305583de691cab3c9af45e5287db0a3529ea517c35eff4767491efcc module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:19 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:19.801212900Z" level=info msg="ignoring event" container=77a3b3590b9aa46cda285fc13f0eb69864570d411f836d6635490284cbb8ffd3 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:19 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:19.888831400Z" level=info msg="ignoring event" container=bfa84a2ffd228f119df433c7266b611f44398bcf0f75764f7b83026b9c5f073d module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:19 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:19.888902300Z" level=info msg="ignoring event" container=d2010d6f19be0c00b1b23922145e44466896613cc54c9dabe18f1743990c7946 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:19 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:19.889046400Z" level=info msg="ignoring event" container=2ddc1a898dfb6bdfa2192a1ad55421e8c06adb5f1ec25dc0c4c4cfac116e88af module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:19 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:19.991434500Z" level=info msg="ignoring event" container=909e135e054cc30a8071e17a4ae073838e8cbee380ac575ae832c3eed81d8053 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:19 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:19.991967100Z" level=info msg="ignoring event" container=9aaae8d9608b86439288c99b679a5d80ea4c92244bd1e99fa17b6d9a0825a80a module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:19 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:19.992448000Z" level=info msg="ignoring event" container=bbd1baa4cb2a56e436e609efae295f3b7f3554e405c09ef8cd71a2e20875eb05 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:20 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:20.101148100Z" level=info msg="ignoring event" container=ddadbb8af8f59dd7bcbbc6f541cc9add1879600b98260c585bee87b63a3f2176 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:21 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:21.394548300Z" level=info msg="ignoring event" container=f808f562e4c468a2ac3b7b9648e0ed31f46e15deb3cd95cfa099880a3f3edaa9 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:21 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:21.587607700Z" level=info msg="ignoring event" container=b10946ca0bcfbc6e53ac9f0da0b7eecc81faf3ff2d465ba20619ae8b54d19491 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:24 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:24.497971500Z" level=info msg="ignoring event" container=796c188ab0cbbbbdb1748c7ca3ec638f0b548aef6e16807e83b55ec33a0828a4 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:24 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:24.598114300Z" level=info msg="ignoring event" container=c93090aa25350595a9d466ede333b6ee67fbad25ebd223b99a43e6b2c0d3ca85 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:34 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:34.111579800Z" level=info msg="ignoring event" container=fe506de671ae7fba5dffae696c3cd7d1e1a52f3732f1c738ce0eb93a0bf53f5e module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:35:34 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:35:34.309193700Z" level=info msg="ignoring event" container=f9286f1960b88854b2e86df970d569d11daa22334f7fef143f0e936f6cd145d3 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:37:01 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:37:01.088956500Z" level=info msg="ignoring event" container=e63bea6377f2a0a0cc3ee701649c463d8c75818970630810f7ea0f4f37715b75 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:37:02 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:37:02.806372400Z" level=info msg="ignoring event" container=23b52b71894a503bdc65ed36c95f8a20ef3e2bc39d1b744966749997165ada3f module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:40:55 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:40:55.794817100Z" level=info msg="ignoring event" container=831ef2e56aa65c62d7c5c41f2db658df0122503be11bdf7e0a17fe28cd5822b1 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
May 31 17:40:56 functional-20220531173104-2108 dockerd[510]: time="2022-05-31T17:40:56.349511900Z" level=info msg="Layer sha256:8d988d9cbd4c3812fb85f3c741a359985602af139e727005f4d4471ac42f9d1a cleaned up"
*
* ==> container status <==
* CONTAINER IMAGE CREATED STATE NAME ATTEMPT POD ID
0b5ccd9823932 mysql@sha256:7e99b2b8d5bca914ef31059858210f57b009c40375d647f0d4d65ecd01d6b1d5 31 minutes ago Running mysql 0 333834c1cb3d8
3289072c6c844 nginx@sha256:2bcabc23b45489fb0885d69a06ba1d648aeda973fae7bb981bafbb884165e514 34 minutes ago Running myfrontend 0 00208e1f542a1
6adb5fb1de300 k8s.gcr.io/echoserver@sha256:cb3386f863f6a4b05f33c191361723f9d5927ac287463b1bea633bf859475969 34 minutes ago Running echoserver 0 7ef50adfd038f
1182335c773e4 k8s.gcr.io/echoserver@sha256:cb3386f863f6a4b05f33c191361723f9d5927ac287463b1bea633bf859475969 34 minutes ago Running echoserver 0 768d4e79d18b3
835617a7dc034 nginx@sha256:a74534e76ee1121d418fa7394ca930eb67440deda413848bc67c68138535b989 35 minutes ago Running nginx 0 104acaf228231
0e1ed68a43faa a4ca41631cc7a 35 minutes ago Running coredns 1 44909b59d356f
a24e38366a7b4 6e38f40d628db 35 minutes ago Running storage-provisioner 2 37cc42c5630cd
fedfb55afc4b2 8fa62c12256df 35 minutes ago Running kube-apiserver 0 d3e5c39f666c8
adf0898fd4ff8 595f327f224a4 35 minutes ago Running kube-scheduler 1 d06ea92e30a2c
ad11c3777c4ed 4c03754524064 35 minutes ago Running kube-proxy 1 d59f78b47d67b
c93090aa25350 6e38f40d628db 35 minutes ago Exited storage-provisioner 1 37cc42c5630cd
7eb1fdcb70879 25f8c7f3da61c 35 minutes ago Running etcd 1 0d14dc606fc5b
67bdd1b22c523 df7b72818ad2e 35 minutes ago Running kube-controller-manager 1 b60f69cbd7b19
796c188ab0cbb a4ca41631cc7a 38 minutes ago Exited coredns 0 bfa84a2ffd228
909e135e054cc 4c03754524064 38 minutes ago Exited kube-proxy 0 aa7f15a988995
ddadbb8af8f59 df7b72818ad2e 38 minutes ago Exited kube-controller-manager 0 d2010d6f19be0
f808f562e4c46 595f327f224a4 38 minutes ago Exited kube-scheduler 0 9aaae8d9608b8
77a3b3590b9aa 25f8c7f3da61c 38 minutes ago Exited etcd 0 bbd1baa4cb2a5
*
* ==> coredns [0e1ed68a43fa] <==
* .:53
[INFO] plugin/reload: Running configuration MD5 = c23ed519c17e71ee396ed052e6209e94
CoreDNS-1.8.6
linux/amd64, go1.17.1, 13a9191
*
* ==> coredns [796c188ab0cb] <==
* .:53
[INFO] plugin/reload: Running configuration MD5 = db32ca3650231d74073ff4cf814959a7
CoreDNS-1.8.6
linux/amd64, go1.17.1, 13a9191
[INFO] Reloading
[INFO] plugin/health: Going into lameduck mode for 5s
[INFO] plugin/reload: Running configuration MD5 = c23ed519c17e71ee396ed052e6209e94
[INFO] Reloading complete
[INFO] SIGTERM: Shutting down servers then terminating
[INFO] plugin/health: Going into lameduck mode for 5s
*
* ==> describe nodes <==
* Name: functional-20220531173104-2108
Roles: control-plane,master
Labels: beta.kubernetes.io/arch=amd64
beta.kubernetes.io/os=linux
kubernetes.io/arch=amd64
kubernetes.io/hostname=functional-20220531173104-2108
kubernetes.io/os=linux
minikube.k8s.io/commit=bd46569bd7cb517fcad2e704abdebd2826bd8454
minikube.k8s.io/name=functional-20220531173104-2108
minikube.k8s.io/primary=true
minikube.k8s.io/updated_at=2022_05_31T17_32_50_0700
minikube.k8s.io/version=v1.26.0-beta.1
node-role.kubernetes.io/control-plane=
node-role.kubernetes.io/master=
node.kubernetes.io/exclude-from-external-load-balancers=
Annotations: kubeadm.alpha.kubernetes.io/cri-socket: /var/run/dockershim.sock
node.alpha.kubernetes.io/ttl: 0
volumes.kubernetes.io/controller-managed-attach-detach: true
CreationTimestamp: Tue, 31 May 2022 17:32:44 +0000
Taints: <none>
Unschedulable: false
Lease:
HolderIdentity: functional-20220531173104-2108
AcquireTime: <unset>
RenewTime: Tue, 31 May 2022 18:11:11 +0000
Conditions:
Type Status LastHeartbeatTime LastTransitionTime Reason Message
---- ------ ----------------- ------------------ ------ -------
MemoryPressure False Tue, 31 May 2022 18:06:36 +0000 Tue, 31 May 2022 17:32:41 +0000 KubeletHasSufficientMemory kubelet has sufficient memory available
DiskPressure False Tue, 31 May 2022 18:06:36 +0000 Tue, 31 May 2022 17:32:41 +0000 KubeletHasNoDiskPressure kubelet has no disk pressure
PIDPressure False Tue, 31 May 2022 18:06:36 +0000 Tue, 31 May 2022 17:32:41 +0000 KubeletHasSufficientPID kubelet has sufficient PID available
Ready True Tue, 31 May 2022 18:06:36 +0000 Tue, 31 May 2022 17:33:01 +0000 KubeletReady kubelet is posting ready status
Addresses:
InternalIP: 192.168.49.2
Hostname: functional-20220531173104-2108
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: bfc82849fe6e4a6a9236307a23a8b5f1
System UUID: bfc82849fe6e4a6a9236307a23a8b5f1
Boot ID: 99d8680c-6839-4c5e-a5fa-8740ef80d5ef
Kernel Version: 5.10.102.1-microsoft-standard-WSL2
OS Image: Ubuntu 20.04.4 LTS
Operating System: linux
Architecture: amd64
Container Runtime Version: docker://20.10.16
Kubelet Version: v1.23.6
Kube-Proxy Version: v1.23.6
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-54fbb85-c6cbz 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 34m
default hello-node-connect-74cf8bc446-5wbb6 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 34m
default mysql-b87c45988-hqk85 600m (3%!)(MISSING) 700m (4%!)(MISSING) 512Mi (0%!)(MISSING) 700Mi (1%!)(MISSING) 31m
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) 34m
kube-system coredns-64897985d-9zl57 100m (0%!)(MISSING) 0 (0%!)(MISSING) 70Mi (0%!)(MISSING) 170Mi (0%!)(MISSING) 38m
kube-system etcd-functional-20220531173104-2108 100m (0%!)(MISSING) 0 (0%!)(MISSING) 100Mi (0%!)(MISSING) 0 (0%!)(MISSING) 38m
kube-system kube-apiserver-functional-20220531173104-2108 250m (1%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 35m
kube-system kube-controller-manager-functional-20220531173104-2108 200m (1%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 38m
kube-system kube-proxy-sc9l4 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 38m
kube-system kube-scheduler-functional-20220531173104-2108 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 35m kube-proxy
Normal Starting 38m kube-proxy
Normal NodeHasNoDiskPressure 38m (x7 over 38m) kubelet Node functional-20220531173104-2108 status is now: NodeHasNoDiskPressure
Normal NodeHasSufficientPID 38m (x7 over 38m) kubelet Node functional-20220531173104-2108 status is now: NodeHasSufficientPID
Normal NodeHasSufficientMemory 38m (x8 over 38m) kubelet Node functional-20220531173104-2108 status is now: NodeHasSufficientMemory
Normal NodeHasNoDiskPressure 38m kubelet Node functional-20220531173104-2108 status is now: NodeHasNoDiskPressure
Normal NodeHasSufficientPID 38m kubelet Node functional-20220531173104-2108 status is now: NodeHasSufficientPID
Normal NodeHasSufficientMemory 38m kubelet Node functional-20220531173104-2108 status is now: NodeHasSufficientMemory
Normal Starting 38m kubelet Starting kubelet.
Normal NodeAllocatableEnforced 38m kubelet Updated Node Allocatable limit across pods
Normal NodeReady 38m kubelet Node functional-20220531173104-2108 status is now: NodeReady
Normal Starting 35m kubelet Starting kubelet.
Normal NodeHasSufficientMemory 35m (x2 over 35m) kubelet Node functional-20220531173104-2108 status is now: NodeHasSufficientMemory
Normal NodeHasNoDiskPressure 35m (x2 over 35m) kubelet Node functional-20220531173104-2108 status is now: NodeHasNoDiskPressure
Normal NodeHasSufficientPID 35m (x2 over 35m) kubelet Node functional-20220531173104-2108 status is now: NodeHasSufficientPID
Normal NodeAllocatableEnforced 35m kubelet Updated Node Allocatable limit across pods
*
* ==> dmesg <==
* [May31 17:46] WSL2: Performing memory compaction.
[May31 17:47] WSL2: Performing memory compaction.
[May31 17:48] WSL2: Performing memory compaction.
[May31 17:49] WSL2: Performing memory compaction.
[May31 17:50] WSL2: Performing memory compaction.
[May31 17:51] WSL2: Performing memory compaction.
[May31 17:52] WSL2: Performing memory compaction.
[May31 17:53] WSL2: Performing memory compaction.
[May31 17:54] WSL2: Performing memory compaction.
[May31 17:55] WSL2: Performing memory compaction.
[May31 17:56] WSL2: Performing memory compaction.
[May31 17:57] WSL2: Performing memory compaction.
[May31 17:58] WSL2: Performing memory compaction.
[May31 17:59] WSL2: Performing memory compaction.
[May31 18:00] WSL2: Performing memory compaction.
[May31 18:01] WSL2: Performing memory compaction.
[May31 18:02] WSL2: Performing memory compaction.
[May31 18:03] WSL2: Performing memory compaction.
[May31 18:04] WSL2: Performing memory compaction.
[May31 18:05] WSL2: Performing memory compaction.
[May31 18:06] WSL2: Performing memory compaction.
[May31 18:07] WSL2: Performing memory compaction.
[May31 18:08] WSL2: Performing memory compaction.
[May31 18:09] WSL2: Performing memory compaction.
[May31 18:10] WSL2: Performing memory compaction.
*
* ==> etcd [77a3b3590b9a] <==
* {"level":"warn","ts":"2022-05-31T17:33:09.698Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"106.7221ms","expected-duration":"100ms","prefix":"","request":"header:<ID:8128013381219972195 username:\"kube-apiserver-etcd-client\" auth_revision:1 > txn:<compare:<target:MOD key:\"/registry/pods/kube-system/coredns-64897985d-9zl57\" mod_revision:437 > success:<request_put:<key:\"/registry/pods/kube-system/coredns-64897985d-9zl57\" value_size:4559 >> failure:<request_range:<key:\"/registry/pods/kube-system/coredns-64897985d-9zl57\" > >>","response":"size:16"}
{"level":"info","ts":"2022-05-31T17:33:09.785Z","caller":"traceutil/trace.go:171","msg":"trace[2132922401] linearizableReadLoop","detail":"{readStateIndex:478; appliedIndex:477; }","duration":"195.0218ms","start":"2022-05-31T17:33:09.590Z","end":"2022-05-31T17:33:09.785Z","steps":["trace[2132922401] 'read index received' (duration: 745.1µs)","trace[2132922401] 'applied index is now lower than readState.Index' (duration: 194.2719ms)"],"step_count":2}
{"level":"warn","ts":"2022-05-31T17:33:09.785Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"195.2333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/functional-20220531173104-2108\" ","response":"range_response_count:1 size:4510"}
{"level":"info","ts":"2022-05-31T17:33:09.785Z","caller":"traceutil/trace.go:171","msg":"trace[59375942] range","detail":"{range_begin:/registry/minions/functional-20220531173104-2108; range_end:; response_count:1; response_revision:465; }","duration":"195.2987ms","start":"2022-05-31T17:33:09.590Z","end":"2022-05-31T17:33:09.785Z","steps":["trace[59375942] 'agreement among raft nodes before linearized reading' (duration: 195.1802ms)"],"step_count":1}
{"level":"info","ts":"2022-05-31T17:33:09.786Z","caller":"traceutil/trace.go:171","msg":"trace[2120425565] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"197.5044ms","start":"2022-05-31T17:33:09.588Z","end":"2022-05-31T17:33:09.786Z","steps":["trace[2120425565] 'compare' (duration: 106.451ms)"],"step_count":1}
{"level":"warn","ts":"2022-05-31T17:33:11.008Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"106.1085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2022-05-31T17:33:11.008Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"106.4847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-64897985d-9zl57\" ","response":"range_response_count:1 size:4454"}
{"level":"info","ts":"2022-05-31T17:33:11.008Z","caller":"traceutil/trace.go:171","msg":"trace[576033879] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:480; }","duration":"106.2849ms","start":"2022-05-31T17:33:10.902Z","end":"2022-05-31T17:33:11.008Z","steps":["trace[576033879] 'agreement among raft nodes before linearized reading' (duration: 61.1456ms)","trace[576033879] 'range keys from in-memory index tree' (duration: 44.9423ms)"],"step_count":2}
{"level":"info","ts":"2022-05-31T17:33:11.009Z","caller":"traceutil/trace.go:171","msg":"trace[126526605] range","detail":"{range_begin:/registry/pods/kube-system/coredns-64897985d-9zl57; range_end:; response_count:1; response_revision:480; }","duration":"106.5717ms","start":"2022-05-31T17:33:10.902Z","end":"2022-05-31T17:33:11.008Z","steps":["trace[126526605] 'agreement among raft nodes before linearized reading' (duration: 61.3689ms)","trace[126526605] 'range keys from in-memory index tree' (duration: 45.0854ms)"],"step_count":2}
{"level":"warn","ts":"2022-05-31T17:33:11.008Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"106.4246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/k8s.io-minikube-hostpath\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2022-05-31T17:33:11.009Z","caller":"traceutil/trace.go:171","msg":"trace[773953843] range","detail":"{range_begin:/registry/services/endpoints/kube-system/k8s.io-minikube-hostpath; range_end:; response_count:0; response_revision:480; }","duration":"106.805ms","start":"2022-05-31T17:33:10.902Z","end":"2022-05-31T17:33:11.009Z","steps":["trace[773953843] 'agreement among raft nodes before linearized reading' (duration: 61.3958ms)","trace[773953843] 'range keys from in-memory index tree' (duration: 45.017ms)"],"step_count":2}
{"level":"warn","ts":"2022-05-31T17:33:11.239Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"130.5692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/functional-20220531173104-2108\" ","response":"range_response_count:1 size:4510"}
{"level":"info","ts":"2022-05-31T17:33:11.239Z","caller":"traceutil/trace.go:171","msg":"trace[1737174060] range","detail":"{range_begin:/registry/minions/functional-20220531173104-2108; range_end:; response_count:1; response_revision:483; }","duration":"130.8705ms","start":"2022-05-31T17:33:11.109Z","end":"2022-05-31T17:33:11.239Z","steps":["trace[1737174060] 'agreement among raft nodes before linearized reading' (duration: 84.0218ms)","trace[1737174060] 'range keys from in-memory index tree' (duration: 46.5054ms)"],"step_count":2}
{"level":"info","ts":"2022-05-31T17:33:11.239Z","caller":"traceutil/trace.go:171","msg":"trace[986926177] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"123.4756ms","start":"2022-05-31T17:33:11.116Z","end":"2022-05-31T17:33:11.239Z","steps":["trace[986926177] 'process raft request' (duration: 76.6828ms)","trace[986926177] 'compare' (duration: 46.242ms)"],"step_count":2}
{"level":"info","ts":"2022-05-31T17:33:11.604Z","caller":"traceutil/trace.go:171","msg":"trace[1288232695] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:499; }","duration":"101.8248ms","start":"2022-05-31T17:33:11.502Z","end":"2022-05-31T17:33:11.604Z","steps":["trace[1288232695] 'read index received' (duration: 101.8156ms)","trace[1288232695] 'applied index is now lower than readState.Index' (duration: 6.1µs)"],"step_count":2}
{"level":"warn","ts":"2022-05-31T17:33:11.604Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"102.1533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-functional-20220531173104-2108\" ","response":"range_response_count:1 size:4203"}
{"level":"info","ts":"2022-05-31T17:33:11.604Z","caller":"traceutil/trace.go:171","msg":"trace[206237108] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-functional-20220531173104-2108; range_end:; response_count:1; response_revision:486; }","duration":"102.3019ms","start":"2022-05-31T17:33:11.502Z","end":"2022-05-31T17:33:11.604Z","steps":["trace[206237108] 'agreement among raft nodes before linearized reading' (duration: 102.032ms)"],"step_count":1}
{"level":"info","ts":"2022-05-31T17:35:19.286Z","caller":"osutil/interrupt_unix.go:64","msg":"received signal; shutting down","signal":"terminated"}
{"level":"info","ts":"2022-05-31T17:35:19.286Z","caller":"embed/etcd.go:367","msg":"closing etcd server","name":"functional-20220531173104-2108","data-dir":"/var/lib/minikube/etcd","advertise-peer-urls":["https://192.168.49.2:2380"],"advertise-client-urls":["https://192.168.49.2:2379"]}
WARNING: 2022/05/31 17:35:19 [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/05/31 17:35:19 [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-05-31T17:35:19.298Z","caller":"etcdserver/server.go:1438","msg":"skipped leadership transfer for single voting member cluster","local-member-id":"aec36adc501070cc","current-leader-member-id":"aec36adc501070cc"}
{"level":"info","ts":"2022-05-31T17:35:19.401Z","caller":"embed/etcd.go:562","msg":"stopping serving peer traffic","address":"192.168.49.2:2380"}
{"level":"info","ts":"2022-05-31T17:35:19.403Z","caller":"embed/etcd.go:567","msg":"stopped serving peer traffic","address":"192.168.49.2:2380"}
{"level":"info","ts":"2022-05-31T17:35:19.403Z","caller":"embed/etcd.go:369","msg":"closed etcd server","name":"functional-20220531173104-2108","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 [7eb1fdcb7087] <==
* {"level":"warn","ts":"2022-05-31T17:40:13.131Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"723.7071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"warn","ts":"2022-05-31T17:40:13.130Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"2.7340478s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2022-05-31T17:40:13.131Z","caller":"traceutil/trace.go:171","msg":"trace[114366969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:946; }","duration":"2.7347865s","start":"2022-05-31T17:40:10.396Z","end":"2022-05-31T17:40:13.131Z","steps":["trace[114366969] 'range keys from in-memory index tree' (duration: 2.7339633s)"],"step_count":1}
{"level":"warn","ts":"2022-05-31T17:40:13.131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2022-05-31T17:40:10.396Z","time spent":"2.7348276s","remote":"127.0.0.1:36182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"info","ts":"2022-05-31T17:40:13.131Z","caller":"traceutil/trace.go:171","msg":"trace[1235275351] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:948; }","duration":"723.7702ms","start":"2022-05-31T17:40:12.407Z","end":"2022-05-31T17:40:13.131Z","steps":["trace[1235275351] 'agreement among raft nodes before linearized reading' (duration: 723.6897ms)"],"step_count":1}
{"level":"warn","ts":"2022-05-31T17:40:13.131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2022-05-31T17:40:12.407Z","time spent":"724.0601ms","remote":"127.0.0.1:36182","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "}
{"level":"warn","ts":"2022-05-31T17:40:13.131Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"2.0242807s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:1 size:343"}
{"level":"info","ts":"2022-05-31T17:40:13.131Z","caller":"traceutil/trace.go:171","msg":"trace[1654666654] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:1; response_revision:948; }","duration":"2.0246224s","start":"2022-05-31T17:40:11.107Z","end":"2022-05-31T17:40:13.131Z","steps":["trace[1654666654] 'agreement among raft nodes before linearized reading' (duration: 2.0240912s)"],"step_count":1}
{"level":"warn","ts":"2022-05-31T17:40:13.131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2022-05-31T17:40:11.107Z","time spent":"2.0246833s","remote":"127.0.0.1:36098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":30,"response count":1,"response size":367,"request content":"key:\"/registry/namespaces/default\" "}
{"level":"warn","ts":"2022-05-31T17:40:13.130Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"3.3309698s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/k8s.io-minikube-hostpath\" ","response":"range_response_count:1 size:1133"}
{"level":"info","ts":"2022-05-31T17:40:13.132Z","caller":"traceutil/trace.go:171","msg":"trace[756194152] range","detail":"{range_begin:/registry/services/endpoints/kube-system/k8s.io-minikube-hostpath; range_end:; response_count:1; response_revision:946; }","duration":"3.3321347s","start":"2022-05-31T17:40:09.799Z","end":"2022-05-31T17:40:13.131Z","steps":["trace[756194152] 'range keys from in-memory index tree' (duration: 3.3308663s)"],"step_count":1}
{"level":"warn","ts":"2022-05-31T17:40:13.132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2022-05-31T17:40:09.799Z","time spent":"3.3321908s","remote":"127.0.0.1:36100","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":1157,"request content":"key:\"/registry/services/endpoints/kube-system/k8s.io-minikube-hostpath\" "}
{"level":"info","ts":"2022-05-31T17:45:36.047Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":974}
{"level":"info","ts":"2022-05-31T17:45:36.048Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":974,"took":"1.166ms"}
{"level":"info","ts":"2022-05-31T17:50:36.063Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1183}
{"level":"info","ts":"2022-05-31T17:50:36.064Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1183,"took":"715.4µs"}
{"level":"info","ts":"2022-05-31T17:55:36.080Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1393}
{"level":"info","ts":"2022-05-31T17:55:36.081Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1393,"took":"821.6µs"}
{"level":"info","ts":"2022-05-31T17:56:11.306Z","caller":"traceutil/trace.go:171","msg":"trace[1260663686] transaction","detail":"{read_only:false; response_revision:1628; number_of_response:1; }","duration":"109.2685ms","start":"2022-05-31T17:56:11.196Z","end":"2022-05-31T17:56:11.305Z","steps":["trace[1260663686] 'process raft request' (duration: 83.9453ms)","trace[1260663686] 'compare' (duration: 25.0457ms)"],"step_count":2}
{"level":"info","ts":"2022-05-31T18:00:36.113Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1603}
{"level":"info","ts":"2022-05-31T18:00:36.114Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1603,"took":"652.6µs"}
{"level":"info","ts":"2022-05-31T18:05:36.130Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1813}
{"level":"info","ts":"2022-05-31T18:05:36.131Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1813,"took":"682.1µs"}
{"level":"info","ts":"2022-05-31T18:10:36.144Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2023}
{"level":"info","ts":"2022-05-31T18:10:36.145Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":2023,"took":"613.2µs"}
*
* ==> kernel <==
* 18:11:20 up 59 min, 0 users, load average: 0.21, 0.28, 0.44
Linux functional-20220531173104-2108 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.4 LTS"
*
* ==> kube-apiserver [fedfb55afc4b] <==
* Trace[1631072592]: ---"Listing from storage done" 1290ms (17:39:42.603)
Trace[1631072592]: [1.2911037s] [1.2911037s] END
{"level":"warn","ts":"2022-05-31T17:40:12.397Z","logger":"etcd-client","caller":"v3/retry_interceptor.go:62","msg":"retrying of unary invoker failed","target":"etcd-endpoints://0xc002b6c000/#initially=[https://127.0.0.1:2379]","attempt":0,"error":"rpc error: code = DeadlineExceeded desc = context deadline exceeded"}
I0531 17:40:13.132369 1 trace.go:205] Trace[1101327824]: "Create" url:/api/v1/namespaces/kube-system/events,user-agent:kubelet/v1.23.6 (linux/amd64) kubernetes/ad33385,audit-id:38759316-3673-4f68-a8bb-151eb07d43f1,client:192.168.49.2,accept:application/vnd.kubernetes.protobuf,application/json,protocol:HTTP/2.0 (31-May-2022 17:40:12.413) (total time: 718ms):
Trace[1101327824]: ---"Object stored in database" 718ms (17:40:13.132)
Trace[1101327824]: [718.4759ms] [718.4759ms] END
I0531 17:40:13.132425 1 trace.go:205] Trace[207720524]: "GuaranteedUpdate etcd3" type:*coordination.Lease (31-May-2022 17:40:10.605) (total time: 2526ms):
Trace[207720524]: ---"Transaction committed" 2525ms (17:40:13.132)
Trace[207720524]: [2.5264065s] [2.5264065s] END
I0531 17:40:13.132630 1 trace.go:205] Trace[1666363601]: "List etcd3" key:/pods/default,resourceVersion:,resourceVersionMatch:,limit:0,continue: (31-May-2022 17:40:10.313) (total time: 2819ms):
Trace[1666363601]: [2.8192399s] [2.8192399s] END
I0531 17:40:13.132645 1 trace.go:205] Trace[1788252629]: "Update" url:/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/functional-20220531173104-2108,user-agent:kubelet/v1.23.6 (linux/amd64) kubernetes/ad33385,audit-id:5e81e9b7-91c0-4fe0-ba53-09a8d12ac490,client:192.168.49.2,accept:application/vnd.kubernetes.protobuf,application/json,protocol:HTTP/2.0 (31-May-2022 17:40:10.605) (total time: 2526ms):
Trace[1788252629]: ---"Object stored in database" 2526ms (17:40:13.132)
Trace[1788252629]: [2.5268845s] [2.5268845s] END
I0531 17:40:13.132811 1 trace.go:205] Trace[1040422210]: "Get" url:/api/v1/namespaces/default,user-agent:kube-apiserver/v1.23.6 (linux/amd64) kubernetes/ad33385,audit-id:19943911-f674-4af8-93b9-4d946f70dd89,client:127.0.0.1,accept:application/vnd.kubernetes.protobuf, */*,protocol:HTTP/2.0 (31-May-2022 17:40:11.106) (total time: 2026ms):
Trace[1040422210]: ---"About to write a response" 2026ms (17:40:13.132)
Trace[1040422210]: [2.0264395s] [2.0264395s] END
I0531 17:40:13.133466 1 trace.go:205] Trace[2858733]: "List" url:/api/v1/namespaces/default/pods,user-agent:e2e-windows-amd64.exe/v0.0.0 (windows/amd64) kubernetes/$Format,audit-id:bd4a9a02-c598-413a-a8b1-29a42f138d4c,client:192.168.49.1,accept:application/json, */*,protocol:HTTP/2.0 (31-May-2022 17:40:10.313) (total time: 2820ms):
Trace[2858733]: ---"Listing from storage done" 2819ms (17:40:13.132)
Trace[2858733]: [2.8201283s] [2.8201283s] END
I0531 17:40:13.132820 1 trace.go:205] Trace[393344095]: "Get" url:/api/v1/namespaces/kube-system/endpoints/k8s.io-minikube-hostpath,user-agent:storage-provisioner/v0.0.0 (linux/amd64) kubernetes/$Format,audit-id:7cb2b9e1-3040-4a1b-98d0-2da211d49607,client:192.168.49.2,accept:application/json, */*,protocol:HTTP/2.0 (31-May-2022 17:40:09.798) (total time: 3333ms):
Trace[393344095]: ---"About to write a response" 3333ms (17:40:13.132)
Trace[393344095]: [3.333828s] [3.333828s] END
W0531 17:51:52.489350 1 watcher.go:229] watch chan error: etcdserver: mvcc: required revision has been compacted
W0531 18:07:46.407468 1 watcher.go:229] watch chan error: etcdserver: mvcc: required revision has been compacted
*
* ==> kube-controller-manager [67bdd1b22c52] <==
* I0531 17:35:52.586194 1 shared_informer.go:247] Caches are synced for deployment
I0531 17:35:52.586612 1 shared_informer.go:247] Caches are synced for crt configmap
I0531 17:35:52.587022 1 shared_informer.go:247] Caches are synced for stateful set
I0531 17:35:52.587048 1 shared_informer.go:247] Caches are synced for namespace
I0531 17:35:52.587492 1 shared_informer.go:247] Caches are synced for ReplicaSet
I0531 17:35:52.587073 1 shared_informer.go:247] Caches are synced for TTL
I0531 17:35:52.590485 1 shared_informer.go:247] Caches are synced for GC
I0531 17:35:52.591621 1 shared_informer.go:247] Caches are synced for expand
I0531 17:35:52.592161 1 shared_informer.go:240] Waiting for caches to sync for garbage collector
I0531 17:35:52.593009 1 shared_informer.go:247] Caches are synced for certificate-csrapproving
I0531 17:35:52.593195 1 shared_informer.go:247] Caches are synced for PV protection
I0531 17:35:52.625116 1 shared_informer.go:247] Caches are synced for ClusterRoleAggregator
I0531 17:35:52.625668 1 shared_informer.go:247] Caches are synced for attach detach
I0531 17:35:52.691797 1 shared_informer.go:247] Caches are synced for resource quota
I0531 17:35:52.717799 1 shared_informer.go:247] Caches are synced for resource quota
I0531 17:35:53.193618 1 shared_informer.go:247] Caches are synced for garbage collector
I0531 17:35:53.216601 1 shared_informer.go:247] Caches are synced for garbage collector
I0531 17:35:53.216751 1 garbagecollector.go:155] Garbage collector: all resource monitors have synced. Proceeding to collect garbage
I0531 17:36:28.124977 1 event.go:294] "Event occurred" object="default/myclaim" 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"
I0531 17:36:37.487272 1 event.go:294] "Event occurred" object="default/hello-node-connect" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set hello-node-connect-74cf8bc446 to 1"
I0531 17:36:37.689199 1 event.go:294] "Event occurred" object="default/hello-node-connect-74cf8bc446" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: hello-node-connect-74cf8bc446-5wbb6"
I0531 17:37:01.384489 1 event.go:294] "Event occurred" object="default/hello-node" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set hello-node-54fbb85 to 1"
I0531 17:37:02.485730 1 event.go:294] "Event occurred" object="default/hello-node-54fbb85" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: hello-node-54fbb85-c6cbz"
I0531 17:39:27.189379 1 event.go:294] "Event occurred" object="default/mysql" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set mysql-b87c45988 to 1"
I0531 17:39:27.287705 1 event.go:294] "Event occurred" object="default/mysql-b87c45988" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: mysql-b87c45988-hqk85"
*
* ==> kube-controller-manager [ddadbb8af8f5] <==
* I0531 17:33:02.393030 1 shared_informer.go:247] Caches are synced for taint
I0531 17:33:02.393461 1 node_lifecycle_controller.go:1397] Initializing eviction metric for zone:
W0531 17:33:02.393579 1 node_lifecycle_controller.go:1012] Missing timestamp for Node functional-20220531173104-2108. Assuming now as a timestamp.
I0531 17:33:02.393654 1 node_lifecycle_controller.go:1213] Controller detected that zone is now in state Normal.
I0531 17:33:02.393994 1 taint_manager.go:187] "Starting NoExecuteTaintManager"
I0531 17:33:02.394783 1 event.go:294] "Event occurred" object="functional-20220531173104-2108" kind="Node" apiVersion="v1" type="Normal" reason="RegisteredNode" message="Node functional-20220531173104-2108 event: Registered Node functional-20220531173104-2108 in Controller"
I0531 17:33:02.394971 1 shared_informer.go:247] Caches are synced for ClusterRoleAggregator
I0531 17:33:02.489977 1 range_allocator.go:374] Set node functional-20220531173104-2108 PodCIDR to [10.244.0.0/24]
I0531 17:33:02.492251 1 shared_informer.go:247] Caches are synced for resource quota
I0531 17:33:02.496977 1 shared_informer.go:247] Caches are synced for disruption
I0531 17:33:02.497081 1 disruption.go:371] Sending events to api server.
I0531 17:33:02.503283 1 shared_informer.go:240] Waiting for caches to sync for garbage collector
I0531 17:33:02.509448 1 shared_informer.go:247] Caches are synced for stateful set
I0531 17:33:02.584994 1 shared_informer.go:247] Caches are synced for resource quota
I0531 17:33:02.594681 1 shared_informer.go:247] Caches are synced for service account
I0531 17:33:02.595225 1 shared_informer.go:247] Caches are synced for namespace
I0531 17:33:02.889741 1 event.go:294] "Event occurred" object="kube-system/coredns" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set coredns-64897985d to 2"
I0531 17:33:02.985790 1 shared_informer.go:247] Caches are synced for garbage collector
I0531 17:33:02.987849 1 shared_informer.go:247] Caches are synced for garbage collector
I0531 17:33:02.987963 1 garbagecollector.go:155] Garbage collector: all resource monitors have synced. Proceeding to collect garbage
I0531 17:33:02.995082 1 event.go:294] "Event occurred" object="kube-system/kube-proxy" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: kube-proxy-sc9l4"
I0531 17:33:03.193258 1 event.go:294] "Event occurred" object="kube-system/coredns-64897985d" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-64897985d-ct8qm"
I0531 17:33:03.295205 1 event.go:294] "Event occurred" object="kube-system/coredns-64897985d" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: coredns-64897985d-9zl57"
I0531 17:33:04.423418 1 event.go:294] "Event occurred" object="kube-system/coredns" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled down replica set coredns-64897985d to 1"
I0531 17:33:04.599470 1 event.go:294] "Event occurred" object="kube-system/coredns-64897985d" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulDelete" message="Deleted pod: coredns-64897985d-ct8qm"
*
* ==> kube-proxy [909e135e054c] <==
* E0531 17:33:06.103431 1 proxier.go:647] "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"
I0531 17:33:06.106486 1 proxier.go:657] "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"
I0531 17:33:06.110222 1 proxier.go:657] "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"
I0531 17:33:06.189907 1 proxier.go:657] "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"
I0531 17:33:06.195133 1 proxier.go:657] "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"
I0531 17:33:06.198664 1 proxier.go:657] "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"
I0531 17:33:06.327073 1 node.go:163] Successfully retrieved node IP: 192.168.49.2
I0531 17:33:06.327259 1 server_others.go:138] "Detected node IP" address="192.168.49.2"
I0531 17:33:06.327392 1 server_others.go:561] "Unknown proxy mode, assuming iptables proxy" proxyMode=""
I0531 17:33:06.688869 1 server_others.go:206] "Using iptables Proxier"
I0531 17:33:06.689291 1 server_others.go:213] "kube-proxy running in dual-stack mode" ipFamily=IPv4
I0531 17:33:06.689740 1 server_others.go:214] "Creating dualStackProxier for iptables"
I0531 17:33:06.689814 1 server_others.go:491] "Detect-local-mode set to ClusterCIDR, but no IPv6 cluster CIDR defined, , defaulting to no-op detect-local for IPv6"
I0531 17:33:06.692445 1 server.go:656] "Version info" version="v1.23.6"
I0531 17:33:06.696163 1 config.go:317] "Starting service config controller"
I0531 17:33:06.696291 1 shared_informer.go:240] Waiting for caches to sync for service config
I0531 17:33:06.696737 1 config.go:226] "Starting endpoint slice config controller"
I0531 17:33:06.696756 1 shared_informer.go:240] Waiting for caches to sync for endpoint slice config
I0531 17:33:06.797135 1 shared_informer.go:247] Caches are synced for endpoint slice config
I0531 17:33:06.797221 1 shared_informer.go:247] Caches are synced for service config
*
* ==> kube-proxy [ad11c3777c4e] <==
* I0531 17:35:24.098053 1 proxier.go:657] "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"
I0531 17:35:24.101813 1 proxier.go:657] "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"
I0531 17:35:24.104508 1 proxier.go:657] "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"
I0531 17:35:24.107448 1 proxier.go:657] "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"
E0531 17:35:24.185240 1 node.go:152] Failed to retrieve node info: Get "https://control-plane.minikube.internal:8441/api/v1/nodes/functional-20220531173104-2108": dial tcp 192.168.49.2:8441: connect: connection refused
E0531 17:35:25.227143 1 node.go:152] Failed to retrieve node info: Get "https://control-plane.minikube.internal:8441/api/v1/nodes/functional-20220531173104-2108": dial tcp 192.168.49.2:8441: connect: connection refused
I0531 17:35:33.386904 1 node.go:163] Successfully retrieved node IP: 192.168.49.2
I0531 17:35:33.387082 1 server_others.go:138] "Detected node IP" address="192.168.49.2"
I0531 17:35:33.387156 1 server_others.go:561] "Unknown proxy mode, assuming iptables proxy" proxyMode=""
I0531 17:35:33.805882 1 server_others.go:206] "Using iptables Proxier"
I0531 17:35:33.806008 1 server_others.go:213] "kube-proxy running in dual-stack mode" ipFamily=IPv4
I0531 17:35:33.806021 1 server_others.go:214] "Creating dualStackProxier for iptables"
I0531 17:35:33.806044 1 server_others.go:491] "Detect-local-mode set to ClusterCIDR, but no IPv6 cluster CIDR defined, , defaulting to no-op detect-local for IPv6"
I0531 17:35:33.806489 1 server.go:656] "Version info" version="v1.23.6"
I0531 17:35:33.807519 1 config.go:317] "Starting service config controller"
I0531 17:35:33.807537 1 shared_informer.go:240] Waiting for caches to sync for service config
I0531 17:35:33.807580 1 config.go:226] "Starting endpoint slice config controller"
I0531 17:35:33.807585 1 shared_informer.go:240] Waiting for caches to sync for endpoint slice config
I0531 17:35:33.908774 1 shared_informer.go:247] Caches are synced for endpoint slice config
I0531 17:35:33.908937 1 shared_informer.go:247] Caches are synced for service config
W0531 17:35:34.187163 1 reflector.go:442] k8s.io/client-go/informers/factory.go:134: watch of *v1.Service ended with: very short watch: k8s.io/client-go/informers/factory.go:134: Unexpected watch close - watch lasted less than a second and no items received
W0531 17:35:34.187246 1 reflector.go:442] k8s.io/client-go/informers/factory.go:134: watch of *v1.EndpointSlice ended with: very short watch: k8s.io/client-go/informers/factory.go:134: Unexpected watch close - watch lasted less than a second and no items received
E0531 17:35:34.187323 1 event_broadcaster.go:262] Unable to write event: 'Post "https://control-plane.minikube.internal:8441/apis/events.k8s.io/v1/namespaces/default/events": unexpected EOF' (may retry after sleeping)
W0531 17:35:35.389226 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.Service: Get "https://control-plane.minikube.internal:8441/api/v1/services?labelSelector=%!s(MISSING)ervice.kubernetes.io%!F(MISSING)headless%!C(MISSING)%!s(MISSING)ervice.kubernetes.io%!F(MISSING)service-proxy-name&resourceVersion=586": dial tcp 192.168.49.2:8441: connect: connection refused
E0531 17:35:35.389399 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.Service: failed to list *v1.Service: Get "https://control-plane.minikube.internal:8441/api/v1/services?labelSelector=%!s(MISSING)ervice.kubernetes.io%!F(MISSING)headless%!C(MISSING)%!s(MISSING)ervice.kubernetes.io%!F(MISSING)service-proxy-name&resourceVersion=586": dial tcp 192.168.49.2:8441: connect: connection refused
*
* ==> kube-scheduler [adf0898fd4ff] <==
* E0531 17:35:39.190312 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.StatefulSet: failed to list *v1.StatefulSet: statefulsets.apps is forbidden: User "system:kube-scheduler" cannot list resource "statefulsets" in API group "apps" at the cluster scope
W0531 17:35:39.190431 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.ReplicationController: replicationcontrollers is forbidden: User "system:kube-scheduler" cannot list resource "replicationcontrollers" in API group "" at the cluster scope
E0531 17:35:39.190512 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.ReplicationController: failed to list *v1.ReplicationController: replicationcontrollers is forbidden: User "system:kube-scheduler" cannot list resource "replicationcontrollers" in API group "" at the cluster scope
W0531 17:35:39.190547 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.PersistentVolume: persistentvolumes is forbidden: User "system:kube-scheduler" cannot list resource "persistentvolumes" in API group "" at the cluster scope
E0531 17:35:39.190726 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.PersistentVolume: failed to list *v1.PersistentVolume: persistentvolumes is forbidden: User "system:kube-scheduler" cannot list resource "persistentvolumes" in API group "" at the cluster scope
W0531 17:35:39.191107 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.PersistentVolumeClaim: persistentvolumeclaims is forbidden: User "system:kube-scheduler" cannot list resource "persistentvolumeclaims" in API group "" at the cluster scope
W0531 17:35:39.191011 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.Service: services is forbidden: User "system:kube-scheduler" cannot list resource "services" in API group "" at the cluster scope
W0531 17:35:39.190885 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1beta1.CSIStorageCapacity: csistoragecapacities.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "csistoragecapacities" in API group "storage.k8s.io" at the cluster scope
W0531 17:35:39.191304 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.Namespace: namespaces is forbidden: User "system:kube-scheduler" cannot list resource "namespaces" in API group "" at the cluster scope
W0531 17:35:39.191378 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.PodDisruptionBudget: poddisruptionbudgets.policy is forbidden: User "system:kube-scheduler" cannot list resource "poddisruptionbudgets" in API group "policy" at the cluster scope
E0531 17:35:39.191418 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.PodDisruptionBudget: failed to list *v1.PodDisruptionBudget: poddisruptionbudgets.policy is forbidden: User "system:kube-scheduler" cannot list resource "poddisruptionbudgets" in API group "policy" at the cluster scope
E0531 17:35:39.191448 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.Namespace: failed to list *v1.Namespace: namespaces is forbidden: User "system:kube-scheduler" cannot list resource "namespaces" in API group "" at the cluster scope
E0531 17:35:39.191508 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.Node: unknown (get nodes)
E0531 17:35:39.191561 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.Pod: unknown (get pods)
W0531 17:35:39.191747 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.ReplicaSet: replicasets.apps is forbidden: User "system:kube-scheduler" cannot list resource "replicasets" in API group "apps" at the cluster scope
E0531 17:35:39.191747 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.PersistentVolumeClaim: failed to list *v1.PersistentVolumeClaim: persistentvolumeclaims is forbidden: User "system:kube-scheduler" cannot list resource "persistentvolumeclaims" in API group "" at the cluster scope
W0531 17:35:39.190596 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.StorageClass: storageclasses.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "storageclasses" in API group "storage.k8s.io" at the cluster scope
E0531 17:35:39.287970 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.StorageClass: failed to list *v1.StorageClass: storageclasses.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "storageclasses" in API group "storage.k8s.io" at the cluster scope
E0531 17:35:39.191321 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User "system:kube-scheduler" cannot list resource "services" in API group "" at the cluster scope
E0531 17:35:39.191420 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1beta1.CSIStorageCapacity: failed to list *v1beta1.CSIStorageCapacity: csistoragecapacities.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "csistoragecapacities" in API group "storage.k8s.io" at the cluster scope
W0531 17:35:39.190556 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope
E0531 17:35:39.288095 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.CSIDriver: failed to list *v1.CSIDriver: csidrivers.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "csidrivers" in API group "storage.k8s.io" at the cluster scope
E0531 17:35:39.191783 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.ReplicaSet: failed to list *v1.ReplicaSet: replicasets.apps is forbidden: User "system:kube-scheduler" cannot list resource "replicasets" in API group "apps" at the cluster scope
W0531 17:35:39.295870 1 reflector.go:324] k8s.io/apiserver/pkg/server/dynamiccertificates/configmap_cafile_content.go:205: failed to list *v1.ConfigMap: configmaps "extension-apiserver-authentication" is forbidden: User "system:kube-scheduler" cannot list resource "configmaps" in API group "" in the namespace "kube-system"
E0531 17:35:39.296068 1 reflector.go:138] k8s.io/apiserver/pkg/server/dynamiccertificates/configmap_cafile_content.go:205: Failed to watch *v1.ConfigMap: failed to list *v1.ConfigMap: configmaps "extension-apiserver-authentication" is forbidden: User "system:kube-scheduler" cannot list resource "configmaps" in API group "" in the namespace "kube-system"
*
* ==> kube-scheduler [f808f562e4c4] <==
* W0531 17:32:45.288186 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.CSINode: csinodes.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "csinodes" in API group "storage.k8s.io" at the cluster scope
E0531 17:32:45.288296 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.CSINode: failed to list *v1.CSINode: csinodes.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "csinodes" in API group "storage.k8s.io" at the cluster scope
W0531 17:32:45.288300 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.Node: nodes is forbidden: User "system:kube-scheduler" cannot list resource "nodes" in API group "" at the cluster scope
W0531 17:32:45.288524 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.StorageClass: storageclasses.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "storageclasses" in API group "storage.k8s.io" at the cluster scope
E0531 17:32:45.288540 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.Node: failed to list *v1.Node: nodes is forbidden: User "system:kube-scheduler" cannot list resource "nodes" in API group "" at the cluster scope
E0531 17:32:45.288552 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.StorageClass: failed to list *v1.StorageClass: storageclasses.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "storageclasses" in API group "storage.k8s.io" at the cluster scope
W0531 17:32:45.589835 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.ReplicationController: replicationcontrollers is forbidden: User "system:kube-scheduler" cannot list resource "replicationcontrollers" in API group "" at the cluster scope
E0531 17:32:45.589984 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.ReplicationController: failed to list *v1.ReplicationController: replicationcontrollers is forbidden: User "system:kube-scheduler" cannot list resource "replicationcontrollers" in API group "" at the cluster scope
W0531 17:32:45.702471 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.PodDisruptionBudget: poddisruptionbudgets.policy is forbidden: User "system:kube-scheduler" cannot list resource "poddisruptionbudgets" in API group "policy" at the cluster scope
E0531 17:32:45.702598 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.PodDisruptionBudget: failed to list *v1.PodDisruptionBudget: poddisruptionbudgets.policy is forbidden: User "system:kube-scheduler" cannot list resource "poddisruptionbudgets" in API group "policy" at the cluster scope
W0531 17:32:45.731493 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1beta1.CSIStorageCapacity: csistoragecapacities.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "csistoragecapacities" in API group "storage.k8s.io" at the cluster scope
E0531 17:32:45.731611 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1beta1.CSIStorageCapacity: failed to list *v1beta1.CSIStorageCapacity: csistoragecapacities.storage.k8s.io is forbidden: User "system:kube-scheduler" cannot list resource "csistoragecapacities" in API group "storage.k8s.io" at the cluster scope
W0531 17:32:45.741158 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.StatefulSet: statefulsets.apps is forbidden: User "system:kube-scheduler" cannot list resource "statefulsets" in API group "apps" at the cluster scope
E0531 17:32:45.741325 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.StatefulSet: failed to list *v1.StatefulSet: statefulsets.apps is forbidden: User "system:kube-scheduler" cannot list resource "statefulsets" in API group "apps" at the cluster scope
W0531 17:32:45.807409 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.Service: services is forbidden: User "system:kube-scheduler" cannot list resource "services" in API group "" at the cluster scope
E0531 17:32:45.807526 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.Service: failed to list *v1.Service: services is forbidden: User "system:kube-scheduler" cannot list resource "services" in API group "" at the cluster scope
W0531 17:32:45.829957 1 reflector.go:324] k8s.io/client-go/informers/factory.go:134: failed to list *v1.PersistentVolumeClaim: persistentvolumeclaims is forbidden: User "system:kube-scheduler" cannot list resource "persistentvolumeclaims" in API group "" at the cluster scope
E0531 17:32:45.830093 1 reflector.go:138] k8s.io/client-go/informers/factory.go:134: Failed to watch *v1.PersistentVolumeClaim: failed to list *v1.PersistentVolumeClaim: persistentvolumeclaims is forbidden: User "system:kube-scheduler" cannot list resource "persistentvolumeclaims" in API group "" at the cluster scope
W0531 17:32:47.002641 1 reflector.go:324] k8s.io/apiserver/pkg/server/dynamiccertificates/configmap_cafile_content.go:205: failed to list *v1.ConfigMap: configmaps "extension-apiserver-authentication" is forbidden: User "system:kube-scheduler" cannot list resource "configmaps" in API group "" in the namespace "kube-system"
E0531 17:32:47.002772 1 reflector.go:138] k8s.io/apiserver/pkg/server/dynamiccertificates/configmap_cafile_content.go:205: Failed to watch *v1.ConfigMap: failed to list *v1.ConfigMap: configmaps "extension-apiserver-authentication" is forbidden: User "system:kube-scheduler" cannot list resource "configmaps" in API group "" in the namespace "kube-system"
E0531 17:32:47.087448 1 plugin.go:138] "getting namespace, assuming empty set of namespace labels" err="namespace \"kube-system\" not found" namespace="kube-system"
I0531 17:32:51.587983 1 shared_informer.go:247] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0531 17:35:19.631143 1 configmap_cafile_content.go:222] "Shutting down controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0531 17:35:19.631934 1 tlsconfig.go:255] "Shutting down DynamicServingCertificateController"
I0531 17:35:19.632617 1 secure_serving.go:311] Stopped listening on 127.0.0.1:10259
*
* ==> kubelet <==
* -- Logs begin at Tue 2022-05-31 17:31:59 UTC, end at Tue 2022-05-31 18:11:20 UTC. --
May 31 17:37:05 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:05.105444 6055 reconciler.go:221] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-mlwfx\" (UniqueName: \"kubernetes.io/projected/b31211e5-01d1-4a06-9d69-72182ab83802-kube-api-access-mlwfx\") pod \"sp-pod\" (UID: \"b31211e5-01d1-4a06-9d69-72182ab83802\") " pod="default/sp-pod"
May 31 17:37:05 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:05.287672 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/hello-node-54fbb85-c6cbz through plugin: invalid network status for"
May 31 17:37:05 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:05.287695 6055 pod_container_deletor.go:79] "Container not found in pod's containers" containerID="7ef50adfd038f2286f21035755a0bc0609a23b76236474e8b4d00792eecf0d76"
May 31 17:37:05 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:05.906126 6055 kubelet_volumes.go:160] "Cleaned up orphaned pod volumes dir" podUID=21fd3f05-62fb-433b-8773-6875c87575ce path="/var/lib/kubelet/pods/21fd3f05-62fb-433b-8773-6875c87575ce/volumes"
May 31 17:37:06 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:06.305829 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/hello-node-54fbb85-c6cbz through plugin: invalid network status for"
May 31 17:37:07 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:07.129839 6055 pod_container_deletor.go:79] "Container not found in pod's containers" containerID="00208e1f542a1644bacc9fc2e4e3d6cce48255de697dfc5e59ad362f05793ffb"
May 31 17:37:07 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:07.130189 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/sp-pod through plugin: invalid network status for"
May 31 17:37:07 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:07.139575 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/hello-node-connect-74cf8bc446-5wbb6 through plugin: invalid network status for"
May 31 17:37:08 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:08.207787 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/hello-node-connect-74cf8bc446-5wbb6 through plugin: invalid network status for"
May 31 17:37:08 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:08.219427 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/hello-node-54fbb85-c6cbz through plugin: invalid network status for"
May 31 17:37:08 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:08.233119 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/sp-pod through plugin: invalid network status for"
May 31 17:37:09 functional-20220531173104-2108 kubelet[6055]: I0531 17:37:09.634733 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/sp-pod through plugin: invalid network status for"
May 31 17:39:27 functional-20220531173104-2108 kubelet[6055]: I0531 17:39:27.296674 6055 topology_manager.go:200] "Topology Admit Handler"
May 31 17:39:27 functional-20220531173104-2108 kubelet[6055]: I0531 17:39:27.489435 6055 reconciler.go:221] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-47pdt\" (UniqueName: \"kubernetes.io/projected/f511a394-30ea-40ce-9841-29501af6ecf7-kube-api-access-47pdt\") pod \"mysql-b87c45988-hqk85\" (UID: \"f511a394-30ea-40ce-9841-29501af6ecf7\") " pod="default/mysql-b87c45988-hqk85"
May 31 17:39:29 functional-20220531173104-2108 kubelet[6055]: I0531 17:39:29.228606 6055 pod_container_deletor.go:79] "Container not found in pod's containers" containerID="333834c1cb3d8874bb9a5260ff5c49ec9c421df7d40510d4994f747cf7b71ec7"
May 31 17:39:29 functional-20220531173104-2108 kubelet[6055]: I0531 17:39:29.228681 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/mysql-b87c45988-hqk85 through plugin: invalid network status for"
May 31 17:39:30 functional-20220531173104-2108 kubelet[6055]: I0531 17:39:30.248557 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/mysql-b87c45988-hqk85 through plugin: invalid network status for"
May 31 17:40:13 functional-20220531173104-2108 kubelet[6055]: I0531 17:40:13.811273 6055 docker_sandbox.go:402] "Failed to read pod IP from plugin/docker" err="Couldn't find network status for default/mysql-b87c45988-hqk85 through plugin: invalid network status for"
May 31 17:40:32 functional-20220531173104-2108 kubelet[6055]: W0531 17:40:32.493500 6055 sysinfo.go:203] Nodes topology is not available, providing CPU topology
May 31 17:45:32 functional-20220531173104-2108 kubelet[6055]: W0531 17:45:32.497023 6055 sysinfo.go:203] Nodes topology is not available, providing CPU topology
May 31 17:50:32 functional-20220531173104-2108 kubelet[6055]: W0531 17:50:32.501018 6055 sysinfo.go:203] Nodes topology is not available, providing CPU topology
May 31 17:55:32 functional-20220531173104-2108 kubelet[6055]: W0531 17:55:32.501239 6055 sysinfo.go:203] Nodes topology is not available, providing CPU topology
May 31 18:00:32 functional-20220531173104-2108 kubelet[6055]: W0531 18:00:32.500643 6055 sysinfo.go:203] Nodes topology is not available, providing CPU topology
May 31 18:05:32 functional-20220531173104-2108 kubelet[6055]: W0531 18:05:32.502294 6055 sysinfo.go:203] Nodes topology is not available, providing CPU topology
May 31 18:10:32 functional-20220531173104-2108 kubelet[6055]: W0531 18:10:32.502814 6055 sysinfo.go:203] Nodes topology is not available, providing CPU topology
*
* ==> storage-provisioner [a24e38366a7b] <==
* I0531 17:35:42.604630 1 storage_provisioner.go:116] Initializing the minikube storage provisioner...
I0531 17:35:42.693442 1 storage_provisioner.go:141] Storage provisioner initialized, now starting service!
I0531 17:35:42.693925 1 leaderelection.go:243] attempting to acquire leader lease kube-system/k8s.io-minikube-hostpath...
I0531 17:36:00.237376 1 leaderelection.go:253] successfully acquired lease kube-system/k8s.io-minikube-hostpath
I0531 17:36:00.237517 1 event.go:282] Event(v1.ObjectReference{Kind:"Endpoints", Namespace:"kube-system", Name:"k8s.io-minikube-hostpath", UID:"384e3ae8-40aa-4b44-8ed1-ea8b9c2eb632", APIVersion:"v1", ResourceVersion:"648", FieldPath:""}): type: 'Normal' reason: 'LeaderElection' functional-20220531173104-2108_eb15f159-a5f4-4351-8afd-7524ee07e4af became leader
I0531 17:36:00.237615 1 controller.go:835] Starting provisioner controller k8s.io/minikube-hostpath_functional-20220531173104-2108_eb15f159-a5f4-4351-8afd-7524ee07e4af!
I0531 17:36:00.338799 1 controller.go:884] Started provisioner controller k8s.io/minikube-hostpath_functional-20220531173104-2108_eb15f159-a5f4-4351-8afd-7524ee07e4af!
I0531 17:36:28.124827 1 controller.go:1332] provision "default/myclaim" class "standard": started
I0531 17:36:28.125875 1 event.go:282] Event(v1.ObjectReference{Kind:"PersistentVolumeClaim", Namespace:"default", Name:"myclaim", UID:"18fcadfc-4369-421a-97a7-f376ed316380", APIVersion:"v1", ResourceVersion:"686", FieldPath:""}): type: 'Normal' reason: 'Provisioning' External provisioner is provisioning volume for claim "default/myclaim"
I0531 17:36:28.125373 1 storage_provisioner.go:61] Provisioning volume {&StorageClass{ObjectMeta:{standard b434fe0f-783d-4d0d-8b61-1218c61b254f 471 0 2022-05-31 17:33:10 +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-05-31 17:33:10 +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-18fcadfc-4369-421a-97a7-f376ed316380 &PersistentVolumeClaim{ObjectMeta:{myclaim default 18fcadfc-4369-421a-97a7-f376ed316380 686 0 2022-05-31 17:36:28 +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-05-31 17:36:28 +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-05-31 17:36:28 +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
I0531 17:36:28.128438 1 controller.go:1439] provision "default/myclaim" class "standard": volume "pvc-18fcadfc-4369-421a-97a7-f376ed316380" provisioned
I0531 17:36:28.129530 1 controller.go:1456] provision "default/myclaim" class "standard": succeeded
I0531 17:36:28.129644 1 volume_store.go:212] Trying to save persistentvolume "pvc-18fcadfc-4369-421a-97a7-f376ed316380"
I0531 17:36:28.141506 1 volume_store.go:219] persistentvolume "pvc-18fcadfc-4369-421a-97a7-f376ed316380" saved
I0531 17:36:28.142141 1 event.go:282] Event(v1.ObjectReference{Kind:"PersistentVolumeClaim", Namespace:"default", Name:"myclaim", UID:"18fcadfc-4369-421a-97a7-f376ed316380", APIVersion:"v1", ResourceVersion:"686", FieldPath:""}): type: 'Normal' reason: 'ProvisioningSucceeded' Successfully provisioned volume pvc-18fcadfc-4369-421a-97a7-f376ed316380
*
* ==> storage-provisioner [c93090aa2535] <==
* I0531 17:35:24.385678 1 storage_provisioner.go:116] Initializing the minikube storage provisioner...
F0531 17:35:24.389863 1 main.go:39] error getting server version: Get "https://10.96.0.1:443/version?timeout=32s": dial tcp 10.96.0.1:443: connect: connection refused
-- /stdout --
helpers_test.go:254: (dbg) Run: out/minikube-windows-amd64.exe status --format={{.APIServer}} -p functional-20220531173104-2108 -n functional-20220531173104-2108
helpers_test.go:254: (dbg) Done: out/minikube-windows-amd64.exe status --format={{.APIServer}} -p functional-20220531173104-2108 -n functional-20220531173104-2108: (6.3387248s)
helpers_test.go:261: (dbg) Run: kubectl --context functional-20220531173104-2108 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-20220531173104-2108 describe pod
helpers_test.go:275: (dbg) Non-zero exit: kubectl --context functional-20220531173104-2108 describe pod : exit status 1 (199.0365ms)
** stderr **
error: resource name may not be empty
** /stderr **
helpers_test.go:277: kubectl --context functional-20220531173104-2108 describe pod : exit status 1
--- FAIL: TestFunctional/parallel/ServiceCmd (2067.20s)