{"level":"warn","ts":"2026-09-22T14:45:58.524461Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-22T14:45:58.524554Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.4:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.4:2380","--initial-cluster=instance=https://162.253.55.4:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.4:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.4:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-09-22T14:45:58.524627Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-22T14:45:58.524655Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.4:2380"]} {"level":"info","ts":"2026-09-22T14:45:58.52468Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-22T14:45:58.525443Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.4:2379"]} {"level":"info","ts":"2026-09-22T14:45:58.525544Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.4:2380"],"listen-peer-urls":["https://162.253.55.4:2380"],"advertise-client-urls":["https://162.253.55.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.4:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-09-22T14:45:58.529451Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.637117ms"} {"level":"info","ts":"2026-09-22T14:45:58.537184Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"caafea9f270da559","cluster-id":"271ff399bb4addea"} {"level":"info","ts":"2026-09-22T14:45:58.53727Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 switched to configuration voters=()"} {"level":"info","ts":"2026-09-22T14:45:58.537293Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 became follower at term 0"} {"level":"info","ts":"2026-09-22T14:45:58.537306Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft caafea9f270da559 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-22T14:45:58.537314Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 became follower at term 1"} {"level":"info","ts":"2026-09-22T14:45:58.537352Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 switched to configuration voters=(14605150085861713241)"} {"level":"warn","ts":"2026-09-22T14:45:58.543331Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-22T14:45:58.544781Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-22T14:45:58.545916Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-09-22T14:45:58.548182Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"caafea9f270da559","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-22T14:45:58.548291Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"caafea9f270da559","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-22T14:45:58.548403Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-22T14:45:58.548486Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-22T14:45:58.548495Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-09-22T14:45:58.549341Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 switched to configuration voters=(14605150085861713241)"} {"level":"info","ts":"2026-09-22T14:45:58.549449Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"271ff399bb4addea","local-member-id":"caafea9f270da559","added-peer-id":"caafea9f270da559","added-peer-peer-urls":["https://162.253.55.4:2380"]} {"level":"info","ts":"2026-09-22T14:45:58.553149Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-09-22T14:45:58.553343Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"caafea9f270da559","initial-advertise-peer-urls":["https://162.253.55.4:2380"],"listen-peer-urls":["https://162.253.55.4:2380"],"advertise-client-urls":["https://162.253.55.4:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.4:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-22T14:45:58.55337Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-22T14:45:58.553467Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.4:2380"} {"level":"info","ts":"2026-09-22T14:45:58.553479Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.4:2380"} {"level":"info","ts":"2026-09-22T14:45:59.238403Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 is starting a new election at term 1"} {"level":"info","ts":"2026-09-22T14:45:59.238458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-22T14:45:59.238494Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 received MsgPreVoteResp from caafea9f270da559 at term 1"} {"level":"info","ts":"2026-09-22T14:45:59.238512Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 became candidate at term 2"} {"level":"info","ts":"2026-09-22T14:45:59.238536Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 received MsgVoteResp from caafea9f270da559 at term 2"} {"level":"info","ts":"2026-09-22T14:45:59.238557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"caafea9f270da559 became leader at term 2"} {"level":"info","ts":"2026-09-22T14:45:59.238569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: caafea9f270da559 elected leader caafea9f270da559 at term 2"} {"level":"info","ts":"2026-09-22T14:45:59.239921Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T14:45:59.240914Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"caafea9f270da559","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.4:2379]}","request-path":"/0/members/caafea9f270da559/attributes","cluster-id":"271ff399bb4addea","publish-timeout":"7s"} {"level":"info","ts":"2026-09-22T14:45:59.240937Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T14:45:59.241055Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-22T14:45:59.241215Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-22T14:45:59.241228Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-22T14:45:59.241571Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"271ff399bb4addea","local-member-id":"caafea9f270da559","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T14:45:59.241717Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T14:45:59.241757Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-22T14:45:59.242611Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-22T14:45:59.244306Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.4:2379"} {"level":"warn","ts":"2026-09-22T14:46:01.140344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.154253ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-09-22T14:46:01.140453Z","caller":"traceutil/trace.go:171","msg":"trace[13341441] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"329.135265ms","start":"2026-09-22T14:46:00.811298Z","end":"2026-09-22T14:46:01.140433Z","steps":["trace[13341441] 'read index received' (duration: 166.311913ms)","trace[13341441] 'applied index is now lower than readState.Index' (duration: 162.822162ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T14:46:01.140677Z","caller":"traceutil/trace.go:171","msg":"trace[999440229] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"334.020624ms","start":"2026-09-22T14:46:00.806552Z","end":"2026-09-22T14:46:01.140573Z","steps":["trace[999440229] 'process raft request' (duration: 170.989118ms)","trace[999440229] 'compare' (duration: 161.998099ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:46:01.140882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.526905ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-22T14:46:01.140985Z","caller":"traceutil/trace.go:171","msg":"trace[518534620] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:3; }","duration":"329.680749ms","start":"2026-09-22T14:46:00.811284Z","end":"2026-09-22T14:46:01.140965Z","steps":["trace[518534620] 'agreement among raft nodes before linearized reading' (duration: 329.307119ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.141048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.811277Z","time spent":"329.73903ms","remote":"127.0.0.1:53890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-09-22T14:46:01.141236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.806544Z","time spent":"334.302542ms","remote":"127.0.0.1:53552","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T14:46:01.292564Z","caller":"traceutil/trace.go:171","msg":"trace[287354263] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"419.693423ms","start":"2026-09-22T14:46:00.872845Z","end":"2026-09-22T14:46:01.292539Z","steps":["trace[287354263] 'process raft request' (duration: 419.57381ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.292732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.846056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-22T14:46:01.292745Z","caller":"traceutil/trace.go:171","msg":"trace[1103255180] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"419.94423ms","start":"2026-09-22T14:46:00.872786Z","end":"2026-09-22T14:46:01.29273Z","steps":["trace[1103255180] 'process raft request' (duration: 419.57613ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:01.292769Z","caller":"traceutil/trace.go:171","msg":"trace[885094223] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"443.906687ms","start":"2026-09-22T14:46:00.848852Z","end":"2026-09-22T14:46:01.292759Z","steps":["trace[885094223] 'agreement among raft nodes before linearized reading' (duration: 443.782844ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.292798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.848845Z","time spent":"443.946548ms","remote":"127.0.0.1:53604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-22T14:46:01.292845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.872771Z","time spent":"420.000942ms","remote":"127.0.0.1:54048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T14:46:01.292895Z","caller":"traceutil/trace.go:171","msg":"trace[1658395130] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"420.279059ms","start":"2026-09-22T14:46:00.872576Z","end":"2026-09-22T14:46:01.292856Z","steps":["trace[1658395130] 'process raft request' (duration: 418.388229ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.292931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.141205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-22T14:46:01.292959Z","caller":"traceutil/trace.go:171","msg":"trace[915354952] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"420.136075ms","start":"2026-09-22T14:46:00.872814Z","end":"2026-09-22T14:46:01.29295Z","steps":["trace[915354952] 'process raft request' (duration: 419.577301ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:01.292994Z","caller":"traceutil/trace.go:171","msg":"trace[557478653] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"420.226748ms","start":"2026-09-22T14:46:00.872741Z","end":"2026-09-22T14:46:01.292967Z","steps":["trace[557478653] 'agreement among raft nodes before linearized reading' (duration: 420.121845ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.293004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.872806Z","time spent":"420.176706ms","remote":"127.0.0.1:54048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T14:46:01.293024Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.872732Z","time spent":"420.285149ms","remote":"127.0.0.1:53604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-22T14:46:01.293085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.912499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-22T14:46:01.293077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.628915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.4\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-22T14:46:01.293118Z","caller":"traceutil/trace.go:171","msg":"trace[1250525248] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"369.964461ms","start":"2026-09-22T14:46:00.923145Z","end":"2026-09-22T14:46:01.29311Z","steps":["trace[1250525248] 'agreement among raft nodes before linearized reading' (duration: 369.913959ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.293143Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.923135Z","time spent":"370.002161ms","remote":"127.0.0.1:53604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-22T14:46:01.293175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.236838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-22T14:46:01.293189Z","caller":"traceutil/trace.go:171","msg":"trace[1963013897] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"420.290759ms","start":"2026-09-22T14:46:00.872879Z","end":"2026-09-22T14:46:01.293169Z","steps":["trace[1963013897] 'process raft request' (duration: 419.56984ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:01.293222Z","caller":"traceutil/trace.go:171","msg":"trace[881608079] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"420.31465ms","start":"2026-09-22T14:46:00.872896Z","end":"2026-09-22T14:46:01.29321Z","steps":["trace[881608079] 'agreement among raft nodes before linearized reading' (duration: 420.257349ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.29327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.872875Z","time spent":"420.385782ms","remote":"127.0.0.1:53580","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-09-22T14:46:01.29328Z","caller":"traceutil/trace.go:171","msg":"trace[359592610] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"406.3874ms","start":"2026-09-22T14:46:00.886883Z","end":"2026-09-22T14:46:01.293271Z","steps":["trace[359592610] 'process raft request' (duration: 405.665181ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.293285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.115203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-09-22T14:46:01.293271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.872857Z","time spent":"420.374492ms","remote":"127.0.0.1:53962","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T14:46:01.293312Z","caller":"traceutil/trace.go:171","msg":"trace[2044117591] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"444.168885ms","start":"2026-09-22T14:46:00.849136Z","end":"2026-09-22T14:46:01.293304Z","steps":["trace[2044117591] 'agreement among raft nodes before linearized reading' (duration: 444.065632ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.293323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.886875Z","time spent":"406.426361ms","remote":"127.0.0.1:53744","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":849,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T14:46:01.293338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.84912Z","time spent":"444.212396ms","remote":"127.0.0.1:53604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-09-22T14:46:01.293188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.145815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-09-22T14:46:01.293142Z","caller":"traceutil/trace.go:171","msg":"trace[529400841] range","detail":"{range_begin:/registry/masterleases/162.253.55.4; range_end:; response_count:0; response_revision:11; }","duration":"421.725047ms","start":"2026-09-22T14:46:00.871407Z","end":"2026-09-22T14:46:01.293132Z","steps":["trace[529400841] 'agreement among raft nodes before linearized reading' (duration: 421.643825ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.293453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.871386Z","time spent":"422.059417ms","remote":"127.0.0.1:53532","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/162.253.55.4\" "} {"level":"info","ts":"2026-09-22T14:46:01.293474Z","caller":"traceutil/trace.go:171","msg":"trace[1491371139] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"420.581707ms","start":"2026-09-22T14:46:00.872879Z","end":"2026-09-22T14:46:01.293461Z","steps":["trace[1491371139] 'process raft request' (duration: 419.604671ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.293531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.872856Z","time spent":"420.648979ms","remote":"127.0.0.1:54048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-22T14:46:01.293422Z","caller":"traceutil/trace.go:171","msg":"trace[1563014666] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"435.390161ms","start":"2026-09-22T14:46:00.858023Z","end":"2026-09-22T14:46:01.293413Z","steps":["trace[1563014666] 'agreement among raft nodes before linearized reading' (duration: 435.134984ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:01.293611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.858016Z","time spent":"435.588317ms","remote":"127.0.0.1:53604","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-09-22T14:46:01.293783Z","caller":"traceutil/trace.go:171","msg":"trace[2081794014] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"411.68846ms","start":"2026-09-22T14:46:00.882081Z","end":"2026-09-22T14:46:01.293769Z","steps":["trace[2081794014] 'process raft request' (duration: 410.435307ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:01.292603Z","caller":"traceutil/trace.go:171","msg":"trace[1648317695] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:6; }","duration":"152.098626ms","start":"2026-09-22T14:46:01.140484Z","end":"2026-09-22T14:46:01.292582Z","steps":["trace[1648317695] 'read index received' (duration: 150.543664ms)","trace[1648317695] 'applied index is now lower than readState.Index' (duration: 1.554042ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:46:01.29395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.882067Z","time spent":"411.797424ms","remote":"127.0.0.1:53670","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3157,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T14:46:01.293989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.872819Z","time spent":"419.853108ms","remote":"127.0.0.1:54048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T14:46:01.294127Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:00.872558Z","time spent":"420.446044ms","remote":"127.0.0.1:54048","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T14:46:01.29525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.438638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3169"} {"level":"info","ts":"2026-09-22T14:46:01.295297Z","caller":"traceutil/trace.go:171","msg":"trace[1619983988] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:11; }","duration":"151.523271ms","start":"2026-09-22T14:46:01.143762Z","end":"2026-09-22T14:46:01.295286Z","steps":["trace[1619983988] 'agreement among raft nodes before linearized reading' (duration: 151.413938ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:41.22537Z","caller":"traceutil/trace.go:171","msg":"trace[551866161] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"148.13972ms","start":"2026-09-22T14:46:41.077207Z","end":"2026-09-22T14:46:41.225346Z","steps":["trace[551866161] 'process raft request' (duration: 147.813981ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.202938Z","caller":"traceutil/trace.go:171","msg":"trace[1730644452] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"150.522794ms","start":"2026-09-22T14:46:43.052399Z","end":"2026-09-22T14:46:43.202922Z","steps":["trace[1730644452] 'process raft request' (duration: 150.494763ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.202963Z","caller":"traceutil/trace.go:171","msg":"trace[1030421429] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"155.412813ms","start":"2026-09-22T14:46:43.047527Z","end":"2026-09-22T14:46:43.20294Z","steps":["trace[1030421429] 'process raft request' (duration: 144.732009ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.203068Z","caller":"traceutil/trace.go:171","msg":"trace[836407706] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"154.036517ms","start":"2026-09-22T14:46:43.049026Z","end":"2026-09-22T14:46:43.203063Z","steps":["trace[836407706] 'process raft request' (duration: 153.836071ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.206518Z","caller":"traceutil/trace.go:171","msg":"trace[563038066] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"142.355056ms","start":"2026-09-22T14:46:43.064135Z","end":"2026-09-22T14:46:43.20649Z","steps":["trace[563038066] 'process raft request' (duration: 142.085339ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.206811Z","caller":"traceutil/trace.go:171","msg":"trace[12184126] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"151.249353ms","start":"2026-09-22T14:46:43.055546Z","end":"2026-09-22T14:46:43.206796Z","steps":["trace[12184126] 'process raft request' (duration: 150.549724ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.207029Z","caller":"traceutil/trace.go:171","msg":"trace[431164507] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"135.062952ms","start":"2026-09-22T14:46:43.071904Z","end":"2026-09-22T14:46:43.206967Z","steps":["trace[431164507] 'process raft request' (duration: 134.343613ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.207055Z","caller":"traceutil/trace.go:171","msg":"trace[559242330] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"151.415917ms","start":"2026-09-22T14:46:43.055628Z","end":"2026-09-22T14:46:43.207044Z","steps":["trace[559242330] 'process raft request' (duration: 150.555365ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.20721Z","caller":"traceutil/trace.go:171","msg":"trace[691432366] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"133.774268ms","start":"2026-09-22T14:46:43.073402Z","end":"2026-09-22T14:46:43.207176Z","steps":["trace[691432366] 'process raft request' (duration: 132.875534ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.207229Z","caller":"traceutil/trace.go:171","msg":"trace[79156294] transaction","detail":"{read_only:false; number_of_response:1; response_revision:510; }","duration":"123.798903ms","start":"2026-09-22T14:46:43.083408Z","end":"2026-09-22T14:46:43.207207Z","steps":["trace[79156294] 'process raft request' (duration: 122.917489ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.207053Z","caller":"traceutil/trace.go:171","msg":"trace[220371532] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"102.002923ms","start":"2026-09-22T14:46:43.105031Z","end":"2026-09-22T14:46:43.207034Z","steps":["trace[220371532] 'process raft request' (duration: 101.477039ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.206972Z","caller":"traceutil/trace.go:171","msg":"trace[890164246] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"113.059237ms","start":"2026-09-22T14:46:43.093895Z","end":"2026-09-22T14:46:43.206954Z","steps":["trace[890164246] 'process raft request' (duration: 112.573504ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:43.211682Z","caller":"traceutil/trace.go:171","msg":"trace[1398499810] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"119.643872ms","start":"2026-09-22T14:46:43.09203Z","end":"2026-09-22T14:46:43.211674Z","steps":["trace[1398499810] 'process raft request' (duration: 114.350291ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:49.948121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.0363ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-22T14:46:49.948296Z","caller":"traceutil/trace.go:171","msg":"trace[2083221720] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"143.567968ms","start":"2026-09-22T14:46:49.804709Z","end":"2026-09-22T14:46:49.948277Z","steps":["trace[2083221720] 'process raft request' (duration: 143.515417ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:46:49.948543Z","caller":"traceutil/trace.go:171","msg":"trace[533411980] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"176.065246ms","start":"2026-09-22T14:46:49.772403Z","end":"2026-09-22T14:46:49.948468Z","steps":["trace[533411980] 'process raft request' (duration: 31.588054ms)","trace[533411980] 'compare' (duration: 143.909897ms)"],"step_count":2} {"level":"warn","ts":"2026-09-22T14:46:50.422952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.956312ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-22T14:46:50.423189Z","caller":"traceutil/trace.go:171","msg":"trace[1188353151] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"392.58902ms","start":"2026-09-22T14:46:50.030555Z","end":"2026-09-22T14:46:50.423144Z","steps":["trace[1188353151] 'process raft request' (duration: 20.373872ms)","trace[1188353151] 'compare' (duration: 371.817318ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T14:46:50.423293Z","caller":"traceutil/trace.go:171","msg":"trace[528393788] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"390.788853ms","start":"2026-09-22T14:46:50.032456Z","end":"2026-09-22T14:46:50.423245Z","steps":["trace[528393788] 'process raft request' (duration: 390.600848ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:50.423348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:50.030525Z","time spent":"392.750945ms","remote":"127.0.0.1:53568","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":775,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-22T14:46:50.423467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:50.032437Z","time spent":"390.936587ms","remote":"127.0.0.1:53680","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3209,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T14:46:50.423687Z","caller":"traceutil/trace.go:171","msg":"trace[1124306102] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"391.056981ms","start":"2026-09-22T14:46:50.032598Z","end":"2026-09-22T14:46:50.423655Z","steps":["trace[1124306102] 'process raft request' (duration: 390.524877ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:46:50.423819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-22T14:46:50.032582Z","time spent":"391.178244ms","remote":"127.0.0.1:53720","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-09-22T14:46:50.629624Z","caller":"traceutil/trace.go:171","msg":"trace[2113327007] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"201.142252ms","start":"2026-09-22T14:46:50.428433Z","end":"2026-09-22T14:46:50.629575Z","steps":["trace[2113327007] 'process raft request' (duration: 178.951173ms)","trace[2113327007] 'compare' (duration: 21.854751ms)"],"step_count":2} {"level":"info","ts":"2026-09-22T14:48:03.786899Z","caller":"traceutil/trace.go:171","msg":"trace[1205230110] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"173.256359ms","start":"2026-09-22T14:48:03.61362Z","end":"2026-09-22T14:48:03.786876Z","steps":["trace[1205230110] 'process raft request' (duration: 173.130816ms)"],"step_count":1} {"level":"info","ts":"2026-09-22T14:48:17.258575Z","caller":"traceutil/trace.go:171","msg":"trace[865371957] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"116.933911ms","start":"2026-09-22T14:48:17.141581Z","end":"2026-09-22T14:48:17.258515Z","steps":["trace[865371957] 'process raft request' (duration: 116.622252ms)"],"step_count":1} {"level":"warn","ts":"2026-09-22T14:48:17.655045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.216521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-22T14:48:17.655267Z","caller":"traceutil/trace.go:171","msg":"trace[1543847411] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1230; }","duration":"162.455367ms","start":"2026-09-22T14:48:17.49278Z","end":"2026-09-22T14:48:17.655235Z","steps":["trace[1543847411] 'count revisions from in-memory index tree' (duration: 162.13724ms)"],"step_count":1}