Skip to content

Instantly share code, notes, and snippets.

@kwilczynski
Created January 22, 2024 16:36
Show Gist options
  • Save kwilczynski/a194305c0b2324aa1d254cccc40da5b3 to your computer and use it in GitHub Desktop.
Save kwilczynski/a194305c0b2324aa1d254cccc40da5b3 to your computer and use it in GitHub Desktop.
kube-system kube-apiserver-master-node kube-apiserver 00000010 75 72 63 65 51 75 6f 74 61 4c 69 73 74 12 0c 0a |urceQuotaList...|
kube-system kube-apiserver-master-node kube-apiserver 00000020 0a 0a 00 12 04 32 38 37 39 1a 00 1a 00 22 00 |.....2879....".|
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037670 1 eventhandlers.go:126] "Add event for unscheduled pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037703 1 scheduling_queue.go:575] "Pod moved to an internal scheduling queue" pod="default/test-cj4n2" event="PodAdd" queue="Active"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037736 1 schedule_one.go:85] "About to try and schedule pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037742 1 schedule_one.go:98] "Attempting to schedule pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037912 1 default_binder.go:53] "Attempting to bind pod to node" pod="default/test-cj4n2" node="worker-node01"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037964 1 request.go:1210] Request Body:
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0d 0a 02 76 31 12 07 42 69 6e 64 |k8s.....v1..Bind|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036129 1 apf_controller.go:1057] plState.quiescing=false, plState.numPending=0, useless=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036207 1 httplog.go:132] "HTTP" verb="POST" URI="/api/v1/namespaces/default/pods" latency="11.947334ms" userAgent="kube-controller-manager/v1.29.0 (linux/amd64) kubernetes/3f7a50f/system:serviceaccount:kube-system:daemon-set-controller" audit-ID="73f7b953-e314-451b-8689-5b4deed5d6c3" srcIP="10.0.0.10:35022" apf_pl="workload-high" apf_fs="kube-system-service-accounts" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="10.883816ms" resp=201
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036363 1 graph_populator.go:77] updatePod default/test-cj4n2, no node
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036396 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036437 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036472 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036558 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-controller-manager-master-node kube-controller-manager I0117 07:18:07.036981 1 event.go:376] "Event occurred" object="default/test" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: test-cj4n2"
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.038565 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.038625 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.040120 1 handler.go:143] kube-apiserver: POST "/api/v1/namespaces/default/events" satisfied by gorestful with webservice /api/v1
kube-system kube-scheduler-master-node kube-scheduler 00000080 00 |.|
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037999 1 round_trippers.go:463] POST https://10.0.0.10:6443/api/v1/namespaces/default/pods/test-cj4n2/binding
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.038015 1 round_trippers.go:469] Request Headers:
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.038020 1 round_trippers.go:473] Content-Type: application/vnd.kubernetes.protobuf
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041535 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041576 1 httplog.go:132] "HTTP" verb="PUT" URI="/apis/apps/v1/namespaces/default/daemonsets/test/status" latency="3.111106ms" userAgent="kube-controller-manager/v1.29.0 (linux/amd64) kubernetes/3f7a50f/system:serviceaccount:kube-system:daemon-set-controller" audit-ID="05f45f6a-8a2e-4963-b5c2-f9bc4733abbf" srcIP="10.0.0.10:35022" apf_pl="workload-high" apf_fs="kube-system-service-accounts" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="2.679023ms" resp=409
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041928 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041972 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041985 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 41 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.67098059ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041993 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 111 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.03514130ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041999 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 57 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=0.95026372ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042005 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 35 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.22282837ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042012 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 18 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.18736564ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042018 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 78 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.19310824ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042030 1 queueset.go:614] QS(workload-high) at t=2024-01-17 07:18:07.042027642 R=2.42372649ss: For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} chose queue 41, with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} & 0 seats in use & nextDispatchR=1.67098059ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042040 1 queueset.go:645] QS(workload-high) at t=2024-01-17 07:18:07.042038512 R=2.42372649ss: initialized queue 41 start R due to request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042065 1 queueset.go:736] QS(workload-high) at t=2024-01-17 07:18:07.042058593 R=2.42372649ss: dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} work {{1 0 0s} 300000 0} from queue 41 with start R 2.42372649ss, queue will have 0 waiting & 1 requests occupying 1 seats, set will have 2 seats occupied
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042075 1 apf_filter.go:169] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042091 1 queueset.go:422] QS(workload-high): Dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} from its queue
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042131 1 handler.go:153] kube-aggregator: POST "/api/v1/namespaces/default/pods/test-cj4n2/binding" satisfied by nonGoRestful
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042137 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-cj4n2/binding" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042148 1 handler.go:143] kube-apiserver: POST "/api/v1/namespaces/default/pods/test-cj4n2/binding" satisfied by gorestful with webservice /api/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042357 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test", Verb:"get", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"", Name:"test", Parts:[]string{"daemonsets", "test"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042395 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test", Verb:"get", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"", Name:"test", Parts:[]string{"daemonsets", "test"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045235 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045311 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045500 1 queueset.go:912] QS(workload-high) at t=2024-01-17 07:18:07.045492119 R=2.42723589ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 41 start R to 2.42716002ss due to service time 0.003433526s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045520 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045548 1 httplog.go:132] "HTTP" verb="POST" URI="/api/v1/namespaces/default/pods/test-cj4n2/binding" latency="4.922121ms" userAgent="kube-scheduler/v1.29.0 (linux/amd64) kubernetes/3f7a50f/scheduler" audit-ID="a48c17dd-51d1-4965-a9a4-475c16ebf995" srcIP="10.0.0.10:47624" apf_pl="workload-high" apf_fs="kube-scheduler" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="3.386328ms" resp=201
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045906 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045970 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046203 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046244 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046433 1 graph_populator.go:89] updatePod default/test-cj4n2 for node worker-node01
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046463 1 graph_populator.go:92] updatePod default/test-cj4n2 for node worker-node01 completed in 16.276µs
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046797 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046851 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.048959 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-k2ggq" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.049477 1 handler.go:143] kube-apiserver: GET "/api/v1/namespaces/default/pods/test-k2ggq" satisfied by gorestful with webservice /api/v1
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051206 1 eventhandlers.go:197] "Add event for scheduled pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051264 1 round_trippers.go:574] Response Status: 201 Created in 13 milliseconds
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051270 1 round_trippers.go:577] Response Headers:
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051289 1 round_trippers.go:580] Content-Length: 48
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051292 1 round_trippers.go:580] Date: Wed, 17 Jan 2024 07:18:07 GMT
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051340 1 eventhandlers.go:171] "Delete event for unscheduled pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051399 1 request.go:1210] Response Body:
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0c 0a 02 76 31 12 06 53 74 61 74 |k8s.....v1..Stat|
kube-system kube-scheduler-master-node kube-scheduler 00000010 75 73 12 18 0a 06 0a 00 12 00 1a 00 12 07 53 75 |us............Su|
kube-system kube-scheduler-master-node kube-scheduler 00000020 63 63 65 73 73 1a 00 22 00 30 c9 01 1a 00 22 00 |ccess..".0....".|
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051503 1 cache.go:389] "Finished binding for pod, can be expired" podKey="c99b01d3-ec57-4c5c-b440-fd1ce6bff033" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051566 1 schedule_one.go:302] "Successfully bound pod to node" pod="default/test-cj4n2" node="worker-node01" evaluatedNodes=1 feasibleNodes=1
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051674 1 request.go:1210] Request Body:
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0b 0a 02 76 31 12 05 45 76 65 6e |k8s.....v1..Even|
kube-system kube-scheduler-master-node kube-scheduler 000000a0 64 22 39 53 75 63 63 65 73 73 66 75 6c 6c 79 20 |d"9Successfully |
kube-system kube-scheduler-master-node kube-scheduler 000000b0 61 73 73 69 67 6e 65 64 20 64 65 66 61 75 6c 74 |assigned default|
kube-system kube-scheduler-master-node kube-scheduler 000000c0 2f 74 65 73 74 2d 63 6a 34 6e 32 20 74 6f 20 77 |/test-cj4n2 to [truncated 475 chars]
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051749 1 round_trippers.go:463] POST https://10.0.0.10:6443/api/v1/namespaces/default/events
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051764 1 round_trippers.go:469] Request Headers:
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.056424 1 pathrecorder.go:248] kube-aggregator: "/apis/apps/v1/namespaces/default/daemonsets/test/status" satisfied by prefix /apis/apps/v1/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.056430 1 handler.go:143] kube-apiserver: PUT "/apis/apps/v1/namespaces/default/daemonsets/test/status" satisfied by gorestful with webservice /apis/apps/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058470 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058513 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", numQueues=64
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058535 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 62 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.36662762ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058544 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 48 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.36915623ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058550 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 3 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37123761ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058556 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 16 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37368784ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058562 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 1 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38084400ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058567 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 37 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 1 seats in use, nextDispatchR=1.38360342ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058579 1 queueset.go:614] QS(system) at t=2024-01-17 07:18:07.058572785 R=1.38353240ss: For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} chose queue 62, with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} & 0 seats in use & nextDispatchR=1.36662762ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058589 1 queueset.go:645] QS(system) at t=2024-01-17 07:18:07.058586751 R=1.38353240ss: initialized queue 62 start R due to request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058615 1 queueset.go:736] QS(system) at t=2024-01-17 07:18:07.058608327 R=1.38353240ss: dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} work {{1 0 0s} 300000 0} from queue 62 with start R 1.38353240ss, queue will have 0 waiting & 1 requests occupying 1 seats, set will have 2 seats occupied
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058628 1 apf_filter.go:169] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058642 1 queueset.go:422] QS(system): Dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} from its queue
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058670 1 handler.go:153] kube-aggregator: GET "/api/v1/namespaces/default/pods/test-cj4n2" satisfied by nonGoRestful
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058680 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-cj4n2" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058685 1 handler.go:143] kube-apiserver: GET "/api/v1/namespaces/default/pods/test-cj4n2" satisfied by gorestful with webservice /api/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.060159 1 queueset.go:912] QS(workload-high) at t=2024-01-17 07:18:07.060146779 R=2.44047671ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 35 start R to 2.44037167ss due to service time 0.006048424s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.060181 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061253 1 httplog.go:132] "HTTP" verb="PUT" URI="/apis/apps/v1/namespaces/default/daemonsets/test/status" latency="5.115999ms" userAgent="kube-controller-manager/v1.29.0 (linux/amd64) kubernetes/3f7a50f/system:serviceaccount:kube-system:daemon-set-controller" audit-ID="86780f36-04f1-49d1-b123-80a500f104c0" srcIP="10.0.0.10:35022" apf_pl="workload-high" apf_fs="kube-system-service-accounts" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="4.781214ms" resp=200
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061768 1 round_trippers.go:580] Date: Wed, 17 Jan 2024 07:18:07 GMT
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061192 1 queueset.go:912] QS(system) at t=2024-01-17 07:18:07.061181472 R=1.38618301ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 62 start R to 1.38610554ss due to service time 0.002573145s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061794 1 round_trippers.go:580] Audit-Id: 39bf8413-5abd-4c9e-93b7-3de0624ae2de
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061358 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061390 1 httplog.go:132] "HTTP" verb="GET" URI="/api/v1/namespaces/default/pods/test-cj4n2" latency="3.110834ms" userAgent="kubelet/v1.29.0 (linux/amd64) kubernetes/3f7a50f" audit-ID="c35173e6-e660-431d-8d4f-99197187761d" srcIP="10.0.0.11:60384" apf_pl="system" apf_fs="system-nodes" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="2.523297ms" resp=200
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061469 1 queueset.go:912] QS(system) at t=2024-01-17 07:18:07.061462352 R=1.38646476ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 37 start R to 1.38638790ss due to service time 0.005784481s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061482 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true, Finish() => panicking=false idle=true
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061826 1 round_trippers.go:580] X-Kubernetes-Pf-Flowschema-Uid: e1263288-4891-415c-8f90-2b18f1339865
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061878 1 request.go:1210] Response Body:
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063082 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0b 0a 02 76 31 12 05 45 76 65 6e |k8s.....v1..Even|
kube-system kube-scheduler-master-node kube-scheduler 00000010 74 12 b3 04 0a ce 02 0a 1b 74 65 73 74 2d 63 6a |t........test-cj|
kube-system kube-scheduler-master-node kube-scheduler 00000040 00 2a 24 30 38 62 65 30 31 61 33 2d 36 32 63 37 |.*$08be01a3-62c7|
kube-system kube-scheduler-master-node kube-scheduler 00000050 2d 34 30 30 66 2d 61 32 30 37 2d 30 34 66 61 61 |-400f-a207-04faa|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063145 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", numQueues=64
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063162 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 48 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.36915623ss
kube-system kube-scheduler-master-node kube-scheduler 00000060 37 63 32 36 30 33 63 32 04 32 38 38 33 38 00 42 |7c2603c2.28838.B|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063187 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 3 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37123761ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063201 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 16 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37368784ss
kube-system kube-scheduler-master-node kube-scheduler 00000070 08 08 af fe 9d ad 06 10 00 8a 01 e8 01 0a 0e 6b |...............k|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063207 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 1 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38084400ss
kube-system kube-scheduler-master-node kube-scheduler 00000080 75 62 65 2d 73 63 68 65 64 75 6c 65 72 12 06 55 |ube-scheduler..U|
kube-system kube-scheduler-master-node kube-scheduler 00000090 70 64 61 74 65 1a 02 76 31 22 08 08 af fe 9d ad |pdate..v1"......|
kube-system kube-scheduler-master-node kube-scheduler 000000a0 06 10 00 32 08 46 69 65 6c 64 73 56 31 3a b3 01 |...2.FieldsV1:..|
kube-system kube-scheduler-master-node kube-scheduler 000000b0 0a b0 01 7b 22 66 3a 63 6f 75 6e 74 22 3a 7b 7d |...{"f:count":{}|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063213 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 37 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38638790ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063219 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 62 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38610554ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063231 1 queueset.go:614] QS(system) at t=2024-01-17 07:18:07.063227381 R=1.38646476ss: For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} chose queue 48, with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} & 0 seats in use & nextDispatchR=1.36915623ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063240 1 queueset.go:645] QS(system) at t=2024-01-17 07:18:07.063238445 R=1.38646476ss: initialized queue 48 start R due to request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063584 1 queueset.go:736] QS(system) at t=2024-01-17 07:18:07.063574103 R=1.38646476ss: dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} work {{1 0 0s} 300000 0} from queue 48 with start R 1.38646476ss, queue will have 0 waiting & 1 requests occupying 1 seats, set will have 1 seats occupied
kube-system kube-scheduler-master-node kube-scheduler 000000c0 2c 22 66 3a 66 69 72 73 74 54 69 6d 65 73 74 61 |,"f:firstTimest [truncated 1894 chars]
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063609 1 apf_filter.go:169] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063634 1 queueset.go:422] QS(system): Dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} from its queue
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063672 1 handler.go:153] kube-aggregator: PATCH "/api/v1/namespaces/default/pods/test-cj4n2/status" satisfied by nonGoRestful
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063682 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-cj4n2/status" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063686 1 handler.go:143] kube-apiserver: PATCH "/api/v1/namespaces/default/pods/test-cj4n2/status" satisfied by gorestful with webservice /api/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067479 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067586 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067874 1 queueset.go:912] QS(system) at t=2024-01-17 07:18:07.067858838 R=1.39116207ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 48 start R to 1.39074950ss due to service time 0.004284735s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067905 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true, Finish() => panicking=false idle=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067927 1 apf_controller.go:1057] plState.quiescing=false, plState.numPending=0, useless=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067964 1 httplog.go:132] "HTTP" verb="PATCH" URI="/api/v1/namespaces/default/pods/test-cj4n2/status" latency="5.109778ms" userAgent="kubelet/v1.29.0 (linux/amd64) kubernetes/3f7a50f" audit-ID="d3211c52-5276-4bc2-9732-d037c3cdd378" srcIP="10.0.0.11:60384" apf_pl="system" apf_fs="system-nodes" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="4.198598ms" resp=200
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068455 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068505 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068769 1 graph_populator.go:84] updatePod default/test-cj4n2, node unchanged
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068908 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068972 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.069726 1 eventhandlers.go:244] "Delete event for scheduled pod" pod="default/test-cj4n2"
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.165760 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/worker-node02", Verb:"update", APIPrefix:"apis", APIGroup:"coordination.k8s.io", APIVersion:"v1", Namespace:"kube-node-lease", Resource:"leases", Subresource:"", Name:"worker-node02", Parts:[]string{"leases", "worker-node02"}}, User: &user.DefaultInfo{Name:"system:node:worker-node02", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.165872 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/worker-node02", Verb:"update", APIPrefix:"apis", APIGroup:"coordination.k8s.io", APIVersion:"v1", Namespace:"kube-node-lease", Resource:"leases", Subresource:"", Name:"worker-node02", Parts:[]string{"leases", "worker-node02"}}, User: &user.DefaultInfo{Name:"system:node:worker-node02", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-node-high", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="node-high", numQueues=64
  kwilczynski@rocinante  Other/vagrant-kubeadm-kubernetes   main ✘  $ rg test-cj4n2 stern123.log -N | grep -vE '^--$'
kube-system kube-apiserver-master-node kube-apiserver 00000010 75 72 63 65 51 75 6f 74 61 4c 69 73 74 12 0c 0a |urceQuotaList...|
kube-system kube-apiserver-master-node kube-apiserver 00000020 0a 0a 00 12 04 32 38 37 39 1a 00 1a 00 22 00 |.....2879....".|
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037670 1 eventhandlers.go:126] "Add event for unscheduled pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037703 1 scheduling_queue.go:575] "Pod moved to an internal scheduling queue" pod="default/test-cj4n2" event="PodAdd" queue="Active"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037736 1 schedule_one.go:85] "About to try and schedule pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037742 1 schedule_one.go:98] "Attempting to schedule pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037912 1 default_binder.go:53] "Attempting to bind pod to node" pod="default/test-cj4n2" node="worker-node01"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037964 1 request.go:1210] Request Body:
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0d 0a 02 76 31 12 07 42 69 6e 64 |k8s.....v1..Bind|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036129 1 apf_controller.go:1057] plState.quiescing=false, plState.numPending=0, useless=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036207 1 httplog.go:132] "HTTP" verb="POST" URI="/api/v1/namespaces/default/pods" latency="11.947334ms" userAgent="kube-controller-manager/v1.29.0 (linux/amd64) kubernetes/3f7a50f/system:serviceaccount:kube-system:daemon-set-controller" audit-ID="73f7b953-e314-451b-8689-5b4deed5d6c3" srcIP="10.0.0.10:35022" apf_pl="workload-high" apf_fs="kube-system-service-accounts" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="10.883816ms" resp=201
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036363 1 graph_populator.go:77] updatePod default/test-cj4n2, no node
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036396 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036437 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036472 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036558 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-controller-manager-master-node kube-controller-manager I0117 07:18:07.036981 1 event.go:376] "Event occurred" object="default/test" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: test-cj4n2"
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.038565 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.038625 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.040120 1 handler.go:143] kube-apiserver: POST "/api/v1/namespaces/default/events" satisfied by gorestful with webservice /api/v1
kube-system kube-scheduler-master-node kube-scheduler 00000080 00 |.|
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037999 1 round_trippers.go:463] POST https://10.0.0.10:6443/api/v1/namespaces/default/pods/test-cj4n2/binding
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.038015 1 round_trippers.go:469] Request Headers:
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.038020 1 round_trippers.go:473] Content-Type: application/vnd.kubernetes.protobuf
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041535 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041576 1 httplog.go:132] "HTTP" verb="PUT" URI="/apis/apps/v1/namespaces/default/daemonsets/test/status" latency="3.111106ms" userAgent="kube-controller-manager/v1.29.0 (linux/amd64) kubernetes/3f7a50f/system:serviceaccount:kube-system:daemon-set-controller" audit-ID="05f45f6a-8a2e-4963-b5c2-f9bc4733abbf" srcIP="10.0.0.10:35022" apf_pl="workload-high" apf_fs="kube-system-service-accounts" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="2.679023ms" resp=409
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041928 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041972 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041985 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 41 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.67098059ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041993 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 111 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.03514130ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041999 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 57 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=0.95026372ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042005 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 35 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.22282837ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042012 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 18 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.18736564ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042018 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 78 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.19310824ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042030 1 queueset.go:614] QS(workload-high) at t=2024-01-17 07:18:07.042027642 R=2.42372649ss: For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} chose queue 41, with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} & 0 seats in use & nextDispatchR=1.67098059ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042040 1 queueset.go:645] QS(workload-high) at t=2024-01-17 07:18:07.042038512 R=2.42372649ss: initialized queue 41 start R due to request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042065 1 queueset.go:736] QS(workload-high) at t=2024-01-17 07:18:07.042058593 R=2.42372649ss: dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} work {{1 0 0s} 300000 0} from queue 41 with start R 2.42372649ss, queue will have 0 waiting & 1 requests occupying 1 seats, set will have 2 seats occupied
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042075 1 apf_filter.go:169] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042091 1 queueset.go:422] QS(workload-high): Dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} from its queue
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042131 1 handler.go:153] kube-aggregator: POST "/api/v1/namespaces/default/pods/test-cj4n2/binding" satisfied by nonGoRestful
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042137 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-cj4n2/binding" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042148 1 handler.go:143] kube-apiserver: POST "/api/v1/namespaces/default/pods/test-cj4n2/binding" satisfied by gorestful with webservice /api/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042357 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test", Verb:"get", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"", Name:"test", Parts:[]string{"daemonsets", "test"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042395 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test", Verb:"get", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"", Name:"test", Parts:[]string{"daemonsets", "test"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045235 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045311 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045500 1 queueset.go:912] QS(workload-high) at t=2024-01-17 07:18:07.045492119 R=2.42723589ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 41 start R to 2.42716002ss due to service time 0.003433526s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045520 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045548 1 httplog.go:132] "HTTP" verb="POST" URI="/api/v1/namespaces/default/pods/test-cj4n2/binding" latency="4.922121ms" userAgent="kube-scheduler/v1.29.0 (linux/amd64) kubernetes/3f7a50f/scheduler" audit-ID="a48c17dd-51d1-4965-a9a4-475c16ebf995" srcIP="10.0.0.10:47624" apf_pl="workload-high" apf_fs="kube-scheduler" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="3.386328ms" resp=201
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045906 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045970 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046203 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046244 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046433 1 graph_populator.go:89] updatePod default/test-cj4n2 for node worker-node01
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046463 1 graph_populator.go:92] updatePod default/test-cj4n2 for node worker-node01 completed in 16.276µs
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046797 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046851 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.048959 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-k2ggq" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.049477 1 handler.go:143] kube-apiserver: GET "/api/v1/namespaces/default/pods/test-k2ggq" satisfied by gorestful with webservice /api/v1
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051206 1 eventhandlers.go:197] "Add event for scheduled pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051264 1 round_trippers.go:574] Response Status: 201 Created in 13 milliseconds
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051270 1 round_trippers.go:577] Response Headers:
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051289 1 round_trippers.go:580] Content-Length: 48
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051292 1 round_trippers.go:580] Date: Wed, 17 Jan 2024 07:18:07 GMT
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051340 1 eventhandlers.go:171] "Delete event for unscheduled pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051399 1 request.go:1210] Response Body:
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0c 0a 02 76 31 12 06 53 74 61 74 |k8s.....v1..Stat|
kube-system kube-scheduler-master-node kube-scheduler 00000010 75 73 12 18 0a 06 0a 00 12 00 1a 00 12 07 53 75 |us............Su|
kube-system kube-scheduler-master-node kube-scheduler 00000020 63 63 65 73 73 1a 00 22 00 30 c9 01 1a 00 22 00 |ccess..".0....".|
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051503 1 cache.go:389] "Finished binding for pod, can be expired" podKey="c99b01d3-ec57-4c5c-b440-fd1ce6bff033" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051566 1 schedule_one.go:302] "Successfully bound pod to node" pod="default/test-cj4n2" node="worker-node01" evaluatedNodes=1 feasibleNodes=1
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051674 1 request.go:1210] Request Body:
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0b 0a 02 76 31 12 05 45 76 65 6e |k8s.....v1..Even|
kube-system kube-scheduler-master-node kube-scheduler 000000a0 64 22 39 53 75 63 63 65 73 73 66 75 6c 6c 79 20 |d"9Successfully |
kube-system kube-scheduler-master-node kube-scheduler 000000b0 61 73 73 69 67 6e 65 64 20 64 65 66 61 75 6c 74 |assigned default|
kube-system kube-scheduler-master-node kube-scheduler 000000c0 2f 74 65 73 74 2d 63 6a 34 6e 32 20 74 6f 20 77 |/test-cj4n2 to [truncated 475 chars]
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051749 1 round_trippers.go:463] POST https://10.0.0.10:6443/api/v1/namespaces/default/events
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051764 1 round_trippers.go:469] Request Headers:
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.056424 1 pathrecorder.go:248] kube-aggregator: "/apis/apps/v1/namespaces/default/daemonsets/test/status" satisfied by prefix /apis/apps/v1/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.056430 1 handler.go:143] kube-apiserver: PUT "/apis/apps/v1/namespaces/default/daemonsets/test/status" satisfied by gorestful with webservice /apis/apps/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058470 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058513 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", numQueues=64
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058535 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 62 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.36662762ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058544 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 48 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.36915623ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058550 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 3 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37123761ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058556 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 16 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37368784ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058562 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 1 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38084400ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058567 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 37 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 1 seats in use, nextDispatchR=1.38360342ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058579 1 queueset.go:614] QS(system) at t=2024-01-17 07:18:07.058572785 R=1.38353240ss: For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} chose queue 62, with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} & 0 seats in use & nextDispatchR=1.36662762ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058589 1 queueset.go:645] QS(system) at t=2024-01-17 07:18:07.058586751 R=1.38353240ss: initialized queue 62 start R due to request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058615 1 queueset.go:736] QS(system) at t=2024-01-17 07:18:07.058608327 R=1.38353240ss: dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} work {{1 0 0s} 300000 0} from queue 62 with start R 1.38353240ss, queue will have 0 waiting & 1 requests occupying 1 seats, set will have 2 seats occupied
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058628 1 apf_filter.go:169] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058642 1 queueset.go:422] QS(system): Dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} from its queue
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058670 1 handler.go:153] kube-aggregator: GET "/api/v1/namespaces/default/pods/test-cj4n2" satisfied by nonGoRestful
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058680 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-cj4n2" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058685 1 handler.go:143] kube-apiserver: GET "/api/v1/namespaces/default/pods/test-cj4n2" satisfied by gorestful with webservice /api/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.060159 1 queueset.go:912] QS(workload-high) at t=2024-01-17 07:18:07.060146779 R=2.44047671ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 35 start R to 2.44037167ss due to service time 0.006048424s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.060181 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061253 1 httplog.go:132] "HTTP" verb="PUT" URI="/apis/apps/v1/namespaces/default/daemonsets/test/status" latency="5.115999ms" userAgent="kube-controller-manager/v1.29.0 (linux/amd64) kubernetes/3f7a50f/system:serviceaccount:kube-system:daemon-set-controller" audit-ID="86780f36-04f1-49d1-b123-80a500f104c0" srcIP="10.0.0.10:35022" apf_pl="workload-high" apf_fs="kube-system-service-accounts" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="4.781214ms" resp=200
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061768 1 round_trippers.go:580] Date: Wed, 17 Jan 2024 07:18:07 GMT
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061192 1 queueset.go:912] QS(system) at t=2024-01-17 07:18:07.061181472 R=1.38618301ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 62 start R to 1.38610554ss due to service time 0.002573145s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061794 1 round_trippers.go:580] Audit-Id: 39bf8413-5abd-4c9e-93b7-3de0624ae2de
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061358 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061390 1 httplog.go:132] "HTTP" verb="GET" URI="/api/v1/namespaces/default/pods/test-cj4n2" latency="3.110834ms" userAgent="kubelet/v1.29.0 (linux/amd64) kubernetes/3f7a50f" audit-ID="c35173e6-e660-431d-8d4f-99197187761d" srcIP="10.0.0.11:60384" apf_pl="system" apf_fs="system-nodes" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="2.523297ms" resp=200
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061469 1 queueset.go:912] QS(system) at t=2024-01-17 07:18:07.061462352 R=1.38646476ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 37 start R to 1.38638790ss due to service time 0.005784481s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061482 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true, Finish() => panicking=false idle=true
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061826 1 round_trippers.go:580] X-Kubernetes-Pf-Flowschema-Uid: e1263288-4891-415c-8f90-2b18f1339865
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061878 1 request.go:1210] Response Body:
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063082 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0b 0a 02 76 31 12 05 45 76 65 6e |k8s.....v1..Even|
kube-system kube-scheduler-master-node kube-scheduler 00000010 74 12 b3 04 0a ce 02 0a 1b 74 65 73 74 2d 63 6a |t........test-cj|
kube-system kube-scheduler-master-node kube-scheduler 00000040 00 2a 24 30 38 62 65 30 31 61 33 2d 36 32 63 37 |.*$08be01a3-62c7|
kube-system kube-scheduler-master-node kube-scheduler 00000050 2d 34 30 30 66 2d 61 32 30 37 2d 30 34 66 61 61 |-400f-a207-04faa|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063145 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", numQueues=64
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063162 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 48 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.36915623ss
kube-system kube-scheduler-master-node kube-scheduler 00000060 37 63 32 36 30 33 63 32 04 32 38 38 33 38 00 42 |7c2603c2.28838.B|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063187 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 3 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37123761ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063201 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 16 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37368784ss
kube-system kube-scheduler-master-node kube-scheduler 00000070 08 08 af fe 9d ad 06 10 00 8a 01 e8 01 0a 0e 6b |...............k|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063207 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 1 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38084400ss
kube-system kube-scheduler-master-node kube-scheduler 00000080 75 62 65 2d 73 63 68 65 64 75 6c 65 72 12 06 55 |ube-scheduler..U|
kube-system kube-scheduler-master-node kube-scheduler 00000090 70 64 61 74 65 1a 02 76 31 22 08 08 af fe 9d ad |pdate..v1"......|
kube-system kube-scheduler-master-node kube-scheduler 000000a0 06 10 00 32 08 46 69 65 6c 64 73 56 31 3a b3 01 |...2.FieldsV1:..|
kube-system kube-scheduler-master-node kube-scheduler 000000b0 0a b0 01 7b 22 66 3a 63 6f 75 6e 74 22 3a 7b 7d |...{"f:count":{}|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063213 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 37 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38638790ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063219 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 62 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38610554ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063231 1 queueset.go:614] QS(system) at t=2024-01-17 07:18:07.063227381 R=1.38646476ss: For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} chose queue 48, with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} & 0 seats in use & nextDispatchR=1.36915623ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063240 1 queueset.go:645] QS(system) at t=2024-01-17 07:18:07.063238445 R=1.38646476ss: initialized queue 48 start R due to request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063584 1 queueset.go:736] QS(system) at t=2024-01-17 07:18:07.063574103 R=1.38646476ss: dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} work {{1 0 0s} 300000 0} from queue 48 with start R 1.38646476ss, queue will have 0 waiting & 1 requests occupying 1 seats, set will have 1 seats occupied
kube-system kube-scheduler-master-node kube-scheduler 000000c0 2c 22 66 3a 66 69 72 73 74 54 69 6d 65 73 74 61 |,"f:firstTimest [truncated 1894 chars]
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063609 1 apf_filter.go:169] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063634 1 queueset.go:422] QS(system): Dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} from its queue
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063672 1 handler.go:153] kube-aggregator: PATCH "/api/v1/namespaces/default/pods/test-cj4n2/status" satisfied by nonGoRestful
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063682 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-cj4n2/status" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063686 1 handler.go:143] kube-apiserver: PATCH "/api/v1/namespaces/default/pods/test-cj4n2/status" satisfied by gorestful with webservice /api/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067479 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067586 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067874 1 queueset.go:912] QS(system) at t=2024-01-17 07:18:07.067858838 R=1.39116207ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 48 start R to 1.39074950ss due to service time 0.004284735s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067905 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true, Finish() => panicking=false idle=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067927 1 apf_controller.go:1057] plState.quiescing=false, plState.numPending=0, useless=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067964 1 httplog.go:132] "HTTP" verb="PATCH" URI="/api/v1/namespaces/default/pods/test-cj4n2/status" latency="5.109778ms" userAgent="kubelet/v1.29.0 (linux/amd64) kubernetes/3f7a50f" audit-ID="d3211c52-5276-4bc2-9732-d037c3cdd378" srcIP="10.0.0.11:60384" apf_pl="system" apf_fs="system-nodes" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="4.198598ms" resp=200
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068455 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068505 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068769 1 graph_populator.go:84] updatePod default/test-cj4n2, node unchanged
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068908 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068972 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.069726 1 eventhandlers.go:244] "Delete event for scheduled pod" pod="default/test-cj4n2"
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.165760 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/worker-node02", Verb:"update", APIPrefix:"apis", APIGroup:"coordination.k8s.io", APIVersion:"v1", Namespace:"kube-node-lease", Resource:"leases", Subresource:"", Name:"worker-node02", Parts:[]string{"leases", "worker-node02"}}, User: &user.DefaultInfo{Name:"system:node:worker-node02", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.165872 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/worker-node02", Verb:"update", APIPrefix:"apis", APIGroup:"coordination.k8s.io", APIVersion:"v1", Namespace:"kube-node-lease", Resource:"leases", Subresource:"", Name:"worker-node02", Parts:[]string{"leases", "worker-node02"}}, User: &user.DefaultInfo{Name:"system:node:worker-node02", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-node-high", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="node-high", numQueues=64
  kwilczynski@rocinante  Other/vagrant-kubeadm-kubernetes   main ✘  $ rg test-cj4n2 stern123.log -N | grep -vE '^--$'
kube-system kube-apiserver-master-node kube-apiserver 00000010 75 72 63 65 51 75 6f 74 61 4c 69 73 74 12 0c 0a |urceQuotaList...|
kube-system kube-apiserver-master-node kube-apiserver 00000020 0a 0a 00 12 04 32 38 37 39 1a 00 1a 00 22 00 |.....2879....".|
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037670 1 eventhandlers.go:126] "Add event for unscheduled pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037703 1 scheduling_queue.go:575] "Pod moved to an internal scheduling queue" pod="default/test-cj4n2" event="PodAdd" queue="Active"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037736 1 schedule_one.go:85] "About to try and schedule pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037742 1 schedule_one.go:98] "Attempting to schedule pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037912 1 default_binder.go:53] "Attempting to bind pod to node" pod="default/test-cj4n2" node="worker-node01"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037964 1 request.go:1210] Request Body:
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0d 0a 02 76 31 12 07 42 69 6e 64 |k8s.....v1..Bind|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036129 1 apf_controller.go:1057] plState.quiescing=false, plState.numPending=0, useless=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036207 1 httplog.go:132] "HTTP" verb="POST" URI="/api/v1/namespaces/default/pods" latency="11.947334ms" userAgent="kube-controller-manager/v1.29.0 (linux/amd64) kubernetes/3f7a50f/system:serviceaccount:kube-system:daemon-set-controller" audit-ID="73f7b953-e314-451b-8689-5b4deed5d6c3" srcIP="10.0.0.10:35022" apf_pl="workload-high" apf_fs="kube-system-service-accounts" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="10.883816ms" resp=201
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036363 1 graph_populator.go:77] updatePod default/test-cj4n2, no node
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036396 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036437 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036472 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.036558 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-controller-manager-master-node kube-controller-manager I0117 07:18:07.036981 1 event.go:376] "Event occurred" object="default/test" fieldPath="" kind="DaemonSet" apiVersion="apps/v1" type="Normal" reason="SuccessfulCreate" message="Created pod: test-cj4n2"
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.038565 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.038625 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.040120 1 handler.go:143] kube-apiserver: POST "/api/v1/namespaces/default/events" satisfied by gorestful with webservice /api/v1
kube-system kube-scheduler-master-node kube-scheduler 00000080 00 |.|
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.037999 1 round_trippers.go:463] POST https://10.0.0.10:6443/api/v1/namespaces/default/pods/test-cj4n2/binding
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.038015 1 round_trippers.go:469] Request Headers:
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.038020 1 round_trippers.go:473] Content-Type: application/vnd.kubernetes.protobuf
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041535 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041576 1 httplog.go:132] "HTTP" verb="PUT" URI="/apis/apps/v1/namespaces/default/daemonsets/test/status" latency="3.111106ms" userAgent="kube-controller-manager/v1.29.0 (linux/amd64) kubernetes/3f7a50f/system:serviceaccount:kube-system:daemon-set-controller" audit-ID="05f45f6a-8a2e-4963-b5c2-f9bc4733abbf" srcIP="10.0.0.10:35022" apf_pl="workload-high" apf_fs="kube-system-service-accounts" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="2.679023ms" resp=409
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041928 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041972 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041985 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 41 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.67098059ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041993 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 111 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.03514130ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.041999 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 57 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=0.95026372ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042005 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 35 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.22282837ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042012 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 18 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.18736564ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042018 1 queueset.go:606] QS(workload-high): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} considering queue 78 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=2.19310824ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042030 1 queueset.go:614] QS(workload-high) at t=2024-01-17 07:18:07.042027642 R=2.42372649ss: For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} chose queue 41, with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} & 0 seats in use & nextDispatchR=1.67098059ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042040 1 queueset.go:645] QS(workload-high) at t=2024-01-17 07:18:07.042038512 R=2.42372649ss: initialized queue 41 start R due to request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042065 1 queueset.go:736] QS(workload-high) at t=2024-01-17 07:18:07.042058593 R=2.42372649ss: dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} work {{1 0 0s} 300000 0} from queue 41 with start R 2.42372649ss, queue will have 0 waiting & 1 requests occupying 1 seats, set will have 2 seats occupied
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042075 1 apf_filter.go:169] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042091 1 queueset.go:422] QS(workload-high): Dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} from its queue
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042131 1 handler.go:153] kube-aggregator: POST "/api/v1/namespaces/default/pods/test-cj4n2/binding" satisfied by nonGoRestful
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042137 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-cj4n2/binding" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042148 1 handler.go:143] kube-apiserver: POST "/api/v1/namespaces/default/pods/test-cj4n2/binding" satisfied by gorestful with webservice /api/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042357 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test", Verb:"get", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"", Name:"test", Parts:[]string{"daemonsets", "test"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.042395 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test", Verb:"get", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"", Name:"test", Parts:[]string{"daemonsets", "test"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045235 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045311 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045500 1 queueset.go:912] QS(workload-high) at t=2024-01-17 07:18:07.045492119 R=2.42723589ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 41 start R to 2.42716002ss due to service time 0.003433526s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045520 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/binding", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"binding", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "binding"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045548 1 httplog.go:132] "HTTP" verb="POST" URI="/api/v1/namespaces/default/pods/test-cj4n2/binding" latency="4.922121ms" userAgent="kube-scheduler/v1.29.0 (linux/amd64) kubernetes/3f7a50f/scheduler" audit-ID="a48c17dd-51d1-4965-a9a4-475c16ebf995" srcIP="10.0.0.10:47624" apf_pl="workload-high" apf_fs="kube-scheduler" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="3.386328ms" resp=201
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045906 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.045970 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046203 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046244 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046433 1 graph_populator.go:89] updatePod default/test-cj4n2 for node worker-node01
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046463 1 graph_populator.go:92] updatePod default/test-cj4n2 for node worker-node01 completed in 16.276µs
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046797 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.046851 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/apps/v1/namespaces/default/daemonsets/test/status", Verb:"update", APIPrefix:"apis", APIGroup:"apps", APIVersion:"v1", Namespace:"default", Resource:"daemonsets", Subresource:"status", Name:"test", Parts:[]string{"daemonsets", "test", "status"}}, User: &user.DefaultInfo{Name:"system:serviceaccount:kube-system:daemon-set-controller", UID:"aff01727-38e3-450a-a3d6-7851282720a1", Groups:[]string{"system:serviceaccounts", "system:serviceaccounts:kube-system", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-system-service-accounts", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", numQueues=128
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.048959 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-k2ggq" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.049477 1 handler.go:143] kube-apiserver: GET "/api/v1/namespaces/default/pods/test-k2ggq" satisfied by gorestful with webservice /api/v1
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051206 1 eventhandlers.go:197] "Add event for scheduled pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051264 1 round_trippers.go:574] Response Status: 201 Created in 13 milliseconds
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051270 1 round_trippers.go:577] Response Headers:
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051289 1 round_trippers.go:580] Content-Length: 48
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051292 1 round_trippers.go:580] Date: Wed, 17 Jan 2024 07:18:07 GMT
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051340 1 eventhandlers.go:171] "Delete event for unscheduled pod" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051399 1 request.go:1210] Response Body:
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0c 0a 02 76 31 12 06 53 74 61 74 |k8s.....v1..Stat|
kube-system kube-scheduler-master-node kube-scheduler 00000010 75 73 12 18 0a 06 0a 00 12 00 1a 00 12 07 53 75 |us............Su|
kube-system kube-scheduler-master-node kube-scheduler 00000020 63 63 65 73 73 1a 00 22 00 30 c9 01 1a 00 22 00 |ccess..".0....".|
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051503 1 cache.go:389] "Finished binding for pod, can be expired" podKey="c99b01d3-ec57-4c5c-b440-fd1ce6bff033" pod="default/test-cj4n2"
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051566 1 schedule_one.go:302] "Successfully bound pod to node" pod="default/test-cj4n2" node="worker-node01" evaluatedNodes=1 feasibleNodes=1
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051674 1 request.go:1210] Request Body:
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0b 0a 02 76 31 12 05 45 76 65 6e |k8s.....v1..Even|
kube-system kube-scheduler-master-node kube-scheduler 000000a0 64 22 39 53 75 63 63 65 73 73 66 75 6c 6c 79 20 |d"9Successfully |
kube-system kube-scheduler-master-node kube-scheduler 000000b0 61 73 73 69 67 6e 65 64 20 64 65 66 61 75 6c 74 |assigned default|
kube-system kube-scheduler-master-node kube-scheduler 000000c0 2f 74 65 73 74 2d 63 6a 34 6e 32 20 74 6f 20 77 |/test-cj4n2 to [truncated 475 chars]
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051749 1 round_trippers.go:463] POST https://10.0.0.10:6443/api/v1/namespaces/default/events
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.051764 1 round_trippers.go:469] Request Headers:
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.056424 1 pathrecorder.go:248] kube-aggregator: "/apis/apps/v1/namespaces/default/daemonsets/test/status" satisfied by prefix /apis/apps/v1/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.056430 1 handler.go:143] kube-apiserver: PUT "/apis/apps/v1/namespaces/default/daemonsets/test/status" satisfied by gorestful with webservice /apis/apps/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058470 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058513 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", numQueues=64
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058535 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 62 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.36662762ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058544 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 48 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.36915623ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058550 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 3 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37123761ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058556 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 16 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37368784ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058562 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 1 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38084400ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058567 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 37 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 1 seats in use, nextDispatchR=1.38360342ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058579 1 queueset.go:614] QS(system) at t=2024-01-17 07:18:07.058572785 R=1.38353240ss: For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} chose queue 62, with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} & 0 seats in use & nextDispatchR=1.36662762ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058589 1 queueset.go:645] QS(system) at t=2024-01-17 07:18:07.058586751 R=1.38353240ss: initialized queue 62 start R due to request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058615 1 queueset.go:736] QS(system) at t=2024-01-17 07:18:07.058608327 R=1.38353240ss: dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} work {{1 0 0s} 300000 0} from queue 62 with start R 1.38353240ss, queue will have 0 waiting & 1 requests occupying 1 seats, set will have 2 seats occupied
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058628 1 apf_filter.go:169] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058642 1 queueset.go:422] QS(system): Dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} from its queue
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058670 1 handler.go:153] kube-aggregator: GET "/api/v1/namespaces/default/pods/test-cj4n2" satisfied by nonGoRestful
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058680 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-cj4n2" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.058685 1 handler.go:143] kube-apiserver: GET "/api/v1/namespaces/default/pods/test-cj4n2" satisfied by gorestful with webservice /api/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.060159 1 queueset.go:912] QS(workload-high) at t=2024-01-17 07:18:07.060146779 R=2.44047671ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}} &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 35 start R to 2.44037167ss due to service time 0.006048424s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.060181 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}}, User: &user.DefaultInfo{Name:"system:kube-scheduler", UID:"", Groups:[]string{"system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="kube-scheduler", distMethod=&v1.FlowDistinguisherMethod{Type:"ByNamespace"}, plName="workload-high", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061253 1 httplog.go:132] "HTTP" verb="PUT" URI="/apis/apps/v1/namespaces/default/daemonsets/test/status" latency="5.115999ms" userAgent="kube-controller-manager/v1.29.0 (linux/amd64) kubernetes/3f7a50f/system:serviceaccount:kube-system:daemon-set-controller" audit-ID="86780f36-04f1-49d1-b123-80a500f104c0" srcIP="10.0.0.10:35022" apf_pl="workload-high" apf_fs="kube-system-service-accounts" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="4.781214ms" resp=200
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061768 1 round_trippers.go:580] Date: Wed, 17 Jan 2024 07:18:07 GMT
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061192 1 queueset.go:912] QS(system) at t=2024-01-17 07:18:07.061181472 R=1.38618301ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 62 start R to 1.38610554ss due to service time 0.002573145s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061794 1 round_trippers.go:580] Audit-Id: 39bf8413-5abd-4c9e-93b7-3de0624ae2de
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061358 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2", Verb:"get", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true, Finish() => panicking=false idle=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061390 1 httplog.go:132] "HTTP" verb="GET" URI="/api/v1/namespaces/default/pods/test-cj4n2" latency="3.110834ms" userAgent="kubelet/v1.29.0 (linux/amd64) kubernetes/3f7a50f" audit-ID="c35173e6-e660-431d-8d4f-99197187761d" srcIP="10.0.0.11:60384" apf_pl="system" apf_fs="system-nodes" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="2.523297ms" resp=200
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061469 1 queueset.go:912] QS(system) at t=2024-01-17 07:18:07.061462352 R=1.38646476ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 37 start R to 1.38638790ss due to service time 0.005784481s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.061482 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/events", Verb:"create", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"events", Subresource:"", Name:"", Parts:[]string{"events"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true, Finish() => panicking=false idle=true
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061826 1 round_trippers.go:580] X-Kubernetes-Pf-Flowschema-Uid: e1263288-4891-415c-8f90-2b18f1339865
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.061878 1 request.go:1210] Response Body:
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063082 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-scheduler-master-node kube-scheduler 00000000 6b 38 73 00 0a 0b 0a 02 76 31 12 05 45 76 65 6e |k8s.....v1..Even|
kube-system kube-scheduler-master-node kube-scheduler 00000010 74 12 b3 04 0a ce 02 0a 1b 74 65 73 74 2d 63 6a |t........test-cj|
kube-system kube-scheduler-master-node kube-scheduler 00000040 00 2a 24 30 38 62 65 30 31 61 33 2d 36 32 63 37 |.*$08be01a3-62c7|
kube-system kube-scheduler-master-node kube-scheduler 00000050 2d 34 30 30 66 2d 61 32 30 37 2d 30 34 66 61 61 |-400f-a207-04faa|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063145 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", numQueues=64
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063162 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 48 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.36915623ss
kube-system kube-scheduler-master-node kube-scheduler 00000060 37 63 32 36 30 33 63 32 04 32 38 38 33 38 00 42 |7c2603c2.28838.B|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063187 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 3 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37123761ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063201 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 16 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.37368784ss
kube-system kube-scheduler-master-node kube-scheduler 00000070 08 08 af fe 9d ad 06 10 00 8a 01 e8 01 0a 0e 6b |...............k|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063207 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 1 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38084400ss
kube-system kube-scheduler-master-node kube-scheduler 00000080 75 62 65 2d 73 63 68 65 64 75 6c 65 72 12 06 55 |ube-scheduler..U|
kube-system kube-scheduler-master-node kube-scheduler 00000090 70 64 61 74 65 1a 02 76 31 22 08 08 af fe 9d ad |pdate..v1"......|
kube-system kube-scheduler-master-node kube-scheduler 000000a0 06 10 00 32 08 46 69 65 6c 64 73 56 31 3a b3 01 |...2.FieldsV1:..|
kube-system kube-scheduler-master-node kube-scheduler 000000b0 0a b0 01 7b 22 66 3a 63 6f 75 6e 74 22 3a 7b 7d |...{"f:count":{}|
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063213 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 37 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38638790ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063219 1 queueset.go:606] QS(system): For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} considering queue 62 with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} and 0 seats in use, nextDispatchR=1.38610554ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063231 1 queueset.go:614] QS(system) at t=2024-01-17 07:18:07.063227381 R=1.38646476ss: For request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} chose queue 48, with sum: queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} & 0 seats in use & nextDispatchR=1.36915623ss
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063240 1 queueset.go:645] QS(system) at t=2024-01-17 07:18:07.063238445 R=1.38646476ss: initialized queue 48 start R due to request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063584 1 queueset.go:736] QS(system) at t=2024-01-17 07:18:07.063574103 R=1.38646476ss: dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} work {{1 0 0s} 300000 0} from queue 48 with start R 1.38646476ss, queue will have 0 waiting & 1 requests occupying 1 seats, set will have 1 seats occupied
kube-system kube-scheduler-master-node kube-scheduler 000000c0 2c 22 66 3a 66 69 72 73 74 54 69 6d 65 73 74 61 |,"f:firstTimest [truncated 1894 chars]
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063609 1 apf_filter.go:169] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063634 1 queueset.go:422] QS(system): Dispatching request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} from its queue
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063672 1 handler.go:153] kube-aggregator: PATCH "/api/v1/namespaces/default/pods/test-cj4n2/status" satisfied by nonGoRestful
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063682 1 pathrecorder.go:248] kube-aggregator: "/api/v1/namespaces/default/pods/test-cj4n2/status" satisfied by prefix /api/
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.063686 1 handler.go:143] kube-apiserver: PATCH "/api/v1/namespaces/default/pods/test-cj4n2/status" satisfied by gorestful with webservice /api/v1
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067479 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067586 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067874 1 queueset.go:912] QS(system) at t=2024-01-17 07:18:07.067858838 R=1.39116207ss: request &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}} &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)} finished all use of 1 seats, adjusted queue 48 start R to 1.39074950ss due to service time 0.004284735s, queue will have 0 requests with queueset.queueSum{InitialSeatsSum:0, MaxSeatsSum:0, TotalWorkSum:0x0} waiting & 0 requests occupying 0 seats
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067905 1 apf_filter.go:173] Handle(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/api/v1/namespaces/default/pods/test-cj4n2/status", Verb:"patch", APIPrefix:"api", APIGroup:"", APIVersion:"v1", Namespace:"default", Resource:"pods", Subresource:"status", Name:"test-cj4n2", Parts:[]string{"pods", "test-cj4n2", "status"}}, User: &user.DefaultInfo{Name:"system:node:worker-node01", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-nodes", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="system", isExempt=false, queued=true, Finish() => panicking=false idle=true
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067927 1 apf_controller.go:1057] plState.quiescing=false, plState.numPending=0, useless=false
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.067964 1 httplog.go:132] "HTTP" verb="PATCH" URI="/api/v1/namespaces/default/pods/test-cj4n2/status" latency="5.109778ms" userAgent="kubelet/v1.29.0 (linux/amd64) kubernetes/3f7a50f" audit-ID="d3211c52-5276-4bc2-9732-d037c3cdd378" srcIP="10.0.0.11:60384" apf_pl="system" apf_fs="system-nodes" apf_iseats=1 apf_fseats=0 apf_additionalLatency="0s" apf_execution_time="4.198598ms" resp=200
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068455 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068505 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068769 1 graph_populator.go:84] updatePod default/test-cj4n2, node unchanged
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068908 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.068972 1 versioning.go:225] a memory allocator was provided but the encoder {"name":"json","pretty":"false","strict":"false","yaml":"false"} doesn't implement the runtime.EncoderWithAllocator, using regular encoder.Encode method
kube-system kube-scheduler-master-node kube-scheduler I0117 07:18:07.069726 1 eventhandlers.go:244] "Delete event for scheduled pod" pod="default/test-cj4n2"
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.165760 1 apf_controller.go:989] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/worker-node02", Verb:"update", APIPrefix:"apis", APIGroup:"coordination.k8s.io", APIVersion:"v1", Namespace:"kube-node-lease", Resource:"leases", Subresource:"", Name:"worker-node02", Parts:[]string{"leases", "worker-node02"}}, User: &user.DefaultInfo{Name:"system:node:worker-node02", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}})
kube-system kube-apiserver-master-node kube-apiserver I0117 07:18:07.165872 1 apf_controller.go:1037] startRequest(RequestDigest{RequestInfo: &request.RequestInfo{IsResourceRequest:true, Path:"/apis/coordination.k8s.io/v1/namespaces/kube-node-lease/leases/worker-node02", Verb:"update", APIPrefix:"apis", APIGroup:"coordination.k8s.io", APIVersion:"v1", Namespace:"kube-node-lease", Resource:"leases", Subresource:"", Name:"worker-node02", Parts:[]string{"leases", "worker-node02"}}, User: &user.DefaultInfo{Name:"system:node:worker-node02", UID:"", Groups:[]string{"system:nodes", "system:authenticated"}, Extra:map[string][]string(nil)}}) => fsName="system-node-high", distMethod=&v1.FlowDistinguisherMethod{Type:"ByUser"}, plName="node-high", numQueues=64
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment