I installed rancher and portainer on docker on ubuntu server on proxmox. I have acces to the portainer UI but still can’t get the Rancher UI : ERR_CONNECTION_REFUSED
I have set a static ip 192.168.1.240 then I got to https://192.168.1.240 and https://192.168.1.240:443. Please help me.
Well since it says up 6 seconds, it’s probably crashing in a loop… look at the logs.
No not 6 seconds, 6 minutes and I deleted the first rancher container after I installed Portainer
Look at your screenshot. Created 6 minutes ago, up 6 seconds.
I have the exact same problem… Just install latest Ubuntu 20.04.2, latest docker 20.10.7 and rancher/rancher: latest
The rancher server UI refused the connection…
A month ago, when I first installed it, it was working just fine. Then I need to installed it on the 2nd machine, and it no longer be able to access the admin UI
I will not come into a forum and ask a question if I did not spend hours before I try to fix my issues…
rancher/server:stable works fine in port 8080, but I want a specific UI that my favorite youtuber use and he definitly don’t use rancher/server, by the way I don’t know where are the cluster into that server UI.
Hi,
I had the same problem yesterday after upgrading to the last kernel “Ubuntu 20.04 LTS : Linux 5.4.0-80-generic”.
After rolling back to the n-1 version of the kernel (5.4.0-77-generic) i was able to restart my rancher (rancher 2.5.9 single node on docker 20.10.7).
If needed :
You can roll back the kernel version easily via the “grub” menu : on boot, choose the grub menu et the menu “Advanced”, and choose “5.4.0-77” kernel version.
After, in linux remove the 5.4.0-80 kernel files via :
sudo apt remove linux-image-5.4.0-80-generic linux-headers-5.4.0-80-generic linux-image-unsigned-5.4.0-80-generic
and finally :
sudo apt autoremove
TiTidom.
That is interesting, I guess I learned something, but I installed the 20.04 so in the advanced menu of the grub there is only 5.4.0-80-generic and 5.4.0-80-generic (recovery mode) even if I tried to remove linux-image-5.4.0-80-generic. I guess I should install a previous version of Ubuntu.
Not sure if I understand your advice. I custom the port to fit my arrangement, certainly not 8080 but something else however it still point to port 80 and 443 of the server. I did search on this forum but return none result so far.
I doubt that it has something to do with the updates from Ubuntu itself lately (in a month or so), or the docker, or even the rancher… As I said, a month ago, I was able to get everything works in one go… not this time.
I will try the roll-back the Ubuntu updates per TiTidom’s post, and would let you know
I don’t tell you to do this, I just tell you that this command line works for me while I still can’t accecss the UI of rancher/rancher just like you.
I repeat but hey why not, rancher/server is not rancher/rancher, with rancher/server you need to set a host on another machine, this is a nightmare for a noob like me with kubernetes, I don’t recommend it, I can’t even access the rancher UI
8080 and rancher/server (vs rancher/rancher) are for 1.x and ancient/no longer maintained.
My point about the 6 seconds is that means it’s crashing and being restarted, which means the log probably says something relevant, but you still haven’t looked (or at least shown us).
The log
{"log":"I0726 08:03:38.621010 33 server_others.go:186] Using iptables Proxier.\n","stream":"stderr","time":"2021-07-26T08:03:38.621042631Z"}
{"log":"I0726 08:03:38.621124 33 server.go:650] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:03:38.621152201Z"}
{"log":"I0726 08:03:38.622410 33 conntrack.go:103] Set sysctl 'net/netfilter/nf_conntrack_max' to 196608\n","stream":"stderr","time":"2021-07-26T08 :03:38.622447957Z"}
{"log":"F0726 08:03:38.622424 33 server.go:495] open /proc/sys/net/netfilter/nf_conntrack_max: permission denied\n","stream":"stderr","time":"2021- 07-26T08:03:38.622453877Z"}
{"log":"2021/07/26 08:03:38 [FATAL] k3s exited with: exit status 1\n","stream":"stdout","time":"2021-07-26T08:03:38.62569003Z"}
{"log":"2021/07/26 08:03:39 [INFO] Rancher version v2.5.9 (3c5418944) is starting\n","stream":"stdout","time":"2021-07-26T08:03:39.35145985Z"}
{"log":"2021/07/26 08:03:39 [INFO] Listening on /tmp/log.sock\n","stream":"stdout","time":"2021-07-26T08:03:39.35148656Z"}
{"log":"2021/07/26 08:03:39 [INFO] Rancher arguments {ACMEDomains:[] AddLocal:true Embedded:false BindHost: HTTPListenPort:80 HTTPSListenPort:443 K8sMod e:auto Debug:false Trace:false NoCACerts:false AuditLogPath:/var/log/auditlog/rancher-api-audit.log AuditLogMaxage:10 AuditLogMaxsize:100 AuditLogMaxbac kup:10 AuditLevel:0 Agent:false Features: ClusterRegistry:}\n","stream":"stdout","time":"2021-07-26T08:03:39.35149096Z"}
{"log":"2021/07/26 08:03:39 [INFO] Running etcd --data-dir=management-state/etcd --heartbeat-interval=500 --election-timeout=5000\n","stream":"stdout"," time":"2021-07-26T08:03:39.351744339Z"}
{"log":"2021-07-26 08:03:39.359624 W | pkg/flags: unrecognized environment variable ETCD_URL_arm64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-arm64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:03:39.35971127Z"}
{"log":"2021-07-26 08:03:39.359651 W | pkg/flags: unrecognized environment variable ETCD_URL_amd64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-amd64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:03:39.35972207Z"}
{"log":"2021-07-26 08:03:39.359655 W | pkg/flags: unrecognized environment variable ETCD_UNSUPPORTED_ARCH=amd64\n","stream":"stderr","time":"2021-07-26T 08:03:39.35972609Z"}
{"log":"2021-07-26 08:03:39.359665 W | pkg/flags: unrecognized environment variable ETCD_URL=ETCD_URL_amd64\n","stream":"stderr","time":"2021-07-26T08:0 3:39.35974706Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:03:39.3597495Z" }
{"log":"2021-07-26 08:03:39.359694 I | etcdmain: etcd Version: 3.4.3\n","stream":"stderr","time":"2021-07-26T08:03:39.35975131Z"}
{"log":"2021-07-26 08:03:39.359704 I | etcdmain: Git SHA: 3cf2f69b5\n","stream":"stderr","time":"2021-07-26T08:03:39.35975533Z"}
{"log":"2021-07-26 08:03:39.359708 I | etcdmain: Go Version: go1.12.12\n","stream":"stderr","time":"2021-07-26T08:03:39.35975731Z"}
{"log":"2021-07-26 08:03:39.359717 I | etcdmain: Go OS/Arch: linux/amd64\n","stream":"stderr","time":"2021-07-26T08:03:39.35975919Z"}
{"log":"2021-07-26 08:03:39.359722 I | etcdmain: setting maximum number of CPUs to 6, total number of available CPUs is 6\n","stream":"stderr","time":"2 021-07-26T08:03:39.35976101Z"}
{"log":"2021-07-26 08:03:39.359782 N | etcdmain: the server is already initialized as member before, starting as etcd member...\n","stream":"stderr","ti me":"2021-07-26T08:03:39.35984985Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:03:39.35987119Z "}
{"log":"2021-07-26 08:03:39.360137 I | embed: name = default\n","stream":"stderr","time":"2021-07-26T08:03:39.36020122Z"}
{"log":"2021-07-26 08:03:39.360149 I | embed: data dir = management-state/etcd\n","stream":"stderr","time":"2021-07-26T08:03:39.36021762Z"}
{"log":"2021-07-26 08:03:39.360153 I | embed: member dir = management-state/etcd/member\n","stream":"stderr","time":"2021-07-26T08:03:39.36022417Z"}
{"log":"2021-07-26 08:03:39.360157 I | embed: heartbeat = 500ms\n","stream":"stderr","time":"2021-07-26T08:03:39.36022982Z"}
{"log":"2021-07-26 08:03:39.360165 I | embed: election = 5000ms\n","stream":"stderr","time":"2021-07-26T08:03:39.3602354Z"}
{"log":"2021-07-26 08:03:39.360174 I | embed: snapshot count = 100000\n","stream":"stderr","time":"2021-07-26T08:03:39.36024082Z"}
{"log":"2021-07-26 08:03:39.360188 I | embed: advertise client URLs = http://localhost:2379\n","stream":"stderr","time":"2021-07-26T08:03:39.36024809Z"}
{"log":"2021-07-26 08:03:39.360198 I | embed: initial advertise peer URLs = http://localhost:2380\n","stream":"stderr","time":"2021-07-26T08:03:39.36025 366Z"}
{"log":"2021-07-26 08:03:39.360210 I | embed: initial cluster = \n","stream":"stderr","time":"2021-07-26T08:03:39.36025892Z"}
{"log":"2021-07-26 08:03:39.365259 I | etcdserver: restarting member 8e9e05c52164694d in cluster cdf818194e3a8c32 at commit index 1227\n","stream":"stde rr","time":"2021-07-26T08:03:39.365328058Z"}
{"log":"raft2021/07/26 08:03:39 INFO: 8e9e05c52164694d switched to configuration voters=()\n","stream":"stderr","time":"2021-07-26T08:03:39.365554497Z"}
{"log":"raft2021/07/26 08:03:39 INFO: 8e9e05c52164694d became follower at term 37\n","stream":"stderr","time":"2021-07-26T08:03:39.365561567Z"}
{"log":"raft2021/07/26 08:03:39 INFO: newRaft 8e9e05c52164694d [peers: [], term: 37, commit: 1227, applied: 0, lastindex: 1227, lastterm: 37]\n","stream ":"stderr","time":"2021-07-26T08:03:39.365564797Z"}
{"log":"2021-07-26 08:03:39.369615 W | auth: simple token is not cryptographically signed\n","stream":"stderr","time":"2021-07-26T08:03:39.369703947Z"}
{"log":"2021-07-26 08:03:39.371408 I | etcdserver: starting server... [version: 3.4.3, cluster version: to_be_decided]\n","stream":"stderr","time":"2021 -07-26T08:03:39.371477522Z"}
{"log":"raft2021/07/26 08:03:39 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437)\n","stream":"stderr","time":"2021-07-26T0 8:03:39.371779223Z"}
{"log":"2021-07-26 08:03:39.371805 I | etcdserver/membership: added member 8e9e05c52164694d [http://localhost:2380] to cluster cdf818194e3a8c32\n","stre am":"stderr","time":"2021-07-26T08:03:39.371856662Z"}
{"log":"2021-07-26 08:03:39.371877 N | etcdserver/membership: set the initial cluster version to 3.4\n","stream":"stderr","time":"2021-07-26T08:03:39.37 1936172Z"}
{"log":"2021-07-26 08:03:39.371904 I | etcdserver/api: enabled capabilities for version 3.4\n","stream":"stderr","time":"2021-07-26T08:03:39.371953492Z" }
{"log":"2021-07-26 08:03:39.374065 I | embed: listening for peers on 127.0.0.1:2380\n","stream":"stderr","time":"2021-07-26T08:03:39.374166546Z"}
{"log":"raft2021/07/26 08:03:46 INFO: 8e9e05c52164694d is starting a new election at term 37\n","stream":"stderr","time":"2021-07-26T08:03:46.366074523Z "}
{"log":"raft2021/07/26 08:03:46 INFO: 8e9e05c52164694d became candidate at term 38\n","stream":"stderr","time":"2021-07-26T08:03:46.366102683Z"}
{"log":"raft2021/07/26 08:03:46 INFO: 8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 38\n","stream":"stderr","time":"2021-07-26T08: 03:46.366108103Z"}
{"log":"raft2021/07/26 08:03:46 INFO: 8e9e05c52164694d became leader at term 38\n","stream":"stderr","time":"2021-07-26T08:03:46.366112203Z"}
{"log":"raft2021/07/26 08:03:46 INFO: raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 38\n","stream":"stderr","time":"2021-07-26T08: 03:46.366115972Z"}
{"log":"2021-07-26 08:03:46.368863 I | embed: ready to serve client requests\n","stream":"stderr","time":"2021-07-26T08:03:46.368975046Z"}
{"log":"2021-07-26 08:03:46.368900 I | etcdserver: published {Name:default ClientURLs:[http://localhost:2379]} to cluster cdf818194e3a8c32\n","stream":" stderr","time":"2021-07-26T08:03:46.368988066Z"}
{"log":"2021-07-26 08:03:46.369614 N | embed: serving insecure client requests on 127.0.0.1:2379, this is strongly discouraged!\n","stream":"stderr","ti me":"2021-07-26T08:03:46.369701714Z"}
{"log":"2021/07/26 08:03:46 [INFO] Waiting for server to become available: Get \"https://127.0.0.1:6443/version?timeout=15m0s\": dial tcp 127.0.0.1:6443 : connect: connection refused\n","stream":"stdout","time":"2021-07-26T08:03:46.383175671Z"}
{"log":"time=\"2021-07-26T08:03:46.544224297Z\" level=info msg=\"Starting k3s v1.19.8+k3s1 (95fc76b2)\"\n","stream":"stderr","time":"2021-07-26T08:03:46 .544363086Z"}
{"log":"time=\"2021-07-26T08:03:46.544378316Z\" level=info msg=\"Cluster bootstrap already complete\"\n","stream":"stderr","time":"2021-07-26T08:03:46.5 44458566Z"}
{"log":"time=\"2021-07-26T08:03:46.552062518Z\" level=info msg=\"Running kube-apiserver --advertise-port=6443 --allow-privileged=true --anonymous-auth=f alse --api-audiences=unknown --authorization-mode=Node,RBAC --bind-address=127.0.0.1 --cert-dir=/var/lib/rancher/k3s/server/tls/temporary-certs --client -ca-file=/var/lib/rancher/k3s/server/tls/client-ca.crt --enable-admission-plugins=NodeRestriction --etcd-servers=http://localhost:2379 --insecure-port=0 --kubelet-certificate-authority=/var/lib/rancher/k3s/server/tls/server-ca.crt --kubelet-client-certificate=/var/lib/rancher/k3s/server/tls/client-kube- apiserver.crt --kubelet-client-key=/var/lib/rancher/k3s/server/tls/client-kube-apiserver.key --profiling=false --proxy-client-cert-file=/var/lib/rancher /k3s/server/tls/client-auth-proxy.crt --proxy-client-key-file=/var/lib/rancher/k3s/server/tls/client-auth-proxy.key --requestheader-allowed-names=system :auth-proxy --requestheader-client-ca-file=/var/lib/rancher/k3s/server/tls/request-header-ca.crt --requestheader-extra-headers-prefix=X-Remote-Extra- -- requestheader-group-headers=X-Remote-Group --requestheader-username-headers=X-Remote-User --secure-port=6444 --service-account-issuer=k3s --service-acco unt-key-file=/var/lib/rancher/k3s/server/tls/service.key --service-account-signing-key-file=/var/lib/rancher/k3s/server/tls/service.key --service-cluste r-ip-range=10.43.0.0/16 --storage-backend=etcd3 --tls-cert-file=/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.crt --tls-private-key-file=/var/l ib/rancher/k3s/server/tls/serving-kube-apiserver.key\"\n","stream":"stderr","time":"2021-07-26T08:03:46.552174628Z"}
{"log":"I0726 08:03:46.552698 35 server.go:652] external host was not specified, using 172.17.0.2\n","stream":"stderr","time":"2021-07-26T08:03:46. 552770886Z"}
{"log":"I0726 08:03:46.552853 35 server.go:177] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:03:46.552911836Z"}
{"log":"I0726 08:03:46.555552 35 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:03:46.55562372Z"}
{"log":"I0726 08:03:46.555562 35 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:03:46.55563548Z"}
{"log":"I0726 08:03:46.556118 35 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:03:46.556185948Z"}
{"log":"I0726 08:03:46.556126 35 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:03:46.556192628Z"}
{"log":"I0726 08:03:46.577726 35 master.go:271] Using reconciler: lease\n","stream":"stderr","time":"2021-07-26T08:03:46.577854697Z"}
{"log":"W0726 08:03:46.864644 35 genericapiserver.go:412] Skipping API batch/v2alpha1 because it has no resources.\n","stream":"stderr","time":"202 1-07-26T08:03:46.864763282Z"}
{"log":"W0726 08:03:46.873745 35 genericapiserver.go:412] Skipping API discovery.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr", "time":"2021-07-26T08:03:46.87385191Z"}
{"log":"W0726 08:03:46.883268 35 genericapiserver.go:412] Skipping API node.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr","time ":"2021-07-26T08:03:46.883348538Z"}
{"log":"W0726 08:03:46.893515 35 genericapiserver.go:412] Skipping API rbac.authorization.k8s.io/v1alpha1 because it has no resources.\n","stream": "stderr","time":"2021-07-26T08:03:46.893590563Z"}
{"log":"W0726 08:03:46.895617 35 genericapiserver.go:412] Skipping API scheduling.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr" ,"time":"2021-07-26T08:03:46.895680608Z"}
{"log":"W0726 08:03:46.904610 35 genericapiserver.go:412] Skipping API storage.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr","t ime":"2021-07-26T08:03:46.904680857Z"}
{"log":"W0726 08:03:46.916235 35 genericapiserver.go:412] Skipping API apps/v1beta2 because it has no resources.\n","stream":"stderr","time":"2021- 07-26T08:03:46.916317799Z"}
{"log":"W0726 08:03:46.916250 35 genericapiserver.go:412] Skipping API apps/v1beta1 because it has no resources.\n","stream":"stderr","time":"2021- 07-26T08:03:46.916331159Z"}
{"log":"I0726 08:03:46.923062 35 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:03:46.923160403Z"}
{"log":"I0726 08:03:46.923078 35 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:03:46.923181523Z"}
{"log":"time=\"2021-07-26T08:03:46.930599045Z\" level=info msg=\"Running kube-scheduler --address=127.0.0.1 --bind-address=127.0.0.1 --kubeconfig=/var/l ib/rancher/k3s/server/cred/scheduler.kubeconfig --port=10251 --profiling=false --secure-port=0\"\n","stream":"stderr","time":"2021-07-26T08:03:46.930687 335Z"}
{"log":"time=\"2021-07-26T08:03:46.930664075Z\" level=info msg=\"Waiting for API server to become available\"\n","stream":"stderr","time":"2021-07-26T08 :03:46.930718725Z"}
{"log":"I0726 08:03:46.930899 35 registry.go:173] Registering SelectorSpread plugin\n","stream":"stderr","time":"2021-07-26T08:03:46.930938314Z"}
{"log":"I0726 08:03:46.930916 35 registry.go:173] Registering SelectorSpread plugin\n","stream":"stderr","time":"2021-07-26T08:03:46.930942424Z"}
{"log":"time=\"2021-07-26T08:03:46.931239844Z\" level=info msg=\"Running kube-controller-manager --address=127.0.0.1 --allocate-node-cidrs=true --bind-a ddress=127.0.0.1 --cluster-cidr=10.42.0.0/16 --cluster-signing-cert-file=/var/lib/rancher/k3s/server/tls/client-ca.crt --cluster-signing-key-file=/var/l ib/rancher/k3s/server/tls/client-ca.key --kubeconfig=/var/lib/rancher/k3s/server/cred/controller.kubeconfig --port=10252 --profiling=false --root-ca-fil e=/var/lib/rancher/k3s/server/tls/server-ca.crt --secure-port=0 --service-account-private-key-file=/var/lib/rancher/k3s/server/tls/service.key --use-ser vice-account-credentials=true\"\n","stream":"stderr","time":"2021-07-26T08:03:46.931294503Z"}
{"log":"time=\"2021-07-26T08:03:46.932614900Z\" level=info msg=\"Node token is available at /var/lib/rancher/k3s/server/token\"\n","stream":"stderr","ti me":"2021-07-26T08:03:46.93266062Z"}
{"log":"time=\"2021-07-26T08:03:46.932641070Z\" level=info msg=\"To join node to cluster: k3s agent -s https://172.17.0.2:6443 -t ${NODE_TOKEN}\"\n","st ream":"stderr","time":"2021-07-26T08:03:46.9326657Z"}
{"log":"time=\"2021-07-26T08:03:46.933648917Z\" level=info msg=\"Wrote kubeconfig /etc/rancher/k3s/k3s.yaml\"\n","stream":"stderr","time":"2021-07-26T08 :03:46.933697897Z"}
{"log":"time=\"2021-07-26T08:03:46.933674977Z\" level=info msg=\"Run: k3s kubectl\"\n","stream":"stderr","time":"2021-07-26T08:03:46.933703957Z"}
{"log":"time=\"2021-07-26T08:03:46.933766887Z\" level=info msg=\"Module overlay was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:03:46.93 3808717Z"}
{"log":"time=\"2021-07-26T08:03:46.933789547Z\" level=info msg=\"Module nf_conntrack was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:03: 46.933821047Z"}
{"log":"time=\"2021-07-26T08:03:46.933811997Z\" level=info msg=\"Module br_netfilter was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:03: 46.933850238Z"}
{"log":"time=\"2021-07-26T08:03:46.933822627Z\" level=info msg=\"Module iptable_nat was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:03:4 6.933855358Z"}
{"log":"time=\"2021-07-26T08:03:46.944375042Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:03:46 http: TLS handshake error from 127.0.0.1:55560: remote error: tls: bad certificate\"\n","stream":"stderr","time":"2021-07-26T08:03:46.944454671Z"}
{"log":"time=\"2021-07-26T08:03:46.947835864Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:03:46 http: TLS handshake error from 127.0.0.1:55566: remote error: tls: bad certificate\"\n","stream":"stderr","time":"2021-07-26T08:03:46.947891603Z"}
{"log":"time=\"2021-07-26T08:03:46.962239429Z\" level=info msg=\"certificate CN=local-node signed by CN=k3s-server-ca@1627286228: notBefore=2021-07-26 0 7:57:08 +0000 UTC notAfter=2022-07-26 08:03:46 +0000 UTC\"\n","stream":"stderr","time":"2021-07-26T08:03:46.962411399Z"}
{"log":"time=\"2021-07-26T08:03:46.965031233Z\" level=info msg=\"certificate CN=system:node:local-node,O=system:nodes signed by CN=k3s-client-ca@1627286 228: notBefore=2021-07-26 07:57:08 +0000 UTC notAfter=2022-07-26 08:03:46 +0000 UTC\"\n","stream":"stderr","time":"2021-07-26T08:03:46.965138613Z"}
{"log":"time=\"2021-07-26T08:03:46.970041841Z\" level=info msg=\"Logging containerd to /var/lib/rancher/k3s/agent/containerd/containerd.log\"\n","stream ":"stderr","time":"2021-07-26T08:03:46.970140561Z"}
{"log":"time=\"2021-07-26T08:03:46.970201020Z\" level=info msg=\"Running containerd -c /var/lib/rancher/k3s/agent/etc/containerd/config.toml -a /run/k3s /containerd/containerd.sock --state /run/k3s/containerd --root /var/lib/rancher/k3s/agent/containerd\"\n","stream":"stderr","time":"2021-07-26T08:03:46. 9703023Z"}
{"log":"time=\"2021-07-26T08:03:47.971875595Z\" level=info msg=\"Containerd is now running\"\n","stream":"stderr","time":"2021-07-26T08:03:47.972006625Z "}
{"log":"time=\"2021-07-26T08:03:47.978470289Z\" level=info msg=\"Connecting to proxy\" url=\"wss://127.0.0.1:6443/v1-k3s/connect\"\n","stream":"stderr", "time":"2021-07-26T08:03:47.978586129Z"}
{"log":"time=\"2021-07-26T08:03:47.980650244Z\" level=info msg=\"Handling backend connection request [local-node]\"\n","stream":"stderr","time":"2021-07 -26T08:03:47.980744084Z"}
{"log":"time=\"2021-07-26T08:03:47.981115193Z\" level=warning msg=\"Disabling CPU quotas due to missing cpu.cfs_period_us\"\n","stream":"stderr","time": "2021-07-26T08:03:47.981226643Z"}
{"log":"time=\"2021-07-26T08:03:47.981170323Z\" level=info msg=\"Running kubelet --address=0.0.0.0 --anonymous-auth=false --authentication-token-webhook =true --authorization-mode=Webhook --cgroup-driver=cgroupfs --client-ca-file=/var/lib/rancher/k3s/agent/client-ca.crt --cloud-provider=external --cluste r-dns=10.43.0.10 --cluster-domain=cluster.local --cni-bin-dir=/var/lib/rancher/k3s/data/ab1b521f47b3cbc273e0c667521084cff1ea3540d55b425ac7ed30c27daf92f8 /bin --cni-conf-dir=/var/lib/rancher/k3s/agent/etc/cni/net.d --container-runtime-endpoint=/run/k3s/containerd/containerd.sock --container-runtime=remote --containerd=/run/k3s/containerd/containerd.sock --cpu-cfs-quota=false --eviction-hard=imagefs.available\u003c5%,nodefs.available\u003c5% --eviction-mi nimum-reclaim=imagefs.available=10%,nodefs.available=10% --fail-swap-on=false --healthz-bind-address=127.0.0.1 --hostname-override=local-node --kubeconf ig=/var/lib/rancher/k3s/agent/kubelet.kubeconfig --kubelet-cgroups=/k3s --node-labels= --pod-manifest-path=/var/lib/rancher/k3s/agent/pod-manifests --re ad-only-port=0 --resolv-conf=/etc/resolv.conf --runtime-cgroups=/k3s --serialize-image-pulls=false --tls-cert-file=/var/lib/rancher/k3s/agent/serving-ku belet.crt --tls-private-key-file=/var/lib/rancher/k3s/agent/serving-kubelet.key\"\n","stream":"stderr","time":"2021-07-26T08:03:47.981279483Z"}
{"log":"time=\"2021-07-26T08:03:47.981834351Z\" level=info msg=\"Running kube-proxy --cluster-cidr=10.42.0.0/16 --healthz-bind-address=127.0.0.1 --hostn ame-override=local-node --kubeconfig=/var/lib/rancher/k3s/agent/kubeproxy.kubeconfig --proxy-mode=iptables\"\n","stream":"stderr","time":"2021-07-26T08: 03:47.981898971Z"}
{"log":"Flag --cloud-provider has been deprecated, will be removed in 1.23, in favor of removing cloud provider code from Kubelet.\n","stream":"stderr", "time":"2021-07-26T08:03:47.982056291Z"}
{"log":"Flag --containerd has been deprecated, This is a cadvisor flag that was mistakenly registered with the Kubelet. Due to legacy concerns, it will follow the standard CLI deprecation timeline before being removed.\n","stream":"stderr","time":"2021-07-26T08:03:47.982069981Z"}
{"log":"W0726 08:03:47.982107 35 server.go:226] WARNING: all flags other than --config, --write-config-to, and --cleanup are deprecated. Please beg in using a config file ASAP.\n","stream":"stderr","time":"2021-07-26T08:03:47.98216484Z"}
{"log":"I0726 08:03:47.982455 35 server.go:407] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:03:47.98252885Z"}
{"log":"W0726 08:03:47.984123 35 proxier.go:639] Failed to read file /lib/modules/4.15.0-151-generic/modules.builtin with error open /lib/modules/4 .15.0-151-generic/modules.builtin: no such file or directory. You can ignore this message when kube-proxy is running inside container without mounting / lib/modules\n","stream":"stderr","time":"2021-07-26T08:03:47.984181286Z"}
{"log":"W0726 08:03:47.984565 35 proxier.go:649] Failed to load kernel module ip_vs with modprobe. You can ignore this message when kube-proxy is r unning inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:03:47.984638635Z"}
{"log":"W0726 08:03:47.984905 35 proxier.go:649] Failed to load kernel module ip_vs_rr with modprobe. You can ignore this message when kube-proxy i s running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:03:47.984957434Z"}
{"log":"W0726 08:03:47.985225 35 proxier.go:649] Failed to load kernel module ip_vs_wrr with modprobe. You can ignore this message when kube-proxy is running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:03:47.985273963Z"}
{"log":"W0726 08:03:47.985502 35 proxier.go:649] Failed to load kernel module ip_vs_sh with modprobe. You can ignore this message when kube-proxy i s running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:03:47.985554292Z"}
{"log":"W0726 08:03:47.985777 35 proxier.go:649] Failed to load kernel module nf_conntrack_ipv4 with modprobe. You can ignore this message when kub e-proxy is running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:03:47.985850061Z"}
{"log":"time=\"2021-07-26T08:03:47.988612455Z\" level=info msg=\"Waiting for node local-node CIDR not assigned yet\"\n","stream":"stderr","time":"2021-0 7-26T08:03:47.988690035Z"}
{"log":"E0726 08:03:47.990932 35 node.go:125] Failed to retrieve node info: nodes \"local-node\" is forbidden: User \"system:kube-proxy\" cannot ge t resource \"nodes\" in API group \"\" at the cluster scope\n","stream":"stderr","time":"2021-07-26T08:03:47.99101939Z"}
{"log":"I0726 08:03:48.003527 35 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/agent/client-ca.crt\n","stream":"st derr","time":"2021-07-26T08:03:48.003595119Z"}
{"log":"I0726 08:03:48.192845 35 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/server/tls/client-ca.crt\n","stream ":"stderr","time":"2021-07-26T08:03:48.192979236Z"}
{"log":"I0726 08:03:48.192845 35 dynamic_cafile_content.go:167] Starting request-header::/var/lib/rancher/k3s/server/tls/request-header-ca.crt\n"," stream":"stderr","time":"2021-07-26T08:03:48.193010516Z"}
{"log":"I0726 08:03:48.192972 35 dynamic_serving_content.go:130] Starting serving-cert::/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.crt: :/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.key\n","stream":"stderr","time":"2021-07-26T08:03:48.193063046Z"}
{"log":"I0726 08:03:48.193188 35 secure_serving.go:197] Serving securely on 127.0.0.1:6444\n","stream":"stderr","time":"2021-07-26T08:03:48.1932521 15Z"}
{"log":"I0726 08:03:48.193232 35 apiservice_controller.go:97] Starting APIServiceRegistrationController\n","stream":"stderr","time":"2021-07-26T08: 03:48.193275355Z"}
{"log":"I0726 08:03:48.193240 35 cache.go:32] Waiting for caches to sync for APIServiceRegistrationController controller\n","stream":"stderr","time ":"2021-07-26T08:03:48.193279995Z"}
{"log":"I0726 08:03:48.193263 35 tlsconfig.go:240] Starting DynamicServingCertificateController\n","stream":"stderr","time":"2021-07-26T08:03:48.19 3304525Z"}
{"log":"I0726 08:03:48.193307 35 customresource_discovery_controller.go:209] Starting DiscoveryController\n","stream":"stderr","time":"2021-07-26T0 8:03:48.193365305Z"}
{"log":"I0726 08:03:48.193645 35 dynamic_serving_content.go:130] Starting aggregator-proxy-cert::/var/lib/rancher/k3s/server/tls/client-auth-proxy. crt::/var/lib/rancher/k3s/server/tls/client-auth-proxy.key\n","stream":"stderr","time":"2021-07-26T08:03:48.193707904Z"}
{"log":"I0726 08:03:48.193677 35 available_controller.go:475] Starting AvailableConditionController\n","stream":"stderr","time":"2021-07-26T08:03:4 8.193749374Z"}
{"log":"I0726 08:03:48.193682 35 cache.go:32] Waiting for caches to sync for AvailableConditionController controller\n","stream":"stderr","time":"2 021-07-26T08:03:48.193753944Z"}
{"log":"I0726 08:03:48.193703 35 autoregister_controller.go:141] Starting autoregister controller\n","stream":"stderr","time":"2021-07-26T08:03:48. 193829703Z"}
{"log":"I0726 08:03:48.193712 35 cache.go:32] Waiting for caches to sync for autoregister controller\n","stream":"stderr","time":"2021-07-26T08:03: 48.193834853Z"}
{"log":"I0726 08:03:48.193724 35 controller.go:86] Starting OpenAPI controller\n","stream":"stderr","time":"2021-07-26T08:03:48.193838473Z"}
{"log":"I0726 08:03:48.193740 35 naming_controller.go:291] Starting NamingConditionController\n","stream":"stderr","time":"2021-07-26T08:03:48.1938 41933Z"}
{"log":"I0726 08:03:48.193751 35 establishing_controller.go:76] Starting EstablishingController\n","stream":"stderr","time":"2021-07-26T08:03:48.19 3845443Z"}
{"log":"I0726 08:03:48.193768 35 nonstructuralschema_controller.go:186] Starting NonStructuralSchemaConditionController\n","stream":"stderr","time" :"2021-07-26T08:03:48.193848993Z"}
{"log":"I0726 08:03:48.193784 35 apiapproval_controller.go:186] Starting KubernetesAPIApprovalPolicyConformantConditionController\n","stream":"stde rr","time":"2021-07-26T08:03:48.193852533Z"}
{"log":"I0726 08:03:48.193796 35 crd_finalizer.go:266] Starting CRDFinalizer\n","stream":"stderr","time":"2021-07-26T08:03:48.193856113Z"}
{"log":"I0726 08:03:48.194087 35 crdregistration_controller.go:111] Starting crd-autoregister controller\n","stream":"stderr","time":"2021-07-26T08 :03:48.194146823Z"}
{"log":"I0726 08:03:48.194100 35 shared_informer.go:240] Waiting for caches to sync for crd-autoregister\n","stream":"stderr","time":"2021-07-26T08 :03:48.194169722Z"}
{"log":"I0726 08:03:48.194146 35 controller.go:83] Starting OpenAPI AggregationController\n","stream":"stderr","time":"2021-07-26T08:03:48.19418520 2Z"}
{"log":"I0726 08:03:48.194538 35 cluster_authentication_trust_controller.go:440] Starting cluster_authentication_trust_controller controller\n","st ream":"stderr","time":"2021-07-26T08:03:48.194606161Z"}
{"log":"I0726 08:03:48.194552 35 shared_informer.go:240] Waiting for caches to sync for cluster_authentication_trust_controller\n","stream":"stderr ","time":"2021-07-26T08:03:48.194613671Z"}
{"log":"I0726 08:03:48.194965 35 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/server/tls/client-ca.crt\n","stream ":"stderr","time":"2021-07-26T08:03:48.19502893Z"}
{"log":"I0726 08:03:48.194990 35 dynamic_cafile_content.go:167] Starting request-header::/var/lib/rancher/k3s/server/tls/request-header-ca.crt\n"," stream":"stderr","time":"2021-07-26T08:03:48.19503588Z"}
{"log":"time=\"2021-07-26T08:03:48.209546476Z\" level=info msg=\"Running cloud-controller-manager --allocate-node-cidrs=true --allow-untagged-cloud=true --bind-address=127.0.0.1 --cloud-provider=k3s --cluster-cidr=10.42.0.0/16 --kubeconfig=/var/lib/rancher/k3s/server/cred/cloud-controller.kubeconfig --n ode-status-update-frequency=1m --profiling=false --secure-port=0\"\n","stream":"stderr","time":"2021-07-26T08:03:48.209655555Z"}
{"log":"Flag --allow-untagged-cloud has been deprecated, This flag is deprecated and will be removed in a future release. A cluster-id will be required on cloud instances.\n","stream":"stderr","time":"2021-07-26T08:03:48.209681415Z"}
{"log":"I0726 08:03:48.213060 35 controllermanager.go:127] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:03:48.213140087Z"}
{"log":"W0726 08:03:48.213082 35 controllermanager.go:139] detected a cluster without a ClusterID. A ClusterID will be required in the future. Pl ease tag your cluster to avoid any future issues\n","stream":"stderr","time":"2021-07-26T08:03:48.213186227Z"}
{"log":"I0726 08:03:48.213102 35 leaderelection.go:243] attempting to acquire leader lease kube-system/cloud-controller-manager...\n","stream":"st derr","time":"2021-07-26T08:03:48.213190657Z"}
{"log":"E0726 08:03:48.222225 35 controller.go:156] Unable to remove old endpoints from kubernetes service: no master IPs were listed in storage, r efusing to erase all endpoints for the kubernetes service\n","stream":"stderr","time":"2021-07-26T08:03:48.222325146Z"}
{"log":"I0726 08:03:48.293392 35 cache.go:39] Caches are synced for APIServiceRegistrationController controller\n","stream":"stderr","time":"2021-0 7-26T08:03:48.293539223Z"}
{"log":"I0726 08:03:48.293754 35 cache.go:39] Caches are synced for autoregister controller\n","stream":"stderr","time":"2021-07-26T08:03:48.293848 052Z"}
{"log":"I0726 08:03:48.293784 35 cache.go:39] Caches are synced for AvailableConditionController controller\n","stream":"stderr","time":"2021-07-26 T08:03:48.293860132Z"}
{"log":"I0726 08:03:48.294386 35 shared_informer.go:247] Caches are synced for crd-autoregister \n","stream":"stderr","time":"2021-07-26T08:03:48.2 94454792Z"}
{"log":"I0726 08:03:48.294587 35 shared_informer.go:247] Caches are synced for cluster_authentication_trust_controller \n","stream":"stderr","time" :"2021-07-26T08:03:48.294649661Z"}
{"log":"W0726 08:03:48.396959 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:48.397078877Z"}
{"log":"W0726 08:03:48.417152 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:48.417271458Z"}
{"log":"W0726 08:03:48.446313 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:48.446426389Z"}
{"log":"W0726 08:03:48.489482 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:48.489594115Z"}
{"log":"W0726 08:03:48.500835 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:48.500908398Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting API controllers\n","stream":"stdout","time":"2021-07-26T08:03:48.75014141Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting management.cattle.io/v3, Kind=User controller\n","stream":"stdout","time":"2021-07-26T08:03:48.871879208Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting management.cattle.io/v3, Kind=UserAttribute controller\n","stream":"stdout","time":"2021-07-26T08:03:48.8719 10497Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting management.cattle.io/v3, Kind=GroupMember controller\n","stream":"stdout","time":"2021-07-26T08:03:48.871929 927Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting management.cattle.io/v3, Kind=Token controller\n","stream":"stdout","time":"2021-07-26T08:03:48.871933457Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting /v1, Kind=Secret controller\n","stream":"stdout","time":"2021-07-26T08:03:48.871994858Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting management.cattle.io/v3, Kind=Group controller\n","stream":"stdout","time":"2021-07-26T08:03:48.872168688Z"}
{"log":"W0726 08:03:48.888929 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:48.889076387Z"}
{"log":"W0726 08:03:48.898327 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:48.898421714Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting catalog.cattle.io/v1, Kind=ClusterRepo controller\n","stream":"stdout","time":"2021-07-26T08:03:48.988892167 Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting apiregistration.k8s.io/v1, Kind=APIService controller\n","stream":"stdout","time":"2021-07-26T08:03:48.98892 9937Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting management.cattle.io/v3, Kind=Feature controller\n","stream":"stdout","time":"2021-07-26T08:03:48.988932307Z "}
{"log":"2021/07/26 08:03:48 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=RoleBinding controller\n","stream":"stdout","time":"2021-07-26T08:03:48.9 89133677Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting management.cattle.io/v3, Kind=Preference controller\n","stream":"stdout","time":"2021-07-26T08:03:48.9891612 87Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting /v1, Kind=Secret controller\n","stream":"stdout","time":"2021-07-26T08:03:48.989207427Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=ClusterRole controller\n","stream":"stdout","time":"2021-07-26T08:03:48.9 89214217Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting apiextensions.k8s.io/v1beta1, Kind=CustomResourceDefinition controller\n","stream":"stdout","time":"2021-07- 26T08:03:48.989356566Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=ClusterRoleBinding controller\n","stream":"stdout","time":"2021-07-26T08: 03:48.989452766Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting management.cattle.io/v3, Kind=Cluster controller\n","stream":"stdout","time":"2021-07-26T08:03:48.989567116Z "}
{"log":"2021/07/26 08:03:48 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=Role controller\n","stream":"stdout","time":"2021-07-26T08:03:48.98965181 5Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting /v1, Kind=ConfigMap controller\n","stream":"stdout","time":"2021-07-26T08:03:48.990981283Z"}
{"log":"2021/07/26 08:03:48 [INFO] Starting management.cattle.io/v3, Kind=Setting controller\n","stream":"stdout","time":"2021-07-26T08:03:48.991034813Z "}
{"log":"I0726 08:03:48.991314 9 leaderelection.go:243] attempting to acquire leader lease kube-system/cattle-controllers...\n","stream":"stderr"," time":"2021-07-26T08:03:48.991373172Z"}
{"log":"time=\"2021-07-26T08:03:48.995475412Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:03:48 http: TLS handshake error from 127.0.0.1:55808: EOF\"\n","stream":"stderr","time":"2021-07-26T08:03:48.995570592Z"}
{"log":"time=\"2021-07-26T08:03:48.995555062Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:03:48 http: TLS handshake error from 127.0.0.1:55804: EOF\"\n","stream":"stderr","time":"2021-07-26T08:03:48.995625112Z"}
{"log":"time=\"2021-07-26T08:03:48.995586162Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:03:48 http: TLS handshake error from 127.0.0.1:55806: EOF\"\n","stream":"stderr","time":"2021-07-26T08:03:48.995633062Z"}
{"log":"I0726 08:03:48.995745 9 leaderelection.go:253] successfully acquired lease kube-system/cattle-controllers\n","stream":"stderr","time":"202 1-07-26T08:03:48.995803541Z"}
{"log":"W0726 08:03:49.001868 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:49.001976047Z"}
{"log":"W0726 08:03:49.013800 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:49.013897308Z"}
{"log":"W0726 08:03:49.031351 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:49.031460625Z"}
{"log":"2021/07/26 08:03:49 [INFO] Running in single server mode, will not peer connections\n","stream":"stdout","time":"2021-07-26T08:03:49.036061675Z" }
{"log":"2021/07/26 08:03:49 [INFO] Steve auth startup complete\n","stream":"stdout","time":"2021-07-26T08:03:49.041282092Z"}
{"log":"W0726 08:03:49.046331 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:49.046414649Z"}
{"log":"W0726 08:03:49.049751 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:49.049827721Z"}
{"log":"W0726 08:03:49.061495 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:49.061581123Z"}
{"log":"W0726 08:03:49.062471 9 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:03:49.062554201Z"}
{"log":"I0726 08:03:49.144277 35 node.go:136] Successfully retrieved node IP: 172.17.0.2\n","stream":"stderr","time":"2021-07-26T08:03:49.144394054 Z"}
{"log":"I0726 08:03:49.144313 35 server_others.go:143] kube-proxy node IP is an IPv4 address (172.17.0.2), assume IPv4 operation\n","stream":"stder r","time":"2021-07-26T08:03:49.144417384Z"}
{"log":"I0726 08:03:49.144919 35 server_others.go:186] Using iptables Proxier.\n","stream":"stderr","time":"2021-07-26T08:03:49.144995832Z"}
{"log":"I0726 08:03:49.145116 35 server.go:650] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:03:49.145170432Z"}
{"log":"I0726 08:03:49.145457 35 conntrack.go:103] Set sysctl 'net/netfilter/nf_conntrack_max' to 196608\n","stream":"stderr","time":"2021-07-26T08 :03:49.145516271Z"}
{"log":"F0726 08:03:49.145481 35 server.go:495] open /proc/sys/net/netfilter/nf_conntrack_max: permission denied\n","stream":"stderr","time":"2021- 07-26T08:03:49.145525951Z"}
{"log":"W0726 08:03:49.161311 9 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ClusterRepo ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:03:49.161390394Z"}
{"log":"2021/07/26 08:03:49 [FATAL] k3s exited with: exit status 1\n","stream":"stdout","time":"2021-07-26T08:03:49.162350711Z"}
{"log":"2021/07/26 08:03:49 [INFO] Rancher version v2.5.9 (3c5418944) is starting\n","stream":"stdout","time":"2021-07-26T08:03:49.974069991Z"}
{"log":"2021/07/26 08:03:49 [INFO] Rancher arguments {ACMEDomains:[] AddLocal:true Embedded:false BindHost: HTTPListenPort:80 HTTPSListenPort:443 K8sMod e:auto Debug:false Trace:false NoCACerts:false AuditLogPath:/var/log/auditlog/rancher-api-audit.log AuditLogMaxage:10 AuditLogMaxsize:100 AuditLogMaxbac kup:10 AuditLevel:0 Agent:false Features: ClusterRegistry:}\n","stream":"stdout","time":"2021-07-26T08:03:49.974108611Z"}
{"log":"2021/07/26 08:03:49 [INFO] Listening on /tmp/log.sock\n","stream":"stdout","time":"2021-07-26T08:03:49.974117431Z"}
{"log":"2021/07/26 08:03:49 [INFO] Running etcd --data-dir=management-state/etcd --heartbeat-interval=500 --election-timeout=5000\n","stream":"stdout"," time":"2021-07-26T08:03:49.97434677Z"}
{"log":"2021-07-26 08:03:49.982914 W | pkg/flags: unrecognized environment variable ETCD_URL_arm64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-arm64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:03:49.983032069Z"}
{"log":"2021-07-26 08:03:49.982946 W | pkg/flags: unrecognized environment variable ETCD_URL_amd64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-amd64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:03:49.983049189Z"}
{"log":"2021-07-26 08:03:49.982951 W | pkg/flags: unrecognized environment variable ETCD_UNSUPPORTED_ARCH=amd64\n","stream":"stderr","time":"2021-07-26T 08:03:49.983054519Z"}
{"log":"2021-07-26 08:03:49.982955 W | pkg/flags: unrecognized environment variable ETCD_URL=ETCD_URL_amd64\n","stream":"stderr","time":"2021-07-26T08:0 3:49.983069319Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:03:49.983073089 Z"}
{"log":"2021-07-26 08:03:49.982979 I | etcdmain: etcd Version: 3.4.3\n","stream":"stderr","time":"2021-07-26T08:03:49.983076629Z"}
{"log":"2021-07-26 08:03:49.982982 I | etcdmain: Git SHA: 3cf2f69b5\n","stream":"stderr","time":"2021-07-26T08:03:49.983080069Z"}
{"log":"2021-07-26 08:03:49.982987 I | etcdmain: Go Version: go1.12.12\n","stream":"stderr","time":"2021-07-26T08:03:49.983084889Z"}
{"log":"2021-07-26 08:03:49.982990 I | etcdmain: Go OS/Arch: linux/amd64\n","stream":"stderr","time":"2021-07-26T08:03:49.983090089Z"}
{"log":"2021-07-26 08:03:49.982994 I | etcdmain: setting maximum number of CPUs to 6, total number of available CPUs is 6\n","stream":"stderr","time":"2 021-07-26T08:03:49.983096809Z"}
{"log":"2021-07-26 08:03:49.983041 N | etcdmain: the server is already initialized as member before, starting as etcd member...\n","stream":"stderr","ti me":"2021-07-26T08:03:49.983142729Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:03:49.983154259 Z"}
{"log":"2021-07-26 08:03:49.983402 I | embed: name = default\n","stream":"stderr","time":"2021-07-26T08:03:49.983484758Z"}
{"log":"2021-07-26 08:03:49.983414 I | embed: data dir = management-state/etcd\n","stream":"stderr","time":"2021-07-26T08:03:49.983509348Z"}
{"log":"2021-07-26 08:03:49.983418 I | embed: member dir = management-state/etcd/member\n","stream":"stderr","time":"2021-07-26T08:03:49.983511848Z"}
{"log":"2021-07-26 08:03:49.983422 I | embed: heartbeat = 500ms\n","stream":"stderr","time":"2021-07-26T08:03:49.983514368Z"}
{"log":"2021-07-26 08:03:49.983425 I | embed: election = 5000ms\n","stream":"stderr","time":"2021-07-26T08:03:49.983516328Z"}
{"log":"2021-07-26 08:03:49.983429 I | embed: snapshot count = 100000\n","stream":"stderr","time":"2021-07-26T08:03:49.983518008Z"}
{"log":"2021-07-26 08:03:49.983443 I | embed: advertise client URLs = http://localhost:2379\n","stream":"stderr","time":"2021-07-26T08:03:49.983519898Z" }
{"log":"2021-07-26 08:03:49.983454 I | embed: initial advertise peer URLs = http://localhost:2380\n","stream":"stderr","time":"2021-07-26T08:03:49.98352 1638Z"}
{"log":"2021-07-26 08:03:49.983459 I | embed: initial cluster = \n","stream":"stderr","time":"2021-07-26T08:03:49.983523538Z"}
{"log":"2021-07-26 08:03:49.990037 I | etcdserver: restarting member 8e9e05c52164694d in cluster cdf818194e3a8c32 at commit index 1250\n","stream":"stde rr","time":"2021-07-26T08:03:49.990117913Z"}
{"log":"raft2021/07/26 08:03:49 INFO: 8e9e05c52164694d switched to configuration voters=()\n","stream":"stderr","time":"2021-07-26T08:03:49.990351342Z"}
{"log":"raft2021/07/26 08:03:49 INFO: 8e9e05c52164694d became follower at term 38\n","stream":"stderr","time":"2021-07-26T08:03:49.990357272Z"}
{"log":"raft2021/07/26 08:03:49 INFO: newRaft 8e9e05c52164694d [peers: [], term: 38, commit: 1250, applied: 0, lastindex: 1250, lastterm: 38]\n","stream ":"stderr","time":"2021-07-26T08:03:49.990359312Z"}
{"log":"2021-07-26 08:03:49.994782 W | auth: simple token is not cryptographically signed\n","stream":"stderr","time":"2021-07-26T08:03:49.994869641Z"}
{"log":"2021-07-26 08:03:49.996496 I | etcdserver: starting server... [version: 3.4.3, cluster version: to_be_decided]\n","stream":"stderr","time":"2021 -07-26T08:03:49.996595116Z"}
{"log":"raft2021/07/26 08:03:49 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437)\n","stream":"stderr","time":"2021-07-26T0 8:03:49.997129816Z"}
{"log":"2021-07-26 08:03:49.997164 I | etcdserver/membership: added member 8e9e05c52164694d [http://localhost:2380] to cluster cdf818194e3a8c32\n","stre am":"stderr","time":"2021-07-26T08:03:49.997218916Z"}
{"log":"2021-07-26 08:03:49.997277 N | etcdserver/membership: set the initial cluster version to 3.4\n","stream":"stderr","time":"2021-07-26T08:03:49.99 7355345Z"}
{"log":"2021-07-26 08:03:49.997315 I | etcdserver/api: enabled capabilities for version 3.4\n","stream":"stderr","time":"2021-07-26T08:03:49.997374315Z" }
{"log":"2021-07-26 08:03:49.997926 I | embed: listening for peers on 127.0.0.1:2380\n","stream":"stderr","time":"2021-07-26T08:03:49.998003603Z"}
{"log":"raft2021/07/26 08:03:58 INFO: 8e9e05c52164694d is starting a new election at term 38\n","stream":"stderr","time":"2021-07-26T08:03:58.490995878Z "}
{"log":"raft2021/07/26 08:03:58 INFO: 8e9e05c52164694d became candidate at term 39\n","stream":"stderr","time":"2021-07-26T08:03:58.491033337Z"}
{"log":"raft2021/07/26 08:03:58 INFO: 8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 39\n","stream":"stderr","time":"2021-07-26T08: 03:58.491038147Z"}
{"log":"raft2021/07/26 08:03:58 INFO: 8e9e05c52164694d became leader at term 39\n","stream":"stderr","time":"2021-07-26T08:03:58.491041927Z"}
{"log":"raft2021/07/26 08:03:58 INFO: raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 39\n","stream":"stderr","time":"2021-07-26T08: 03:58.491045487Z"}
{"log":"2021-07-26 08:03:58.490967 I | etcdserver: published {Name:default ClientURLs:[http://localhost:2379]} to cluster cdf818194e3a8c32\n","stream":" stderr","time":"2021-07-26T08:03:58.491081647Z"}
{"log":"2021-07-26 08:03:58.490998 I | embed: ready to serve client requests\n","stream":"stderr","time":"2021-07-26T08:03:58.491105627Z"}
{"log":"2021-07-26 08:03:58.491696 N | embed: serving insecure client requests on 127.0.0.1:2379, this is strongly discouraged!\n","stream":"stderr","ti me":"2021-07-26T08:03:58.491814505Z"}
{"log":"2021/07/26 08:03:58 [INFO] Waiting for server to become available: Get \"https://127.0.0.1:6443/version?timeout=15m0s\": dial tcp 127.0.0.1:6443 : connect: connection refused\n","stream":"stdout","time":"2021-07-26T08:03:58.505192072Z"}
{"log":"time=\"2021-07-26T08:03:58.664994837Z\" level=info msg=\"Starting k3s v1.19.8+k3s1 (95fc76b2)\"\n","stream":"stderr","time":"2021-07-26T08:03:58 .665123226Z"}
{"log":"time=\"2021-07-26T08:03:58.665185186Z\" level=info msg=\"Cluster bootstrap already complete\"\n","stream":"stderr","time":"2021-07-26T08:03:58.6 65290906Z"}
{"log":"time=\"2021-07-26T08:03:58.673091736Z\" level=info msg=\"Running kube-apiserver --advertise-port=6443 --allow-privileged=true --anonymous-auth=f alse --api-audiences=unknown --authorization-mode=Node,RBAC --bind-address=127.0.0.1 --cert-dir=/var/lib/rancher/k3s/server/tls/temporary-certs --client -ca-file=/var/lib/rancher/k3s/server/tls/client-ca.crt --enable-admission-plugins=NodeRestriction --etcd-servers=http://localhost:2379 --insecure-port=0 --kubelet-certificate-authority=/var/lib/rancher/k3s/server/tls/server-ca.crt --kubelet-client-certificate=/var/lib/rancher/k3s/server/tls/client-kube- apiserver.crt --kubelet-client-key=/var/lib/rancher/k3s/server/tls/client-kube-apiserver.key --profiling=false --proxy-client-cert-file=/var/lib/rancher /k3s/server/tls/client-auth-proxy.crt --proxy-client-key-file=/var/lib/rancher/k3s/server/tls/client-auth-proxy.key --requestheader-allowed-names=system :auth-proxy --requestheader-client-ca-file=/var/lib/rancher/k3s/server/tls/request-header-ca.crt --requestheader-extra-headers-prefix=X-Remote-Extra- -- requestheader-group-headers=X-Remote-Group --requestheader-username-headers=X-Remote-User --secure-port=6444 --service-account-issuer=k3s --service-acco unt-key-file=/var/lib/rancher/k3s/server/tls/service.key --service-account-signing-key-file=/var/lib/rancher/k3s/server/tls/service.key --service-cluste r-ip-range=10.43.0.0/16 --storage-backend=etcd3 --tls-cert-file=/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.crt --tls-private-key-file=/var/l ib/rancher/k3s/server/tls/serving-kube-apiserver.key\"\n","stream":"stderr","time":"2021-07-26T08:03:58.673227246Z"}
{"log":"I0726 08:03:58.673766 33 server.go:652] external host was not specified, using 172.17.0.2\n","stream":"stderr","time":"2021-07-26T08:03:58. 673833194Z"}
{"log":"I0726 08:03:58.673917 33 server.go:177] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:03:58.673974554Z"}
{"log":"I0726 08:03:58.676885 33 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:03:58.676960707Z"}
{"log":"I0726 08:03:58.676895 33 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:03:58.676978017Z"}
{"log":"I0726 08:03:58.677426 33 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:03:58.677489186Z"}
{"log":"I0726 08:03:58.677436 33 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:03:58.677495736Z"}
{"log":"I0726 08:03:58.699102 33 master.go:271] Using reconciler: lease\n","stream":"stderr","time":"2021-07-26T08:03:58.699217073Z"}
{"log":"W0726 08:03:58.957958 33 genericapiserver.go:412] Skipping API batch/v2alpha1 because it has no resources.\n","stream":"stderr","time":"202 1-07-26T08:03:58.958099698Z"}
{"log":"W0726 08:03:58.974802 33 genericapiserver.go:412] Skipping API discovery.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr", "time":"2021-07-26T08:03:58.974885826Z"}
{"log":"W0726 08:03:58.992321 33 genericapiserver.go:412] Skipping API node.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr","time ":"2021-07-26T08:03:58.992404433Z"}
{"log":"W0726 08:03:59.006876 33 genericapiserver.go:412] Skipping API rbac.authorization.k8s.io/v1alpha1 because it has no resources.\n","stream": "stderr","time":"2021-07-26T08:03:59.006978876Z"}
{"log":"W0726 08:03:59.008983 33 genericapiserver.go:412] Skipping API scheduling.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr" ,"time":"2021-07-26T08:03:59.009046612Z"}
{"log":"W0726 08:03:59.017670 33 genericapiserver.go:412] Skipping API storage.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr","t ime":"2021-07-26T08:03:59.01775078Z"}
{"log":"W0726 08:03:59.029046 33 genericapiserver.go:412] Skipping API apps/v1beta2 because it has no resources.\n","stream":"stderr","time":"2021- 07-26T08:03:59.029135672Z"}
{"log":"W0726 08:03:59.029060 33 genericapiserver.go:412] Skipping API apps/v1beta1 because it has no resources.\n","stream":"stderr","time":"2021- 07-26T08:03:59.029143732Z"}
{"log":"I0726 08:03:59.035793 33 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:03:59.035865406Z"}
{"log":"I0726 08:03:59.035806 33 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:03:59.035874676Z"}
{"log":"time=\"2021-07-26T08:03:59.042212261Z\" level=info msg=\"Running kube-scheduler --address=127.0.0.1 --bind-address=127.0.0.1 --kubeconfig=/var/l ib/rancher/k3s/server/cred/scheduler.kubeconfig --port=10251 --profiling=false --secure-port=0\"\n","stream":"stderr","time":"2021-07-26T08:03:59.042357 36Z"}
{"log":"I0726 08:03:59.042514 33 registry.go:173] Registering SelectorSpread plugin\n","stream":"stderr","time":"2021-07-26T08:03:59.04261476Z"}
{"log":"I0726 08:03:59.042536 33 registry.go:173] Registering SelectorSpread plugin\n","stream":"stderr","time":"2021-07-26T08:03:59.04264198Z"}
{"log":"time=\"2021-07-26T08:03:59.042830339Z\" level=info msg=\"Running kube-controller-manager --address=127.0.0.1 --allocate-node-cidrs=true --bind-a ddress=127.0.0.1 --cluster-cidr=10.42.0.0/16 --cluster-signing-cert-file=/var/lib/rancher/k3s/server/tls/client-ca.crt --cluster-signing-key-file=/var/l ib/rancher/k3s/server/tls/client-ca.key --kubeconfig=/var/lib/rancher/k3s/server/cred/controller.kubeconfig --port=10252 --profiling=false --root-ca-fil e=/var/lib/rancher/k3s/server/tls/server-ca.crt --secure-port=0 --service-account-private-key-file=/var/lib/rancher/k3s/server/tls/service.key --use-ser vice-account-credentials=true\"\n","stream":"stderr","time":"2021-07-26T08:03:59.042918339Z"}
{"log":"time=\"2021-07-26T08:03:59.043951626Z\" level=info msg=\"Waiting for API server to become available\"\n","stream":"stderr","time":"2021-07-26T08 :03:59.044044476Z"}
{"log":"time=\"2021-07-26T08:03:59.044232795Z\" level=info msg=\"Node token is available at /var/lib/rancher/k3s/server/token\"\n","stream":"stderr","ti me":"2021-07-26T08:03:59.044324605Z"}
{"log":"time=\"2021-07-26T08:03:59.044262225Z\" level=info msg=\"To join node to cluster: k3s agent -s https://172.17.0.2:6443 -t ${NODE_TOKEN}\"\n","st ream":"stderr","time":"2021-07-26T08:03:59.044340465Z"}
{"log":"time=\"2021-07-26T08:03:59.045365713Z\" level=info msg=\"Wrote kubeconfig /etc/rancher/k3s/k3s.yaml\"\n","stream":"stderr","time":"2021-07-26T08 :03:59.045448213Z"}
{"log":"time=\"2021-07-26T08:03:59.045394433Z\" level=info msg=\"Run: k3s kubectl\"\n","stream":"stderr","time":"2021-07-26T08:03:59.045457353Z"}
{"log":"time=\"2021-07-26T08:03:59.045522123Z\" level=info msg=\"Module overlay was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:03:59.04 5595173Z"}
{"log":"time=\"2021-07-26T08:03:59.045546533Z\" level=info msg=\"Module nf_conntrack was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:03: 59.045602483Z"}
{"log":"time=\"2021-07-26T08:03:59.045561733Z\" level=info msg=\"Module br_netfilter was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:03: 59.045606472Z"}
{"log":"time=\"2021-07-26T08:03:59.045575543Z\" level=info msg=\"Module iptable_nat was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:03:5 9.045611632Z"}
{"log":"time=\"2021-07-26T08:03:59.061000375Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:03:59 http: TLS handshake error from 127.0.0.1:55968: remote error: tls: bad certificate\"\n","stream":"stderr","time":"2021-07-26T08:03:59.061195234Z"}
{"log":"time=\"2021-07-26T08:03:59.065623933Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:03:59 http: TLS handshake error from 127.0.0.1:55976: remote error: tls: bad certificate\"\n","stream":"stderr","time":"2021-07-26T08:03:59.065740023Z"}
{"log":"time=\"2021-07-26T08:03:59.076422886Z\" level=info msg=\"certificate CN=local-node signed by CN=k3s-server-ca@1627286228: notBefore=2021-07-26 0 7:57:08 +0000 UTC notAfter=2022-07-26 08:03:59 +0000 UTC\"\n","stream":"stderr","time":"2021-07-26T08:03:59.076561496Z"}
{"log":"time=\"2021-07-26T08:03:59.078455351Z\" level=info msg=\"certificate CN=system:node:local-node,O=system:nodes signed by CN=k3s-client-ca@1627286 228: notBefore=2021-07-26 07:57:08 +0000 UTC notAfter=2022-07-26 08:03:59 +0000 UTC\"\n","stream":"stderr","time":"2021-07-26T08:03:59.078546171Z"}
{"log":"time=\"2021-07-26T08:03:59.081726923Z\" level=info msg=\"Logging containerd to /var/lib/rancher/k3s/agent/containerd/containerd.log\"\n","stream ":"stderr","time":"2021-07-26T08:03:59.081806113Z"}
{"log":"time=\"2021-07-26T08:03:59.081849473Z\" level=info msg=\"Running containerd -c /var/lib/rancher/k3s/agent/etc/containerd/config.toml -a /run/k3s /containerd/containerd.sock --state /run/k3s/containerd --root /var/lib/rancher/k3s/agent/containerd\"\n","stream":"stderr","time":"2021-07-26T08:03:59. 081919943Z"}
{"log":"time=\"2021-07-26T08:04:00.083777900Z\" level=info msg=\"Containerd is now running\"\n","stream":"stderr","time":"2021-07-26T08:04:00.083911409Z "}
{"log":"time=\"2021-07-26T08:04:00.090161644Z\" level=info msg=\"Connecting to proxy\" url=\"wss://127.0.0.1:6443/v1-k3s/connect\"\n","stream":"stderr", "time":"2021-07-26T08:04:00.090290674Z"}
{"log":"time=\"2021-07-26T08:04:00.092226518Z\" level=info msg=\"Handling backend connection request [local-node]\"\n","stream":"stderr","time":"2021-07 -26T08:04:00.092318178Z"}
{"log":"time=\"2021-07-26T08:04:00.092661877Z\" level=warning msg=\"Disabling CPU quotas due to missing cpu.cfs_period_us\"\n","stream":"stderr","time": "2021-07-26T08:04:00.092729197Z"}
{"log":"time=\"2021-07-26T08:04:00.092729327Z\" level=info msg=\"Running kubelet --address=0.0.0.0 --anonymous-auth=false --authentication-token-webhook =true --authorization-mode=Webhook --cgroup-driver=cgroupfs --client-ca-file=/var/lib/rancher/k3s/agent/client-ca.crt --cloud-provider=external --cluste r-dns=10.43.0.10 --cluster-domain=cluster.local --cni-bin-dir=/var/lib/rancher/k3s/data/ab1b521f47b3cbc273e0c667521084cff1ea3540d55b425ac7ed30c27daf92f8 /bin --cni-conf-dir=/var/lib/rancher/k3s/agent/etc/cni/net.d --container-runtime-endpoint=/run/k3s/containerd/containerd.sock --container-runtime=remote --containerd=/run/k3s/containerd/containerd.sock --cpu-cfs-quota=false --eviction-hard=imagefs.available\u003c5%,nodefs.available\u003c5% --eviction-mi nimum-reclaim=imagefs.available=10%,nodefs.available=10% --fail-swap-on=false --healthz-bind-address=127.0.0.1 --hostname-override=local-node --kubeconf ig=/var/lib/rancher/k3s/agent/kubelet.kubeconfig --kubelet-cgroups=/k3s --node-labels= --pod-manifest-path=/var/lib/rancher/k3s/agent/pod-manifests --re ad-only-port=0 --resolv-conf=/etc/resolv.conf --runtime-cgroups=/k3s --serialize-image-pulls=false --tls-cert-file=/var/lib/rancher/k3s/agent/serving-ku belet.crt --tls-private-key-file=/var/lib/rancher/k3s/agent/serving-kubelet.key\"\n","stream":"stderr","time":"2021-07-26T08:04:00.092833217Z"}
{"log":"time=\"2021-07-26T08:04:00.093372655Z\" level=info msg=\"Running kube-proxy --cluster-cidr=10.42.0.0/16 --healthz-bind-address=127.0.0.1 --hostn ame-override=local-node --kubeconfig=/var/lib/rancher/k3s/agent/kubeproxy.kubeconfig --proxy-mode=iptables\"\n","stream":"stderr","time":"2021-07-26T08: 04:00.093446505Z"}
{"log":"Flag --cloud-provider has been deprecated, will be removed in 1.23, in favor of removing cloud provider code from Kubelet.\n","stream":"stderr", "time":"2021-07-26T08:04:00.093566255Z"}
{"log":"Flag --containerd has been deprecated, This is a cadvisor flag that was mistakenly registered with the Kubelet. Due to legacy concerns, it will follow the standard CLI deprecation timeline before being removed.\n","stream":"stderr","time":"2021-07-26T08:04:00.093632285Z"}
{"log":"W0726 08:04:00.093682 33 server.go:226] WARNING: all flags other than --config, --write-config-to, and --cleanup are deprecated. Please beg in using a config file ASAP.\n","stream":"stderr","time":"2021-07-26T08:04:00.093733315Z"}
{"log":"W0726 08:04:00.094101 33 proxier.go:639] Failed to read file /lib/modules/4.15.0-151-generic/modules.builtin with error open /lib/modules/4 .15.0-151-generic/modules.builtin: no such file or directory. You can ignore this message when kube-proxy is running inside container without mounting / lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:00.094150964Z"}
{"log":"I0726 08:04:00.094280 33 server.go:407] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:00.094339664Z"}
{"log":"W0726 08:04:00.094532 33 proxier.go:649] Failed to load kernel module ip_vs with modprobe. You can ignore this message when kube-proxy is r unning inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:00.094564833Z"}
{"log":"W0726 08:04:00.094824 33 proxier.go:649] Failed to load kernel module ip_vs_rr with modprobe. You can ignore this message when kube-proxy i s running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:00.094853853Z"}
{"log":"W0726 08:04:00.096595 33 proxier.go:649] Failed to load kernel module ip_vs_wrr with modprobe. You can ignore this message when kube-proxy is running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:00.096683328Z"}
{"log":"W0726 08:04:00.096871 33 proxier.go:649] Failed to load kernel module ip_vs_sh with modprobe. You can ignore this message when kube-proxy i s running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:00.096913247Z"}
{"log":"W0726 08:04:00.097147 33 proxier.go:649] Failed to load kernel module nf_conntrack_ipv4 with modprobe. You can ignore this message when kub e-proxy is running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:00.097187486Z"}
{"log":"time=\"2021-07-26T08:04:00.101333546Z\" level=info msg=\"Waiting for node local-node CIDR not assigned yet\"\n","stream":"stderr","time":"2021-0 7-26T08:04:00.101473386Z"}
{"log":"E0726 08:04:00.102005 33 node.go:125] Failed to retrieve node info: nodes \"local-node\" is forbidden: User \"system:kube-proxy\" cannot ge t resource \"nodes\" in API group \"\" at the cluster scope\n","stream":"stderr","time":"2021-07-26T08:04:00.102082395Z"}
{"log":"I0726 08:04:00.117761 33 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/agent/client-ca.crt\n","stream":"st derr","time":"2021-07-26T08:04:00.117876296Z"}
{"log":"I0726 08:04:00.289786 33 dynamic_cafile_content.go:167] Starting request-header::/var/lib/rancher/k3s/server/tls/request-header-ca.crt\n"," stream":"stderr","time":"2021-07-26T08:04:00.289932461Z"}
{"log":"I0726 08:04:00.289806 33 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/server/tls/client-ca.crt\n","stream ":"stderr","time":"2021-07-26T08:04:00.289959541Z"}
{"log":"I0726 08:04:00.290029 33 dynamic_serving_content.go:130] Starting serving-cert::/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.crt: :/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.key\n","stream":"stderr","time":"2021-07-26T08:04:00.290103941Z"}
{"log":"I0726 08:04:00.290228 33 secure_serving.go:197] Serving securely on 127.0.0.1:6444\n","stream":"stderr","time":"2021-07-26T08:04:00.2902888 11Z"}
{"log":"I0726 08:04:00.290259 33 tlsconfig.go:240] Starting DynamicServingCertificateController\n","stream":"stderr","time":"2021-07-26T08:04:00.29 0296901Z"}
{"log":"I0726 08:04:00.290322 33 autoregister_controller.go:141] Starting autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04:00. 29035764Z"}
{"log":"I0726 08:04:00.290337 33 cache.go:32] Waiting for caches to sync for autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04: 00.29036359Z"}
{"log":"I0726 08:04:00.290392 33 customresource_discovery_controller.go:209] Starting DiscoveryController\n","stream":"stderr","time":"2021-07-26T0 8:04:00.29041165Z"}
{"log":"I0726 08:04:00.290455 33 controller.go:83] Starting OpenAPI AggregationController\n","stream":"stderr","time":"2021-07-26T08:04:00.29047785 Z"}
{"log":"I0726 08:04:00.290512 33 controller.go:86] Starting OpenAPI controller\n","stream":"stderr","time":"2021-07-26T08:04:00.29052789Z"}
{"log":"I0726 08:04:00.290550 33 naming_controller.go:291] Starting NamingConditionController\n","stream":"stderr","time":"2021-07-26T08:04:00.2905 7681Z"}
{"log":"I0726 08:04:00.290602 33 establishing_controller.go:76] Starting EstablishingController\n","stream":"stderr","time":"2021-07-26T08:04:00.29 061816Z"}
{"log":"I0726 08:04:00.290658 33 nonstructuralschema_controller.go:186] Starting NonStructuralSchemaConditionController\n","stream":"stderr","time" :"2021-07-26T08:04:00.29067828Z"}
{"log":"I0726 08:04:00.290703 33 apiapproval_controller.go:186] Starting KubernetesAPIApprovalPolicyConformantConditionController\n","stream":"stde rr","time":"2021-07-26T08:04:00.290727379Z"}
{"log":"I0726 08:04:00.290749 33 crd_finalizer.go:266] Starting CRDFinalizer\n","stream":"stderr","time":"2021-07-26T08:04:00.290766699Z"}
{"log":"I0726 08:04:00.290796 33 dynamic_serving_content.go:130] Starting aggregator-proxy-cert::/var/lib/rancher/k3s/server/tls/client-auth-proxy. crt::/var/lib/rancher/k3s/server/tls/client-auth-proxy.key\n","stream":"stderr","time":"2021-07-26T08:04:00.290814669Z"}
{"log":"I0726 08:04:00.290940 33 cluster_authentication_trust_controller.go:440] Starting cluster_authentication_trust_controller controller\n","st ream":"stderr","time":"2021-07-26T08:04:00.290973659Z"}
{"log":"I0726 08:04:00.290953 33 shared_informer.go:240] Waiting for caches to sync for cluster_authentication_trust_controller\n","stream":"stderr ","time":"2021-07-26T08:04:00.290979819Z"}
{"log":"I0726 08:04:00.290985 33 apiservice_controller.go:97] Starting APIServiceRegistrationController\n","stream":"stderr","time":"2021-07-26T08: 04:00.291004759Z"}
{"log":"I0726 08:04:00.290990 33 cache.go:32] Waiting for caches to sync for APIServiceRegistrationController controller\n","stream":"stderr","time ":"2021-07-26T08:04:00.291009659Z"}
{"log":"I0726 08:04:00.291010 33 available_controller.go:475] Starting AvailableConditionController\n","stream":"stderr","time":"2021-07-26T08:04:0 0.291028239Z"}
{"log":"I0726 08:04:00.291015 33 cache.go:32] Waiting for caches to sync for AvailableConditionController controller\n","stream":"stderr","time":"2 021-07-26T08:04:00.291032169Z"}
{"log":"I0726 08:04:00.291036 33 crdregistration_controller.go:111] Starting crd-autoregister controller\n","stream":"stderr","time":"2021-07-26T08 :04:00.291052329Z"}
{"log":"I0726 08:04:00.291040 33 shared_informer.go:240] Waiting for caches to sync for crd-autoregister\n","stream":"stderr","time":"2021-07-26T08 :04:00.291056459Z"}
{"log":"I0726 08:04:00.291070 33 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/server/tls/client-ca.crt\n","stream ":"stderr","time":"2021-07-26T08:04:00.291089618Z"}
{"log":"I0726 08:04:00.291096 33 dynamic_cafile_content.go:167] Starting request-header::/var/lib/rancher/k3s/server/tls/request-header-ca.crt\n"," stream":"stderr","time":"2021-07-26T08:04:00.291121188Z"}
{"log":"time=\"2021-07-26T08:04:00.301676822Z\" level=info msg=\"Running cloud-controller-manager --allocate-node-cidrs=true --allow-untagged-cloud=true --bind-address=127.0.0.1 --cloud-provider=k3s --cluster-cidr=10.42.0.0/16 --kubeconfig=/var/lib/rancher/k3s/server/cred/cloud-controller.kubeconfig --n ode-status-update-frequency=1m --profiling=false --secure-port=0\"\n","stream":"stderr","time":"2021-07-26T08:04:00.301794292Z"}
{"log":"Flag --allow-untagged-cloud has been deprecated, This flag is deprecated and will be removed in a future release. A cluster-id will be required on cloud instances.\n","stream":"stderr","time":"2021-07-26T08:04:00.301811972Z"}
{"log":"I0726 08:04:00.306755 33 controllermanager.go:127] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:00.30682975Z"}
{"log":"W0726 08:04:00.306784 33 controllermanager.go:139] detected a cluster without a ClusterID. A ClusterID will be required in the future. Pl ease tag your cluster to avoid any future issues\n","stream":"stderr","time":"2021-07-26T08:04:00.3068398Z"}
{"log":"I0726 08:04:00.306809 33 leaderelection.go:243] attempting to acquire leader lease kube-system/cloud-controller-manager...\n","stream":"st derr","time":"2021-07-26T08:04:00.30684196Z"}
{"log":"E0726 08:04:00.327143 33 controller.go:156] Unable to remove old endpoints from kubernetes service: no master IPs were listed in storage, r efusing to erase all endpoints for the kubernetes service\n","stream":"stderr","time":"2021-07-26T08:04:00.32726369Z"}
{"log":"I0726 08:04:00.390529 33 cache.go:39] Caches are synced for autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04:00.390691 814Z"}
{"log":"I0726 08:04:00.391293 33 shared_informer.go:247] Caches are synced for crd-autoregister \n","stream":"stderr","time":"2021-07-26T08:04:00.3 91391892Z"}
{"log":"I0726 08:04:00.391477 33 cache.go:39] Caches are synced for APIServiceRegistrationController controller\n","stream":"stderr","time":"2021-0 7-26T08:04:00.391559661Z"}
{"log":"I0726 08:04:00.391552 33 shared_informer.go:247] Caches are synced for cluster_authentication_trust_controller \n","stream":"stderr","time" :"2021-07-26T08:04:00.391591731Z"}
{"log":"I0726 08:04:00.391718 33 cache.go:39] Caches are synced for AvailableConditionController controller\n","stream":"stderr","time":"2021-07-26 T08:04:00.391780321Z"}
{"log":"W0726 08:04:00.527035 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:00.527153688Z"}
{"log":"W0726 08:04:00.545550 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:00.545672731Z"}
{"log":"W0726 08:04:00.557023 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:00.557133963Z"}
{"log":"W0726 08:04:00.597937 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:00.598041902Z"}
{"log":"W0726 08:04:00.609401 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:00.609477974Z"}
{"log":"2021/07/26 08:04:00 [INFO] Starting API controllers\n","stream":"stdout","time":"2021-07-26T08:04:00.889052616Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting management.cattle.io/v3, Kind=GroupMember controller\n","stream":"stdout","time":"2021-07-26T08:04:01.111823 926Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting management.cattle.io/v3, Kind=UserAttribute controller\n","stream":"stdout","time":"2021-07-26T08:04:01.1119 06306Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting management.cattle.io/v3, Kind=Group controller\n","stream":"stdout","time":"2021-07-26T08:04:01.111986715Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting /v1, Kind=Secret controller\n","stream":"stdout","time":"2021-07-26T08:04:01.111994165Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting management.cattle.io/v3, Kind=Token controller\n","stream":"stdout","time":"2021-07-26T08:04:01.112092075Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting management.cattle.io/v3, Kind=User controller\n","stream":"stdout","time":"2021-07-26T08:04:01.113026873Z"}
{"log":"W0726 08:04:01.129542 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:01.129656402Z"}
{"log":"W0726 08:04:01.135495 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:01.135587098Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting management.cattle.io/v3, Kind=Feature controller\n","stream":"stdout","time":"2021-07-26T08:04:01.235494261Z "}
{"log":"2021/07/26 08:04:01 [INFO] Starting apiregistration.k8s.io/v1, Kind=APIService controller\n","stream":"stdout","time":"2021-07-26T08:04:01.23554 476Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=RoleBinding controller\n","stream":"stdout","time":"2021-07-26T08:04:01.2 3568595Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting apiextensions.k8s.io/v1beta1, Kind=CustomResourceDefinition controller\n","stream":"stdout","time":"2021-07- 26T08:04:01.23571399Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=Role controller\n","stream":"stdout","time":"2021-07-26T08:04:01.2357934Z "}
{"log":"2021/07/26 08:04:01 [INFO] Starting management.cattle.io/v3, Kind=Cluster controller\n","stream":"stdout","time":"2021-07-26T08:04:01.235949659Z "}
{"log":"2021/07/26 08:04:01 [INFO] Starting /v1, Kind=Secret controller\n","stream":"stdout","time":"2021-07-26T08:04:01.235996689Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=ClusterRoleBinding controller\n","stream":"stdout","time":"2021-07-26T08: 04:01.236138309Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting /v1, Kind=ConfigMap controller\n","stream":"stdout","time":"2021-07-26T08:04:01.236879707Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting management.cattle.io/v3, Kind=Setting controller\n","stream":"stdout","time":"2021-07-26T08:04:01.236981997Z "}
{"log":"2021/07/26 08:04:01 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=ClusterRole controller\n","stream":"stdout","time":"2021-07-26T08:04:01.2 39937369Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting catalog.cattle.io/v1, Kind=ClusterRepo controller\n","stream":"stdout","time":"2021-07-26T08:04:01.241958535 Z"}
{"log":"2021/07/26 08:04:01 [INFO] Starting management.cattle.io/v3, Kind=Preference controller\n","stream":"stdout","time":"2021-07-26T08:04:01.2431565 72Z"}
{"log":"time=\"2021-07-26T08:04:01.243376131Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:01 http: TLS handshake error from 127.0.0.1:56224: EOF\"\n","stream":"stderr","time":"2021-07-26T08:04:01.243478741Z"}
{"log":"time=\"2021-07-26T08:04:01.243497921Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:01 http: TLS handshake error from 127.0.0.1:56220: EOF\"\n","stream":"stderr","time":"2021-07-26T08:04:01.243543961Z"}
{"log":"time=\"2021-07-26T08:04:01.243561231Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:01 http: TLS handshake error from 127.0.0.1:56222: EOF\"\n","stream":"stderr","time":"2021-07-26T08:04:01.24360295Z"}
{"log":"I0726 08:04:01.246096 8 leaderelection.go:243] attempting to acquire leader lease kube-system/cattle-controllers...\n","stream":"stderr"," time":"2021-07-26T08:04:01.246183044Z"}
{"log":"W0726 08:04:01.256103 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:01.256214879Z"}
{"log":"I0726 08:04:01.259245 8 leaderelection.go:253] successfully acquired lease kube-system/cattle-controllers\n","stream":"stderr","time":"202 1-07-26T08:04:01.259351441Z"}
{"log":"W0726 08:04:01.269923 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:01.270024815Z"}
{"log":"I0726 08:04:01.275879 33 node.go:136] Successfully retrieved node IP: 172.17.0.2\n","stream":"stderr","time":"2021-07-26T08:04:01.276002441 Z"}
{"log":"I0726 08:04:01.275915 33 server_others.go:143] kube-proxy node IP is an IPv4 address (172.17.0.2), assume IPv4 operation\n","stream":"stder r","time":"2021-07-26T08:04:01.276032991Z"}
{"log":"I0726 08:04:01.276543 33 server_others.go:186] Using iptables Proxier.\n","stream":"stderr","time":"2021-07-26T08:04:01.276617549Z"}
{"log":"I0726 08:04:01.276747 33 server.go:650] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:01.276819949Z"}
{"log":"I0726 08:04:01.277069 33 conntrack.go:103] Set sysctl 'net/netfilter/nf_conntrack_max' to 196608\n","stream":"stderr","time":"2021-07-26T08 :04:01.277135148Z"}
{"log":"F0726 08:04:01.277093 33 server.go:495] open /proc/sys/net/netfilter/nf_conntrack_max: permission denied\n","stream":"stderr","time":"2021- 07-26T08:04:01.277148608Z"}
{"log":"W0726 08:04:01.292758 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Feature ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wa tch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.292835609Z"}
{"log":"W0726 08:04:01.292785 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.Role ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.292957429Z"}
{"log":"W0726 08:04:01.292902 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ClusterRoleBinding ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.292979188Z"}
{"log":"W0726 08:04:01.292946 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ClusterRole ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293034118Z"}
{"log":"W0726 08:04:01.292966 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Setting ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wa tch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293042098Z"}
{"log":"W0726 08:04:01.292826 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.RoleBinding ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293046678Z"}
{"log":"W0726 08:04:01.293070 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.User ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293135118Z"}
{"log":"W0726 08:04:01.293081 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Token ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watc h lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293145858Z"}
{"log":"W0726 08:04:01.293247 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1beta1.CustomResourceDefinition ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexp ected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293325298Z"}
{"log":"W0726 08:04:01.293260 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Group ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watc h lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293354357Z"}
{"log":"W0726 08:04:01.293291 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.GroupMember ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293359157Z"}
{"log":"2021/07/26 08:04:01 [ERROR] failed to call leader func: failed to add authconfig data: Post \"https://127.0.0.1:6443/apis/management.cattle.io/v 3/authconfigs\": EOF\n","stream":"stdout","time":"2021-07-26T08:04:01.293378307Z"}
{"log":"W0726 08:04:01.293312 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.UserAttribute ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch clos e - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293398057Z"}
{"log":"W0726 08:04:01.293327 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.Secret ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wat ch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293402927Z"}
{"log":"W0726 08:04:01.293343 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Preference ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293407217Z"}
{"log":"W0726 08:04:01.293341 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.Secret ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wat ch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293415077Z"}
{"log":"W0726 08:04:01.293455 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Cluster ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wa tch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293492947Z"}
{"log":"W0726 08:04:01.293564 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.APIService ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293610127Z"}
{"log":"W0726 08:04:01.293581 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ClusterRepo ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:01.293637367Z"}
{"log":"2021/07/26 08:04:01 [FATAL] k3s exited with: exit status 1\n","stream":"stdout","time":"2021-07-26T08:04:01.293727506Z"}
{"log":"2021/07/26 08:04:01 [INFO] Rancher version v2.5.9 (3c5418944) is starting\n","stream":"stdout","time":"2021-07-26T08:04:01.9565208Z"}
{"log":"2021/07/26 08:04:01 [INFO] Rancher arguments {ACMEDomains:[] AddLocal:true Embedded:false BindHost: HTTPListenPort:80 HTTPSListenPort:443 K8sMod e:auto Debug:false Trace:false NoCACerts:false AuditLogPath:/var/log/auditlog/rancher-api-audit.log AuditLogMaxage:10 AuditLogMaxsize:100 AuditLogMaxbac kup:10 AuditLevel:0 Agent:false Features: ClusterRegistry:}\n","stream":"stdout","time":"2021-07-26T08:04:01.95655205Z"}
{"log":"2021/07/26 08:04:01 [INFO] Listening on /tmp/log.sock\n","stream":"stdout","time":"2021-07-26T08:04:01.95656369Z"}
{"log":"2021/07/26 08:04:01 [INFO] Running etcd --data-dir=management-state/etcd --heartbeat-interval=500 --election-timeout=5000\n","stream":"stdout"," time":"2021-07-26T08:04:01.9567682Z"}
{"log":"2021-07-26 08:04:01.963210 W | pkg/flags: unrecognized environment variable ETCD_URL_arm64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-arm64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:04:01.963318723Z"}
{"log":"2021-07-26 08:04:01.963229 W | pkg/flags: unrecognized environment variable ETCD_URL_amd64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-amd64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:04:01.963343353Z"}
{"log":"2021-07-26 08:04:01.963231 W | pkg/flags: unrecognized environment variable ETCD_UNSUPPORTED_ARCH=amd64\n","stream":"stderr","time":"2021-07-26T 08:04:01.963346383Z"}
{"log":"2021-07-26 08:04:01.963234 W | pkg/flags: unrecognized environment variable ETCD_URL=ETCD_URL_amd64\n","stream":"stderr","time":"2021-07-26T08:0 4:01.963348753Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:04:01.963351073 Z"}
{"log":"2021-07-26 08:04:01.963250 I | etcdmain: etcd Version: 3.4.3\n","stream":"stderr","time":"2021-07-26T08:04:01.963354173Z"}
{"log":"2021-07-26 08:04:01.963252 I | etcdmain: Git SHA: 3cf2f69b5\n","stream":"stderr","time":"2021-07-26T08:04:01.963357773Z"}
{"log":"2021-07-26 08:04:01.963254 I | etcdmain: Go Version: go1.12.12\n","stream":"stderr","time":"2021-07-26T08:04:01.963361003Z"}
{"log":"2021-07-26 08:04:01.963256 I | etcdmain: Go OS/Arch: linux/amd64\n","stream":"stderr","time":"2021-07-26T08:04:01.963364143Z"}
{"log":"2021-07-26 08:04:01.963258 I | etcdmain: setting maximum number of CPUs to 6, total number of available CPUs is 6\n","stream":"stderr","time":"2 021-07-26T08:04:01.963366913Z"}
{"log":"2021-07-26 08:04:01.963289 N | etcdmain: the server is already initialized as member before, starting as etcd member...\n","stream":"stderr","ti me":"2021-07-26T08:04:01.963369243Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:04:01.963371403 Z"}
{"log":"2021-07-26 08:04:01.963496 I | embed: name = default\n","stream":"stderr","time":"2021-07-26T08:04:01.963564603Z"}
{"log":"2021-07-26 08:04:01.963504 I | embed: data dir = management-state/etcd\n","stream":"stderr","time":"2021-07-26T08:04:01.963579013Z"}
{"log":"2021-07-26 08:04:01.963506 I | embed: member dir = management-state/etcd/member\n","stream":"stderr","time":"2021-07-26T08:04:01.963584503Z"}
{"log":"2021-07-26 08:04:01.963508 I | embed: heartbeat = 500ms\n","stream":"stderr","time":"2021-07-26T08:04:01.963588963Z"}
{"log":"2021-07-26 08:04:01.963510 I | embed: election = 5000ms\n","stream":"stderr","time":"2021-07-26T08:04:01.963593353Z"}
{"log":"2021-07-26 08:04:01.963512 I | embed: snapshot count = 100000\n","stream":"stderr","time":"2021-07-26T08:04:01.963597653Z"}
{"log":"2021-07-26 08:04:01.963516 I | embed: advertise client URLs = http://localhost:2379\n","stream":"stderr","time":"2021-07-26T08:04:01.963601923Z" }
{"log":"2021-07-26 08:04:01.963518 I | embed: initial advertise peer URLs = http://localhost:2380\n","stream":"stderr","time":"2021-07-26T08:04:01.96360 6223Z"}
{"log":"2021-07-26 08:04:01.963521 I | embed: initial cluster = \n","stream":"stderr","time":"2021-07-26T08:04:01.963621103Z"}
{"log":"2021-07-26 08:04:01.967504 I | etcdserver: restarting member 8e9e05c52164694d in cluster cdf818194e3a8c32 at commit index 1268\n","stream":"stde rr","time":"2021-07-26T08:04:01.967579033Z"}
{"log":"raft2021/07/26 08:04:01 INFO: 8e9e05c52164694d switched to configuration voters=()\n","stream":"stderr","time":"2021-07-26T08:04:01.967631143Z"}
{"log":"raft2021/07/26 08:04:01 INFO: 8e9e05c52164694d became follower at term 39\n","stream":"stderr","time":"2021-07-26T08:04:01.967669633Z"}
{"log":"raft2021/07/26 08:04:01 INFO: newRaft 8e9e05c52164694d [peers: [], term: 39, commit: 1268, applied: 0, lastindex: 1268, lastterm: 39]\n","stream ":"stderr","time":"2021-07-26T08:04:01.967676323Z"}
{"log":"2021-07-26 08:04:01.972542 W | auth: simple token is not cryptographically signed\n","stream":"stderr","time":"2021-07-26T08:04:01.97260017Z"}
{"log":"2021-07-26 08:04:01.974316 I | etcdserver: starting server... [version: 3.4.3, cluster version: to_be_decided]\n","stream":"stderr","time":"2021 -07-26T08:04:01.974363945Z"}
{"log":"raft2021/07/26 08:04:01 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437)\n","stream":"stderr","time":"2021-07-26T0 8:04:01.974593035Z"}
{"log":"2021-07-26 08:04:01.974824 I | etcdserver/membership: added member 8e9e05c52164694d [http://localhost:2380] to cluster cdf818194e3a8c32\n","stre am":"stderr","time":"2021-07-26T08:04:01.974887754Z"}
{"log":"2021-07-26 08:04:01.974886 I | etcdserver: 8e9e05c52164694d as single-node; fast-forwarding 9 ticks (election ticks 10)\n","stream":"stderr","ti me":"2021-07-26T08:04:01.974933114Z"}
{"log":"2021-07-26 08:04:01.974907 N | etcdserver/membership: set the initial cluster version to 3.4\n","stream":"stderr","time":"2021-07-26T08:04:01.97 4942875Z"}
{"log":"2021-07-26 08:04:01.974936 I | etcdserver/api: enabled capabilities for version 3.4\n","stream":"stderr","time":"2021-07-26T08:04:01.974992085Z" }
{"log":"2021-07-26 08:04:01.977200 I | embed: listening for peers on 127.0.0.1:2380\n","stream":"stderr","time":"2021-07-26T08:04:01.977271578Z"}
{"log":"raft2021/07/26 08:04:06 INFO: 8e9e05c52164694d is starting a new election at term 39\n","stream":"stderr","time":"2021-07-26T08:04:06.468128007Z "}
{"log":"raft2021/07/26 08:04:06 INFO: 8e9e05c52164694d became candidate at term 40\n","stream":"stderr","time":"2021-07-26T08:04:06.468153597Z"}
{"log":"raft2021/07/26 08:04:06 INFO: 8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 40\n","stream":"stderr","time":"2021-07-26T08: 04:06.468158487Z"}
{"log":"raft2021/07/26 08:04:06 INFO: 8e9e05c52164694d became leader at term 40\n","stream":"stderr","time":"2021-07-26T08:04:06.468162267Z"}
{"log":"raft2021/07/26 08:04:06 INFO: raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 40\n","stream":"stderr","time":"2021-07-26T08: 04:06.468165877Z"}
{"log":"2021-07-26 08:04:06.472842 I | etcdserver: published {Name:default ClientURLs:[http://localhost:2379]} to cluster cdf818194e3a8c32\n","stream":" stderr","time":"2021-07-26T08:04:06.472948855Z"}
{"log":"2021-07-26 08:04:06.472871 I | embed: ready to serve client requests\n","stream":"stderr","time":"2021-07-26T08:04:06.472982764Z"}
{"log":"2021-07-26 08:04:06.473499 N | embed: serving insecure client requests on 127.0.0.1:2379, this is strongly discouraged!\n","stream":"stderr","ti me":"2021-07-26T08:04:06.473597873Z"}
{"log":"2021/07/26 08:04:06 [INFO] Waiting for server to become available: Get \"https://127.0.0.1:6443/version?timeout=15m0s\": dial tcp 127.0.0.1:6443 : connect: connection refused\n","stream":"stdout","time":"2021-07-26T08:04:06.487200259Z"}
{"log":"time=\"2021-07-26T08:04:06.646021016Z\" level=info msg=\"Starting k3s v1.19.8+k3s1 (95fc76b2)\"\n","stream":"stderr","time":"2021-07-26T08:04:06 .646179896Z"}
{"log":"time=\"2021-07-26T08:04:06.646225635Z\" level=info msg=\"Cluster bootstrap already complete\"\n","stream":"stderr","time":"2021-07-26T08:04:06.6 46316595Z"}
{"log":"time=\"2021-07-26T08:04:06.661474088Z\" level=info msg=\"Running kube-apiserver --advertise-port=6443 --allow-privileged=true --anonymous-auth=f alse --api-audiences=unknown --authorization-mode=Node,RBAC --bind-address=127.0.0.1 --cert-dir=/var/lib/rancher/k3s/server/tls/temporary-certs --client -ca-file=/var/lib/rancher/k3s/server/tls/client-ca.crt --enable-admission-plugins=NodeRestriction --etcd-servers=http://localhost:2379 --insecure-port=0 --kubelet-certificate-authority=/var/lib/rancher/k3s/server/tls/server-ca.crt --kubelet-client-certificate=/var/lib/rancher/k3s/server/tls/client-kube- apiserver.crt --kubelet-client-key=/var/lib/rancher/k3s/server/tls/client-kube-apiserver.key --profiling=false --proxy-client-cert-file=/var/lib/rancher /k3s/server/tls/client-auth-proxy.crt --proxy-client-key-file=/var/lib/rancher/k3s/server/tls/client-auth-proxy.key --requestheader-allowed-names=system :auth-proxy --requestheader-client-ca-file=/var/lib/rancher/k3s/server/tls/request-header-ca.crt --requestheader-extra-headers-prefix=X-Remote-Extra- -- requestheader-group-headers=X-Remote-Group --requestheader-username-headers=X-Remote-User --secure-port=6444 --service-account-issuer=k3s --service-acco unt-key-file=/var/lib/rancher/k3s/server/tls/service.key --service-account-signing-key-file=/var/lib/rancher/k3s/server/tls/service.key --service-cluste r-ip-range=10.43.0.0/16 --storage-backend=etcd3 --tls-cert-file=/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.crt --tls-private-key-file=/var/l ib/rancher/k3s/server/tls/serving-kube-apiserver.key\"\n","stream":"stderr","time":"2021-07-26T08:04:06.661619657Z"}
{"log":"I0726 08:04:06.662559 34 server.go:652] external host was not specified, using 172.17.0.2\n","stream":"stderr","time":"2021-07-26T08:04:06. 662617105Z"}
{"log":"I0726 08:04:06.662789 34 server.go:177] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:06.662836684Z"}
{"log":"I0726 08:04:06.668326 34 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:04:06.668430811Z"}
{"log":"I0726 08:04:06.668480 34 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:04:06.66853915Z"}
{"log":"I0726 08:04:06.670289 34 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:04:06.670391355Z"}
{"log":"I0726 08:04:06.670309 34 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:04:06.670405075Z"}
{"log":"I0726 08:04:06.693170 34 master.go:271] Using reconciler: lease\n","stream":"stderr","time":"2021-07-26T08:04:06.693301568Z"}
{"log":"W0726 08:04:06.938909 34 genericapiserver.go:412] Skipping API batch/v2alpha1 because it has no resources.\n","stream":"stderr","time":"202 1-07-26T08:04:06.939051516Z"}
{"log":"W0726 08:04:06.947692 34 genericapiserver.go:412] Skipping API discovery.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr", "time":"2021-07-26T08:04:06.947785463Z"}
{"log":"W0726 08:04:06.972446 34 genericapiserver.go:412] Skipping API node.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr","time ":"2021-07-26T08:04:06.972577102Z"}
{"log":"W0726 08:04:06.993441 34 genericapiserver.go:412] Skipping API rbac.authorization.k8s.io/v1alpha1 because it has no resources.\n","stream": "stderr","time":"2021-07-26T08:04:06.993548589Z"}
{"log":"W0726 08:04:06.997289 34 genericapiserver.go:412] Skipping API scheduling.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr" ,"time":"2021-07-26T08:04:06.99735614Z"}
{"log":"W0726 08:04:07.011755 34 genericapiserver.go:412] Skipping API storage.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr","t ime":"2021-07-26T08:04:07.011828284Z"}
{"log":"W0726 08:04:07.023489 34 genericapiserver.go:412] Skipping API apps/v1beta2 because it has no resources.\n","stream":"stderr","time":"2021- 07-26T08:04:07.023581244Z"}
{"log":"W0726 08:04:07.023504 34 genericapiserver.go:412] Skipping API apps/v1beta1 because it has no resources.\n","stream":"stderr","time":"2021- 07-26T08:04:07.023596164Z"}
{"log":"I0726 08:04:07.029950 34 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:04:07.030023778Z"}
{"log":"I0726 08:04:07.029964 34 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:04:07.030034748Z"}
{"log":"time=\"2021-07-26T08:04:07.036213032Z\" level=info msg=\"Running kube-scheduler --address=127.0.0.1 --bind-address=127.0.0.1 --kubeconfig=/var/l ib/rancher/k3s/server/cred/scheduler.kubeconfig --port=10251 --profiling=false --secure-port=0\"\n","stream":"stderr","time":"2021-07-26T08:04:07.036335 902Z"}
{"log":"time=\"2021-07-26T08:04:07.036608441Z\" level=info msg=\"Waiting for API server to become available\"\n","stream":"stderr","time":"2021-07-26T08 :04:07.036728611Z"}
{"log":"I0726 08:04:07.036634 34 registry.go:173] Registering SelectorSpread plugin\n","stream":"stderr","time":"2021-07-26T08:04:07.036929122Z"}
{"log":"I0726 08:04:07.036879 34 registry.go:173] Registering SelectorSpread plugin\n","stream":"stderr","time":"2021-07-26T08:04:07.036944541Z"}
{"log":"time=\"2021-07-26T08:04:07.037199851Z\" level=info msg=\"Running kube-controller-manager --address=127.0.0.1 --allocate-node-cidrs=true --bind-a ddress=127.0.0.1 --cluster-cidr=10.42.0.0/16 --cluster-signing-cert-file=/var/lib/rancher/k3s/server/tls/client-ca.crt --cluster-signing-key-file=/var/l ib/rancher/k3s/server/tls/client-ca.key --kubeconfig=/var/lib/rancher/k3s/server/cred/controller.kubeconfig --port=10252 --profiling=false --root-ca-fil e=/var/lib/rancher/k3s/server/tls/server-ca.crt --secure-port=0 --service-account-private-key-file=/var/lib/rancher/k3s/server/tls/service.key --use-ser vice-account-credentials=true\"\n","stream":"stderr","time":"2021-07-26T08:04:07.03729619Z"}
{"log":"time=\"2021-07-26T08:04:07.038577417Z\" level=info msg=\"Node token is available at /var/lib/rancher/k3s/server/token\"\n","stream":"stderr","ti me":"2021-07-26T08:04:07.038678227Z"}
{"log":"time=\"2021-07-26T08:04:07.038604617Z\" level=info msg=\"To join node to cluster: k3s agent -s https://172.17.0.2:6443 -t ${NODE_TOKEN}\"\n","st ream":"stderr","time":"2021-07-26T08:04:07.038691377Z"}
{"log":"time=\"2021-07-26T08:04:07.039825373Z\" level=info msg=\"Wrote kubeconfig /etc/rancher/k3s/k3s.yaml\"\n","stream":"stderr","time":"2021-07-26T08 :04:07.039925833Z"}
{"log":"time=\"2021-07-26T08:04:07.039852533Z\" level=info msg=\"Run: k3s kubectl\"\n","stream":"stderr","time":"2021-07-26T08:04:07.039940153Z"}
{"log":"time=\"2021-07-26T08:04:07.039968153Z\" level=info msg=\"Module overlay was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04:07.04 0036213Z"}
{"log":"time=\"2021-07-26T08:04:07.039996843Z\" level=info msg=\"Module nf_conntrack was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04: 07.040048923Z"}
{"log":"time=\"2021-07-26T08:04:07.040012883Z\" level=info msg=\"Module br_netfilter was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04: 07.040096083Z"}
{"log":"time=\"2021-07-26T08:04:07.040032603Z\" level=info msg=\"Module iptable_nat was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04:0 7.040108613Z"}
{"log":"time=\"2021-07-26T08:04:07.051419024Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:07 http: TLS handshake error from 127.0.0.1:56384: remote error: tls: bad certificate\"\n","stream":"stderr","time":"2021-07-26T08:04:07.051537104Z"}
{"log":"time=\"2021-07-26T08:04:07.056013854Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:07 http: TLS handshake error from 127.0.0.1:56390: remote error: tls: bad certificate\"\n","stream":"stderr","time":"2021-07-26T08:04:07.056114953Z"}
{"log":"time=\"2021-07-26T08:04:07.066866155Z\" level=info msg=\"certificate CN=local-node signed by CN=k3s-server-ca@1627286228: notBefore=2021-07-26 0 7:57:08 +0000 UTC notAfter=2022-07-26 08:04:07 +0000 UTC\"\n","stream":"stderr","time":"2021-07-26T08:04:07.066973795Z"}
{"log":"time=\"2021-07-26T08:04:07.069580089Z\" level=info msg=\"certificate CN=system:node:local-node,O=system:nodes signed by CN=k3s-client-ca@1627286 228: notBefore=2021-07-26 07:57:08 +0000 UTC notAfter=2022-07-26 08:04:07 +0000 UTC\"\n","stream":"stderr","time":"2021-07-26T08:04:07.069663349Z"}
{"log":"time=\"2021-07-26T08:04:07.087558734Z\" level=info msg=\"Logging containerd to /var/lib/rancher/k3s/agent/containerd/containerd.log\"\n","stream ":"stderr","time":"2021-07-26T08:04:07.087695804Z"}
{"log":"time=\"2021-07-26T08:04:07.087838843Z\" level=info msg=\"Running containerd -c /var/lib/rancher/k3s/agent/etc/containerd/config.toml -a /run/k3s /containerd/containerd.sock --state /run/k3s/containerd --root /var/lib/rancher/k3s/agent/containerd\"\n","stream":"stderr","time":"2021-07-26T08:04:07. 087991413Z"}
{"log":"time=\"2021-07-26T08:04:08.089025397Z\" level=info msg=\"Containerd is now running\"\n","stream":"stderr","time":"2021-07-26T08:04:08.089169417Z "}
{"log":"time=\"2021-07-26T08:04:08.096022760Z\" level=info msg=\"Connecting to proxy\" url=\"wss://127.0.0.1:6443/v1-k3s/connect\"\n","stream":"stderr", "time":"2021-07-26T08:04:08.09612291Z"}
{"log":"time=\"2021-07-26T08:04:08.098131185Z\" level=info msg=\"Handling backend connection request [local-node]\"\n","stream":"stderr","time":"2021-07 -26T08:04:08.098231135Z"}
{"log":"time=\"2021-07-26T08:04:08.098564734Z\" level=warning msg=\"Disabling CPU quotas due to missing cpu.cfs_period_us\"\n","stream":"stderr","time": "2021-07-26T08:04:08.098652244Z"}
{"log":"time=\"2021-07-26T08:04:08.098624684Z\" level=info msg=\"Running kubelet --address=0.0.0.0 --anonymous-auth=false --authentication-token-webhook =true --authorization-mode=Webhook --cgroup-driver=cgroupfs --client-ca-file=/var/lib/rancher/k3s/agent/client-ca.crt --cloud-provider=external --cluste r-dns=10.43.0.10 --cluster-domain=cluster.local --cni-bin-dir=/var/lib/rancher/k3s/data/ab1b521f47b3cbc273e0c667521084cff1ea3540d55b425ac7ed30c27daf92f8 /bin --cni-conf-dir=/var/lib/rancher/k3s/agent/etc/cni/net.d --container-runtime-endpoint=/run/k3s/containerd/containerd.sock --container-runtime=remote --containerd=/run/k3s/containerd/containerd.sock --cpu-cfs-quota=false --eviction-hard=imagefs.available\u003c5%,nodefs.available\u003c5% --eviction-mi nimum-reclaim=imagefs.available=10%,nodefs.available=10% --fail-swap-on=false --healthz-bind-address=127.0.0.1 --hostname-override=local-node --kubeconf ig=/var/lib/rancher/k3s/agent/kubelet.kubeconfig --kubelet-cgroups=/k3s --node-labels= --pod-manifest-path=/var/lib/rancher/k3s/agent/pod-manifests --re ad-only-port=0 --resolv-conf=/etc/resolv.conf --runtime-cgroups=/k3s --serialize-image-pulls=false --tls-cert-file=/var/lib/rancher/k3s/agent/serving-ku belet.crt --tls-private-key-file=/var/lib/rancher/k3s/agent/serving-kubelet.key\"\n","stream":"stderr","time":"2021-07-26T08:04:08.098721934Z"}
{"log":"time=\"2021-07-26T08:04:08.099328292Z\" level=info msg=\"Running kube-proxy --cluster-cidr=10.42.0.0/16 --healthz-bind-address=127.0.0.1 --hostn ame-override=local-node --kubeconfig=/var/lib/rancher/k3s/agent/kubeproxy.kubeconfig --proxy-mode=iptables\"\n","stream":"stderr","time":"2021-07-26T08: 04:08.099441922Z"}
{"log":"Flag --cloud-provider has been deprecated, will be removed in 1.23, in favor of removing cloud provider code from Kubelet.\n","stream":"stderr", "time":"2021-07-26T08:04:08.099553521Z"}
{"log":"Flag --containerd has been deprecated, This is a cadvisor flag that was mistakenly registered with the Kubelet. Due to legacy concerns, it will follow the standard CLI deprecation timeline before being removed.\n","stream":"stderr","time":"2021-07-26T08:04:08.099575591Z"}
{"log":"W0726 08:04:08.099694 34 server.go:226] WARNING: all flags other than --config, --write-config-to, and --cleanup are deprecated. Please beg in using a config file ASAP.\n","stream":"stderr","time":"2021-07-26T08:04:08.099765391Z"}
{"log":"I0726 08:04:08.099917 34 server.go:407] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:08.09998435Z"}
{"log":"W0726 08:04:08.100189 34 proxier.go:639] Failed to read file /lib/modules/4.15.0-151-generic/modules.builtin with error open /lib/modules/4 .15.0-151-generic/modules.builtin: no such file or directory. You can ignore this message when kube-proxy is running inside container without mounting / lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:08.100258199Z"}
{"log":"W0726 08:04:08.100719 34 proxier.go:649] Failed to load kernel module ip_vs with modprobe. You can ignore this message when kube-proxy is r unning inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:08.100776578Z"}
{"log":"W0726 08:04:08.101102 34 proxier.go:649] Failed to load kernel module ip_vs_rr with modprobe. You can ignore this message when kube-proxy i s running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:08.101167758Z"}
{"log":"time=\"2021-07-26T08:04:08.107112582Z\" level=info msg=\"Waiting for node local-node CIDR not assigned yet\"\n","stream":"stderr","time":"2021-0 7-26T08:04:08.107211092Z"}
{"log":"W0726 08:04:08.111336 34 proxier.go:649] Failed to load kernel module ip_vs_wrr with modprobe. You can ignore this message when kube-proxy is running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:08.111424301Z"}
{"log":"W0726 08:04:08.111686 34 proxier.go:649] Failed to load kernel module ip_vs_sh with modprobe. You can ignore this message when kube-proxy i s running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:08.1117475Z"}
{"log":"W0726 08:04:08.112138 34 proxier.go:649] Failed to load kernel module nf_conntrack_ipv4 with modprobe. You can ignore this message when kub e-proxy is running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:08.112192529Z"}
{"log":"E0726 08:04:08.117954 34 node.go:125] Failed to retrieve node info: nodes \"local-node\" is forbidden: User \"system:kube-proxy\" cannot ge t resource \"nodes\" in API group \"\" at the cluster scope\n","stream":"stderr","time":"2021-07-26T08:04:08.118035405Z"}
{"log":"I0726 08:04:08.122352 34 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/agent/client-ca.crt\n","stream":"st derr","time":"2021-07-26T08:04:08.122419054Z"}
{"log":"I0726 08:04:08.321398 34 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/server/tls/client-ca.crt\n","stream ":"stderr","time":"2021-07-26T08:04:08.321539785Z"}
{"log":"I0726 08:04:08.321398 34 dynamic_cafile_content.go:167] Starting request-header::/var/lib/rancher/k3s/server/tls/request-header-ca.crt\n"," stream":"stderr","time":"2021-07-26T08:04:08.321595275Z"}
{"log":"I0726 08:04:08.321534 34 dynamic_serving_content.go:130] Starting serving-cert::/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.crt: :/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.key\n","stream":"stderr","time":"2021-07-26T08:04:08.321603595Z"}
{"log":"I0726 08:04:08.321739 34 secure_serving.go:197] Serving securely on 127.0.0.1:6444\n","stream":"stderr","time":"2021-07-26T08:04:08.3218325 44Z"}
{"log":"I0726 08:04:08.321776 34 available_controller.go:475] Starting AvailableConditionController\n","stream":"stderr","time":"2021-07-26T08:04:0 8.321848514Z"}
{"log":"I0726 08:04:08.321787 34 cache.go:32] Waiting for caches to sync for AvailableConditionController controller\n","stream":"stderr","time":"2 021-07-26T08:04:08.321855354Z"}
{"log":"I0726 08:04:08.321804 34 tlsconfig.go:240] Starting DynamicServingCertificateController\n","stream":"stderr","time":"2021-07-26T08:04:08.32 1860994Z"}
{"log":"I0726 08:04:08.321868 34 customresource_discovery_controller.go:209] Starting DiscoveryController\n","stream":"stderr","time":"2021-07-26T0 8:04:08.322065573Z"}
{"log":"I0726 08:04:08.321918 34 apiservice_controller.go:97] Starting APIServiceRegistrationController\n","stream":"stderr","time":"2021-07-26T08: 04:08.322079133Z"}
{"log":"I0726 08:04:08.321928 34 cache.go:32] Waiting for caches to sync for APIServiceRegistrationController controller\n","stream":"stderr","time ":"2021-07-26T08:04:08.322085143Z"}
{"log":"I0726 08:04:08.321944 34 dynamic_serving_content.go:130] Starting aggregator-proxy-cert::/var/lib/rancher/k3s/server/tls/client-auth-proxy. crt::/var/lib/rancher/k3s/server/tls/client-auth-proxy.key\n","stream":"stderr","time":"2021-07-26T08:04:08.322101233Z"}
{"log":"I0726 08:04:08.321954 34 autoregister_controller.go:141] Starting autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04:08. 322107333Z"}
{"log":"I0726 08:04:08.321960 34 cache.go:32] Waiting for caches to sync for autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04: 08.322112633Z"}
{"log":"I0726 08:04:08.321976 34 crdregistration_controller.go:111] Starting crd-autoregister controller\n","stream":"stderr","time":"2021-07-26T08 :04:08.322117953Z"}
{"log":"I0726 08:04:08.321982 34 shared_informer.go:240] Waiting for caches to sync for crd-autoregister\n","stream":"stderr","time":"2021-07-26T08 :04:08.322123163Z"}
{"log":"I0726 08:04:08.321989 34 controller.go:83] Starting OpenAPI AggregationController\n","stream":"stderr","time":"2021-07-26T08:04:08.32212836 3Z"}
{"log":"I0726 08:04:08.322335 34 cluster_authentication_trust_controller.go:440] Starting cluster_authentication_trust_controller controller\n","st ream":"stderr","time":"2021-07-26T08:04:08.322524762Z"}
{"log":"I0726 08:04:08.322346 34 shared_informer.go:240] Waiting for caches to sync for cluster_authentication_trust_controller\n","stream":"stderr ","time":"2021-07-26T08:04:08.322538832Z"}
{"log":"I0726 08:04:08.322354 34 controller.go:86] Starting OpenAPI controller\n","stream":"stderr","time":"2021-07-26T08:04:08.322544592Z"}
{"log":"I0726 08:04:08.322376 34 naming_controller.go:291] Starting NamingConditionController\n","stream":"stderr","time":"2021-07-26T08:04:08.3225 49652Z"}
{"log":"I0726 08:04:08.322397 34 establishing_controller.go:76] Starting EstablishingController\n","stream":"stderr","time":"2021-07-26T08:04:08.32 2554942Z"}
{"log":"I0726 08:04:08.322425 34 nonstructuralschema_controller.go:186] Starting NonStructuralSchemaConditionController\n","stream":"stderr","time" :"2021-07-26T08:04:08.322560092Z"}
{"log":"I0726 08:04:08.322446 34 apiapproval_controller.go:186] Starting KubernetesAPIApprovalPolicyConformantConditionController\n","stream":"stde rr","time":"2021-07-26T08:04:08.322580332Z"}
{"log":"I0726 08:04:08.322469 34 crd_finalizer.go:266] Starting CRDFinalizer\n","stream":"stderr","time":"2021-07-26T08:04:08.322594552Z"}
{"log":"I0726 08:04:08.323023 34 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/server/tls/client-ca.crt\n","stream ":"stderr","time":"2021-07-26T08:04:08.323097471Z"}
{"log":"I0726 08:04:08.323041 34 dynamic_cafile_content.go:167] Starting request-header::/var/lib/rancher/k3s/server/tls/request-header-ca.crt\n"," stream":"stderr","time":"2021-07-26T08:04:08.323111611Z"}
{"log":"time=\"2021-07-26T08:04:08.326176113Z\" level=info msg=\"Running cloud-controller-manager --allocate-node-cidrs=true --allow-untagged-cloud=true --bind-address=127.0.0.1 --cloud-provider=k3s --cluster-cidr=10.42.0.0/16 --kubeconfig=/var/lib/rancher/k3s/server/cred/cloud-controller.kubeconfig --n ode-status-update-frequency=1m --profiling=false --secure-port=0\"\n","stream":"stderr","time":"2021-07-26T08:04:08.326287233Z"}
{"log":"Flag --allow-untagged-cloud has been deprecated, This flag is deprecated and will be removed in a future release. A cluster-id will be required on cloud instances.\n","stream":"stderr","time":"2021-07-26T08:04:08.326306093Z"}
{"log":"I0726 08:04:08.345265 34 controllermanager.go:127] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:08.345403725Z"}
{"log":"W0726 08:04:08.345281 34 controllermanager.go:139] detected a cluster without a ClusterID. A ClusterID will be required in the future. Pl ease tag your cluster to avoid any future issues\n","stream":"stderr","time":"2021-07-26T08:04:08.345442255Z"}
{"log":"I0726 08:04:08.345295 34 leaderelection.go:243] attempting to acquire leader lease kube-system/cloud-controller-manager...\n","stream":"st derr","time":"2021-07-26T08:04:08.345448855Z"}
{"log":"E0726 08:04:08.355907 34 controller.go:156] Unable to remove old endpoints from kubernetes service: no master IPs were listed in storage, r efusing to erase all endpoints for the kubernetes service\n","stream":"stderr","time":"2021-07-26T08:04:08.355995878Z"}
{"log":"I0726 08:04:08.421914 34 cache.go:39] Caches are synced for AvailableConditionController controller\n","stream":"stderr","time":"2021-07-26 T08:04:08.422032233Z"}
{"log":"I0726 08:04:08.421984 34 cache.go:39] Caches are synced for APIServiceRegistrationController controller\n","stream":"stderr","time":"2021-0 7-26T08:04:08.422053233Z"}
{"log":"I0726 08:04:08.422138 34 cache.go:39] Caches are synced for autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04:08.422241 732Z"}
{"log":"I0726 08:04:08.422453 34 shared_informer.go:247] Caches are synced for cluster_authentication_trust_controller \n","stream":"stderr","time" :"2021-07-26T08:04:08.422546591Z"}
{"log":"I0726 08:04:08.422558 34 shared_informer.go:247] Caches are synced for crd-autoregister \n","stream":"stderr","time":"2021-07-26T08:04:08.4 22629431Z"}
{"log":"W0726 08:04:08.505665 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:08.505838162Z"}
{"log":"W0726 08:04:08.527670 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:08.527812677Z"}
{"log":"W0726 08:04:08.547750 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:08.547876107Z"}
{"log":"W0726 08:04:08.631143 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:08.631295938Z"}
{"log":"W0726 08:04:08.648264 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:08.648359016Z"}
{"log":"2021/07/26 08:04:08 [INFO] Starting API controllers\n","stream":"stdout","time":"2021-07-26T08:04:08.922135429Z"}
{"log":"2021/07/26 08:04:09 [INFO] Starting management.cattle.io/v3, Kind=Token controller\n","stream":"stdout","time":"2021-07-26T08:04:09.149496937Z"}
{"log":"2021/07/26 08:04:09 [INFO] Starting /v1, Kind=Secret controller\n","stream":"stdout","time":"2021-07-26T08:04:09.149536867Z"}
{"log":"2021/07/26 08:04:09 [INFO] Starting management.cattle.io/v3, Kind=UserAttribute controller\n","stream":"stdout","time":"2021-07-26T08:04:09.1495 43077Z"}
{"log":"2021/07/26 08:04:09 [INFO] Starting management.cattle.io/v3, Kind=Group controller\n","stream":"stdout","time":"2021-07-26T08:04:09.149609097Z"}
{"log":"2021/07/26 08:04:09 [INFO] Starting management.cattle.io/v3, Kind=User controller\n","stream":"stdout","time":"2021-07-26T08:04:09.149617917Z"}
{"log":"2021/07/26 08:04:09 [INFO] Starting management.cattle.io/v3, Kind=GroupMember controller\n","stream":"stdout","time":"2021-07-26T08:04:09.149623 087Z"}
{"log":"W0726 08:04:09.166910 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:09.167062663Z"}
{"log":"W0726 08:04:09.175238 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:09.175347582Z"}
{"log":"I0726 08:04:09.230118 34 node.go:136] Successfully retrieved node IP: 172.17.0.2\n","stream":"stderr","time":"2021-07-26T08:04:09.230240265 Z"}
{"log":"I0726 08:04:09.230154 34 server_others.go:143] kube-proxy node IP is an IPv4 address (172.17.0.2), assume IPv4 operation\n","stream":"stder r","time":"2021-07-26T08:04:09.230274125Z"}
{"log":"I0726 08:04:09.230755 34 server_others.go:186] Using iptables Proxier.\n","stream":"stderr","time":"2021-07-26T08:04:09.230834903Z"}
{"log":"I0726 08:04:09.230932 34 server.go:650] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:09.230989763Z"}
{"log":"I0726 08:04:09.231282 34 conntrack.go:103] Set sysctl 'net/netfilter/nf_conntrack_max' to 196608\n","stream":"stderr","time":"2021-07-26T08 :04:09.231354922Z"}
{"log":"F0726 08:04:09.231307 34 server.go:495] open /proc/sys/net/netfilter/nf_conntrack_max: permission denied\n","stream":"stderr","time":"2021- 07-26T08:04:09.231370202Z"}
{"log":"W0726 08:04:09.245252 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1beta1.CustomResourceDefinition ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexp ected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245292247Z"}
{"log":"W0726 08:04:09.245325 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.Secret ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wat ch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245371747Z"}
{"log":"W0726 08:04:09.245323 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.Role ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245400207Z"}
{"log":"W0726 08:04:09.245329 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Preference ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245412797Z"}
{"log":"W0726 08:04:09.245371 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ClusterRepo ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245433497Z"}
{"log":"W0726 08:04:09.245372 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ClusterRoleBinding ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245436627Z"}
{"log":"W0726 08:04:09.245397 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.RoleBinding ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245439207Z"}
{"log":"W0726 08:04:09.245501 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Cluster ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wa tch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245569926Z"}
{"log":"W0726 08:04:09.245569 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Setting ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wa tch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245616466Z"}
{"log":"W0726 08:04:09.245617 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Feature ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wa tch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245660716Z"}
{"log":"W0726 08:04:09.245631 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.Secret ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wat ch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245676036Z"}
{"log":"W0726 08:04:09.245649 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ClusterRole ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245713376Z"}
{"log":"W0726 08:04:09.245682 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.APIService ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245720586Z"}
{"log":"W0726 08:04:09.245715 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.GroupMember ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245754576Z"}
{"log":"W0726 08:04:09.245717 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.User ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245762896Z"}
{"log":"W0726 08:04:09.245736 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ConfigMap ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245767446Z"}
{"log":"W0726 08:04:09.245812 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Group ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watc h lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245858366Z"}
{"log":"W0726 08:04:09.245821 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.UserAttribute ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch clos e - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245878545Z"}
{"log":"W0726 08:04:09.245856 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Token ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watc h lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:09.245936345Z"}
{"log":"2021/07/26 08:04:09 [FATAL] k3s exited with: exit status 1\n","stream":"stdout","time":"2021-07-26T08:04:09.246330084Z"}
{"log":"2021/07/26 08:04:10 [INFO] Rancher version v2.5.9 (3c5418944) is starting\n","stream":"stdout","time":"2021-07-26T08:04:10.11920281Z"}
{"log":"2021/07/26 08:04:10 [INFO] Rancher arguments {ACMEDomains:[] AddLocal:true Embedded:false BindHost: HTTPListenPort:80 HTTPSListenPort:443 K8sMod e:auto Debug:false Trace:false NoCACerts:false AuditLogPath:/var/log/auditlog/rancher-api-audit.log AuditLogMaxage:10 AuditLogMaxsize:100 AuditLogMaxbac kup:10 AuditLevel:0 Agent:false Features: ClusterRegistry:}\n","stream":"stdout","time":"2021-07-26T08:04:10.11924818Z"}
{"log":"2021/07/26 08:04:10 [INFO] Listening on /tmp/log.sock\n","stream":"stdout","time":"2021-07-26T08:04:10.11925932Z"}
{"log":"2021/07/26 08:04:10 [INFO] Running etcd --data-dir=management-state/etcd --heartbeat-interval=500 --election-timeout=5000\n","stream":"stdout"," time":"2021-07-26T08:04:10.11947186Z"}
{"log":"2021-07-26 08:04:10.127116 W | pkg/flags: unrecognized environment variable ETCD_URL_arm64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-arm64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:04:10.12725742Z"}
{"log":"2021-07-26 08:04:10.127156 W | pkg/flags: unrecognized environment variable ETCD_URL_amd64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-amd64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:04:10.12728018Z"}
{"log":"2021-07-26 08:04:10.127159 W | pkg/flags: unrecognized environment variable ETCD_UNSUPPORTED_ARCH=amd64\n","stream":"stderr","time":"2021-07-26T 08:04:10.12729758Z"}
{"log":"2021-07-26 08:04:10.127163 W | pkg/flags: unrecognized environment variable ETCD_URL=ETCD_URL_amd64\n","stream":"stderr","time":"2021-07-26T08:0 4:10.12730118Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:04:10.12730435Z "}
{"log":"2021-07-26 08:04:10.127187 I | etcdmain: etcd Version: 3.4.3\n","stream":"stderr","time":"2021-07-26T08:04:10.12730748Z"}
{"log":"2021-07-26 08:04:10.127191 I | etcdmain: Git SHA: 3cf2f69b5\n","stream":"stderr","time":"2021-07-26T08:04:10.12731049Z"}
{"log":"2021-07-26 08:04:10.127195 I | etcdmain: Go Version: go1.12.12\n","stream":"stderr","time":"2021-07-26T08:04:10.12731342Z"}
{"log":"2021-07-26 08:04:10.127198 I | etcdmain: Go OS/Arch: linux/amd64\n","stream":"stderr","time":"2021-07-26T08:04:10.12731643Z"}
{"log":"2021-07-26 08:04:10.127202 I | etcdmain: setting maximum number of CPUs to 6, total number of available CPUs is 6\n","stream":"stderr","time":"2 021-07-26T08:04:10.12731944Z"}
{"log":"2021-07-26 08:04:10.127242 N | etcdmain: the server is already initialized as member before, starting as etcd member...\n","stream":"stderr","ti me":"2021-07-26T08:04:10.12732594Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:04:10.12732951Z "}
{"log":"2021-07-26 08:04:10.127533 I | embed: name = default\n","stream":"stderr","time":"2021-07-26T08:04:10.127594669Z"}
{"log":"2021-07-26 08:04:10.127543 I | embed: data dir = management-state/etcd\n","stream":"stderr","time":"2021-07-26T08:04:10.127608839Z"}
{"log":"2021-07-26 08:04:10.127547 I | embed: member dir = management-state/etcd/member\n","stream":"stderr","time":"2021-07-26T08:04:10.127614039Z"}
{"log":"2021-07-26 08:04:10.127549 I | embed: heartbeat = 500ms\n","stream":"stderr","time":"2021-07-26T08:04:10.127617929Z"}
{"log":"2021-07-26 08:04:10.127552 I | embed: election = 5000ms\n","stream":"stderr","time":"2021-07-26T08:04:10.127621589Z"}
{"log":"2021-07-26 08:04:10.127554 I | embed: snapshot count = 100000\n","stream":"stderr","time":"2021-07-26T08:04:10.127625349Z"}
{"log":"2021-07-26 08:04:10.127560 I | embed: advertise client URLs = http://localhost:2379\n","stream":"stderr","time":"2021-07-26T08:04:10.127629339Z" }
{"log":"2021-07-26 08:04:10.127564 I | embed: initial advertise peer URLs = http://localhost:2380\n","stream":"stderr","time":"2021-07-26T08:04:10.12763 3389Z"}
{"log":"2021-07-26 08:04:10.127568 I | embed: initial cluster = \n","stream":"stderr","time":"2021-07-26T08:04:10.127637339Z"}
{"log":"2021-07-26 08:04:10.135107 I | etcdserver: restarting member 8e9e05c52164694d in cluster cdf818194e3a8c32 at commit index 1282\n","stream":"stde rr","time":"2021-07-26T08:04:10.135289509Z"}
{"log":"raft2021/07/26 08:04:10 INFO: 8e9e05c52164694d switched to configuration voters=()\n","stream":"stderr","time":"2021-07-26T08:04:10.135359209Z"}
{"log":"raft2021/07/26 08:04:10 INFO: 8e9e05c52164694d became follower at term 40\n","stream":"stderr","time":"2021-07-26T08:04:10.135425189Z"}
{"log":"raft2021/07/26 08:04:10 INFO: newRaft 8e9e05c52164694d [peers: [], term: 40, commit: 1282, applied: 0, lastindex: 1282, lastterm: 40]\n","stream ":"stderr","time":"2021-07-26T08:04:10.135436659Z"}
{"log":"2021-07-26 08:04:10.139167 W | auth: simple token is not cryptographically signed\n","stream":"stderr","time":"2021-07-26T08:04:10.13924362Z"}
{"log":"2021-07-26 08:04:10.140913 I | etcdserver: starting server... [version: 3.4.3, cluster version: to_be_decided]\n","stream":"stderr","time":"2021 -07-26T08:04:10.140987015Z"}
{"log":"raft2021/07/26 08:04:10 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437)\n","stream":"stderr","time":"2021-07-26T0 8:04:10.141204374Z"}
{"log":"2021-07-26 08:04:10.141206 I | etcdserver/membership: added member 8e9e05c52164694d [http://localhost:2380] to cluster cdf818194e3a8c32\n","stre am":"stderr","time":"2021-07-26T08:04:10.141246404Z"}
{"log":"2021-07-26 08:04:10.141281 N | etcdserver/membership: set the initial cluster version to 3.4\n","stream":"stderr","time":"2021-07-26T08:04:10.14 1323324Z"}
{"log":"2021-07-26 08:04:10.141302 I | etcdserver/api: enabled capabilities for version 3.4\n","stream":"stderr","time":"2021-07-26T08:04:10.141332274Z" }
{"log":"2021-07-26 08:04:10.144687 I | embed: listening for peers on 127.0.0.1:2380\n","stream":"stderr","time":"2021-07-26T08:04:10.144756765Z"}
{"log":"raft2021/07/26 08:04:18 INFO: 8e9e05c52164694d is starting a new election at term 40\n","stream":"stderr","time":"2021-07-26T08:04:18.635834616Z "}
{"log":"raft2021/07/26 08:04:18 INFO: 8e9e05c52164694d became candidate at term 41\n","stream":"stderr","time":"2021-07-26T08:04:18.635869725Z"}
{"log":"raft2021/07/26 08:04:18 INFO: 8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 41\n","stream":"stderr","time":"2021-07-26T08: 04:18.635875965Z"}
{"log":"raft2021/07/26 08:04:18 INFO: 8e9e05c52164694d became leader at term 41\n","stream":"stderr","time":"2021-07-26T08:04:18.635881895Z"}
{"log":"raft2021/07/26 08:04:18 INFO: raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 41\n","stream":"stderr","time":"2021-07-26T08: 04:18.635887375Z"}
{"log":"2021-07-26 08:04:18.635993 I | etcdserver: published {Name:default ClientURLs:[http://localhost:2379]} to cluster cdf818194e3a8c32\n","stream":" stderr","time":"2021-07-26T08:04:18.636092835Z"}
{"log":"2021-07-26 08:04:18.636029 I | embed: ready to serve client requests\n","stream":"stderr","time":"2021-07-26T08:04:18.636107625Z"}
{"log":"2021-07-26 08:04:18.636823 N | embed: serving insecure client requests on 127.0.0.1:2379, this is strongly discouraged!\n","stream":"stderr","ti me":"2021-07-26T08:04:18.636925962Z"}
{"log":"2021/07/26 08:04:18 [INFO] Waiting for server to become available: Get \"https://127.0.0.1:6443/version?timeout=15m0s\": dial tcp 127.0.0.1:6443 : connect: connection refused\n","stream":"stdout","time":"2021-07-26T08:04:18.651747184Z"}
{"log":"time=\"2021-07-26T08:04:18.827743931Z\" level=info msg=\"Starting k3s v1.19.8+k3s1 (95fc76b2)\"\n","stream":"stderr","time":"2021-07-26T08:04:18 .82788527Z"}
{"log":"time=\"2021-07-26T08:04:18.827996560Z\" level=info msg=\"Cluster bootstrap already complete\"\n","stream":"stderr","time":"2021-07-26T08:04:18.8 2808683Z"}
{"log":"time=\"2021-07-26T08:04:18.843108331Z\" level=info msg=\"Running kube-apiserver --advertise-port=6443 --allow-privileged=true --anonymous-auth=f alse --api-audiences=unknown --authorization-mode=Node,RBAC --bind-address=127.0.0.1 --cert-dir=/var/lib/rancher/k3s/server/tls/temporary-certs --client -ca-file=/var/lib/rancher/k3s/server/tls/client-ca.crt --enable-admission-plugins=NodeRestriction --etcd-servers=http://localhost:2379 --insecure-port=0 --kubelet-certificate-authority=/var/lib/rancher/k3s/server/tls/server-ca.crt --kubelet-client-certificate=/var/lib/rancher/k3s/server/tls/client-kube- apiserver.crt --kubelet-client-key=/var/lib/rancher/k3s/server/tls/client-kube-apiserver.key --profiling=false --proxy-client-cert-file=/var/lib/rancher /k3s/server/tls/client-auth-proxy.crt --proxy-client-key-file=/var/lib/rancher/k3s/server/tls/client-auth-proxy.key --requestheader-allowed-names=system :auth-proxy --requestheader-client-ca-file=/var/lib/rancher/k3s/server/tls/request-header-ca.crt --requestheader-extra-headers-prefix=X-Remote-Extra- -- requestheader-group-headers=X-Remote-Group --requestheader-username-headers=X-Remote-User --secure-port=6444 --service-account-issuer=k3s --service-acco unt-key-file=/var/lib/rancher/k3s/server/tls/service.key --service-account-signing-key-file=/var/lib/rancher/k3s/server/tls/service.key --service-cluste r-ip-range=10.43.0.0/16 --storage-backend=etcd3 --tls-cert-file=/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.crt --tls-private-key-file=/var/l ib/rancher/k3s/server/tls/serving-kube-apiserver.key\"\n","stream":"stderr","time":"2021-07-26T08:04:18.843244941Z"}
{"log":"I0726 08:04:18.844308 34 server.go:652] external host was not specified, using 172.17.0.2\n","stream":"stderr","time":"2021-07-26T08:04:18. 844369739Z"}
{"log":"I0726 08:04:18.844547 34 server.go:177] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:18.844596328Z"}
{"log":"I0726 08:04:18.849262 34 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:04:18.849332426Z"}
{"log":"I0726 08:04:18.849278 34 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:04:18.849348046Z"}
{"log":"I0726 08:04:18.850277 34 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:04:18.850341403Z"}
{"log":"I0726 08:04:18.850292 34 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:04:18.850352503Z"}
{"log":"I0726 08:04:18.872268 34 master.go:271] Using reconciler: lease\n","stream":"stderr","time":"2021-07-26T08:04:18.872413556Z"}
{"log":"W0726 08:04:19.129091 34 genericapiserver.go:412] Skipping API batch/v2alpha1 because it has no resources.\n","stream":"stderr","time":"202 1-07-26T08:04:19.129231429Z"}
{"log":"W0726 08:04:19.137919 34 genericapiserver.go:412] Skipping API discovery.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr", "time":"2021-07-26T08:04:19.138015956Z"}
{"log":"W0726 08:04:19.147825 34 genericapiserver.go:412] Skipping API node.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr","time ":"2021-07-26T08:04:19.14791553Z"}
{"log":"W0726 08:04:19.162348 34 genericapiserver.go:412] Skipping API rbac.authorization.k8s.io/v1alpha1 because it has no resources.\n","stream": "stderr","time":"2021-07-26T08:04:19.162446653Z"}
{"log":"W0726 08:04:19.170632 34 genericapiserver.go:412] Skipping API scheduling.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr" ,"time":"2021-07-26T08:04:19.170766432Z"}
{"log":"W0726 08:04:19.182603 34 genericapiserver.go:412] Skipping API storage.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr","t ime":"2021-07-26T08:04:19.182706931Z"}
{"log":"W0726 08:04:19.194285 34 genericapiserver.go:412] Skipping API apps/v1beta2 because it has no resources.\n","stream":"stderr","time":"2021- 07-26T08:04:19.194399821Z"}
{"log":"W0726 08:04:19.194304 34 genericapiserver.go:412] Skipping API apps/v1beta1 because it has no resources.\n","stream":"stderr","time":"2021- 07-26T08:04:19.194431391Z"}
{"log":"I0726 08:04:19.200843 34 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:04:19.200924424Z"}
{"log":"I0726 08:04:19.200857 34 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:04:19.200937573Z"}
{"log":"time=\"2021-07-26T08:04:19.207108248Z\" level=info msg=\"Running kube-scheduler --address=127.0.0.1 --bind-address=127.0.0.1 --kubeconfig=/var/l ib/rancher/k3s/server/cred/scheduler.kubeconfig --port=10251 --profiling=false --secure-port=0\"\n","stream":"stderr","time":"2021-07-26T08:04:19.207238 327Z"}
{"log":"time=\"2021-07-26T08:04:19.207170508Z\" level=info msg=\"Waiting for API server to become available\"\n","stream":"stderr","time":"2021-07-26T08 :04:19.207304447Z"}
{"log":"I0726 08:04:19.207484 34 registry.go:173] Registering SelectorSpread plugin\n","stream":"stderr","time":"2021-07-26T08:04:19.207558467Z"}
{"log":"I0726 08:04:19.207502 34 registry.go:173] Registering SelectorSpread plugin\n","stream":"stderr","time":"2021-07-26T08:04:19.207566297Z"}
{"log":"time=\"2021-07-26T08:04:19.207807456Z\" level=info msg=\"Running kube-controller-manager --address=127.0.0.1 --allocate-node-cidrs=true --bind-a ddress=127.0.0.1 --cluster-cidr=10.42.0.0/16 --cluster-signing-cert-file=/var/lib/rancher/k3s/server/tls/client-ca.crt --cluster-signing-key-file=/var/l ib/rancher/k3s/server/tls/client-ca.key --kubeconfig=/var/lib/rancher/k3s/server/cred/controller.kubeconfig --port=10252 --profiling=false --root-ca-fil e=/var/lib/rancher/k3s/server/tls/server-ca.crt --secure-port=0 --service-account-private-key-file=/var/lib/rancher/k3s/server/tls/service.key --use-ser vice-account-credentials=true\"\n","stream":"stderr","time":"2021-07-26T08:04:19.207886886Z"}
{"log":"time=\"2021-07-26T08:04:19.209050044Z\" level=info msg=\"Node token is available at /var/lib/rancher/k3s/server/token\"\n","stream":"stderr","ti me":"2021-07-26T08:04:19.209132763Z"}
{"log":"time=\"2021-07-26T08:04:19.209076723Z\" level=info msg=\"To join node to cluster: k3s agent -s https://172.17.0.2:6443 -t ${NODE_TOKEN}\"\n","st ream":"stderr","time":"2021-07-26T08:04:19.209150203Z"}
{"log":"time=\"2021-07-26T08:04:19.210071101Z\" level=info msg=\"Wrote kubeconfig /etc/rancher/k3s/k3s.yaml\"\n","stream":"stderr","time":"2021-07-26T08 :04:19.210139111Z"}
{"log":"time=\"2021-07-26T08:04:19.210096041Z\" level=info msg=\"Run: k3s kubectl\"\n","stream":"stderr","time":"2021-07-26T08:04:19.210146541Z"}
{"log":"time=\"2021-07-26T08:04:19.210181520Z\" level=info msg=\"Module overlay was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04:19.21 025196Z"}
{"log":"time=\"2021-07-26T08:04:19.210200540Z\" level=info msg=\"Module nf_conntrack was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04: 19.21026579Z"}
{"log":"time=\"2021-07-26T08:04:19.210210980Z\" level=info msg=\"Module br_netfilter was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04: 19.2102705Z"}
{"log":"time=\"2021-07-26T08:04:19.210223970Z\" level=info msg=\"Module iptable_nat was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04:1 9.21027548Z"}
{"log":"time=\"2021-07-26T08:04:19.220982773Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:19 http: TLS handshake error from 127.0.0.1:56746: remote error: tls: bad certificate\"\n","stream":"stderr","time":"2021-07-26T08:04:19.221114062Z"}
{"log":"time=\"2021-07-26T08:04:19.224668684Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:19 http: TLS handshake error from 127.0.0.1:56752: remote error: tls: bad certificate\"\n","stream":"stderr","time":"2021-07-26T08:04:19.224771513Z"}
{"log":"time=\"2021-07-26T08:04:19.234845346Z\" level=info msg=\"certificate CN=local-node signed by CN=k3s-server-ca@1627286228: notBefore=2021-07-26 0 7:57:08 +0000 UTC notAfter=2022-07-26 08:04:19 +0000 UTC\"\n","stream":"stderr","time":"2021-07-26T08:04:19.234964056Z"}
{"log":"time=\"2021-07-26T08:04:19.237605310Z\" level=info msg=\"certificate CN=system:node:local-node,O=system:nodes signed by CN=k3s-client-ca@1627286 228: notBefore=2021-07-26 07:57:08 +0000 UTC notAfter=2022-07-26 08:04:19 +0000 UTC\"\n","stream":"stderr","time":"2021-07-26T08:04:19.23769726Z"}
{"log":"time=\"2021-07-26T08:04:19.243574565Z\" level=info msg=\"Logging containerd to /var/lib/rancher/k3s/agent/containerd/containerd.log\"\n","stream ":"stderr","time":"2021-07-26T08:04:19.243677625Z"}
{"log":"time=\"2021-07-26T08:04:19.243719525Z\" level=info msg=\"Running containerd -c /var/lib/rancher/k3s/agent/etc/containerd/config.toml -a /run/k3s /containerd/containerd.sock --state /run/k3s/containerd --root /var/lib/rancher/k3s/agent/containerd\"\n","stream":"stderr","time":"2021-07-26T08:04:19. 243804834Z"}
{"log":"time=\"2021-07-26T08:04:20.245118162Z\" level=info msg=\"Containerd is now running\"\n","stream":"stderr","time":"2021-07-26T08:04:20.245282612Z "}
{"log":"time=\"2021-07-26T08:04:20.251532286Z\" level=info msg=\"Connecting to proxy\" url=\"wss://127.0.0.1:6443/v1-k3s/connect\"\n","stream":"stderr", "time":"2021-07-26T08:04:20.251666016Z"}
{"log":"time=\"2021-07-26T08:04:20.253686140Z\" level=info msg=\"Handling backend connection request [local-node]\"\n","stream":"stderr","time":"2021-07 -26T08:04:20.253778491Z"}
{"log":"time=\"2021-07-26T08:04:20.254145660Z\" level=warning msg=\"Disabling CPU quotas due to missing cpu.cfs_period_us\"\n","stream":"stderr","time": "2021-07-26T08:04:20.254237589Z"}
{"log":"time=\"2021-07-26T08:04:20.254222929Z\" level=info msg=\"Running kubelet --address=0.0.0.0 --anonymous-auth=false --authentication-token-webhook =true --authorization-mode=Webhook --cgroup-driver=cgroupfs --client-ca-file=/var/lib/rancher/k3s/agent/client-ca.crt --cloud-provider=external --cluste r-dns=10.43.0.10 --cluster-domain=cluster.local --cni-bin-dir=/var/lib/rancher/k3s/data/ab1b521f47b3cbc273e0c667521084cff1ea3540d55b425ac7ed30c27daf92f8 /bin --cni-conf-dir=/var/lib/rancher/k3s/agent/etc/cni/net.d --container-runtime-endpoint=/run/k3s/containerd/containerd.sock --container-runtime=remote --containerd=/run/k3s/containerd/containerd.sock --cpu-cfs-quota=false --eviction-hard=imagefs.available\u003c5%,nodefs.available\u003c5% --eviction-mi nimum-reclaim=imagefs.available=10%,nodefs.available=10% --fail-swap-on=false --healthz-bind-address=127.0.0.1 --hostname-override=local-node --kubeconf ig=/var/lib/rancher/k3s/agent/kubelet.kubeconfig --kubelet-cgroups=/k3s --node-labels= --pod-manifest-path=/var/lib/rancher/k3s/agent/pod-manifests --re ad-only-port=0 --resolv-conf=/etc/resolv.conf --runtime-cgroups=/k3s --serialize-image-pulls=false --tls-cert-file=/var/lib/rancher/k3s/agent/serving-ku belet.crt --tls-private-key-file=/var/lib/rancher/k3s/agent/serving-kubelet.key\"\n","stream":"stderr","time":"2021-07-26T08:04:20.254338189Z"}
{"log":"time=\"2021-07-26T08:04:20.254864718Z\" level=info msg=\"Running kube-proxy --cluster-cidr=10.42.0.0/16 --healthz-bind-address=127.0.0.1 --hostn ame-override=local-node --kubeconfig=/var/lib/rancher/k3s/agent/kubeproxy.kubeconfig --proxy-mode=iptables\"\n","stream":"stderr","time":"2021-07-26T08: 04:20.254944277Z"}
{"log":"Flag --cloud-provider has been deprecated, will be removed in 1.23, in favor of removing cloud provider code from Kubelet.\n","stream":"stderr", "time":"2021-07-26T08:04:20.255071247Z"}
{"log":"Flag --containerd has been deprecated, This is a cadvisor flag that was mistakenly registered with the Kubelet. Due to legacy concerns, it will follow the standard CLI deprecation timeline before being removed.\n","stream":"stderr","time":"2021-07-26T08:04:20.255077707Z"}
{"log":"W0726 08:04:20.255165 34 server.go:226] WARNING: all flags other than --config, --write-config-to, and --cleanup are deprecated. Please beg in using a config file ASAP.\n","stream":"stderr","time":"2021-07-26T08:04:20.255220077Z"}
{"log":"I0726 08:04:20.255465 34 server.go:407] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:20.255512096Z"}
{"log":"W0726 08:04:20.255572 34 proxier.go:639] Failed to read file /lib/modules/4.15.0-151-generic/modules.builtin with error open /lib/modules/4 .15.0-151-generic/modules.builtin: no such file or directory. You can ignore this message when kube-proxy is running inside container without mounting / lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:20.255615625Z"}
{"log":"W0726 08:04:20.256087 34 proxier.go:649] Failed to load kernel module ip_vs with modprobe. You can ignore this message when kube-proxy is r unning inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:20.256135914Z"}
{"log":"time=\"2021-07-26T08:04:20.261957889Z\" level=info msg=\"Waiting for node local-node CIDR not assigned yet\"\n","stream":"stderr","time":"2021-0 7-26T08:04:20.262045499Z"}
{"log":"W0726 08:04:20.271423 34 proxier.go:649] Failed to load kernel module ip_vs_rr with modprobe. You can ignore this message when kube-proxy i s running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:20.271557264Z"}
{"log":"W0726 08:04:20.271778 34 proxier.go:649] Failed to load kernel module ip_vs_wrr with modprobe. You can ignore this message when kube-proxy is running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:20.271853364Z"}
{"log":"W0726 08:04:20.272087 34 proxier.go:649] Failed to load kernel module ip_vs_sh with modprobe. You can ignore this message when kube-proxy i s running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:20.272159583Z"}
{"log":"W0726 08:04:20.272425 34 proxier.go:649] Failed to load kernel module nf_conntrack_ipv4 with modprobe. You can ignore this message when kub e-proxy is running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:20.272506602Z"}
{"log":"I0726 08:04:20.275545 34 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/agent/client-ca.crt\n","stream":"st derr","time":"2021-07-26T08:04:20.275630924Z"}
{"log":"E0726 08:04:20.277984 34 node.go:125] Failed to retrieve node info: nodes \"local-node\" is forbidden: User \"system:kube-proxy\" cannot ge t resource \"nodes\" in API group \"\" at the cluster scope\n","stream":"stderr","time":"2021-07-26T08:04:20.278066608Z"}
{"log":"I0726 08:04:20.470800 34 dynamic_cafile_content.go:167] Starting request-header::/var/lib/rancher/k3s/server/tls/request-header-ca.crt\n"," stream":"stderr","time":"2021-07-26T08:04:20.470946712Z"}
{"log":"I0726 08:04:20.470809 34 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/server/tls/client-ca.crt\n","stream ":"stderr","time":"2021-07-26T08:04:20.470977112Z"}
{"log":"I0726 08:04:20.470888 34 dynamic_serving_content.go:130] Starting serving-cert::/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.crt: :/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.key\n","stream":"stderr","time":"2021-07-26T08:04:20.470981782Z"}
{"log":"I0726 08:04:20.471062 34 secure_serving.go:197] Serving securely on 127.0.0.1:6444\n","stream":"stderr","time":"2021-07-26T08:04:20.4711399 71Z"}
{"log":"I0726 08:04:20.471208 34 apiservice_controller.go:97] Starting APIServiceRegistrationController\n","stream":"stderr","time":"2021-07-26T08: 04:20.471297951Z"}
{"log":"I0726 08:04:20.471368 34 cache.go:32] Waiting for caches to sync for APIServiceRegistrationController controller\n","stream":"stderr","time ":"2021-07-26T08:04:20.47143124Z"}
{"log":"I0726 08:04:20.471532 34 autoregister_controller.go:141] Starting autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04:20. 471599Z"}
{"log":"I0726 08:04:20.471538 34 crdregistration_controller.go:111] Starting crd-autoregister controller\n","stream":"stderr","time":"2021-07-26T08 :04:20.47160787Z"}
{"log":"I0726 08:04:20.471547 34 cache.go:32] Waiting for caches to sync for autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04: 20.47161174Z"}
{"log":"I0726 08:04:20.471552 34 shared_informer.go:240] Waiting for caches to sync for crd-autoregister\n","stream":"stderr","time":"2021-07-26T08 :04:20.47161544Z"}
{"log":"I0726 08:04:20.471219 34 tlsconfig.go:240] Starting DynamicServingCertificateController\n","stream":"stderr","time":"2021-07-26T08:04:20.47 169257Z"}
{"log":"I0726 08:04:20.471645 34 naming_controller.go:291] Starting NamingConditionController\n","stream":"stderr","time":"2021-07-26T08:04:20.4717 1361Z"}
{"log":"I0726 08:04:20.471735 34 establishing_controller.go:76] Starting EstablishingController\n","stream":"stderr","time":"2021-07-26T08:04:20.47 1791199Z"}
{"log":"I0726 08:04:20.471245 34 controller.go:83] Starting OpenAPI AggregationController\n","stream":"stderr","time":"2021-07-26T08:04:20.47179827 9Z"}
{"log":"I0726 08:04:20.471768 34 nonstructuralschema_controller.go:186] Starting NonStructuralSchemaConditionController\n","stream":"stderr","time" :"2021-07-26T08:04:20.471801919Z"}
{"log":"I0726 08:04:20.471787 34 apiapproval_controller.go:186] Starting KubernetesAPIApprovalPolicyConformantConditionController\n","stream":"stde rr","time":"2021-07-26T08:04:20.471815129Z"}
{"log":"I0726 08:04:20.471817 34 crd_finalizer.go:266] Starting CRDFinalizer\n","stream":"stderr","time":"2021-07-26T08:04:20.471863339Z"}
{"log":"I0726 08:04:20.471296 34 dynamic_serving_content.go:130] Starting aggregator-proxy-cert::/var/lib/rancher/k3s/server/tls/client-auth-proxy. crt::/var/lib/rancher/k3s/server/tls/client-auth-proxy.key\n","stream":"stderr","time":"2021-07-26T08:04:20.471951369Z"}
{"log":"I0726 08:04:20.471316 34 available_controller.go:475] Starting AvailableConditionController\n","stream":"stderr","time":"2021-07-26T08:04:2 0.471967559Z"}
{"log":"I0726 08:04:20.471901 34 cache.go:32] Waiting for caches to sync for AvailableConditionController controller\n","stream":"stderr","time":"2 021-07-26T08:04:20.471973639Z"}
{"log":"I0726 08:04:20.471350 34 customresource_discovery_controller.go:209] Starting DiscoveryController\n","stream":"stderr","time":"2021-07-26T0 8:04:20.472059749Z"}
{"log":"I0726 08:04:20.472245 34 controller.go:86] Starting OpenAPI controller\n","stream":"stderr","time":"2021-07-26T08:04:20.472323288Z"}
{"log":"I0726 08:04:20.472501 34 cluster_authentication_trust_controller.go:440] Starting cluster_authentication_trust_controller controller\n","st ream":"stderr","time":"2021-07-26T08:04:20.472556677Z"}
{"log":"I0726 08:04:20.472569 34 shared_informer.go:240] Waiting for caches to sync for cluster_authentication_trust_controller\n","stream":"stderr ","time":"2021-07-26T08:04:20.472631157Z"}
{"log":"I0726 08:04:20.472675 34 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/server/tls/client-ca.crt\n","stream ":"stderr","time":"2021-07-26T08:04:20.472725967Z"}
{"log":"I0726 08:04:20.472768 34 dynamic_cafile_content.go:167] Starting request-header::/var/lib/rancher/k3s/server/tls/request-header-ca.crt\n"," stream":"stderr","time":"2021-07-26T08:04:20.472832216Z"}
{"log":"E0726 08:04:20.488143 34 controller.go:156] Unable to remove old endpoints from kubernetes service: no master IPs were listed in storage, r efusing to erase all endpoints for the kubernetes service\n","stream":"stderr","time":"2021-07-26T08:04:20.488251007Z"}
{"log":"time=\"2021-07-26T08:04:20.502688430Z\" level=info msg=\"Running cloud-controller-manager --allocate-node-cidrs=true --allow-untagged-cloud=true --bind-address=127.0.0.1 --cloud-provider=k3s --cluster-cidr=10.42.0.0/16 --kubeconfig=/var/lib/rancher/k3s/server/cred/cloud-controller.kubeconfig --n ode-status-update-frequency=1m --profiling=false --secure-port=0\"\n","stream":"stderr","time":"2021-07-26T08:04:20.502866049Z"}
{"log":"Flag --allow-untagged-cloud has been deprecated, This flag is deprecated and will be removed in a future release. A cluster-id will be required on cloud instances.\n","stream":"stderr","time":"2021-07-26T08:04:20.502900559Z"}
{"log":"I0726 08:04:20.506301 34 controllermanager.go:127] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:20.50637647Z"}
{"log":"W0726 08:04:20.506425 34 controllermanager.go:139] detected a cluster without a ClusterID. A ClusterID will be required in the future. Pl ease tag your cluster to avoid any future issues\n","stream":"stderr","time":"2021-07-26T08:04:20.50645835Z"}
{"log":"I0726 08:04:20.506527 34 leaderelection.go:243] attempting to acquire leader lease kube-system/cloud-controller-manager...\n","stream":"st derr","time":"2021-07-26T08:04:20.50655759Z"}
{"log":"I0726 08:04:20.571515 34 cache.go:39] Caches are synced for APIServiceRegistrationController controller\n","stream":"stderr","time":"2021-0 7-26T08:04:20.571628953Z"}
{"log":"I0726 08:04:20.571621 34 cache.go:39] Caches are synced for autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04:20.571657 923Z"}
{"log":"I0726 08:04:20.571628 34 shared_informer.go:247] Caches are synced for crd-autoregister \n","stream":"stderr","time":"2021-07-26T08:04:20.5 71663383Z"}
{"log":"I0726 08:04:20.572276 34 cache.go:39] Caches are synced for AvailableConditionController controller\n","stream":"stderr","time":"2021-07-26 T08:04:20.572321651Z"}
{"log":"I0726 08:04:20.572773 34 shared_informer.go:247] Caches are synced for cluster_authentication_trust_controller \n","stream":"stderr","time" :"2021-07-26T08:04:20.572837419Z"}
{"log":"W0726 08:04:20.662201 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:20.662301499Z"}
{"log":"W0726 08:04:20.682408 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:20.682483477Z"}
{"log":"W0726 08:04:20.702070 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:20.702165886Z"}
{"log":"W0726 08:04:20.740076 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:20.740179379Z"}
{"log":"W0726 08:04:20.755082 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:20.75519634Z"}
{"log":"2021/07/26 08:04:20 [INFO] Starting API controllers\n","stream":"stdout","time":"2021-07-26T08:04:20.99247407Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting /v1, Kind=Secret controller\n","stream":"stdout","time":"2021-07-26T08:04:21.119211183Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting management.cattle.io/v3, Kind=User controller\n","stream":"stdout","time":"2021-07-26T08:04:21.119285853Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting management.cattle.io/v3, Kind=UserAttribute controller\n","stream":"stdout","time":"2021-07-26T08:04:21.1192 93293Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting management.cattle.io/v3, Kind=Token controller\n","stream":"stdout","time":"2021-07-26T08:04:21.119298853Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting management.cattle.io/v3, Kind=Group controller\n","stream":"stdout","time":"2021-07-26T08:04:21.119304143Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting management.cattle.io/v3, Kind=GroupMember controller\n","stream":"stdout","time":"2021-07-26T08:04:21.119310 873Z"}
{"log":"W0726 08:04:21.138973 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:21.139110732Z"}
{"log":"W0726 08:04:21.147204 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:21.147313071Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=RoleBinding controller\n","stream":"stdout","time":"2021-07-26T08:04:21.2 37550798Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting apiregistration.k8s.io/v1, Kind=APIService controller\n","stream":"stdout","time":"2021-07-26T08:04:21.23758 3538Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting management.cattle.io/v3, Kind=Feature controller\n","stream":"stdout","time":"2021-07-26T08:04:21.237588118Z "}
{"log":"2021/07/26 08:04:21 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=ClusterRole controller\n","stream":"stdout","time":"2021-07-26T08:04:21.2 37809697Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting management.cattle.io/v3, Kind=Setting controller\n","stream":"stdout","time":"2021-07-26T08:04:21.237828307Z "}
{"log":"2021/07/26 08:04:21 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=Role controller\n","stream":"stdout","time":"2021-07-26T08:04:21.23791465 7Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=ClusterRoleBinding controller\n","stream":"stdout","time":"2021-07-26T08: 04:21.238046528Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting catalog.cattle.io/v1, Kind=ClusterRepo controller\n","stream":"stdout","time":"2021-07-26T08:04:21.238144747 Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting management.cattle.io/v3, Kind=Cluster controller\n","stream":"stdout","time":"2021-07-26T08:04:21.238514906Z "}
{"log":"2021/07/26 08:04:21 [INFO] Starting /v1, Kind=ConfigMap controller\n","stream":"stdout","time":"2021-07-26T08:04:21.239238764Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting apiextensions.k8s.io/v1beta1, Kind=CustomResourceDefinition controller\n","stream":"stdout","time":"2021-07- 26T08:04:21.239250484Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting /v1, Kind=Secret controller\n","stream":"stdout","time":"2021-07-26T08:04:21.239303464Z"}
{"log":"2021/07/26 08:04:21 [INFO] Starting management.cattle.io/v3, Kind=Preference controller\n","stream":"stdout","time":"2021-07-26T08:04:21.2395076 34Z"}
{"log":"I0726 08:04:21.240217 8 leaderelection.go:243] attempting to acquire leader lease kube-system/cattle-controllers...\n","stream":"stderr"," time":"2021-07-26T08:04:21.240289391Z"}
{"log":"I0726 08:04:21.245210 8 leaderelection.go:253] successfully acquired lease kube-system/cattle-controllers\n","stream":"stderr","time":"202 1-07-26T08:04:21.245329708Z"}
{"log":"time=\"2021-07-26T08:04:21.248070251Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:21 http: TLS handshake error from 127.0.0.1:57014: EOF\"\n","stream":"stderr","time":"2021-07-26T08:04:21.248209461Z"}
{"log":"W0726 08:04:21.267750 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:21.26790366Z"}
{"log":"W0726 08:04:21.287754 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:21.287885279Z"}
{"log":"W0726 08:04:21.299765 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:21.299867498Z"}
{"log":"2021/07/26 08:04:21 [INFO] Running in single server mode, will not peer connections\n","stream":"stdout","time":"2021-07-26T08:04:21.303978278Z" }
{"log":"W0726 08:04:21.315251 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:21.315374308Z"}
{"log":"W0726 08:04:21.315826 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:21.315885346Z"}
{"log":"2021/07/26 08:04:21 [INFO] Steve auth startup complete\n","stream":"stdout","time":"2021-07-26T08:04:21.321588341Z"}
{"log":"W0726 08:04:21.324888 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:21.324969913Z"}
{"log":"W0726 08:04:21.330052 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:21.33012071Z"}
{"log":"I0726 08:04:21.404519 34 node.go:136] Successfully retrieved node IP: 172.17.0.2\n","stream":"stderr","time":"2021-07-26T08:04:21.404637627 Z"}
{"log":"I0726 08:04:21.404550 34 server_others.go:143] kube-proxy node IP is an IPv4 address (172.17.0.2), assume IPv4 operation\n","stream":"stder r","time":"2021-07-26T08:04:21.404679247Z"}
{"log":"I0726 08:04:21.405130 34 server_others.go:186] Using iptables Proxier.\n","stream":"stderr","time":"2021-07-26T08:04:21.405196896Z"}
{"log":"I0726 08:04:21.405311 34 server.go:650] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:21.405408236Z"}
{"log":"I0726 08:04:21.405656 34 conntrack.go:103] Set sysctl 'net/netfilter/nf_conntrack_max' to 196608\n","stream":"stderr","time":"2021-07-26T08 :04:21.405799775Z"}
{"log":"F0726 08:04:21.405731 34 server.go:495] open /proc/sys/net/netfilter/nf_conntrack_max: permission denied\n","stream":"stderr","time":"2021- 07-26T08:04:21.405836025Z"}
{"log":"W0726 08:04:21.418889 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.Role ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:21.418992041Z"}
{"log":"W0726 08:04:21.420419 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Preference ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:21.420545007Z"}
{"log":"W0726 08:04:21.418917 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Cluster ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wa tch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:21.420650927Z"}
{"log":"W0726 08:04:21.419261 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.GroupMember ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:21.420659857Z"}
{"log":"W0726 08:04:21.420501 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.APIService ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:21.420665307Z"}
{"log":"W0726 08:04:21.419512 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.User ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:21.420670567Z"}
{"log":"W0726 08:04:21.419529 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Token ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watc h lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:21.420688447Z"}
{"log":"W0726 08:04:21.419544 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Group ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watc h lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:21.420693907Z"}
{"log":"W0726 08:04:21.419558 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.UserAttribute ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch clos e - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:21.420709917Z"}
{"log":"2021/07/26 08:04:21 [FATAL] k3s exited with: exit status 1\n","stream":"stdout","time":"2021-07-26T08:04:21.420772607Z"}
{"log":"2021/07/26 08:04:22 [INFO] Rancher version v2.5.9 (3c5418944) is starting\n","stream":"stdout","time":"2021-07-26T08:04:22.193876973Z"}
{"log":"2021/07/26 08:04:22 [INFO] Rancher arguments {ACMEDomains:[] AddLocal:true Embedded:false BindHost: HTTPListenPort:80 HTTPSListenPort:443 K8sMod e:auto Debug:false Trace:false NoCACerts:false AuditLogPath:/var/log/auditlog/rancher-api-audit.log AuditLogMaxage:10 AuditLogMaxsize:100 AuditLogMaxbac kup:10 AuditLevel:0 Agent:false Features: ClusterRegistry:}\n","stream":"stdout","time":"2021-07-26T08:04:22.193907332Z"}
{"log":"2021/07/26 08:04:22 [INFO] Listening on /tmp/log.sock\n","stream":"stdout","time":"2021-07-26T08:04:22.193916582Z"}
{"log":"2021/07/26 08:04:22 [INFO] Running etcd --data-dir=management-state/etcd --heartbeat-interval=500 --election-timeout=5000\n","stream":"stdout"," time":"2021-07-26T08:04:22.194287091Z"}
{"log":"2021-07-26 08:04:22.202991 W | pkg/flags: unrecognized environment variable ETCD_URL_arm64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-arm64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:04:22.203082148Z"}
{"log":"2021-07-26 08:04:22.203023 W | pkg/flags: unrecognized environment variable ETCD_URL_amd64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-amd64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:04:22.203091048Z"}
{"log":"2021-07-26 08:04:22.203028 W | pkg/flags: unrecognized environment variable ETCD_UNSUPPORTED_ARCH=amd64\n","stream":"stderr","time":"2021-07-26T 08:04:22.203093718Z"}
{"log":"2021-07-26 08:04:22.203033 W | pkg/flags: unrecognized environment variable ETCD_URL=ETCD_URL_amd64\n","stream":"stderr","time":"2021-07-26T08:0 4:22.203097718Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:04:22.203100088 Z"}
{"log":"2021-07-26 08:04:22.203068 I | etcdmain: etcd Version: 3.4.3\n","stream":"stderr","time":"2021-07-26T08:04:22.203106638Z"}
{"log":"2021-07-26 08:04:22.203075 I | etcdmain: Git SHA: 3cf2f69b5\n","stream":"stderr","time":"2021-07-26T08:04:22.203109098Z"}
{"log":"2021-07-26 08:04:22.203080 I | etcdmain: Go Version: go1.12.12\n","stream":"stderr","time":"2021-07-26T08:04:22.203111298Z"}
{"log":"2021-07-26 08:04:22.203086 I | etcdmain: Go OS/Arch: linux/amd64\n","stream":"stderr","time":"2021-07-26T08:04:22.203121308Z"}
{"log":"2021-07-26 08:04:22.203092 I | etcdmain: setting maximum number of CPUs to 6, total number of available CPUs is 6\n","stream":"stderr","time":"2 021-07-26T08:04:22.203138768Z"}
{"log":"2021-07-26 08:04:22.203178 N | etcdmain: the server is already initialized as member before, starting as etcd member...\n","stream":"stderr","ti me":"2021-07-26T08:04:22.203238548Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:04:22.203251068 Z"}
{"log":"2021-07-26 08:04:22.203621 I | embed: name = default\n","stream":"stderr","time":"2021-07-26T08:04:22.203688228Z"}
{"log":"2021-07-26 08:04:22.203637 I | embed: data dir = management-state/etcd\n","stream":"stderr","time":"2021-07-26T08:04:22.203700928Z"}
{"log":"2021-07-26 08:04:22.203642 I | embed: member dir = management-state/etcd/member\n","stream":"stderr","time":"2021-07-26T08:04:22.203704608Z"}
{"log":"2021-07-26 08:04:22.203647 I | embed: heartbeat = 500ms\n","stream":"stderr","time":"2021-07-26T08:04:22.203707548Z"}
{"log":"2021-07-26 08:04:22.203652 I | embed: election = 5000ms\n","stream":"stderr","time":"2021-07-26T08:04:22.203710288Z"}
{"log":"2021-07-26 08:04:22.203659 I | embed: snapshot count = 100000\n","stream":"stderr","time":"2021-07-26T08:04:22.203712898Z"}
{"log":"2021-07-26 08:04:22.203671 I | embed: advertise client URLs = http://localhost:2379\n","stream":"stderr","time":"2021-07-26T08:04:22.203715778Z" }
{"log":"2021-07-26 08:04:22.203678 I | embed: initial advertise peer URLs = http://localhost:2380\n","stream":"stderr","time":"2021-07-26T08:04:22.20371 8597Z"}
{"log":"2021-07-26 08:04:22.203685 I | embed: initial cluster = \n","stream":"stderr","time":"2021-07-26T08:04:22.203723257Z"}
{"log":"2021-07-26 08:04:22.209470 I | etcdserver: restarting member 8e9e05c52164694d in cluster cdf818194e3a8c32 at commit index 1305\n","stream":"stde rr","time":"2021-07-26T08:04:22.209540202Z"}
{"log":"raft2021/07/26 08:04:22 INFO: 8e9e05c52164694d switched to configuration voters=()\n","stream":"stderr","time":"2021-07-26T08:04:22.209777731Z"}
{"log":"raft2021/07/26 08:04:22 INFO: 8e9e05c52164694d became follower at term 41\n","stream":"stderr","time":"2021-07-26T08:04:22.209787931Z"}
{"log":"raft2021/07/26 08:04:22 INFO: newRaft 8e9e05c52164694d [peers: [], term: 41, commit: 1305, applied: 0, lastindex: 1305, lastterm: 41]\n","stream ":"stderr","time":"2021-07-26T08:04:22.209791491Z"}
{"log":"2021-07-26 08:04:22.213975 W | auth: simple token is not cryptographically signed\n","stream":"stderr","time":"2021-07-26T08:04:22.2140431Z"}
{"log":"2021-07-26 08:04:22.215713 I | etcdserver: starting server... [version: 3.4.3, cluster version: to_be_decided]\n","stream":"stderr","time":"2021 -07-26T08:04:22.215776456Z"}
{"log":"raft2021/07/26 08:04:22 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437)\n","stream":"stderr","time":"2021-07-26T0 8:04:22.216135545Z"}
{"log":"2021-07-26 08:04:22.216165 I | etcdserver/membership: added member 8e9e05c52164694d [http://localhost:2380] to cluster cdf818194e3a8c32\n","stre am":"stderr","time":"2021-07-26T08:04:22.216235865Z"}
{"log":"2021-07-26 08:04:22.216274 N | etcdserver/membership: set the initial cluster version to 3.4\n","stream":"stderr","time":"2021-07-26T08:04:22.21 6328184Z"}
{"log":"2021-07-26 08:04:22.216310 I | etcdserver/api: enabled capabilities for version 3.4\n","stream":"stderr","time":"2021-07-26T08:04:22.216366094Z" }
{"log":"2021-07-26 08:04:22.216957 I | embed: listening for peers on 127.0.0.1:2380\n","stream":"stderr","time":"2021-07-26T08:04:22.217058962Z"}
{"log":"raft2021/07/26 08:04:31 INFO: 8e9e05c52164694d is starting a new election at term 41\n","stream":"stderr","time":"2021-07-26T08:04:31.710341969Z "}
{"log":"raft2021/07/26 08:04:31 INFO: 8e9e05c52164694d became candidate at term 42\n","stream":"stderr","time":"2021-07-26T08:04:31.710379239Z"}
{"log":"raft2021/07/26 08:04:31 INFO: 8e9e05c52164694d received MsgVoteResp from 8e9e05c52164694d at term 42\n","stream":"stderr","time":"2021-07-26T08: 04:31.710384439Z"}
{"log":"raft2021/07/26 08:04:31 INFO: 8e9e05c52164694d became leader at term 42\n","stream":"stderr","time":"2021-07-26T08:04:31.710388359Z"}
{"log":"raft2021/07/26 08:04:31 INFO: raft.node: 8e9e05c52164694d elected leader 8e9e05c52164694d at term 42\n","stream":"stderr","time":"2021-07-26T08: 04:31.710409959Z"}
{"log":"2021-07-26 08:04:31.711637 I | embed: ready to serve client requests\n","stream":"stderr","time":"2021-07-26T08:04:31.711730066Z"}
{"log":"2021-07-26 08:04:31.711662 I | etcdserver: published {Name:default ClientURLs:[http://localhost:2379]} to cluster cdf818194e3a8c32\n","stream":" stderr","time":"2021-07-26T08:04:31.711759436Z"}
{"log":"2021-07-26 08:04:31.712060 N | embed: serving insecure client requests on 127.0.0.1:2379, this is strongly discouraged!\n","stream":"stderr","ti me":"2021-07-26T08:04:31.712140615Z"}
{"log":"2021/07/26 08:04:31 [INFO] Waiting for server to become available: Get \"https://127.0.0.1:6443/version?timeout=15m0s\": dial tcp 127.0.0.1:6443 : connect: connection refused\n","stream":"stdout","time":"2021-07-26T08:04:31.725692159Z"}
{"log":"time=\"2021-07-26T08:04:31.915805460Z\" level=info msg=\"Starting k3s v1.19.8+k3s1 (95fc76b2)\"\n","stream":"stderr","time":"2021-07-26T08:04:31 .915955559Z"}
{"log":"time=\"2021-07-26T08:04:31.916015069Z\" level=info msg=\"Cluster bootstrap already complete\"\n","stream":"stderr","time":"2021-07-26T08:04:31.9 16098199Z"}
{"log":"time=\"2021-07-26T08:04:31.931111369Z\" level=info msg=\"Running kube-apiserver --advertise-port=6443 --allow-privileged=true --anonymous-auth=f alse --api-audiences=unknown --authorization-mode=Node,RBAC --bind-address=127.0.0.1 --cert-dir=/var/lib/rancher/k3s/server/tls/temporary-certs --client -ca-file=/var/lib/rancher/k3s/server/tls/client-ca.crt --enable-admission-plugins=NodeRestriction --etcd-servers=http://localhost:2379 --insecure-port=0 --kubelet-certificate-authority=/var/lib/rancher/k3s/server/tls/server-ca.crt --kubelet-client-certificate=/var/lib/rancher/k3s/server/tls/client-kube- apiserver.crt --kubelet-client-key=/var/lib/rancher/k3s/server/tls/client-kube-apiserver.key --profiling=false --proxy-client-cert-file=/var/lib/rancher /k3s/server/tls/client-auth-proxy.crt --proxy-client-key-file=/var/lib/rancher/k3s/server/tls/client-auth-proxy.key --requestheader-allowed-names=system :auth-proxy --requestheader-client-ca-file=/var/lib/rancher/k3s/server/tls/request-header-ca.crt --requestheader-extra-headers-prefix=X-Remote-Extra- -- requestheader-group-headers=X-Remote-Group --requestheader-username-headers=X-Remote-User --secure-port=6444 --service-account-issuer=k3s --service-acco unt-key-file=/var/lib/rancher/k3s/server/tls/service.key --service-account-signing-key-file=/var/lib/rancher/k3s/server/tls/service.key --service-cluste r-ip-range=10.43.0.0/16 --storage-backend=etcd3 --tls-cert-file=/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.crt --tls-private-key-file=/var/l ib/rancher/k3s/server/tls/serving-kube-apiserver.key\"\n","stream":"stderr","time":"2021-07-26T08:04:31.931284239Z"}
{"log":"I0726 08:04:31.932199 35 server.go:652] external host was not specified, using 172.17.0.2\n","stream":"stderr","time":"2021-07-26T08:04:31. 932287647Z"}
{"log":"I0726 08:04:31.932475 35 server.go:177] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:31.932547356Z"}
{"log":"I0726 08:04:31.937266 35 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:04:31.937332353Z"}
{"log":"I0726 08:04:31.937285 35 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:04:31.937340253Z"}
{"log":"I0726 08:04:31.938337 35 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:04:31.93840229Z"}
{"log":"I0726 08:04:31.938352 35 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:04:31.93843468Z"}
{"log":"I0726 08:04:31.965142 35 master.go:271] Using reconciler: lease\n","stream":"stderr","time":"2021-07-26T08:04:31.96523164Z"}
{"log":"W0726 08:04:32.231028 35 genericapiserver.go:412] Skipping API batch/v2alpha1 because it has no resources.\n","stream":"stderr","time":"202 1-07-26T08:04:32.231204539Z"}
{"log":"W0726 08:04:32.239840 35 genericapiserver.go:412] Skipping API discovery.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr", "time":"2021-07-26T08:04:32.239949106Z"}
{"log":"W0726 08:04:32.261528 35 genericapiserver.go:412] Skipping API node.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr","time ":"2021-07-26T08:04:32.261668339Z"}
{"log":"W0726 08:04:32.284653 35 genericapiserver.go:412] Skipping API rbac.authorization.k8s.io/v1alpha1 because it has no resources.\n","stream": "stderr","time":"2021-07-26T08:04:32.284792798Z"}
{"log":"W0726 08:04:32.288661 35 genericapiserver.go:412] Skipping API scheduling.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr" ,"time":"2021-07-26T08:04:32.288732237Z"}
{"log":"W0726 08:04:32.303950 35 genericapiserver.go:412] Skipping API storage.k8s.io/v1alpha1 because it has no resources.\n","stream":"stderr","t ime":"2021-07-26T08:04:32.304021897Z"}
{"log":"W0726 08:04:32.319281 35 genericapiserver.go:412] Skipping API apps/v1beta2 because it has no resources.\n","stream":"stderr","time":"2021- 07-26T08:04:32.319350147Z"}
{"log":"W0726 08:04:32.319296 35 genericapiserver.go:412] Skipping API apps/v1beta1 because it has no resources.\n","stream":"stderr","time":"2021- 07-26T08:04:32.319355417Z"}
{"log":"I0726 08:04:32.325545 35 plugins.go:158] Loaded 12 mutating admission controller(s) successfully in the following order: NamespaceLifecycle ,LimitRanger,ServiceAccount,NodeRestriction,TaintNodesByCondition,Priority,DefaultTolerationSeconds,DefaultStorageClass,StorageObjectInUseProtection,Run timeClass,DefaultIngressClass,MutatingAdmissionWebhook.\n","stream":"stderr","time":"2021-07-26T08:04:32.32562436Z"}
{"log":"I0726 08:04:32.325561 35 plugins.go:161] Loaded 10 validating admission controller(s) successfully in the following order: LimitRanger,Serv iceAccount,Priority,PersistentVolumeClaimResize,RuntimeClass,CertificateApproval,CertificateSigning,CertificateSubjectRestriction,ValidatingAdmissionWeb hook,ResourceQuota.\n","stream":"stderr","time":"2021-07-26T08:04:32.32564355Z"}
{"log":"time=\"2021-07-26T08:04:32.334822597Z\" level=info msg=\"Running kube-scheduler --address=127.0.0.1 --bind-address=127.0.0.1 --kubeconfig=/var/l ib/rancher/k3s/server/cred/scheduler.kubeconfig --port=10251 --profiling=false --secure-port=0\"\n","stream":"stderr","time":"2021-07-26T08:04:32.334928 386Z"}
{"log":"time=\"2021-07-26T08:04:32.334919506Z\" level=info msg=\"Waiting for API server to become available\"\n","stream":"stderr","time":"2021-07-26T08 :04:32.334984566Z"}
{"log":"I0726 08:04:32.335201 35 registry.go:173] Registering SelectorSpread plugin\n","stream":"stderr","time":"2021-07-26T08:04:32.335287745Z"}
{"log":"I0726 08:04:32.335221 35 registry.go:173] Registering SelectorSpread plugin\n","stream":"stderr","time":"2021-07-26T08:04:32.335306255Z"}
{"log":"time=\"2021-07-26T08:04:32.335583294Z\" level=info msg=\"Running kube-controller-manager --address=127.0.0.1 --allocate-node-cidrs=true --bind-a ddress=127.0.0.1 --cluster-cidr=10.42.0.0/16 --cluster-signing-cert-file=/var/lib/rancher/k3s/server/tls/client-ca.crt --cluster-signing-key-file=/var/l ib/rancher/k3s/server/tls/client-ca.key --kubeconfig=/var/lib/rancher/k3s/server/cred/controller.kubeconfig --port=10252 --profiling=false --root-ca-fil e=/var/lib/rancher/k3s/server/tls/server-ca.crt --secure-port=0 --service-account-private-key-file=/var/lib/rancher/k3s/server/tls/service.key --use-ser vice-account-credentials=true\"\n","stream":"stderr","time":"2021-07-26T08:04:32.335673364Z"}
{"log":"time=\"2021-07-26T08:04:32.337074930Z\" level=info msg=\"Node token is available at /var/lib/rancher/k3s/server/token\"\n","stream":"stderr","ti me":"2021-07-26T08:04:32.33716291Z"}
{"log":"time=\"2021-07-26T08:04:32.337104660Z\" level=info msg=\"To join node to cluster: k3s agent -s https://172.17.0.2:6443 -t ${NODE_TOKEN}\"\n","st ream":"stderr","time":"2021-07-26T08:04:32.33717691Z"}
{"log":"time=\"2021-07-26T08:04:32.338245797Z\" level=info msg=\"Wrote kubeconfig /etc/rancher/k3s/k3s.yaml\"\n","stream":"stderr","time":"2021-07-26T08 :04:32.338320237Z"}
{"log":"time=\"2021-07-26T08:04:32.338275647Z\" level=info msg=\"Run: k3s kubectl\"\n","stream":"stderr","time":"2021-07-26T08:04:32.338332828Z"}
{"log":"time=\"2021-07-26T08:04:32.338398887Z\" level=info msg=\"Module overlay was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04:32.33 8482117Z"}
{"log":"time=\"2021-07-26T08:04:32.338426137Z\" level=info msg=\"Module nf_conntrack was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04: 32.338492407Z"}
{"log":"time=\"2021-07-26T08:04:32.338442207Z\" level=info msg=\"Module br_netfilter was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04: 32.338498187Z"}
{"log":"time=\"2021-07-26T08:04:32.338457947Z\" level=info msg=\"Module iptable_nat was already loaded\"\n","stream":"stderr","time":"2021-07-26T08:04:3 2.338518317Z"}
{"log":"time=\"2021-07-26T08:04:32.350037527Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:32 http: TLS handshake error from 127.0.0.1:57174: remote error: tls: bad certificate\"\n","stream":"stderr","time":"2021-07-26T08:04:32.350158336Z"}
{"log":"time=\"2021-07-26T08:04:32.354637274Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:32 http: TLS handshake error from 127.0.0.1:57180: remote error: tls: bad certificate\"\n","stream":"stderr","time":"2021-07-26T08:04:32.354749944Z"}
{"log":"time=\"2021-07-26T08:04:32.365563775Z\" level=info msg=\"certificate CN=local-node signed by CN=k3s-server-ca@1627286228: notBefore=2021-07-26 0 7:57:08 +0000 UTC notAfter=2022-07-26 08:04:32 +0000 UTC\"\n","stream":"stderr","time":"2021-07-26T08:04:32.365672975Z"}
{"log":"time=\"2021-07-26T08:04:32.368480507Z\" level=info msg=\"certificate CN=system:node:local-node,O=system:nodes signed by CN=k3s-client-ca@1627286 228: notBefore=2021-07-26 07:57:08 +0000 UTC notAfter=2022-07-26 08:04:32 +0000 UTC\"\n","stream":"stderr","time":"2021-07-26T08:04:32.368587017Z"}
{"log":"time=\"2021-07-26T08:04:32.374623451Z\" level=info msg=\"Logging containerd to /var/lib/rancher/k3s/agent/containerd/containerd.log\"\n","stream ":"stderr","time":"2021-07-26T08:04:32.374689161Z"}
{"log":"time=\"2021-07-26T08:04:32.374739741Z\" level=info msg=\"Running containerd -c /var/lib/rancher/k3s/agent/etc/containerd/config.toml -a /run/k3s /containerd/containerd.sock --state /run/k3s/containerd --root /var/lib/rancher/k3s/agent/containerd\"\n","stream":"stderr","time":"2021-07-26T08:04:32. 374789941Z"}
{"log":"time=\"2021-07-26T08:04:33.376359060Z\" level=info msg=\"Containerd is now running\"\n","stream":"stderr","time":"2021-07-26T08:04:33.37650459Z" }
{"log":"time=\"2021-07-26T08:04:33.381637446Z\" level=info msg=\"Connecting to proxy\" url=\"wss://127.0.0.1:6443/v1-k3s/connect\"\n","stream":"stderr", "time":"2021-07-26T08:04:33.381743345Z"}
{"log":"time=\"2021-07-26T08:04:33.383749871Z\" level=info msg=\"Handling backend connection request [local-node]\"\n","stream":"stderr","time":"2021-07 -26T08:04:33.38383235Z"}
{"log":"time=\"2021-07-26T08:04:33.384204289Z\" level=warning msg=\"Disabling CPU quotas due to missing cpu.cfs_period_us\"\n","stream":"stderr","time": "2021-07-26T08:04:33.384280149Z"}
{"log":"time=\"2021-07-26T08:04:33.384256499Z\" level=info msg=\"Running kubelet --address=0.0.0.0 --anonymous-auth=false --authentication-token-webhook =true --authorization-mode=Webhook --cgroup-driver=cgroupfs --client-ca-file=/var/lib/rancher/k3s/agent/client-ca.crt --cloud-provider=external --cluste r-dns=10.43.0.10 --cluster-domain=cluster.local --cni-bin-dir=/var/lib/rancher/k3s/data/ab1b521f47b3cbc273e0c667521084cff1ea3540d55b425ac7ed30c27daf92f8 /bin --cni-conf-dir=/var/lib/rancher/k3s/agent/etc/cni/net.d --container-runtime-endpoint=/run/k3s/containerd/containerd.sock --container-runtime=remote --containerd=/run/k3s/containerd/containerd.sock --cpu-cfs-quota=false --eviction-hard=imagefs.available\u003c5%,nodefs.available\u003c5% --eviction-mi nimum-reclaim=imagefs.available=10%,nodefs.available=10% --fail-swap-on=false --healthz-bind-address=127.0.0.1 --hostname-override=local-node --kubeconf ig=/var/lib/rancher/k3s/agent/kubelet.kubeconfig --kubelet-cgroups=/k3s --node-labels= --pod-manifest-path=/var/lib/rancher/k3s/agent/pod-manifests --re ad-only-port=0 --resolv-conf=/etc/resolv.conf --runtime-cgroups=/k3s --serialize-image-pulls=false --tls-cert-file=/var/lib/rancher/k3s/agent/serving-ku belet.crt --tls-private-key-file=/var/lib/rancher/k3s/agent/serving-kubelet.key\"\n","stream":"stderr","time":"2021-07-26T08:04:33.384372349Z"}
{"log":"time=\"2021-07-26T08:04:33.384891797Z\" level=info msg=\"Running kube-proxy --cluster-cidr=10.42.0.0/16 --healthz-bind-address=127.0.0.1 --hostn ame-override=local-node --kubeconfig=/var/lib/rancher/k3s/agent/kubeproxy.kubeconfig --proxy-mode=iptables\"\n","stream":"stderr","time":"2021-07-26T08: 04:33.384969367Z"}
{"log":"Flag --cloud-provider has been deprecated, will be removed in 1.23, in favor of removing cloud provider code from Kubelet.\n","stream":"stderr", "time":"2021-07-26T08:04:33.385069747Z"}
{"log":"Flag --containerd has been deprecated, This is a cadvisor flag that was mistakenly registered with the Kubelet. Due to legacy concerns, it will follow the standard CLI deprecation timeline before being removed.\n","stream":"stderr","time":"2021-07-26T08:04:33.385076317Z"}
{"log":"W0726 08:04:33.385170 35 server.go:226] WARNING: all flags other than --config, --write-config-to, and --cleanup are deprecated. Please beg in using a config file ASAP.\n","stream":"stderr","time":"2021-07-26T08:04:33.385244186Z"}
{"log":"I0726 08:04:33.385563 35 server.go:407] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:33.385635385Z"}
{"log":"W0726 08:04:33.385760 35 proxier.go:639] Failed to read file /lib/modules/4.15.0-151-generic/modules.builtin with error open /lib/modules/4 .15.0-151-generic/modules.builtin: no such file or directory. You can ignore this message when kube-proxy is running inside container without mounting / lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:33.385811285Z"}
{"log":"W0726 08:04:33.386220 35 proxier.go:649] Failed to load kernel module ip_vs with modprobe. You can ignore this message when kube-proxy is r unning inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:33.386272723Z"}
{"log":"W0726 08:04:33.386566 35 proxier.go:649] Failed to load kernel module ip_vs_rr with modprobe. You can ignore this message when kube-proxy i s running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:33.386620352Z"}
{"log":"W0726 08:04:33.386850 35 proxier.go:649] Failed to load kernel module ip_vs_wrr with modprobe. You can ignore this message when kube-proxy is running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:33.386882892Z"}
{"log":"W0726 08:04:33.387075 35 proxier.go:649] Failed to load kernel module ip_vs_sh with modprobe. You can ignore this message when kube-proxy i s running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:33.387104371Z"}
{"log":"W0726 08:04:33.387374 35 proxier.go:649] Failed to load kernel module nf_conntrack_ipv4 with modprobe. You can ignore this message when kub e-proxy is running inside container without mounting /lib/modules\n","stream":"stderr","time":"2021-07-26T08:04:33.387400511Z"}
{"log":"E0726 08:04:33.391718 35 node.go:125] Failed to retrieve node info: nodes \"local-node\" is forbidden: User \"system:kube-proxy\" cannot ge t resource \"nodes\" in API group \"\" at the cluster scope\n","stream":"stderr","time":"2021-07-26T08:04:33.391765859Z"}
{"log":"time=\"2021-07-26T08:04:33.392978926Z\" level=info msg=\"Waiting for node local-node CIDR not assigned yet\"\n","stream":"stderr","time":"2021-0 7-26T08:04:33.393013996Z"}
{"log":"I0726 08:04:33.406223 35 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/agent/client-ca.crt\n","stream":"st derr","time":"2021-07-26T08:04:33.406270771Z"}
{"log":"I0726 08:04:33.545674 35 dynamic_cafile_content.go:167] Starting request-header::/var/lib/rancher/k3s/server/tls/request-header-ca.crt\n"," stream":"stderr","time":"2021-07-26T08:04:33.545746292Z"}
{"log":"I0726 08:04:33.545674 35 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/server/tls/client-ca.crt\n","stream ":"stderr","time":"2021-07-26T08:04:33.545761442Z"}
{"log":"I0726 08:04:33.545799 35 dynamic_serving_content.go:130] Starting serving-cert::/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.crt: :/var/lib/rancher/k3s/server/tls/serving-kube-apiserver.key\n","stream":"stderr","time":"2021-07-26T08:04:33.545887262Z"}
{"log":"I0726 08:04:33.546003 35 secure_serving.go:197] Serving securely on 127.0.0.1:6444\n","stream":"stderr","time":"2021-07-26T08:04:33.5460566 51Z"}
{"log":"I0726 08:04:33.546025 35 tlsconfig.go:240] Starting DynamicServingCertificateController\n","stream":"stderr","time":"2021-07-26T08:04:33.54 6102621Z"}
{"log":"I0726 08:04:33.546039 35 dynamic_serving_content.go:130] Starting aggregator-proxy-cert::/var/lib/rancher/k3s/server/tls/client-auth-proxy. crt::/var/lib/rancher/k3s/server/tls/client-auth-proxy.key\n","stream":"stderr","time":"2021-07-26T08:04:33.546109141Z"}
{"log":"I0726 08:04:33.546061 35 controller.go:83] Starting OpenAPI AggregationController\n","stream":"stderr","time":"2021-07-26T08:04:33.54611325 1Z"}
{"log":"I0726 08:04:33.546091 35 customresource_discovery_controller.go:209] Starting DiscoveryController\n","stream":"stderr","time":"2021-07-26T0 8:04:33.546132071Z"}
{"log":"I0726 08:04:33.546405 35 apiservice_controller.go:97] Starting APIServiceRegistrationController\n","stream":"stderr","time":"2021-07-26T08: 04:33.5464457Z"}
{"log":"I0726 08:04:33.546423 35 cache.go:32] Waiting for caches to sync for APIServiceRegistrationController controller\n","stream":"stderr","time ":"2021-07-26T08:04:33.54645272Z"}
{"log":"I0726 08:04:33.546443 35 available_controller.go:475] Starting AvailableConditionController\n","stream":"stderr","time":"2021-07-26T08:04:3 3.54648105Z"}
{"log":"I0726 08:04:33.546447 35 cache.go:32] Waiting for caches to sync for AvailableConditionController controller\n","stream":"stderr","time":"2 021-07-26T08:04:33.54648587Z"}
{"log":"I0726 08:04:33.547959 35 cluster_authentication_trust_controller.go:440] Starting cluster_authentication_trust_controller controller\n","st ream":"stderr","time":"2021-07-26T08:04:33.547998166Z"}
{"log":"I0726 08:04:33.547975 35 shared_informer.go:240] Waiting for caches to sync for cluster_authentication_trust_controller\n","stream":"stderr ","time":"2021-07-26T08:04:33.548006736Z"}
{"log":"I0726 08:04:33.547999 35 autoregister_controller.go:141] Starting autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04:33. 548034306Z"}
{"log":"I0726 08:04:33.548002 35 cache.go:32] Waiting for caches to sync for autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04: 33.548039216Z"}
{"log":"I0726 08:04:33.548040 35 controller.go:86] Starting OpenAPI controller\n","stream":"stderr","time":"2021-07-26T08:04:33.548056826Z"}
{"log":"I0726 08:04:33.548052 35 naming_controller.go:291] Starting NamingConditionController\n","stream":"stderr","time":"2021-07-26T08:04:33.5480 97736Z"}
{"log":"I0726 08:04:33.548063 35 establishing_controller.go:76] Starting EstablishingController\n","stream":"stderr","time":"2021-07-26T08:04:33.54 8102676Z"}
{"log":"I0726 08:04:33.548077 35 nonstructuralschema_controller.go:186] Starting NonStructuralSchemaConditionController\n","stream":"stderr","time" :"2021-07-26T08:04:33.548106196Z"}
{"log":"I0726 08:04:33.548090 35 apiapproval_controller.go:186] Starting KubernetesAPIApprovalPolicyConformantConditionController\n","stream":"stde rr","time":"2021-07-26T08:04:33.548131176Z"}
{"log":"I0726 08:04:33.548102 35 crd_finalizer.go:266] Starting CRDFinalizer\n","stream":"stderr","time":"2021-07-26T08:04:33.548135876Z"}
{"log":"I0726 08:04:33.548149 35 dynamic_cafile_content.go:167] Starting client-ca-bundle::/var/lib/rancher/k3s/server/tls/client-ca.crt\n","stream ":"stderr","time":"2021-07-26T08:04:33.548176876Z"}
{"log":"I0726 08:04:33.548169 35 dynamic_cafile_content.go:167] Starting request-header::/var/lib/rancher/k3s/server/tls/request-header-ca.crt\n"," stream":"stderr","time":"2021-07-26T08:04:33.548214686Z"}
{"log":"I0726 08:04:33.548414 35 crdregistration_controller.go:111] Starting crd-autoregister controller\n","stream":"stderr","time":"2021-07-26T08 :04:33.548449705Z"}
{"log":"I0726 08:04:33.548427 35 shared_informer.go:240] Waiting for caches to sync for crd-autoregister\n","stream":"stderr","time":"2021-07-26T08 :04:33.548456235Z"}
{"log":"time=\"2021-07-26T08:04:33.551191368Z\" level=info msg=\"Running cloud-controller-manager --allocate-node-cidrs=true --allow-untagged-cloud=true --bind-address=127.0.0.1 --cloud-provider=k3s --cluster-cidr=10.42.0.0/16 --kubeconfig=/var/lib/rancher/k3s/server/cred/cloud-controller.kubeconfig --n ode-status-update-frequency=1m --profiling=false --secure-port=0\"\n","stream":"stderr","time":"2021-07-26T08:04:33.551291848Z"}
{"log":"Flag --allow-untagged-cloud has been deprecated, This flag is deprecated and will be removed in a future release. A cluster-id will be required on cloud instances.\n","stream":"stderr","time":"2021-07-26T08:04:33.551309738Z"}
{"log":"I0726 08:04:33.553024 35 controllermanager.go:127] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:33.553087973Z"}
{"log":"W0726 08:04:33.553037 35 controllermanager.go:139] detected a cluster without a ClusterID. A ClusterID will be required in the future. Pl ease tag your cluster to avoid any future issues\n","stream":"stderr","time":"2021-07-26T08:04:33.553100263Z"}
{"log":"I0726 08:04:33.553060 35 leaderelection.go:243] attempting to acquire leader lease kube-system/cloud-controller-manager...\n","stream":"st derr","time":"2021-07-26T08:04:33.553104623Z"}
{"log":"E0726 08:04:33.565666 35 controller.go:156] Unable to remove old endpoints from kubernetes service: no master IPs were listed in storage, r efusing to erase all endpoints for the kubernetes service\n","stream":"stderr","time":"2021-07-26T08:04:33.565764029Z"}
{"log":"I0726 08:04:33.646560 35 cache.go:39] Caches are synced for AvailableConditionController controller\n","stream":"stderr","time":"2021-07-26 T08:04:33.646688716Z"}
{"log":"I0726 08:04:33.646578 35 cache.go:39] Caches are synced for APIServiceRegistrationController controller\n","stream":"stderr","time":"2021-0 7-26T08:04:33.646712986Z"}
{"log":"I0726 08:04:33.648123 35 cache.go:39] Caches are synced for autoregister controller\n","stream":"stderr","time":"2021-07-26T08:04:33.648207 332Z"}
{"log":"I0726 08:04:33.648152 35 shared_informer.go:247] Caches are synced for cluster_authentication_trust_controller \n","stream":"stderr","time" :"2021-07-26T08:04:33.64894508Z"}
{"log":"I0726 08:04:33.650420 35 shared_informer.go:247] Caches are synced for crd-autoregister \n","stream":"stderr","time":"2021-07-26T08:04:33.6 50495816Z"}
{"log":"W0726 08:04:33.741181 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:33.741301226Z"}
{"log":"W0726 08:04:33.758915 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:33.759023759Z"}
{"log":"W0726 08:04:33.777072 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:33.777175651Z"}
{"log":"W0726 08:04:33.836101 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:33.836231356Z"}
{"log":"W0726 08:04:33.851429 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:33.851539795Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting API controllers\n","stream":"stdout","time":"2021-07-26T08:04:34.132460863Z"}
{"log":"time=\"2021-07-26T08:04:34.256828803Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:34 http: TLS handshake error from 127.0.0.1:57368: EOF\"\n","stream":"stderr","time":"2021-07-26T08:04:34.256942623Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting management.cattle.io/v3, Kind=User controller\n","stream":"stdout","time":"2021-07-26T08:04:34.260898572Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting management.cattle.io/v3, Kind=Group controller\n","stream":"stdout","time":"2021-07-26T08:04:34.260908202Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting management.cattle.io/v3, Kind=UserAttribute controller\n","stream":"stdout","time":"2021-07-26T08:04:34.2609 10512Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting management.cattle.io/v3, Kind=Token controller\n","stream":"stdout","time":"2021-07-26T08:04:34.261040372Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting /v1, Kind=Secret controller\n","stream":"stdout","time":"2021-07-26T08:04:34.261209541Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting management.cattle.io/v3, Kind=GroupMember controller\n","stream":"stdout","time":"2021-07-26T08:04:34.261320 042Z"}
{"log":"W0726 08:04:34.281119 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:34.281228209Z"}
{"log":"W0726 08:04:34.286527 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:34.286624075Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting /v1, Kind=Secret controller\n","stream":"stdout","time":"2021-07-26T08:04:34.385828752Z"}
{"log":"I0726 08:04:34.385869 8 leaderelection.go:243] attempting to acquire leader lease kube-system/cattle-controllers...\n","stream":"stderr"," time":"2021-07-26T08:04:34.385938822Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting management.cattle.io/v3, Kind=Feature controller\n","stream":"stdout","time":"2021-07-26T08:04:34.385961972Z "}
{"log":"2021/07/26 08:04:34 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=Role controller\n","stream":"stdout","time":"2021-07-26T08:04:34.38609704 1Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=ClusterRole controller\n","stream":"stdout","time":"2021-07-26T08:04:34.3 86277761Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting catalog.cattle.io/v1, Kind=ClusterRepo controller\n","stream":"stdout","time":"2021-07-26T08:04:34.3864859Z" }
{"log":"2021/07/26 08:04:34 [INFO] Starting management.cattle.io/v3, Kind=Preference controller\n","stream":"stdout","time":"2021-07-26T08:04:34.3865849 1Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=ClusterRoleBinding controller\n","stream":"stdout","time":"2021-07-26T08: 04:34.386685861Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting apiextensions.k8s.io/v1beta1, Kind=CustomResourceDefinition controller\n","stream":"stdout","time":"2021-07- 26T08:04:34.38685865Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting apiregistration.k8s.io/v1, Kind=APIService controller\n","stream":"stdout","time":"2021-07-26T08:04:34.39432 641Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting management.cattle.io/v3, Kind=Setting controller\n","stream":"stdout","time":"2021-07-26T08:04:34.39451673Z" }
{"log":"2021/07/26 08:04:34 [INFO] Starting rbac.authorization.k8s.io/v1, Kind=RoleBinding controller\n","stream":"stdout","time":"2021-07-26T08:04:34.3 94715479Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting /v1, Kind=ConfigMap controller\n","stream":"stdout","time":"2021-07-26T08:04:34.394844509Z"}
{"log":"time=\"2021-07-26T08:04:34.395093178Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:34 http: TLS handshake error from 127.0.0.1:57432: EOF\"\n","stream":"stderr","time":"2021-07-26T08:04:34.395203378Z"}
{"log":"time=\"2021-07-26T08:04:34.395445117Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:34 http: TLS handshake error from 127.0.0.1:57428: EOF\"\n","stream":"stderr","time":"2021-07-26T08:04:34.395540727Z"}
{"log":"time=\"2021-07-26T08:04:34.395899536Z\" level=info msg=\"Cluster-Http-Server 2021/07/26 08:04:34 http: TLS handshake error from 127.0.0.1:57430: EOF\"\n","stream":"stderr","time":"2021-07-26T08:04:34.395983576Z"}
{"log":"2021/07/26 08:04:34 [INFO] Starting management.cattle.io/v3, Kind=Cluster controller\n","stream":"stdout","time":"2021-07-26T08:04:34.401340231Z "}
{"log":"W0726 08:04:34.412609 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:34.412717781Z"}
{"log":"I0726 08:04:34.417677 8 leaderelection.go:253] successfully acquired lease kube-system/cattle-controllers\n","stream":"stderr","time":"202 1-07-26T08:04:34.417775748Z"}
{"log":"W0726 08:04:34.428918 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:34.429016288Z"}
{"log":"W0726 08:04:34.439903 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:34.439981169Z"}
{"log":"2021/07/26 08:04:34 [INFO] Running in single server mode, will not peer connections\n","stream":"stdout","time":"2021-07-26T08:04:34.442493422Z" }
{"log":"W0726 08:04:34.452809 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:34.452892325Z"}
{"log":"W0726 08:04:34.453145 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:34.453238154Z"}
{"log":"W0726 08:04:34.465417 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:34.465508441Z"}
{"log":"W0726 08:04:34.465604 8 warnings.go:80] apiextensions.k8s.io/v1beta1 CustomResourceDefinition is deprecated in v1.16+, unavailable in v1.2 2+; use apiextensions.k8s.io/v1 CustomResourceDefinition\n","stream":"stderr","time":"2021-07-26T08:04:34.465683921Z"}
{"log":"2021/07/26 08:04:34 [INFO] Steve auth startup complete\n","stream":"stdout","time":"2021-07-26T08:04:34.475702365Z"}
{"log":"I0726 08:04:34.534234 35 node.go:136] Successfully retrieved node IP: 172.17.0.2\n","stream":"stderr","time":"2021-07-26T08:04:34.534318169 Z"}
{"log":"I0726 08:04:34.534253 35 server_others.go:143] kube-proxy node IP is an IPv4 address (172.17.0.2), assume IPv4 operation\n","stream":"stder r","time":"2021-07-26T08:04:34.534344329Z"}
{"log":"I0726 08:04:34.534730 35 server_others.go:186] Using iptables Proxier.\n","stream":"stderr","time":"2021-07-26T08:04:34.534786558Z"}
{"log":"I0726 08:04:34.534837 35 server.go:650] Version: v1.19.8+k3s1\n","stream":"stderr","time":"2021-07-26T08:04:34.534909738Z"}
{"log":"I0726 08:04:34.535014 35 conntrack.go:103] Set sysctl 'net/netfilter/nf_conntrack_max' to 196608\n","stream":"stderr","time":"2021-07-26T08 :04:34.535052008Z"}
{"log":"F0726 08:04:34.535045 35 server.go:495] open /proc/sys/net/netfilter/nf_conntrack_max: permission denied\n","stream":"stderr","time":"2021- 07-26T08:04:34.535088598Z"}
{"log":"W0726 08:04:34.543870 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ClusterRepo ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.543944274Z"}
{"log":"W0726 08:04:34.543902 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1beta1.CustomResourceDefinition ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexp ected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.543961354Z"}
{"log":"W0726 08:04:34.543921 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Setting ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wa tch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544004494Z"}
{"log":"W0726 08:04:34.543949 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.APIService ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544010994Z"}
{"log":"W0726 08:04:34.544048 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ClusterRoleBinding ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544083154Z"}
{"log":"W0726 08:04:34.544053 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.ClusterRole ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544090094Z"}
{"log":"W0726 08:04:34.544126 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.Role ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544205203Z"}
{"log":"W0726 08:04:34.544144 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Preference ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544225703Z"}
{"log":"W0726 08:04:34.544194 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Cluster ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wa tch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544268923Z"}
{"log":"W0726 08:04:34.544196 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Feature ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wa tch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544275383Z"}
{"log":"W0726 08:04:34.544281 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.RoleBinding ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544339263Z"}
{"log":"W0726 08:04:34.544323 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.GroupMember ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544353143Z"}
{"log":"W0726 08:04:34.544397 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.UserAttribute ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch clos e - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544444073Z"}
{"log":"W0726 08:04:34.544417 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Token ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watc h lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544451953Z"}
{"log":"W0726 08:04:34.544434 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.Secret ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wat ch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544490403Z"}
{"log":"W0726 08:04:34.544478 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.User ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544548232Z"}
{"log":"W0726 08:04:34.544495 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 1.Secret ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - wat ch lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544570812Z"}
{"log":"W0726 08:04:34.544578 8 reflector.go:437] pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: watch of *v 3.Group ended with: very short watch: pkg/mod/github.com/rancher/client-go@v1.20.0-rancher.1/tools/cache/reflector.go:168: Unexpected watch close - watc h lasted less than a second and no items received\n","stream":"stderr","time":"2021-07-26T08:04:34.544636932Z"}
{"log":"2021/07/26 08:04:34 [FATAL] k3s exited with: exit status 1\n","stream":"stdout","time":"2021-07-26T08:04:34.544962311Z"}
{"log":"2021/07/26 08:04:35 [INFO] Rancher version v2.5.9 (3c5418944) is starting\n","stream":"stdout","time":"2021-07-26T08:04:35.356175004Z"}
{"log":"2021/07/26 08:04:35 [INFO] Listening on /tmp/log.sock\n","stream":"stdout","time":"2021-07-26T08:04:35.356204744Z"}
{"log":"2021/07/26 08:04:35 [INFO] Rancher arguments {ACMEDomains:[] AddLocal:true Embedded:false BindHost: HTTPListenPort:80 HTTPSListenPort:443 K8sMod e:auto Debug:false Trace:false NoCACerts:false AuditLogPath:/var/log/auditlog/rancher-api-audit.log AuditLogMaxage:10 AuditLogMaxsize:100 AuditLogMaxbac kup:10 AuditLevel:0 Agent:false Features: ClusterRegistry:}\n","stream":"stdout","time":"2021-07-26T08:04:35.356238574Z"}
{"log":"2021/07/26 08:04:35 [INFO] Running etcd --data-dir=management-state/etcd --heartbeat-interval=500 --election-timeout=5000\n","stream":"stdout"," time":"2021-07-26T08:04:35.356604453Z"}
{"log":"2021-07-26 08:04:35.365051 W | pkg/flags: unrecognized environment variable ETCD_URL_arm64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-arm64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:04:35.3651924Z"}
{"log":"2021-07-26 08:04:35.365079 W | pkg/flags: unrecognized environment variable ETCD_URL_amd64=https://github.com/etcd-io/etcd/releases/download/v3. 4.3/etcd-v3.4.3-linux-amd64.tar.gz\n","stream":"stderr","time":"2021-07-26T08:04:35.365223099Z"}
{"log":"2021-07-26 08:04:35.365084 W | pkg/flags: unrecognized environment variable ETCD_UNSUPPORTED_ARCH=amd64\n","stream":"stderr","time":"2021-07-26T 08:04:35.365229059Z"}
{"log":"2021-07-26 08:04:35.365090 W | pkg/flags: unrecognized environment variable ETCD_URL=ETCD_URL_amd64\n","stream":"stderr","time":"2021-07-26T08:0 4:35.365233539Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:04:35.365237909 Z"}
{"log":"2021-07-26 08:04:35.365124 I | etcdmain: etcd Version: 3.4.3\n","stream":"stderr","time":"2021-07-26T08:04:35.365242269Z"}
{"log":"2021-07-26 08:04:35.365132 I | etcdmain: Git SHA: 3cf2f69b5\n","stream":"stderr","time":"2021-07-26T08:04:35.365246799Z"}
{"log":"2021-07-26 08:04:35.365136 I | etcdmain: Go Version: go1.12.12\n","stream":"stderr","time":"2021-07-26T08:04:35.365251089Z"}
{"log":"2021-07-26 08:04:35.365139 I | etcdmain: Go OS/Arch: linux/amd64\n","stream":"stderr","time":"2021-07-26T08:04:35.365255309Z"}
{"log":"2021-07-26 08:04:35.365145 I | etcdmain: setting maximum number of CPUs to 6, total number of available CPUs is 6\n","stream":"stderr","time":"2 021-07-26T08:04:35.365259589Z"}
{"log":"2021-07-26 08:04:35.365195 N | etcdmain: the server is already initialized as member before, starting as etcd member...\n","stream":"stderr","ti me":"2021-07-26T08:04:35.365268859Z"}
{"log":"[WARNING] Deprecated '--logger=capnslog' flag is set; use '--logger=zap' flag instead\n","stream":"stderr","time":"2021-07-26T08:04:35.365273859 Z"}
{"log":"2021-07-26 08:04:35.365604 I | embed: name = default\n","stream":"stderr","time":"2021-07-26T08:04:35.365682008Z"}
{"log":"2021-07-26 08:04:35.365630 I | embed: data dir = management-state/etcd\n","stream":"stderr","time":"2021-07-26T08:04:35.365705788Z"}
{"log":"2021-07-26 08:04:35.365635 I | embed: member dir = management-state/etcd/member\n","stream":"stderr","time":"2021-07-26T08:04:35.365711448Z"}
{"log":"2021-07-26 08:04:35.365638 I | embed: heartbeat = 500ms\n","stream":"stderr","time":"2021-07-26T08:04:35.365726468Z"}
{"log":"2021-07-26 08:04:35.365641 I | embed: election = 5000ms\n","stream":"stderr","time":"2021-07-26T08:04:35.365730548Z"}
{"log":"2021-07-26 08:04:35.365645 I | embed: snapshot count = 100000\n","stream":"stderr","time":"2021-07-26T08:04:35.365734338Z"}
{"log":"2021-07-26 08:04:35.365652 I | embed: advertise client URLs = http://localhost:2379\n","stream":"stderr","time":"2021-07-26T08:04:35.365738098Z" }
{"log":"2021-07-26 08:04:35.365656 I | embed: initial advertise peer URLs = http://localhost:2380\n","stream":"stderr","time":"2021-07-26T08:04:35.36574 1868Z"}
{"log":"2021-07-26 08:04:35.365661 I | embed: initial cluster = \n","stream":"stderr","time":"2021-07-26T08:04:35.365745478Z"}
{"log":"2021-07-26 08:04:35.373740 I | etcdserver: restarting member 8e9e05c52164694d in cluster cdf818194e3a8c32 at commit index 1334\n","stream":"stde rr","time":"2021-07-26T08:04:35.373875176Z"}
{"log":"raft2021/07/26 08:04:35 INFO: 8e9e05c52164694d switched to configuration voters=()\n","stream":"stderr","time":"2021-07-26T08:04:35.373984166Z"}
{"log":"raft2021/07/26 08:04:35 INFO: 8e9e05c52164694d became follower at term 42\n","stream":"stderr","time":"2021-07-26T08:04:35.373988186Z"}
{"log":"raft2021/07/26 08:04:35 INFO: newRaft 8e9e05c52164694d [peers: [], term: 42, commit: 1334, applied: 0, lastindex: 1334, lastterm: 42]\n","stream ":"stderr","time":"2021-07-26T08:04:35.373990536Z"}
{"log":"2021-07-26 08:04:35.379247 W | auth: simple token is not cryptographically signed\n","stream":"stderr","time":"2021-07-26T08:04:35.379328352Z"}
{"log":"2021-07-26 08:04:35.380993 I | etcdserver: starting server... [version: 3.4.3, cluster version: to_be_decided]\n","stream":"stderr","time":"2021 -07-26T08:04:35.381066447Z"}
{"log":"raft2021/07/26 08:04:35 INFO: 8e9e05c52164694d switched to configuration voters=(10276657743932975437)\n","stream":"stderr","time":"2021-07-26T0 8:04:35.381474536Z"}
{"log":"2021-07-26 08:04:35.381456 I | etcdserver/membership: added member 8e9e05c52164694d [http://localhost:2380] to cluster cdf818194e3a8c32\n","stre am":"stderr","time":"2021-07-26T08:04:35.381498526Z"}
{"log":"2021-07-26 08:04:35.381557 N | etcdserver/membership: set the initial cluster version to 3.4\n","stream":"stderr","time":"2021-07-26T08:04:35.38 1633226Z"}
{"log":"2021-07-26 08:04:35.381622 I | etcdserver/api: enabled capabilities for version 3.4\n","stream":"stderr","time":"2021-07-26T08:04:35.381674635Z" }
{"log":"2021-07-26 08:04:35.384705 I | embed: listening for peers on 127.0.0.1:2380\n","stream":"stderr","time":"2021-07-26T08:04:35.384804497Z"}
Can confirm. Same issue here. Fresh install of Ubuntu 20.04.2 with docker.io from apt. Running: sudo docker run --privileged -d --restart=unless-stopped -p 80:80 -p 443:443 rancher/rancher = BUSTED. Tested rancher/server, same issue with -p 80:80 -p 443:443 but with -p 8080:8080 I can get the UI to come up just fine. Curl on localhost to localhost will show some error results, but anything to Domain Name or IP = Connection Refused.
:~$ curl -k -v https://localhost
Apparently new users like myself are limited to 2 links in a post. Here is the other output. Yes, this is a fresh install with no ufw installed or running.
:~$ curl -k -v https://198.18.0.50
This is an issue with newer kernels (containing this commit, which was backported into Ubuntu 5.4.0-80) and older k3s versions. Rancher only runs “in” a k8s cluster, so the docker container version runs a copy of k3s inside it to provide that cluster. That version needs to be updated in an upcoming release, or you need a kernel that doesn’t have that change, or install following the helm/HA installation instructions instead of docker run ....
I use this command line :
curl https://releases.rancher.com/install-docker/20.10.sh | sh
on : Rancher Docs: Installing Docker
Do you think I use a wrong version on docker?
It sure would be nice if the quick start guide reflected this or had a warning. The below statements make it appear super easy.
To install and run Rancher, execute the following Docker command on your host:
$ sudo docker run --privileged -d --restart=unless-stopped -p 80:80 -p 443:443 rancher/rancher
I also could not find anything noting these caveats in the support Matrix. The distro I’m using is listed as officially supported.