=== RUN TestFunctional/parallel/ServiceCmd
=== PAUSE TestFunctional/parallel/ServiceCmd
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1432: (dbg) Run: kubectl --context functional-20220728203726-27744 create deployment hello-node --image=k8s.gcr.io/echoserver:1.8
functional_test.go:1438: (dbg) Run: kubectl --context functional-20220728203726-27744 expose deployment hello-node --type=NodePort --port=8080
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-54c4b5c49f-mp9qv" [2bcba4e3-74d3-458b-9a49-49d72c1edb76] 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-54c4b5c49f-mp9qv" [2bcba4e3-74d3-458b-9a49-49d72c1edb76] Running
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1443: (dbg) TestFunctional/parallel/ServiceCmd: app=hello-node healthy within 35.0755855s
functional_test.go:1448: (dbg) Run: out/minikube-windows-amd64.exe -p functional-20220728203726-27744 service list
=== CONT TestFunctional/parallel/ServiceCmd
functional_test.go:1448: (dbg) Done: out/minikube-windows-amd64.exe -p functional-20220728203726-27744 service list: (3.7292095s)
functional_test.go:1462: (dbg) Run: out/minikube-windows-amd64.exe -p functional-20220728203726-27744 service --namespace=default --https --url hello-node
=== CONT TestFunctional/parallel/ServiceCmd
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-20220728203726-27744 service --namespace=default --https --url hello-node: exit status 1 (34m16.2189506s)
-- stdout --
https://127.0.0.1:52039
-- /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-20220728203726-27744 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-20220728203726-27744 describe po hello-node
E0728 21:17:26.580461 27744 cert_rotation.go:168] key failed with : open C:\Users\jenkins.minikube3\minikube-integration\.minikube\profiles\addons-20220728202616-27744\client.crt: The system cannot find the path specified.
functional_test.go:1409: hello-node pod describe:
Name: hello-node-54c4b5c49f-mp9qv
Namespace: default
Priority: 0
Node: functional-20220728203726-27744/192.168.49.2
Start Time: Thu, 28 Jul 2022 20:42:30 +0000
Labels: app=hello-node
pod-template-hash=54c4b5c49f
Annotations: <none>
Status: Running
IP: 172.17.0.6
IPs:
IP: 172.17.0.6
Controlled By: ReplicaSet/hello-node-54c4b5c49f
Containers:
echoserver:
Container ID: docker://944fab2be43b494ca66ef118ee94ac1aa906b3eff24c1578b1545f5ee27d7afd
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: Thu, 28 Jul 2022 20:43:00 +0000
Ready: True
Restart Count: 0
Environment: <none>
Mounts:
/var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-f7thl (ro)
Conditions:
Type Status
Initialized True
Ready True
ContainersReady True
PodScheduled True
Volumes:
kube-api-access-f7thl:
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-54c4b5c49f-mp9qv to functional-20220728203726-27744
Normal Pulling 34m kubelet, functional-20220728203726-27744 Pulling image "k8s.gcr.io/echoserver:1.8"
Normal Pulled 34m kubelet, functional-20220728203726-27744 Successfully pulled image "k8s.gcr.io/echoserver:1.8" in 24.207801s
Normal Created 34m kubelet, functional-20220728203726-27744 Created container echoserver
Normal Started 34m kubelet, functional-20220728203726-27744 Started container echoserver
Name: hello-node-connect-578cdc45cb-sgj5n
Namespace: default
Priority: 0
Node: functional-20220728203726-27744/192.168.49.2
Start Time: Thu, 28 Jul 2022 20:42:22 +0000
Labels: app=hello-node-connect
pod-template-hash=578cdc45cb
Annotations: <none>
Status: Running
IP: 172.17.0.5
IPs:
IP: 172.17.0.5
Controlled By: ReplicaSet/hello-node-connect-578cdc45cb
Containers:
echoserver:
Container ID: docker://28d78eee7dd3c4ce89d155e6e177a114dff6f4bae802e1c061897107d127e444
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: Thu, 28 Jul 2022 20:42:59 +0000
Ready: True
Restart Count: 0
Environment: <none>
Mounts:
/var/run/secrets/kubernetes.io/serviceaccount from kube-api-access-zj86d (ro)
Conditions:
Type Status
Initialized True
Ready True
ContainersReady True
PodScheduled True
Volumes:
kube-api-access-zj86d:
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-578cdc45cb-sgj5n to functional-20220728203726-27744
Normal Pulling 35m kubelet, functional-20220728203726-27744 Pulling image "k8s.gcr.io/echoserver:1.8"
Normal Pulled 34m kubelet, functional-20220728203726-27744 Successfully pulled image "k8s.gcr.io/echoserver:1.8" in 33.3438236s
Normal Created 34m kubelet, functional-20220728203726-27744 Created container echoserver
Normal Started 34m kubelet, functional-20220728203726-27744 Started container echoserver
functional_test.go:1411: (dbg) Run: kubectl --context functional-20220728203726-27744 logs -l app=hello-node
functional_test.go:1415: hello-node logs:
functional_test.go:1417: (dbg) Run: kubectl --context functional-20220728203726-27744 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.103.90.157
Port: <unset> 8080/TCP
TargetPort: 8080/TCP
NodePort: <unset> 31806/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-20220728203726-27744
helpers_test.go:235: (dbg) docker inspect functional-20220728203726-27744:
-- stdout --
[
{
"Id": "fdf6bb16013a067f8d911a381fdb9cbd8cb2de32be10540ed0e540bfc978fb7c",
"Created": "2022-07-28T20:38:04.8404274Z",
"Path": "/usr/local/bin/entrypoint",
"Args": [
"/sbin/init"
],
"State": {
"Status": "running",
"Running": true,
"Paused": false,
"Restarting": false,
"OOMKilled": false,
"Dead": false,
"Pid": 24933,
"ExitCode": 0,
"Error": "",
"StartedAt": "2022-07-28T20:38:05.8355415Z",
"FinishedAt": "0001-01-01T00:00:00Z"
},
"Image": "sha256:443d84da239e4e701685e1614ef94cd6b60d0f0b15265a51d4f657992a9c59d8",
"ResolvConfPath": "/var/lib/docker/containers/fdf6bb16013a067f8d911a381fdb9cbd8cb2de32be10540ed0e540bfc978fb7c/resolv.conf",
"HostnamePath": "/var/lib/docker/containers/fdf6bb16013a067f8d911a381fdb9cbd8cb2de32be10540ed0e540bfc978fb7c/hostname",
"HostsPath": "/var/lib/docker/containers/fdf6bb16013a067f8d911a381fdb9cbd8cb2de32be10540ed0e540bfc978fb7c/hosts",
"LogPath": "/var/lib/docker/containers/fdf6bb16013a067f8d911a381fdb9cbd8cb2de32be10540ed0e540bfc978fb7c/fdf6bb16013a067f8d911a381fdb9cbd8cb2de32be10540ed0e540bfc978fb7c-json.log",
"Name": "/functional-20220728203726-27744",
"RestartCount": 0,
"Driver": "overlay2",
"Platform": "linux",
"MountLabel": "",
"ProcessLabel": "",
"AppArmorProfile": "",
"ExecIDs": null,
"HostConfig": {
"Binds": [
"/lib/modules:/lib/modules:ro",
"functional-20220728203726-27744:/var"
],
"ContainerIDFile": "",
"LogConfig": {
"Type": "json-file",
"Config": {}
},
"NetworkMode": "functional-20220728203726-27744",
"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/56ba0dbae77c21542ce09bde2236d40a56567039813c9c145607e66b7993aa96-init/diff:/var/lib/docker/overlay2/ebecdb71656480305a1aa55ac86b030f1a154d9d8d097f88c76377098f48e268/diff:/var/lib/docker/overlay2/c14561e4f6bbff05c1b2e7429787d40177404e1f306f4a6f0b6d90ea83cbf54e/diff:/var/lib/docker/overlay2/936f80e53da17a3d9a57cc525b05c63820da5883c2e53c0a76dca49756522fd1/diff:/var/lib/docker/overlay2/d14740c04a488879c4403b9c07129daedf98e5dfd5866887394aa9fe7b0db342/diff:/var/lib/docker/overlay2/333462924dcaac50a06ba4eefdc15184fd3c18e000554b1040c6bf7e7835ec6d/diff:/var/lib/docker/overlay2/59dfade3ee7dbb9ed491b304d06aa0a9bbc98c6e5dea1b6be790c3416f5892a8/diff:/var/lib/docker/overlay2/a79b1887950ebd2f820f0a90dc8979a29aad7a215a286957040946a0ba88b0f6/diff:/var/lib/docker/overlay2/78cdbdc0890181e0dcfb77f70bb8db25238349a68442176b9e5ea754022c8d89/diff:/var/lib/docker/overlay2/d05f8af40df9c46549bff017da23a5cb64c9f0f858adc53de6aef169f936e966/diff:/var/lib/docker/overlay2/8f354d
ea73b2f123706fae0f0e9d4c65fbdc54ae4e3de9ecff2a2e155ba34be9/diff:/var/lib/docker/overlay2/28a80e2c77dc5eb593605717ddc26b28e49f68990763513bcb8f6fb561c4b90f/diff:/var/lib/docker/overlay2/f314c6d36ebf9c950702f2c2fc0d5f5b7b293c5b584ed4fa51551c30c8c899b8/diff:/var/lib/docker/overlay2/e85c14137d84e0c5023e37e5afe54212359defeeee98c93535afdbaa550fe577/diff:/var/lib/docker/overlay2/492d925fc29c74b755bfa500f8896cf44e1f59a39b683b31e76d1921584692ab/diff:/var/lib/docker/overlay2/7a69f14d801b4be27ce30bd2c509ddbca158af143411194039296d11f04e3b32/diff:/var/lib/docker/overlay2/78bdfe15d6b7fedd3679e17b00e877ea62930eff304510bbeb22e71110d33ba8/diff:/var/lib/docker/overlay2/eeb0cbb566d31d052984333791c66667cff44287be43251f1f1aa10fead89fdd/diff:/var/lib/docker/overlay2/c81f3fd31b800a3c7eeece1a6800edf733de0fdc30d0ae04489e064febaa27c6/diff:/var/lib/docker/overlay2/59d1d6c9c9504806b1ce39b6a6d742c47dc429f8f11a65bc384f19f1723dbb45/diff:/var/lib/docker/overlay2/19979a43f2af5361e7dc4bdd753b57d089e786724c175868f7d62f7ec190f964/diff:/var/lib/d
ocker/overlay2/21d9bcba520e1fe22b6e26da53cbba3a751d76a59b8cd2fa2a3f409d99f81483/diff:/var/lib/docker/overlay2/d73c755d0106b41bff6dcf25767365438e020e7d81b81130565fdc9ccb6d1b0d/diff:/var/lib/docker/overlay2/259cfbec3c50ebd81f7a228f72137516cb223891943a507c5c9c68dde6383372/diff:/var/lib/docker/overlay2/3879c7f551bc50dc7dc03393437f6c68a37c6378bea342870290cc78840bb1e3/diff:/var/lib/docker/overlay2/ac65de79a2894e4f8992310ae6afe87998c8c1792356068d4e6653a3f0487e6e/diff:/var/lib/docker/overlay2/9130c29718c8b36f4adf94e6108e380585c0f77750eb3957eceaabfeb58049e8/diff:/var/lib/docker/overlay2/32199a5fadb8b1c2cd0a5a69b1283eecd156fe1052ea15e02b908a5eea9b836a/diff:/var/lib/docker/overlay2/de4dec5172922a86ba0a6a30f68bcc6dfc77e6285f7320a96462f748991b3916/diff:/var/lib/docker/overlay2/61e4ba463cd9151b3050de5b24e83f91a6e138c6b805731e645798d883222a65/diff:/var/lib/docker/overlay2/5f52d47d39f925d3d4a3645638d17578048feb6d4286bd31f39b95c8e8c8c229/diff:/var/lib/docker/overlay2/1a13368053b344c17d225c40910c3c37373608b8e78bed20ecc48abf45f
eb120/diff:/var/lib/docker/overlay2/54c865e16adbb827d22f0fc0618481e7400b927f9422836ccaca18e4645e747f/diff:/var/lib/docker/overlay2/321eb988a8ba0a167857b796df3acec4271dfd02aa89452066a4b460b7f73332/diff:/var/lib/docker/overlay2/5610e1b58b8e3a980de417158c7e62ecf33740952b46b2f75b49f1848a499900/diff:/var/lib/docker/overlay2/ab22495a3912b008af446048dd014b4b579e43200c9d1ed11c802503995dba46/diff:/var/lib/docker/overlay2/e404abc02affa7284514059cf76c8512861900c0c4a2dd286b99e67ed5e161d0/diff:/var/lib/docker/overlay2/ba6f3d60d6fd1b31ef5f979e1a9e3067e08fc4411d2d5937d088d70d17faa3d5/diff:/var/lib/docker/overlay2/f44fbc714e4b440971a163c215f59ba5c746a7ebb53a45957e9080b35436b35b/diff:/var/lib/docker/overlay2/f5286d4a862c9778724aa4c8cd3982f46e695f7b09e4028af862280e664a21c0/diff:/var/lib/docker/overlay2/853537d2434c970552ad9e84d88bc994c866ec7da63cf6271f2a6f1b31373120/diff:/var/lib/docker/overlay2/3ba7da58fc5b3091996ea298f0948d9716f4788be18e837eef06d4ce355446a4/diff",
"MergedDir": "/var/lib/docker/overlay2/56ba0dbae77c21542ce09bde2236d40a56567039813c9c145607e66b7993aa96/merged",
"UpperDir": "/var/lib/docker/overlay2/56ba0dbae77c21542ce09bde2236d40a56567039813c9c145607e66b7993aa96/diff",
"WorkDir": "/var/lib/docker/overlay2/56ba0dbae77c21542ce09bde2236d40a56567039813c9c145607e66b7993aa96/work"
},
"Name": "overlay2"
},
"Mounts": [
{
"Type": "bind",
"Source": "/lib/modules",
"Destination": "/lib/modules",
"Mode": "ro",
"RW": false,
"Propagation": "rprivate"
},
{
"Type": "volume",
"Name": "functional-20220728203726-27744",
"Source": "/var/lib/docker/volumes/functional-20220728203726-27744/_data",
"Destination": "/var",
"Driver": "local",
"Mode": "z",
"RW": true,
"Propagation": ""
}
],
"Config": {
"Hostname": "functional-20220728203726-27744",
"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.32-1656700284-14481@sha256:96d18f055abcf72b9f587e13317d6f9b5bb6f60e9fa09d6c51e11defaf9bf842",
"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-20220728203726-27744",
"name.minikube.sigs.k8s.io": "functional-20220728203726-27744",
"role.minikube.sigs.k8s.io": ""
},
"StopSignal": "SIGRTMIN+3"
},
"NetworkSettings": {
"Bridge": "",
"SandboxID": "ac218d0f23b57dbfa49309d6fbc6a7f0bd50360f8e18b67859eaaf49f24e6114",
"HairpinMode": false,
"LinkLocalIPv6Address": "",
"LinkLocalIPv6PrefixLen": 0,
"Ports": {
"22/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "51748"
}
],
"2376/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "51749"
}
],
"32443/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "51750"
}
],
"5000/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "51751"
}
],
"8441/tcp": [
{
"HostIp": "127.0.0.1",
"HostPort": "51747"
}
]
},
"SandboxKey": "/var/run/docker/netns/ac218d0f23b5",
"SecondaryIPAddresses": null,
"SecondaryIPv6Addresses": null,
"EndpointID": "",
"Gateway": "",
"GlobalIPv6Address": "",
"GlobalIPv6PrefixLen": 0,
"IPAddress": "",
"IPPrefixLen": 0,
"IPv6Gateway": "",
"MacAddress": "",
"Networks": {
"functional-20220728203726-27744": {
"IPAMConfig": {
"IPv4Address": "192.168.49.2"
},
"Links": null,
"Aliases": [
"fdf6bb16013a",
"functional-20220728203726-27744"
],
"NetworkID": "465650b4d49a6c639f7487f13345fb43adbbbc3609ad8fd27ef1dcbe5b09abb6",
"EndpointID": "0965f1762f8768e3b4f783370837ede54d7afc3d10fcac9f17d5de7201e51dd9",
"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-20220728203726-27744 -n functional-20220728203726-27744
helpers_test.go:239: (dbg) Done: out/minikube-windows-amd64.exe status --format={{.Host}} -p functional-20220728203726-27744 -n functional-20220728203726-27744: (3.5234129s)
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-20220728203726-27744 logs -n 25
helpers_test.go:247: (dbg) Done: out/minikube-windows-amd64.exe -p functional-20220728203726-27744 logs -n 25: (5.6319101s)
helpers_test.go:252: TestFunctional/parallel/ServiceCmd logs:
-- stdout --
*
* ==> Audit <==
* |----------------|-----------------------------------------------------------------------------------------------------|---------------------------------|-------------------|---------|---------------------|---------------------|
| Command | Args | Profile | User | Version | Start Time | End Time |
|----------------|-----------------------------------------------------------------------------------------------------|---------------------------------|-------------------|---------|---------------------|---------------------|
| ssh | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:43 GMT | 28 Jul 22 20:43 GMT |
| | ssh sudo cat | | | | | |
| | /usr/share/ca-certificates/277442.pem | | | | | |
| image | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:43 GMT | 28 Jul 22 20:43 GMT |
| | image ls | | | | | |
| ssh | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:43 GMT | 28 Jul 22 20:43 GMT |
| | ssh sudo cat | | | | | |
| | /etc/ssl/certs/3ec20f2e.0 | | | | | |
| image | functional-20220728203726-27744 image load --daemon | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:43 GMT | 28 Jul 22 20:43 GMT |
| | gcr.io/google-containers/addon-resizer:functional-20220728203726-27744 | | | | | |
| image | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:43 GMT | 28 Jul 22 20:43 GMT |
| | image ls | | | | | |
| image | functional-20220728203726-27744 image save | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:43 GMT | 28 Jul 22 20:44 GMT |
| | gcr.io/google-containers/addon-resizer:functional-20220728203726-27744 | | | | | |
| | C:\jenkins\workspace\Docker_Windows_integration\addon-resizer-save.tar | | | | | |
| image | functional-20220728203726-27744 image rm | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:44 GMT | 28 Jul 22 20:44 GMT |
| | gcr.io/google-containers/addon-resizer:functional-20220728203726-27744 | | | | | |
| image | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:44 GMT | 28 Jul 22 20:44 GMT |
| | image ls | | | | | |
| image | functional-20220728203726-27744 image load | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:44 GMT | 28 Jul 22 20:44 GMT |
| | C:\jenkins\workspace\Docker_Windows_integration\addon-resizer-save.tar | | | | | |
| image | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:44 GMT | 28 Jul 22 20:44 GMT |
| | image ls | | | | | |
| image | functional-20220728203726-27744 image save --daemon | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:44 GMT | 28 Jul 22 20:44 GMT |
| | gcr.io/google-containers/addon-resizer:functional-20220728203726-27744 | | | | | |
| cp | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:44 GMT | 28 Jul 22 20:44 GMT |
| | cp testdata\cp-test.txt | | | | | |
| | /home/docker/cp-test.txt | | | | | |
| ssh | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:44 GMT | 28 Jul 22 20:44 GMT |
| | ssh -n | | | | | |
| | functional-20220728203726-27744 | | | | | |
| | sudo cat | | | | | |
| | /home/docker/cp-test.txt | | | | | |
| cp | functional-20220728203726-27744 cp functional-20220728203726-27744:/home/docker/cp-test.txt | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:44 GMT | 28 Jul 22 20:44 GMT |
| | C:\Users\jenkins.minikube3\AppData\Local\Temp\TestFunctionalparallelCpCmd2022242482\001\cp-test.txt | | | | | |
| ssh | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:44 GMT | 28 Jul 22 20:44 GMT |
| | ssh -n | | | | | |
| | functional-20220728203726-27744 | | | | | |
| | sudo cat | | | | | |
| | /home/docker/cp-test.txt | | | | | |
| update-context | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:45 GMT | 28 Jul 22 20:45 GMT |
| | update-context | | | | | |
| | --alsologtostderr -v=2 | | | | | |
| update-context | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:45 GMT | 28 Jul 22 20:45 GMT |
| | update-context | | | | | |
| | --alsologtostderr -v=2 | | | | | |
| update-context | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:45 GMT | 28 Jul 22 20:45 GMT |
| | update-context | | | | | |
| | --alsologtostderr -v=2 | | | | | |
| image | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:45 GMT | 28 Jul 22 20:45 GMT |
| | image ls --format short | | | | | |
| image | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:45 GMT | 28 Jul 22 20:45 GMT |
| | image ls --format yaml | | | | | |
| ssh | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:45 GMT | |
| | ssh pgrep buildkitd | | | | | |
| image | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:45 GMT | 28 Jul 22 20:45 GMT |
| | image ls --format json | | | | | |
| image | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:45 GMT | 28 Jul 22 20:45 GMT |
| | image ls --format table | | | | | |
| image | functional-20220728203726-27744 image build -t | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:45 GMT | 28 Jul 22 20:45 GMT |
| | localhost/my-image:functional-20220728203726-27744 | | | | | |
| | testdata\build | | | | | |
| image | functional-20220728203726-27744 | functional-20220728203726-27744 | minikube3\jenkins | v1.26.0 | 28 Jul 22 20:45 GMT | 28 Jul 22 20:45 GMT |
| | image ls | | | | | |
|----------------|-----------------------------------------------------------------------------------------------------|---------------------------------|-------------------|---------|---------------------|---------------------|
*
* ==> Last Start <==
* Log file created at: 2022/07/28 20:43:04
Running on machine: minikube3
Binary: Built with gc go1.18.3 for windows/amd64
Log line format: [IWEF]mmdd hh:mm:ss.uuuuuu threadid file:line] msg
I0728 20:43:04.325591 27580 out.go:296] Setting OutFile to fd 956 ...
I0728 20:43:04.385340 27580 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0728 20:43:04.385340 27580 out.go:309] Setting ErrFile to fd 684...
I0728 20:43:04.385340 27580 out.go:343] TERM=,COLORTERM=, which probably does not support color
I0728 20:43:04.410310 27580 out.go:303] Setting JSON to false
I0728 20:43:04.414702 27580 start.go:115] hostinfo: {"hostname":"minikube3","uptime":8848,"bootTime":1659032136,"procs":191,"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":"a0f355d5-8b6e-4346-9071-73232725d096"}
W0728 20:43:04.414831 27580 start.go:123] gopshost.Virtualization returned error: not implemented yet
I0728 20:43:04.419072 27580 out.go:177] * [functional-20220728203726-27744] minikube v1.26.0 on Microsoft Windows 10 Enterprise N 10.0.19044 Build 19044
I0728 20:43:04.421788 27580 out.go:177] - KUBECONFIG=C:\Users\jenkins.minikube3\minikube-integration\kubeconfig
I0728 20:43:04.425250 27580 out.go:177] - MINIKUBE_HOME=C:\Users\jenkins.minikube3\minikube-integration\.minikube
I0728 20:43:04.427579 27580 out.go:177] - MINIKUBE_LOCATION=14555
I0728 20:43:04.430304 27580 out.go:177] - MINIKUBE_SUPPRESS_DOCKER_PERFORMANCE=true
I0728 20:43:04.433856 27580 config.go:178] Loaded profile config "functional-20220728203726-27744": Driver=docker, ContainerRuntime=docker, KubernetesVersion=v1.24.3
I0728 20:43:04.434734 27580 driver.go:365] Setting default libvirt URI to qemu:///system
I0728 20:43:06.194320 27580 docker.go:137] docker version: linux-20.10.17
I0728 20:43:06.202229 27580 cli_runner.go:164] Run: docker system info --format "{{json .}}"
I0728 20:43:06.812905 27580 info.go:265] docker info: {ID:32WQ:AR2E:QBMQ:3APU:6H37:XHFB:IZYG:CYO4:NVRY:3DND:E2II:HYH4 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:59 OomKillDisable:true NGoroutines:52 SystemTime:2022-07-28 20:43:06.3681643 +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.17 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:10c12954828e7c7c9b6e0ea9b0c02b01407d3ae1 Expected:10c12954828e7c7c9b6e0ea9b0c02b01407d3ae1} RuncCommit:{ID:v1.1.2-0-ga916309 Expected:v1.1.2-0-ga916309} 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.7.0] map[Name:extension Path:C:\Program Files\Docker\cli-plugins\docker-extension.exe SchemaVersion:0.1.0 ShortDescription:Manages Docker extensions Vendor:Docker Inc. Version:v0.2.8] 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-p
lugin 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>}}
I0728 20:43:06.820260 27580 out.go:177] * Using the docker driver based on existing profile
I0728 20:43:06.823279 27580 start.go:284] selected driver: docker
I0728 20:43:06.823279 27580 start.go:808] validating driver "docker" against &{Name:functional-20220728203726-27744 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.32-1656700284-14481@sha256:96d18f055abcf72b9f587e13317d6f9b5bb6f60e9fa09d6c51e11defaf9bf842 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.24.3 ClusterName:functional-20220728203726-27744 Namespace:
default 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.24.3 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 headlamp:false helm-tiller:false inaccel:false ingress:false ingress-dns:false istio:false istio-provisioner:false kong:false kubevirt:false logviewer:false metallb:false metrics-server:false nvidia-driver-installer:false nvidia-gpu-device-plugin:false olm:false pod-security-pol
icy:false portainer:false registry:false registry-aliases:false registry-creds:false storage-provisioner:true storage-provisioner-gluster:false volumesnapshots:false] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true] StartHostTimeout:6m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:C:\Users\jenkins.minikube3:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath:}
I0728 20:43:06.824232 27580 start.go:819] status for docker: {Installed:true Healthy:true Running:false NeedsImprovement:false Error:<nil> Reason: Fix: Doc: Version:}
I0728 20:43:06.838959 27580 cli_runner.go:164] Run: docker system info --format "{{json .}}"
I0728 20:43:07.481318 27580 info.go:265] docker info: {ID:32WQ:AR2E:QBMQ:3APU:6H37:XHFB:IZYG:CYO4:NVRY:3DND:E2II:HYH4 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:59 OomKillDisable:true NGoroutines:52 SystemTime:2022-07-28 20:43:07.0418576 +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.17 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:10c12954828e7c7c9b6e0ea9b0c02b01407d3ae1 Expected:10c12954828e7c7c9b6e0ea9b0c02b01407d3ae1} RuncCommit:{ID:v1.1.2-0-ga916309 Expected:v1.1.2-0-ga916309} 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.7.0] map[Name:extension Path:C:\Program Files\Docker\cli-plugins\docker-extension.exe SchemaVersion:0.1.0 ShortDescription:Manages Docker extensions Vendor:Docker Inc. Version:v0.2.8] 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-p
lugin 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>}}
I0728 20:43:07.527581 27580 cni.go:95] Creating CNI manager for ""
I0728 20:43:07.527760 27580 cni.go:169] CNI unnecessary in this configuration, recommending no CNI
I0728 20:43:07.527760 27580 start_flags.go:310] config:
{Name:functional-20220728203726-27744 KeepContext:false EmbedCerts:false MinikubeISO: KicBaseImage:gcr.io/k8s-minikube/kicbase-builds:v0.0.32-1656700284-14481@sha256:96d18f055abcf72b9f587e13317d6f9b5bb6f60e9fa09d6c51e11defaf9bf842 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.24.3 ClusterName:functional-20220728203726-27744 Namespace:default APIServerName:minikubeCA APIServerNames:[] APIServerIPs:[] DNSDomain:clu
ster.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.24.3 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 headlamp:false helm-tiller:false inaccel:false ingress:false ingress-dns:false istio:false istio-provisioner:false kong:false kubevirt:false logviewer:false metallb:false metrics-server:false nvidia-driver-installer:false nvidia-gpu-device-plugin:false olm:false pod-security-policy:false portainer:false registry:false registry-aliases:false registry-creds:f
alse storage-provisioner:true storage-provisioner-gluster:false volumesnapshots:false] CustomAddonImages:map[] CustomAddonRegistries:map[] VerifyComponents:map[apiserver:true apps_running:true default_sa:true extra:true kubelet:true node_ready:true system_pods:true] StartHostTimeout:6m0s ScheduledStop:<nil> ExposedPorts:[] ListenAddress: Network: Subnet: MultiNodeRequested:false ExtraDisks:0 CertExpiration:26280h0m0s Mount:false MountString:C:\Users\jenkins.minikube3:/minikube-host Mount9PVersion:9p2000.L MountGID:docker MountIP: MountMSize:262144 MountOptions:[] MountPort:0 MountType:9p MountUID:docker BinaryMirror: DisableOptimizations:false DisableMetrics:false CustomQemuFirmwarePath:}
I0728 20:43:07.533154 27580 out.go:177] * dry-run validation complete!
*
* ==> Docker <==
* -- Logs begin at Thu 2022-07-28 20:38:06 UTC, end at Thu 2022-07-28 21:17:35 UTC. --
Jul 28 20:41:21 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:21.603867700Z" level=warning msg="Error (Unable to complete atomic operation, key modified) deleting object [endpoint bc6d77235244a140379feb2041fcaf65162b7d9ae7b602b8e55f46e6725afc5b e5db7ebad3b4989fef2000108f469338d2dc1e06f84dc750db8971311f078e02], retrying...."
Jul 28 20:41:21 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:21.705251500Z" level=info msg="Default bridge (docker0) is assigned with an IP address 172.17.0.0/16. Daemon option --bip can be used to set a preferred IP address"
Jul 28 20:41:21 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:21.807911800Z" level=info msg="Loading containers: done."
Jul 28 20:41:21 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:21.896088200Z" level=info msg="Docker daemon" commit=a89b842 graphdriver(s)=overlay2 version=20.10.17
Jul 28 20:41:21 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:21.896269400Z" level=info msg="Daemon has completed initialization"
Jul 28 20:41:21 functional-20220728203726-27744 systemd[1]: Started Docker Application Container Engine.
Jul 28 20:41:21 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:21.952659700Z" level=info msg="API listen on [::]:2376"
Jul 28 20:41:21 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:21.968096800Z" level=info msg="API listen on /var/run/docker.sock"
Jul 28 20:41:27 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:27.740123900Z" level=info msg="ignoring event" container=ba93d81ee849f55c78d350fe7b82cd0590792f1387bd84572fb3f8bb0e5b18a9 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:41:27 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:27.742870600Z" level=info msg="ignoring event" container=725e4d5680a36ac22897914acddcac5a8d35d8b6a4b8c24c3e3bf2b0e55b168b module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:41:28 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:28.028805500Z" level=info msg="ignoring event" container=55cfb4d3351fe22403938511a3b217b1e79ceea93f6f945f6d4207d21acde619 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:41:28 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:28.132537900Z" level=info msg="ignoring event" container=5404b78ac3e80876327fcf38b682ff39239477a6388c5cf74a3fa34b8023ab12 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:41:28 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:28.134883100Z" level=info msg="ignoring event" container=b77fc7d1d38cc36c2493974510d67a5a818c57ab9106696828775e138705e670 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:41:28 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:28.333322000Z" level=info msg="ignoring event" container=f46db899054f72d26400e0c8fe6d981b5efe0ba897da12013e1ec7978453ca79 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:41:28 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:28.443192800Z" level=info msg="ignoring event" container=1e85fff4ef8e82dcf92bbf1b2d4f0062619c29a6045a9ba4cb8040a9594ff81f module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:41:29 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:29.029269600Z" level=error msg="cbfb951f9f4f240feb1d6aacb3103c33eb11deaced74d0b7cd4ffc7c489448f7 cleanup: failed to delete container from containerd: no such container"
Jul 28 20:41:29 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:29.029327000Z" level=error msg="1b346e8f22517d0f2b77dc3ebec7a62081e3e87a0dfed0d0bd15713b58254517 cleanup: failed to delete container from containerd: no such container"
Jul 28 20:41:29 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:29.141441600Z" level=error msg="309a55ee1d39e6215090ea6da2033eb4b07e44b3565a66aeb5299cf017490ce9 cleanup: failed to delete container from containerd: no such container"
Jul 28 20:41:29 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:29.147365500Z" level=info msg="ignoring event" container=96466537e906ba0b5925798733993a7deba09fb669218218cf170c44599618e3 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:41:29 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:29.241802400Z" level=error msg="ba7129dc349b9524af0dbb4d504d5e3a90c01aa2a6453d8dfdc6f4cf04cbf279 cleanup: failed to delete container from containerd: no such container"
Jul 28 20:41:43 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:41:43.562712200Z" level=info msg="ignoring event" container=09a28211b9ce4f61945402d9f7d9cf7d1e368a1a99e58884f2c7c42b6c8b5be2 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:42:54 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:42:54.544337300Z" level=info msg="ignoring event" container=2c0c15adfd5270ea885f6fae158be516b25e7b5266656fa23deaac753507f7ee module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:42:56 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:42:56.039962300Z" level=info msg="ignoring event" container=7efdd13b1c5570c88e2566d97266e2c4bc618e9033f0eb2e8fe190d6d3a73bc7 module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:45:20 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:45:20.502113600Z" level=info msg="ignoring event" container=bcbf2827280f80d3d8d5a7ad0c34225f8ab6bd3de038a7de942cfab61af7d11e module=libcontainerd namespace=moby topic=/tasks/delete type="*events.TaskDelete"
Jul 28 20:45:21 functional-20220728203726-27744 dockerd[8644]: time="2022-07-28T20:45:21.011130700Z" level=info msg="Layer sha256:8d988d9cbd4c3812fb85f3c741a359985602af139e727005f4d4471ac42f9d1a cleaned up"
*
* ==> container status <==
* CONTAINER IMAGE CREATED STATE NAME ATTEMPT POD ID
001787891aff3 mysql@sha256:b3a86578a582617214477d91e47e850f9e18df0b5d1644fb2d96d91a340b8972 33 minutes ago Running mysql 0 83ed17bf699ec
9c5c2f6a351f3 nginx@sha256:1761fb5661e4d77e107427d8012ad3a5955007d997e0f4a3d41acc9ff20467c7 34 minutes ago Running myfrontend 0 4b3cef209c948
944fab2be43b4 k8s.gcr.io/echoserver@sha256:cb3386f863f6a4b05f33c191361723f9d5927ac287463b1bea633bf859475969 34 minutes ago Running echoserver 0 b752b31c48249
28d78eee7dd3c k8s.gcr.io/echoserver@sha256:cb3386f863f6a4b05f33c191361723f9d5927ac287463b1bea633bf859475969 34 minutes ago Running echoserver 0 6e33788127cf9
d34e0c9463d20 nginx@sha256:87fb6f4040ffd52dd616f360b8520ed4482930ea75417182ad3f76c4aaadf24f 35 minutes ago Running nginx 0 5d3e2b6d7edd1
bc87ba62ccda4 a4ca41631cc7a 35 minutes ago Running coredns 4 18d032ff8d6ad
a21fcfe03d58b 2ae1ba6417cbc 35 minutes ago Running kube-proxy 4 a76b98cd4458d
1deb549ffdeb7 6e38f40d628db 35 minutes ago Running storage-provisioner 4 075e527f80543
5120dc620dfc9 d521dd763e2e3 35 minutes ago Running kube-apiserver 0 94e304a46bcef
0eb297ce7b6b4 586c112956dfc 35 minutes ago Running kube-controller-manager 4 6a5f622f99f89
5aa01b7b50d97 3a5aa3a515f5d 36 minutes ago Running kube-scheduler 3 1a3696e0b48a7
291468797b289 aebe758cef4cd 36 minutes ago Running etcd 4 b01b405fb7165
ba7129dc349b9 3a5aa3a515f5d 36 minutes ago Created kube-scheduler 2 f46db899054f7
309a55ee1d39e aebe758cef4cd 36 minutes ago Created etcd 3 1e85fff4ef8e8
cbfb951f9f4f2 6e38f40d628db 36 minutes ago Created storage-provisioner 3 5404b78ac3e80
1b346e8f22517 2ae1ba6417cbc 36 minutes ago Created kube-proxy 3 b77fc7d1d38cc
55cfb4d3351fe 586c112956dfc 36 minutes ago Exited kube-controller-manager 3 725e4d5680a36
3a745c31ea037 a4ca41631cc7a 36 minutes ago Exited coredns 3 5b60a3fb585de
*
* ==> coredns [3a745c31ea03] <==
* [INFO] plugin/ready: Still waiting on: "kubernetes"
[INFO] plugin/ready: Still waiting on: "kubernetes"
[INFO] plugin/ready: Still waiting on: "kubernetes"
[INFO] SIGTERM: Shutting down servers then terminating
[WARNING] plugin/kubernetes: starting server with unsynced Kubernetes API
.:53
[INFO] plugin/reload: Running configuration MD5 = c23ed519c17e71ee396ed052e6209e94
CoreDNS-1.8.6
linux/amd64, go1.17.1, 13a9191
[INFO] plugin/health: Going into lameduck mode for 5s
*
* ==> coredns [bc87ba62ccda] <==
* .:53
[INFO] plugin/reload: Running configuration MD5 = c23ed519c17e71ee396ed052e6209e94
CoreDNS-1.8.6
linux/amd64, go1.17.1, 13a9191
*
* ==> describe nodes <==
* Name: functional-20220728203726-27744
Roles: control-plane
Labels: beta.kubernetes.io/arch=amd64
beta.kubernetes.io/os=linux
kubernetes.io/arch=amd64
kubernetes.io/hostname=functional-20220728203726-27744
kubernetes.io/os=linux
minikube.k8s.io/commit=363f4186470802814a32480695fe2a353fd5f551
minikube.k8s.io/name=functional-20220728203726-27744
minikube.k8s.io/primary=true
minikube.k8s.io/updated_at=2022_07_28T20_38_44_0700
minikube.k8s.io/version=v1.26.0
node-role.kubernetes.io/control-plane=
node.kubernetes.io/exclude-from-external-load-balancers=
Annotations: kubeadm.alpha.kubernetes.io/cri-socket: unix:///var/run/cri-dockerd.sock
node.alpha.kubernetes.io/ttl: 0
volumes.kubernetes.io/controller-managed-attach-detach: true
CreationTimestamp: Thu, 28 Jul 2022 20:38:41 +0000
Taints: <none>
Unschedulable: false
Lease:
HolderIdentity: functional-20220728203726-27744
AcquireTime: <unset>
RenewTime: Thu, 28 Jul 2022 21:17:30 +0000
Conditions:
Type Status LastHeartbeatTime LastTransitionTime Reason Message
---- ------ ----------------- ------------------ ------ -------
MemoryPressure False Thu, 28 Jul 2022 21:16:19 +0000 Thu, 28 Jul 2022 20:38:41 +0000 KubeletHasSufficientMemory kubelet has sufficient memory available
DiskPressure False Thu, 28 Jul 2022 21:16:19 +0000 Thu, 28 Jul 2022 20:38:41 +0000 KubeletHasNoDiskPressure kubelet has no disk pressure
PIDPressure False Thu, 28 Jul 2022 21:16:19 +0000 Thu, 28 Jul 2022 20:38:41 +0000 KubeletHasSufficientPID kubelet has sufficient PID available
Ready True Thu, 28 Jul 2022 21:16:19 +0000 Thu, 28 Jul 2022 20:38:55 +0000 KubeletReady kubelet is posting ready status
Addresses:
InternalIP: 192.168.49.2
Hostname: functional-20220728203726-27744
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: 855c6c72c86b4657b3d8c3c774fd7e1d
System UUID: 855c6c72c86b4657b3d8c3c774fd7e1d
Boot ID: bb9e6f37-9aa8-49da-88ef-e81defbfcea0
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.17
Kubelet Version: v1.24.3
Kube-Proxy Version: v1.24.3
PodCIDR: 10.244.0.0/24
PodCIDRs: 10.244.0.0/24
Non-terminated Pods: (12 in total)
Namespace Name CPU Requests CPU Limits Memory Requests Memory Limits Age
--------- ---- ------------ ---------- --------------- ------------- ---
default hello-node-54c4b5c49f-mp9qv 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 35m
default hello-node-connect-578cdc45cb-sgj5n 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 35m
default mysql-67f7d69d8b-fzlzd 600m (3%!)(MISSING) 700m (4%!)(MISSING) 512Mi (0%!)(MISSING) 700Mi (1%!)(MISSING) 34m
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-6d4b75cb6d-wjqnz 100m (0%!)(MISSING) 0 (0%!)(MISSING) 70Mi (0%!)(MISSING) 170Mi (0%!)(MISSING) 38m
kube-system etcd-functional-20220728203726-27744 100m (0%!)(MISSING) 0 (0%!)(MISSING) 100Mi (0%!)(MISSING) 0 (0%!)(MISSING) 38m
kube-system kube-apiserver-functional-20220728203726-27744 250m (1%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 35m
kube-system kube-controller-manager-functional-20220728203726-27744 200m (1%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 38m
kube-system kube-proxy-vcwt9 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 0 (0%!)(MISSING) 38m
kube-system kube-scheduler-functional-20220728203726-27744 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 37m kube-proxy
Normal Starting 38m kube-proxy
Normal NodeHasSufficientMemory 39m (x6 over 39m) kubelet Node functional-20220728203726-27744 status is now: NodeHasSufficientMemory
Normal NodeHasNoDiskPressure 39m (x6 over 39m) kubelet Node functional-20220728203726-27744 status is now: NodeHasNoDiskPressure
Normal NodeHasSufficientPID 39m (x5 over 39m) kubelet Node functional-20220728203726-27744 status is now: NodeHasSufficientPID
Normal Starting 38m kubelet Starting kubelet.
Normal NodeHasSufficientMemory 38m kubelet Node functional-20220728203726-27744 status is now: NodeHasSufficientMemory
Normal NodeHasNoDiskPressure 38m kubelet Node functional-20220728203726-27744 status is now: NodeHasNoDiskPressure
Normal NodeHasSufficientPID 38m kubelet Node functional-20220728203726-27744 status is now: NodeHasSufficientPID
Normal NodeAllocatableEnforced 38m kubelet Updated Node Allocatable limit across pods
Normal NodeReady 38m kubelet Node functional-20220728203726-27744 status is now: NodeReady
Normal RegisteredNode 38m node-controller Node functional-20220728203726-27744 event: Registered Node functional-20220728203726-27744 in Controller
Normal RegisteredNode 37m node-controller Node functional-20220728203726-27744 event: Registered Node functional-20220728203726-27744 in Controller
Normal Starting 36m kubelet Starting kubelet.
Normal NodeAllocatableEnforced 36m kubelet Updated Node Allocatable limit across pods
Normal NodeHasSufficientMemory 36m (x8 over 36m) kubelet Node functional-20220728203726-27744 status is now: NodeHasSufficientMemory
Normal NodeHasNoDiskPressure 36m (x8 over 36m) kubelet Node functional-20220728203726-27744 status is now: NodeHasNoDiskPressure
Normal NodeHasSufficientPID 36m (x7 over 36m) kubelet Node functional-20220728203726-27744 status is now: NodeHasSufficientPID
Normal RegisteredNode 35m node-controller Node functional-20220728203726-27744 event: Registered Node functional-20220728203726-27744 in Controller
*
* ==> dmesg <==
* [Jul28 20:52] WSL2: Performing memory compaction.
[Jul28 20:53] WSL2: Performing memory compaction.
[Jul28 20:54] WSL2: Performing memory compaction.
[Jul28 20:55] WSL2: Performing memory compaction.
[Jul28 20:56] WSL2: Performing memory compaction.
[Jul28 20:57] WSL2: Performing memory compaction.
[Jul28 20:58] WSL2: Performing memory compaction.
[Jul28 20:59] WSL2: Performing memory compaction.
[Jul28 21:00] WSL2: Performing memory compaction.
[Jul28 21:02] WSL2: Performing memory compaction.
[Jul28 21:03] WSL2: Performing memory compaction.
[Jul28 21:04] WSL2: Performing memory compaction.
[Jul28 21:05] WSL2: Performing memory compaction.
[Jul28 21:06] WSL2: Performing memory compaction.
[Jul28 21:07] WSL2: Performing memory compaction.
[Jul28 21:08] WSL2: Performing memory compaction.
[Jul28 21:09] WSL2: Performing memory compaction.
[Jul28 21:10] WSL2: Performing memory compaction.
[Jul28 21:11] WSL2: Performing memory compaction.
[Jul28 21:12] WSL2: Performing memory compaction.
[Jul28 21:13] WSL2: Performing memory compaction.
[Jul28 21:14] WSL2: Performing memory compaction.
[Jul28 21:15] WSL2: Performing memory compaction.
[Jul28 21:16] WSL2: Performing memory compaction.
[Jul28 21:17] WSL2: Performing memory compaction.
*
* ==> etcd [291468797b28] <==
* {"level":"warn","ts":"2022-07-28T20:44:36.654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2022-07-28T20:44:34.462Z","time spent":"2.1924346s","remote":"127.0.0.1:58376","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "}
{"level":"warn","ts":"2022-07-28T20:44:36.654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2022-07-28T20:44:34.668Z","time spent":"1.9866652s","remote":"127.0.0.1:58330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":5,"response size":13624,"request content":"key:\"/registry/pods/default/\" range_end:\"/registry/pods/default0\" "}
{"level":"warn","ts":"2022-07-28T20:44:36.654Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"323.8392ms","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-07-28T20:44:36.654Z","caller":"traceutil/trace.go:171","msg":"trace[1780924536] range","detail":"{range_begin:/registry/services/endpoints/kube-system/k8s.io-minikube-hostpath; range_end:; response_count:1; response_revision:870; }","duration":"323.8849ms","start":"2022-07-28T20:44:36.331Z","end":"2022-07-28T20:44:36.654Z","steps":["trace[1780924536] 'agreement among raft nodes before linearized reading' (duration: 323.7894ms)"],"step_count":1}
{"level":"warn","ts":"2022-07-28T20:44:36.654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2022-07-28T20:44:36.331Z","time spent":"323.9313ms","remote":"127.0.0.1:58326","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":"warn","ts":"2022-07-28T20:44:36.655Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"1.2096209s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"}
{"level":"info","ts":"2022-07-28T20:44:36.655Z","caller":"traceutil/trace.go:171","msg":"trace[1736043426] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:870; }","duration":"1.2096737s","start":"2022-07-28T20:44:35.445Z","end":"2022-07-28T20:44:36.655Z","steps":["trace[1736043426] 'agreement among raft nodes before linearized reading' (duration: 1.2095716s)"],"step_count":1}
{"level":"warn","ts":"2022-07-28T20:44:36.655Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2022-07-28T20:44:35.445Z","time spent":"1.2098007s","remote":"127.0.0.1:58402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":31,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "}
{"level":"info","ts":"2022-07-28T20:45:09.751Z","caller":"traceutil/trace.go:171","msg":"trace[1255465266] linearizableReadLoop","detail":"{readStateIndex:1001; appliedIndex:1001; }","duration":"203.3538ms","start":"2022-07-28T20:45:09.548Z","end":"2022-07-28T20:45:09.751Z","steps":["trace[1255465266] 'read index received' (duration: 203.3432ms)","trace[1255465266] 'applied index is now lower than readState.Index' (duration: 7.4µs)"],"step_count":2}
{"level":"warn","ts":"2022-07-28T20:45:09.757Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"208.8344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2022-07-28T20:45:09.757Z","caller":"traceutil/trace.go:171","msg":"trace[1599648854] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:904; }","duration":"209.0158ms","start":"2022-07-28T20:45:09.548Z","end":"2022-07-28T20:45:09.757Z","steps":["trace[1599648854] 'agreement among raft nodes before linearized reading' (duration: 203.474ms)"],"step_count":1}
{"level":"warn","ts":"2022-07-28T20:45:33.934Z","caller":"etcdserver/util.go:166","msg":"apply request took too long","took":"128.8942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"}
{"level":"info","ts":"2022-07-28T20:45:33.934Z","caller":"traceutil/trace.go:171","msg":"trace[1183438607] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:920; }","duration":"129.1821ms","start":"2022-07-28T20:45:33.805Z","end":"2022-07-28T20:45:33.934Z","steps":["trace[1183438607] 'count revisions from in-memory index tree' (duration: 128.7902ms)"],"step_count":1}
{"level":"info","ts":"2022-07-28T20:51:38.674Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":967}
{"level":"info","ts":"2022-07-28T20:51:38.676Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":967,"took":"1.4058ms"}
{"level":"info","ts":"2022-07-28T20:56:38.689Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1177}
{"level":"info","ts":"2022-07-28T20:56:38.690Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1177,"took":"623.3µs"}
{"level":"info","ts":"2022-07-28T21:01:38.707Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1386}
{"level":"info","ts":"2022-07-28T21:01:38.708Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1386,"took":"801.5µs"}
{"level":"info","ts":"2022-07-28T21:06:38.723Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1595}
{"level":"info","ts":"2022-07-28T21:06:38.725Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1595,"took":"705.7µs"}
{"level":"info","ts":"2022-07-28T21:11:38.743Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":1805}
{"level":"info","ts":"2022-07-28T21:11:38.744Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":1805,"took":"636.1µs"}
{"level":"info","ts":"2022-07-28T21:16:38.753Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2015}
{"level":"info","ts":"2022-07-28T21:16:38.754Z","caller":"mvcc/kvstore_compaction.go:57","msg":"finished scheduled compaction","compact-revision":2015,"took":"722.9µs"}
*
* ==> etcd [309a55ee1d39] <==
*
*
* ==> kernel <==
* 21:17:35 up 3:00, 0 users, load average: 0.59, 0.50, 0.54
Linux functional-20220728203726-27744 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 [5120dc620dfc] <==
* Trace[2041146095]: ---"Listing from storage done" 508ms (20:42:44.646)
Trace[2041146095]: [508.7506ms] [508.7506ms] END
I0728 20:42:55.545214 1 trace.go:205] Trace[883070356]: "List(recursive=true) etcd3" key:/pods/default,resourceVersion:,resourceVersionMatch:,limit:0,continue: (28-Jul-2022 20:42:54.961) (total time: 583ms):
Trace[883070356]: [583.1926ms] [583.1926ms] END
I0728 20:42:55.545573 1 trace.go:205] Trace[1024967209]: "List" url:/api/v1/namespaces/default/pods,user-agent:e2e-windows-amd64.exe/v0.0.0 (windows/amd64) kubernetes/$Format,audit-id:cf19b52e-1475-42c9-9cce-c41fccaff4e2,client:192.168.49.1,accept:application/json, */*,protocol:HTTP/2.0 (28-Jul-2022 20:42:54.961) (total time: 583ms):
Trace[1024967209]: ---"Listing from storage done" 583ms (20:42:55.545)
Trace[1024967209]: [583.6242ms] [583.6242ms] END
I0728 20:43:35.561899 1 alloc.go:327] "allocated clusterIPs" service="default/mysql" clusterIPs=map[IPv4:10.106.8.145]
{"level":"warn","ts":"2022-07-28T20:44:04.551Z","logger":"etcd-client","caller":"v3/retry_interceptor.go:62","msg":"retrying of unary invoker failed","target":"etcd-endpoints://0xc003617a40/127.0.0.1:2379","attempt":0,"error":"rpc error: code = DeadlineExceeded desc = context deadline exceeded"}
I0728 20:44:04.938237 1 trace.go:205] Trace[1444335115]: "List(recursive=true) etcd3" key:/pods/default,resourceVersion:,resourceVersionMatch:,limit:0,continue: (28-Jul-2022 20:44:02.670) (total time: 2267ms):
Trace[1444335115]: [2.2675067s] [2.2675067s] END
I0728 20:44:04.938523 1 trace.go:205] Trace[1252270238]: "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:f0759314-8ab0-4aee-8afb-82e597428f70,client:192.168.49.2,accept:application/json, */*,protocol:HTTP/2.0 (28-Jul-2022 20:44:03.892) (total time: 1046ms):
Trace[1252270238]: ---"About to write a response" 1046ms (20:44:04.938)
Trace[1252270238]: [1.0464662s] [1.0464662s] END
I0728 20:44:04.938975 1 trace.go:205] Trace[702408333]: "List" url:/api/v1/namespaces/default/pods,user-agent:e2e-windows-amd64.exe/v0.0.0 (windows/amd64) kubernetes/$Format,audit-id:1524fc38-ec15-4aee-8546-938ce3f3f219,client:192.168.49.1,accept:application/json, */*,protocol:HTTP/2.0 (28-Jul-2022 20:44:02.670) (total time: 2268ms):
Trace[702408333]: ---"Listing from storage done" 2267ms (20:44:04.938)
Trace[702408333]: [2.2682196s] [2.2682196s] END
{"level":"warn","ts":"2022-07-28T20:44:36.547Z","logger":"etcd-client","caller":"v3/retry_interceptor.go:62","msg":"retrying of unary invoker failed","target":"etcd-endpoints://0xc003617a40/127.0.0.1:2379","attempt":0,"error":"rpc error: code = DeadlineExceeded desc = context deadline exceeded"}
I0728 20:44:36.656406 1 trace.go:205] Trace[504324026]: "List(recursive=true) etcd3" key:/pods/default,resourceVersion:,resourceVersionMatch:,limit:0,continue: (28-Jul-2022 20:44:34.666) (total time: 1989ms):
Trace[504324026]: [1.9893726s] [1.9893726s] END
I0728 20:44:36.657252 1 trace.go:205] Trace[907412850]: "List" url:/api/v1/namespaces/default/pods,user-agent:e2e-windows-amd64.exe/v0.0.0 (windows/amd64) kubernetes/$Format,audit-id:d2f938ad-05a5-4205-aabd-3cb58ad06f4c,client:192.168.49.1,accept:application/json, */*,protocol:HTTP/2.0 (28-Jul-2022 20:44:34.666) (total time: 1990ms):
Trace[907412850]: ---"Listing from storage done" 1989ms (20:44:36.656)
Trace[907412850]: [1.9902884s] [1.9902884s] END
W0728 20:58:14.884678 1 watcher.go:229] watch chan error: etcdserver: mvcc: required revision has been compacted
W0728 21:07:24.511981 1 watcher.go:229] watch chan error: etcdserver: mvcc: required revision has been compacted
*
* ==> kube-controller-manager [0eb297ce7b6b] <==
* I0728 20:41:58.731170 1 shared_informer.go:255] Waiting for caches to sync for cidrallocator
I0728 20:41:58.731204 1 shared_informer.go:262] Caches are synced for cidrallocator
I0728 20:41:58.729861 1 shared_informer.go:262] Caches are synced for endpoint_slice
I0728 20:41:58.731722 1 shared_informer.go:262] Caches are synced for daemon sets
I0728 20:41:58.731834 1 shared_informer.go:262] Caches are synced for cronjob
W0728 20:41:58.732766 1 node_lifecycle_controller.go:1014] Missing timestamp for Node functional-20220728203726-27744. Assuming now as a timestamp.
I0728 20:41:58.732850 1 node_lifecycle_controller.go:1215] Controller detected that zone is now in state Normal.
I0728 20:41:58.735121 1 shared_informer.go:262] Caches are synced for bootstrap_signer
I0728 20:41:58.737176 1 shared_informer.go:262] Caches are synced for crt configmap
I0728 20:41:58.737393 1 shared_informer.go:262] Caches are synced for ReplicaSet
I0728 20:41:58.826798 1 shared_informer.go:262] Caches are synced for endpoint_slice_mirroring
I0728 20:41:58.827144 1 shared_informer.go:262] Caches are synced for endpoint
I0728 20:41:58.832147 1 shared_informer.go:255] Waiting for caches to sync for garbage collector
I0728 20:41:58.926131 1 shared_informer.go:262] Caches are synced for resource quota
I0728 20:41:58.935546 1 shared_informer.go:262] Caches are synced for resource quota
I0728 20:41:59.333450 1 shared_informer.go:262] Caches are synced for garbage collector
I0728 20:41:59.336171 1 shared_informer.go:262] Caches are synced for garbage collector
I0728 20:41:59.336240 1 garbagecollector.go:158] Garbage collector: all resource monitors have synced. Proceeding to collect garbage
I0728 20:42:20.227102 1 event.go:294] "Event occurred" object="default/myclaim" fieldPath="" kind="PersistentVolumeClaim" apiVersion="v1" type="Normal" reason="ExternalProvisioning" message="waiting for a volume to be created, either by external provisioner \"k8s.io/minikube-hostpath\" or manually created by system administrator"
I0728 20:42:22.056762 1 event.go:294] "Event occurred" object="default/hello-node-connect" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set hello-node-connect-578cdc45cb to 1"
I0728 20:42:22.543625 1 event.go:294] "Event occurred" object="default/hello-node-connect-578cdc45cb" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: hello-node-connect-578cdc45cb-sgj5n"
I0728 20:42:30.634444 1 event.go:294] "Event occurred" object="default/hello-node" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set hello-node-54c4b5c49f to 1"
I0728 20:42:30.836820 1 event.go:294] "Event occurred" object="default/hello-node-54c4b5c49f" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: hello-node-54c4b5c49f-mp9qv"
I0728 20:43:35.654664 1 event.go:294] "Event occurred" object="default/mysql" fieldPath="" kind="Deployment" apiVersion="apps/v1" type="Normal" reason="ScalingReplicaSet" message="Scaled up replica set mysql-67f7d69d8b to 1"
I0728 20:43:35.735706 1 event.go:294] "Event occurred" object="default/mysql-67f7d69d8b" fieldPath="" kind="ReplicaSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: mysql-67f7d69d8b-fzlzd"
*
* ==> kube-controller-manager [55cfb4d3351f] <==
* I0728 20:41:24.570264 1 serving.go:348] Generated self-signed cert in-memory
I0728 20:41:25.445290 1 controllermanager.go:180] Version: v1.24.3
I0728 20:41:25.445413 1 controllermanager.go:182] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK=""
I0728 20:41:25.447005 1 secure_serving.go:210] Serving securely on 127.0.0.1:10257
I0728 20:41:25.447082 1 dynamic_cafile_content.go:157] "Starting controller" name="request-header::/var/lib/minikube/certs/front-proxy-ca.crt"
I0728 20:41:25.447188 1 tlsconfig.go:240] "Starting DynamicServingCertificateController"
I0728 20:41:25.447283 1 dynamic_cafile_content.go:157] "Starting controller" name="client-ca-bundle::/var/lib/minikube/certs/ca.crt"
*
* ==> kube-proxy [1b346e8f2251] <==
*
*
* ==> kube-proxy [a21fcfe03d58] <==
* I0728 20:41:45.750937 1 proxier.go:667] "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"
I0728 20:41:45.830583 1 proxier.go:667] "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"
I0728 20:41:45.833308 1 proxier.go:667] "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"
I0728 20:41:45.836531 1 proxier.go:667] "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"
I0728 20:41:45.839434 1 proxier.go:667] "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"
I0728 20:41:45.950585 1 node.go:163] Successfully retrieved node IP: 192.168.49.2
I0728 20:41:45.950757 1 server_others.go:138] "Detected node IP" address="192.168.49.2"
I0728 20:41:45.950921 1 server_others.go:578] "Unknown proxy mode, assuming iptables proxy" proxyMode=""
I0728 20:41:46.135874 1 server_others.go:206] "Using iptables Proxier"
I0728 20:41:46.135957 1 server_others.go:213] "kube-proxy running in dual-stack mode" ipFamily=IPv4
I0728 20:41:46.135985 1 server_others.go:214] "Creating dualStackProxier for iptables"
I0728 20:41:46.136017 1 server_others.go:501] "Detect-local-mode set to ClusterCIDR, but no IPv6 cluster CIDR defined, , defaulting to no-op detect-local for IPv6"
I0728 20:41:46.136074 1 proxier.go:259] "Setting route_localnet=1, use nodePortAddresses to filter loopback addresses for NodePorts to skip it https://issues.k8s.io/90259"
I0728 20:41:46.136316 1 proxier.go:259] "Setting route_localnet=1, use nodePortAddresses to filter loopback addresses for NodePorts to skip it https://issues.k8s.io/90259"
I0728 20:41:46.136759 1 server.go:661] "Version info" version="v1.24.3"
I0728 20:41:46.136878 1 server.go:663] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK=""
I0728 20:41:46.137824 1 config.go:317] "Starting service config controller"
I0728 20:41:46.137996 1 shared_informer.go:255] Waiting for caches to sync for service config
I0728 20:41:46.137884 1 config.go:226] "Starting endpoint slice config controller"
I0728 20:41:46.138229 1 shared_informer.go:255] Waiting for caches to sync for endpoint slice config
I0728 20:41:46.138094 1 config.go:444] "Starting node config controller"
I0728 20:41:46.138271 1 shared_informer.go:255] Waiting for caches to sync for node config
I0728 20:41:46.238536 1 shared_informer.go:262] Caches are synced for node config
I0728 20:41:46.238809 1 shared_informer.go:262] Caches are synced for service config
I0728 20:41:46.238873 1 shared_informer.go:262] Caches are synced for endpoint slice config
*
* ==> kube-scheduler [5aa01b7b50d9] <==
* I0728 20:41:36.633095 1 serving.go:348] Generated self-signed cert in-memory
W0728 20:41:42.830201 1 requestheader_controller.go:193] Unable to get configmap/extension-apiserver-authentication in kube-system. Usually fixed by 'kubectl create rolebinding -n kube-system ROLEBINDING_NAME --role=extension-apiserver-authentication-reader --serviceaccount=YOUR_NS:YOUR_SA'
W0728 20:41:42.830310 1 authentication.go:346] Error looking up in-cluster authentication configuration: configmaps "extension-apiserver-authentication" is forbidden: User "system:kube-scheduler" cannot get resource "configmaps" in API group "" in the namespace "kube-system"
W0728 20:41:42.830332 1 authentication.go:347] Continuing without authentication configuration. This may treat all requests as anonymous.
W0728 20:41:42.830347 1 authentication.go:348] To require authentication configuration lookup to succeed, set --authentication-tolerate-lookup-failure=false
I0728 20:41:43.029878 1 server.go:147] "Starting Kubernetes Scheduler" version="v1.24.3"
I0728 20:41:43.030225 1 server.go:149] "Golang settings" GOGC="" GOMAXPROCS="" GOTRACEBACK=""
I0728 20:41:43.033676 1 configmap_cafile_content.go:202] "Starting controller" name="client-ca::kube-system::extension-apiserver-authentication::client-ca-file"
I0728 20:41:43.033718 1 shared_informer.go:255] Waiting for caches to sync for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
I0728 20:41:43.034082 1 secure_serving.go:210] Serving securely on 127.0.0.1:10259
I0728 20:41:43.034245 1 tlsconfig.go:240] "Starting DynamicServingCertificateController"
I0728 20:41:43.134304 1 shared_informer.go:262] Caches are synced for client-ca::kube-system::extension-apiserver-authentication::client-ca-file
*
* ==> kube-scheduler [ba7129dc349b] <==
*
*
* ==> kubelet <==
* -- Logs begin at Thu 2022-07-28 20:38:06 UTC, end at Thu 2022-07-28 21:17:36 UTC. --
Jul 28 20:42:31 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:31.047038 10414 reconciler.go:270] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-f7thl\" (UniqueName: \"kubernetes.io/projected/2bcba4e3-74d3-458b-9a49-49d72c1edb76-kube-api-access-f7thl\") pod \"hello-node-54c4b5c49f-mp9qv\" (UID: \"2bcba4e3-74d3-458b-9a49-49d72c1edb76\") " pod="default/hello-node-54c4b5c49f-mp9qv"
Jul 28 20:42:35 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:35.030855 10414 pod_container_deletor.go:79] "Container not found in pod's containers" containerID="b752b31c482495a4718ab8f0d0676b1ef8a1ccf2ee78cd0f21d8216afe70476e"
Jul 28 20:42:57 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:57.233756 10414 scope.go:110] "RemoveContainer" containerID="2c0c15adfd5270ea885f6fae158be516b25e7b5266656fa23deaac753507f7ee"
Jul 28 20:42:57 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:57.247405 10414 reconciler.go:192] "operationExecutor.UnmountVolume started for volume \"mypd\" (UniqueName: \"kubernetes.io/host-path/66b76d69-df9b-4c1a-b827-599e22051775-pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55\") pod \"66b76d69-df9b-4c1a-b827-599e22051775\" (UID: \"66b76d69-df9b-4c1a-b827-599e22051775\") "
Jul 28 20:42:57 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:57.247615 10414 reconciler.go:192] "operationExecutor.UnmountVolume started for volume \"kube-api-access-pcqbc\" (UniqueName: \"kubernetes.io/projected/66b76d69-df9b-4c1a-b827-599e22051775-kube-api-access-pcqbc\") pod \"66b76d69-df9b-4c1a-b827-599e22051775\" (UID: \"66b76d69-df9b-4c1a-b827-599e22051775\") "
Jul 28 20:42:57 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:57.247708 10414 operation_generator.go:856] UnmountVolume.TearDown succeeded for volume "kubernetes.io/host-path/66b76d69-df9b-4c1a-b827-599e22051775-pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55" (OuterVolumeSpecName: "mypd") pod "66b76d69-df9b-4c1a-b827-599e22051775" (UID: "66b76d69-df9b-4c1a-b827-599e22051775"). InnerVolumeSpecName "pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55". PluginName "kubernetes.io/host-path", VolumeGidValue ""
Jul 28 20:42:57 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:57.252431 10414 operation_generator.go:856] UnmountVolume.TearDown succeeded for volume "kubernetes.io/projected/66b76d69-df9b-4c1a-b827-599e22051775-kube-api-access-pcqbc" (OuterVolumeSpecName: "kube-api-access-pcqbc") pod "66b76d69-df9b-4c1a-b827-599e22051775" (UID: "66b76d69-df9b-4c1a-b827-599e22051775"). InnerVolumeSpecName "kube-api-access-pcqbc". PluginName "kubernetes.io/projected", VolumeGidValue ""
Jul 28 20:42:57 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:57.348101 10414 reconciler.go:312] "Volume detached for volume \"pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55\" (UniqueName: \"kubernetes.io/host-path/66b76d69-df9b-4c1a-b827-599e22051775-pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55\") on node \"functional-20220728203726-27744\" DevicePath \"\""
Jul 28 20:42:57 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:57.348202 10414 reconciler.go:312] "Volume detached for volume \"kube-api-access-pcqbc\" (UniqueName: \"kubernetes.io/projected/66b76d69-df9b-4c1a-b827-599e22051775-kube-api-access-pcqbc\") on node \"functional-20220728203726-27744\" DevicePath \"\""
Jul 28 20:42:59 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:59.157586 10414 topology_manager.go:200] "Topology Admit Handler"
Jul 28 20:42:59 functional-20220728203726-27744 kubelet[10414]: E0728 20:42:59.158894 10414 cpu_manager.go:394] "RemoveStaleState: removing container" podUID="66b76d69-df9b-4c1a-b827-599e22051775" containerName="myfrontend"
Jul 28 20:42:59 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:59.159924 10414 memory_manager.go:345] "RemoveStaleState removing state" podUID="66b76d69-df9b-4c1a-b827-599e22051775" containerName="myfrontend"
Jul 28 20:42:59 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:59.431801 10414 reconciler.go:270] "operationExecutor.VerifyControllerAttachedVolume started for volume \"pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55\" (UniqueName: \"kubernetes.io/host-path/22a487d7-d337-4170-a4b2-b25074680a54-pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55\") pod \"sp-pod\" (UID: \"22a487d7-d337-4170-a4b2-b25074680a54\") " pod="default/sp-pod"
Jul 28 20:42:59 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:59.431898 10414 reconciler.go:270] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-d9wtr\" (UniqueName: \"kubernetes.io/projected/22a487d7-d337-4170-a4b2-b25074680a54-kube-api-access-d9wtr\") pod \"sp-pod\" (UID: \"22a487d7-d337-4170-a4b2-b25074680a54\") " pod="default/sp-pod"
Jul 28 20:42:59 functional-20220728203726-27744 kubelet[10414]: I0728 20:42:59.538564 10414 kubelet_volumes.go:160] "Cleaned up orphaned pod volumes dir" podUID=66b76d69-df9b-4c1a-b827-599e22051775 path="/var/lib/kubelet/pods/66b76d69-df9b-4c1a-b827-599e22051775/volumes"
Jul 28 20:43:35 functional-20220728203726-27744 kubelet[10414]: I0728 20:43:35.751204 10414 topology_manager.go:200] "Topology Admit Handler"
Jul 28 20:43:35 functional-20220728203726-27744 kubelet[10414]: I0728 20:43:35.932856 10414 reconciler.go:270] "operationExecutor.VerifyControllerAttachedVolume started for volume \"kube-api-access-q99zt\" (UniqueName: \"kubernetes.io/projected/d8892d40-f3c6-4697-bfb7-48e99daa3d1f-kube-api-access-q99zt\") pod \"mysql-67f7d69d8b-fzlzd\" (UID: \"d8892d40-f3c6-4697-bfb7-48e99daa3d1f\") " pod="default/mysql-67f7d69d8b-fzlzd"
Jul 28 20:43:37 functional-20220728203726-27744 kubelet[10414]: I0728 20:43:37.394365 10414 pod_container_deletor.go:79] "Container not found in pod's containers" containerID="83ed17bf699ec0da2f83c05a95a89123b6910c9f8ae056be436da3e11d10039b"
Jul 28 20:46:33 functional-20220728203726-27744 kubelet[10414]: W0728 20:46:33.637718 10414 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Jul 28 20:51:33 functional-20220728203726-27744 kubelet[10414]: W0728 20:51:33.640409 10414 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Jul 28 20:56:33 functional-20220728203726-27744 kubelet[10414]: W0728 20:56:33.643435 10414 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Jul 28 21:01:33 functional-20220728203726-27744 kubelet[10414]: W0728 21:01:33.644496 10414 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Jul 28 21:06:33 functional-20220728203726-27744 kubelet[10414]: W0728 21:06:33.646638 10414 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Jul 28 21:11:33 functional-20220728203726-27744 kubelet[10414]: W0728 21:11:33.647841 10414 sysinfo.go:203] Nodes topology is not available, providing CPU topology
Jul 28 21:16:33 functional-20220728203726-27744 kubelet[10414]: W0728 21:16:33.646322 10414 sysinfo.go:203] Nodes topology is not available, providing CPU topology
*
* ==> storage-provisioner [1deb549ffdeb] <==
* I0728 20:41:45.139546 1 storage_provisioner.go:116] Initializing the minikube storage provisioner...
I0728 20:41:45.238892 1 storage_provisioner.go:141] Storage provisioner initialized, now starting service!
I0728 20:41:45.239227 1 leaderelection.go:243] attempting to acquire leader lease kube-system/k8s.io-minikube-hostpath...
I0728 20:42:02.788127 1 leaderelection.go:253] successfully acquired lease kube-system/k8s.io-minikube-hostpath
I0728 20:42:02.788541 1 controller.go:835] Starting provisioner controller k8s.io/minikube-hostpath_functional-20220728203726-27744_8829fe91-a31c-43b5-9364-af6bd2af3d62!
I0728 20:42:02.788524 1 event.go:282] Event(v1.ObjectReference{Kind:"Endpoints", Namespace:"kube-system", Name:"k8s.io-minikube-hostpath", UID:"b3e48302-b602-4e47-86a2-9aded4e4ca7e", APIVersion:"v1", ResourceVersion:"640", FieldPath:""}): type: 'Normal' reason: 'LeaderElection' functional-20220728203726-27744_8829fe91-a31c-43b5-9364-af6bd2af3d62 became leader
I0728 20:42:02.889945 1 controller.go:884] Started provisioner controller k8s.io/minikube-hostpath_functional-20220728203726-27744_8829fe91-a31c-43b5-9364-af6bd2af3d62!
I0728 20:42:20.226661 1 controller.go:1332] provision "default/myclaim" class "standard": started
I0728 20:42:20.227295 1 event.go:282] Event(v1.ObjectReference{Kind:"PersistentVolumeClaim", Namespace:"default", Name:"myclaim", UID:"ff579da9-385b-4ec6-aea7-ccd7f787de55", APIVersion:"v1", ResourceVersion:"666", FieldPath:""}): type: 'Normal' reason: 'Provisioning' External provisioner is provisioning volume for claim "default/myclaim"
I0728 20:42:20.227108 1 storage_provisioner.go:61] Provisioning volume {&StorageClass{ObjectMeta:{standard 60062f2f-e1a6-477b-abf7-1a75bf8c9308 389 0 2022-07-28 20:39:04 +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-07-28 20:39:04 +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-ff579da9-385b-4ec6-aea7-ccd7f787de55 &PersistentVolumeClaim{ObjectMeta:{myclaim default ff579da9-385b-4ec6-aea7-ccd7f787de55 666 0 2022-07-28 20:42:20 +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-07-28 20:42:20 +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-07-28 20:42:20 +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
I0728 20:42:20.228253 1 controller.go:1439] provision "default/myclaim" class "standard": volume "pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55" provisioned
I0728 20:42:20.228432 1 controller.go:1456] provision "default/myclaim" class "standard": succeeded
I0728 20:42:20.228447 1 volume_store.go:212] Trying to save persistentvolume "pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55"
I0728 20:42:20.274820 1 volume_store.go:219] persistentvolume "pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55" saved
I0728 20:42:20.276423 1 event.go:282] Event(v1.ObjectReference{Kind:"PersistentVolumeClaim", Namespace:"default", Name:"myclaim", UID:"ff579da9-385b-4ec6-aea7-ccd7f787de55", APIVersion:"v1", ResourceVersion:"666", FieldPath:""}): type: 'Normal' reason: 'ProvisioningSucceeded' Successfully provisioned volume pvc-ff579da9-385b-4ec6-aea7-ccd7f787de55
*
* ==> storage-provisioner [cbfb951f9f4f] <==
*
-- /stdout --
helpers_test.go:254: (dbg) Run: out/minikube-windows-amd64.exe status --format={{.APIServer}} -p functional-20220728203726-27744 -n functional-20220728203726-27744
helpers_test.go:254: (dbg) Done: out/minikube-windows-amd64.exe status --format={{.APIServer}} -p functional-20220728203726-27744 -n functional-20220728203726-27744: (3.5116983s)
helpers_test.go:261: (dbg) Run: kubectl --context functional-20220728203726-27744 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-20220728203726-27744 describe pod
helpers_test.go:275: (dbg) Non-zero exit: kubectl --context functional-20220728203726-27744 describe pod : exit status 1 (276.4202ms)
** stderr **
error: resource name may not be empty
** /stderr **
helpers_test.go:277: kubectl --context functional-20220728203726-27744 describe pod : exit status 1
--- FAIL: TestFunctional/parallel/ServiceCmd (2111.15s)