{"level":"warn","ts":"2026-10-14T13:01:49.883965Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T13:01:49.884114Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.218: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.218:2380","--initial-cluster=instance=https://162.253.55.218:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.218:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.218: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-10-14T13:01:49.884409Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-10-14T13:01:49.884428Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-10-14T13:01:49.884449Z","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-10-14T13:01:49.885249Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"]} {"level":"info","ts":"2026-10-14T13:01:49.885332Z","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.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.218: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-10-14T13:01:49.90285Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"17.269024ms"} {"level":"info","ts":"2026-10-14T13:01:49.916323Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"bb7d59f4041c8abe","cluster-id":"5330ca29224af3c4"} {"level":"info","ts":"2026-10-14T13:01:49.916408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=()"} {"level":"info","ts":"2026-10-14T13:01:49.916459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 0"} {"level":"info","ts":"2026-10-14T13:01:49.91647Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft bb7d59f4041c8abe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-10-14T13:01:49.916481Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became follower at term 1"} {"level":"info","ts":"2026-10-14T13:01:49.916568Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"warn","ts":"2026-10-14T13:01:49.924566Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-10-14T13:01:49.926436Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-10-14T13:01:49.929799Z","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-10-14T13:01:49.932208Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"bb7d59f4041c8abe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-10-14T13:01:49.932563Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"bb7d59f4041c8abe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-10-14T13:01:49.932657Z","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-10-14T13:01:49.933477Z","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-10-14T13:01:49.933529Z","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-10-14T13:01:49.936318Z","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-10-14T13:01:49.936596Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"bb7d59f4041c8abe","initial-advertise-peer-urls":["https://162.253.55.218:2380"],"listen-peer-urls":["https://162.253.55.218:2380"],"advertise-client-urls":["https://162.253.55.218:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.218:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-10-14T13:01:49.936629Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-10-14T13:01:49.936677Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe switched to configuration voters=(13510053361757227710)"} {"level":"info","ts":"2026-10-14T13:01:49.936725Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-10-14T13:01:49.936754Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.218:2380"} {"level":"info","ts":"2026-10-14T13:01:49.936857Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","added-peer-id":"bb7d59f4041c8abe","added-peer-peer-urls":["https://162.253.55.218:2380"]} {"level":"info","ts":"2026-10-14T13:01:50.716857Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe is starting a new election at term 1"} {"level":"info","ts":"2026-10-14T13:01:50.716922Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became pre-candidate at term 1"} {"level":"info","ts":"2026-10-14T13:01:50.716954Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgPreVoteResp from bb7d59f4041c8abe at term 1"} {"level":"info","ts":"2026-10-14T13:01:50.716968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became candidate at term 2"} {"level":"info","ts":"2026-10-14T13:01:50.716981Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe received MsgVoteResp from bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-10-14T13:01:50.716991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"bb7d59f4041c8abe became leader at term 2"} {"level":"info","ts":"2026-10-14T13:01:50.717001Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: bb7d59f4041c8abe elected leader bb7d59f4041c8abe at term 2"} {"level":"info","ts":"2026-10-14T13:01:50.718908Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T13:01:50.720418Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T13:01:50.720423Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"bb7d59f4041c8abe","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.218:2379]}","request-path":"/0/members/bb7d59f4041c8abe/attributes","cluster-id":"5330ca29224af3c4","publish-timeout":"7s"} {"level":"info","ts":"2026-10-14T13:01:50.720448Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-10-14T13:01:50.722128Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-10-14T13:01:50.722195Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-10-14T13:01:50.722354Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.218:2379"} {"level":"info","ts":"2026-10-14T13:01:50.722386Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5330ca29224af3c4","local-member-id":"bb7d59f4041c8abe","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T13:01:50.722456Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T13:01:50.722471Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-10-14T13:01:50.722584Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-10-14T13:02:45.65257Z","caller":"traceutil/trace.go:171","msg":"trace[1996813986] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"576.656997ms","start":"2026-10-14T13:02:45.07589Z","end":"2026-10-14T13:02:45.652547Z","steps":["trace[1996813986] 'process raft request' (duration: 576.522114ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:45.65297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.075869Z","time spent":"576.782159ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T13:02:45.714086Z","caller":"traceutil/trace.go:171","msg":"trace[30719366] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"630.674171ms","start":"2026-10-14T13:02:45.083383Z","end":"2026-10-14T13:02:45.714057Z","steps":["trace[30719366] 'process raft request' (duration: 630.416725ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:45.714142Z","caller":"traceutil/trace.go:171","msg":"trace[248073348] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"629.909876ms","start":"2026-10-14T13:02:45.084204Z","end":"2026-10-14T13:02:45.714114Z","steps":["trace[248073348] 'process raft request' (duration: 629.738682ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:45.714211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.083363Z","time spent":"630.792064ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T13:02:45.714233Z","caller":"traceutil/trace.go:171","msg":"trace[1170894347] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"528.504382ms","start":"2026-10-14T13:02:45.185707Z","end":"2026-10-14T13:02:45.714212Z","steps":["trace[1170894347] 'process raft request' (duration: 528.332728ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:45.714271Z","caller":"traceutil/trace.go:171","msg":"trace[985048281] transaction","detail":"{read_only:false; response_revision:567; number_of_response:1; }","duration":"578.518264ms","start":"2026-10-14T13:02:45.135724Z","end":"2026-10-14T13:02:45.714242Z","steps":["trace[985048281] 'process raft request' (duration: 578.263119ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:45.714295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.185686Z","time spent":"528.574423ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T13:02:45.71431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.084196Z","time spent":"630.05017ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T13:02:45.714341Z","caller":"traceutil/trace.go:171","msg":"trace[1165326960] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"527.013401ms","start":"2026-10-14T13:02:45.187295Z","end":"2026-10-14T13:02:45.714309Z","steps":["trace[1165326960] 'process raft request' (duration: 526.825577ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:45.714353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.1357Z","time spent":"578.616536ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T13:02:45.714323Z","caller":"traceutil/trace.go:171","msg":"trace[1579242831] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"528.505591ms","start":"2026-10-14T13:02:45.185771Z","end":"2026-10-14T13:02:45.714276Z","steps":["trace[1579242831] 'process raft request' (duration: 528.310847ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:45.714419Z","caller":"traceutil/trace.go:171","msg":"trace[170032121] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"523.639462ms","start":"2026-10-14T13:02:45.190765Z","end":"2026-10-14T13:02:45.714404Z","steps":["trace[170032121] 'process raft request' (duration: 523.395007ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:45.714449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.185766Z","time spent":"528.634344ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T13:02:45.714463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.190752Z","time spent":"523.691764ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T13:02:45.714382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.187287Z","time spent":"527.077253ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T13:02:45.71466Z","caller":"traceutil/trace.go:171","msg":"trace[379178461] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"514.661559ms","start":"2026-10-14T13:02:45.199988Z","end":"2026-10-14T13:02:45.714649Z","steps":["trace[379178461] 'process raft request' (duration: 514.206899ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:45.714692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.199968Z","time spent":"514.70955ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T13:02:45.714846Z","caller":"traceutil/trace.go:171","msg":"trace[1745252775] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"511.726459ms","start":"2026-10-14T13:02:45.20311Z","end":"2026-10-14T13:02:45.714836Z","steps":["trace[1745252775] 'process raft request' (duration: 511.481684ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:45.714897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.203088Z","time spent":"511.79257ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T13:02:45.714928Z","caller":"traceutil/trace.go:171","msg":"trace[477452140] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"485.140505ms","start":"2026-10-14T13:02:45.22978Z","end":"2026-10-14T13:02:45.71492Z","steps":["trace[477452140] 'process raft request' (duration: 484.866829ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:45.714991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.229762Z","time spent":"485.187426ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T13:02:45.715324Z","caller":"traceutil/trace.go:171","msg":"trace[1592949369] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"398.416551ms","start":"2026-10-14T13:02:45.316899Z","end":"2026-10-14T13:02:45.715316Z","steps":["trace[1592949369] 'process raft request' (duration: 398.212857ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:45.715341Z","caller":"traceutil/trace.go:171","msg":"trace[719690469] linearizableReadLoop","detail":"{readStateIndex:597; appliedIndex:585; }","duration":"199.683465ms","start":"2026-10-14T13:02:45.515644Z","end":"2026-10-14T13:02:45.715327Z","steps":["trace[719690469] 'read index received' (duration: 136.784908ms)","trace[719690469] 'applied index is now lower than readState.Index' (duration: 62.897717ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:02:45.715361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:45.316872Z","time spent":"398.472732ms","remote":"127.0.0.1:45584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T13:02:45.715594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.925641ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:02:45.716643Z","caller":"traceutil/trace.go:171","msg":"trace[1054578340] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:575; }","duration":"201.024202ms","start":"2026-10-14T13:02:45.515598Z","end":"2026-10-14T13:02:45.716622Z","steps":["trace[1054578340] 'agreement among raft nodes before linearized reading' (duration: 199.787087ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:46.31146Z","caller":"traceutil/trace.go:171","msg":"trace[95431615] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"123.65678ms","start":"2026-10-14T13:02:46.187759Z","end":"2026-10-14T13:02:46.311416Z","steps":["trace[95431615] 'process raft request' (duration: 73.842881ms)","trace[95431615] 'compare' (duration: 49.709887ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:02:47.979411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.053361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-10-14T13:02:47.979511Z","caller":"traceutil/trace.go:171","msg":"trace[12970697] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:642; }","duration":"152.193593ms","start":"2026-10-14T13:02:47.827304Z","end":"2026-10-14T13:02:47.979497Z","steps":["trace[12970697] 'range keys from in-memory index tree' (duration: 151.905088ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:47.979765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.053486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-10-14T13:02:47.979796Z","caller":"traceutil/trace.go:171","msg":"trace[1012335351] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:642; }","duration":"142.087196ms","start":"2026-10-14T13:02:47.837699Z","end":"2026-10-14T13:02:47.979786Z","steps":["trace[1012335351] 'range keys from in-memory index tree' (duration: 141.731429ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:48.016137Z","caller":"traceutil/trace.go:171","msg":"trace[1969335199] linearizableReadLoop","detail":"{readStateIndex:672; appliedIndex:671; }","duration":"164.493594ms","start":"2026-10-14T13:02:47.851621Z","end":"2026-10-14T13:02:48.016114Z","steps":["trace[1969335199] 'read index received' (duration: 164.214719ms)","trace[1969335199] 'applied index is now lower than readState.Index' (duration: 278.105µs)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:02:48.016408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.76808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-10-14T13:02:48.016458Z","caller":"traceutil/trace.go:171","msg":"trace[293693095] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:643; }","duration":"164.871412ms","start":"2026-10-14T13:02:47.851576Z","end":"2026-10-14T13:02:48.016448Z","steps":["trace[293693095] 'agreement among raft nodes before linearized reading' (duration: 164.707889ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:02:48.016575Z","caller":"traceutil/trace.go:171","msg":"trace[1443655314] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"167.931276ms","start":"2026-10-14T13:02:47.84863Z","end":"2026-10-14T13:02:48.016561Z","steps":["trace[1443655314] 'process raft request' (duration: 167.236551ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:56.760813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.632059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-10-14T13:02:56.760893Z","caller":"traceutil/trace.go:171","msg":"trace[1921800567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:688; }","duration":"340.745661ms","start":"2026-10-14T13:02:56.42013Z","end":"2026-10-14T13:02:56.760876Z","steps":["trace[1921800567] 'range keys from in-memory index tree' (duration: 340.521486ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:56.760909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.932582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-10-14T13:02:56.760931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:56.420113Z","time spent":"340.806412ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-10-14T13:02:56.760939Z","caller":"traceutil/trace.go:171","msg":"trace[811094874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:688; }","duration":"247.996144ms","start":"2026-10-14T13:02:56.512935Z","end":"2026-10-14T13:02:56.760931Z","steps":["trace[811094874] 'range keys from in-memory index tree' (duration: 247.785259ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:56.760974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.716808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-10-14T13:02:56.761Z","caller":"traceutil/trace.go:171","msg":"trace[1954711515] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:688; }","duration":"687.77855ms","start":"2026-10-14T13:02:56.073214Z","end":"2026-10-14T13:02:56.760993Z","steps":["trace[1954711515] 'range keys from in-memory index tree' (duration: 687.343591ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:56.761017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:56.07319Z","time spent":"687.822081ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-10-14T13:02:56.761124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"480.285945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-14T13:02:56.761208Z","caller":"traceutil/trace.go:171","msg":"trace[116761299] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:688; }","duration":"480.415988ms","start":"2026-10-14T13:02:56.280773Z","end":"2026-10-14T13:02:56.761189Z","steps":["trace[116761299] 'range keys from in-memory index tree' (duration: 480.126632ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:56.761288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:56.280754Z","time spent":"480.52084ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-10-14T13:02:56.761146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.251351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-10-14T13:02:56.761697Z","caller":"traceutil/trace.go:171","msg":"trace[1892198794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:688; }","duration":"669.831973ms","start":"2026-10-14T13:02:56.091841Z","end":"2026-10-14T13:02:56.761673Z","steps":["trace[1892198794] 'range keys from in-memory index tree' (duration: 669.116648ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:02:56.761729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:02:56.091814Z","time spent":"669.901635ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-10-14T13:03:14.583208Z","caller":"traceutil/trace.go:171","msg":"trace[1999091035] transaction","detail":"{read_only:false; response_revision:851; number_of_response:1; }","duration":"268.881041ms","start":"2026-10-14T13:03:14.314308Z","end":"2026-10-14T13:03:14.583189Z","steps":["trace[1999091035] 'process raft request' (duration: 268.742078ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:03:57.411614Z","caller":"traceutil/trace.go:171","msg":"trace[1295454770] linearizableReadLoop","detail":"{readStateIndex:1188; appliedIndex:1187; }","duration":"196.290938ms","start":"2026-10-14T13:03:57.215294Z","end":"2026-10-14T13:03:57.411585Z","steps":["trace[1295454770] 'read index received' (duration: 195.976342ms)","trace[1295454770] 'applied index is now lower than readState.Index' (duration: 313.516µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:03:57.412069Z","caller":"traceutil/trace.go:171","msg":"trace[864100558] transaction","detail":"{read_only:false; response_revision:1140; number_of_response:1; }","duration":"291.825757ms","start":"2026-10-14T13:03:57.120193Z","end":"2026-10-14T13:03:57.412019Z","steps":["trace[864100558] 'process raft request' (duration: 291.187624ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:03:57.412211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.990138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-14T13:03:57.41227Z","caller":"traceutil/trace.go:171","msg":"trace[724942497] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1140; }","duration":"168.11438ms","start":"2026-10-14T13:03:57.244145Z","end":"2026-10-14T13:03:57.412259Z","steps":["trace[724942497] 'agreement among raft nodes before linearized reading' (duration: 167.910656ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:03:57.412446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.160615ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-14T13:03:57.412462Z","caller":"traceutil/trace.go:171","msg":"trace[1975141873] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1140; }","duration":"197.218876ms","start":"2026-10-14T13:03:57.215238Z","end":"2026-10-14T13:03:57.412457Z","steps":["trace[1975141873] 'agreement among raft nodes before linearized reading' (duration: 197.130035ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:03:57.844314Z","caller":"traceutil/trace.go:171","msg":"trace[629750280] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"425.412735ms","start":"2026-10-14T13:03:57.418878Z","end":"2026-10-14T13:03:57.844291Z","steps":["trace[629750280] 'process raft request' (duration: 425.086258ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:03:57.844756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:03:57.418851Z","time spent":"425.609989ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:03:57.845493Z","caller":"traceutil/trace.go:171","msg":"trace[1047013783] linearizableReadLoop","detail":"{readStateIndex:1193; appliedIndex:1188; }","duration":"333.778172ms","start":"2026-10-14T13:03:57.511701Z","end":"2026-10-14T13:03:57.84548Z","steps":["trace[1047013783] 'read index received' (duration: 332.491747ms)","trace[1047013783] 'applied index is now lower than readState.Index' (duration: 1.285845ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:03:57.845586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.870334ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:03:57.845607Z","caller":"traceutil/trace.go:171","msg":"trace[994832765] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1145; }","duration":"333.939186ms","start":"2026-10-14T13:03:57.511662Z","end":"2026-10-14T13:03:57.845601Z","steps":["trace[994832765] 'agreement among raft nodes before linearized reading' (duration: 333.873775ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:03:57.845628Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:03:57.511643Z","time spent":"333.980226ms","remote":"127.0.0.1:45544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-10-14T13:03:57.84585Z","caller":"traceutil/trace.go:171","msg":"trace[2033822156] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"426.67082ms","start":"2026-10-14T13:03:57.419168Z","end":"2026-10-14T13:03:57.845838Z","steps":["trace[2033822156] 'process raft request' (duration: 426.134069ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:03:57.845921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:03:57.419158Z","time spent":"426.7185ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:03:57.846015Z","caller":"traceutil/trace.go:171","msg":"trace[354263091] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"426.756762ms","start":"2026-10-14T13:03:57.419252Z","end":"2026-10-14T13:03:57.846009Z","steps":["trace[354263091] 'process raft request' (duration: 426.127969ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:03:57.846048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:03:57.419247Z","time spent":"426.785512ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:03:57.846109Z","caller":"traceutil/trace.go:171","msg":"trace[594671515] transaction","detail":"{read_only:false; response_revision:1144; number_of_response:1; }","duration":"423.474888ms","start":"2026-10-14T13:03:57.422629Z","end":"2026-10-14T13:03:57.846103Z","steps":["trace[594671515] 'process raft request' (duration: 422.774714ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:03:57.846138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:03:57.422617Z","time spent":"423.508438ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:03:57.846197Z","caller":"traceutil/trace.go:171","msg":"trace[1096625010] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"423.098201ms","start":"2026-10-14T13:03:57.423094Z","end":"2026-10-14T13:03:57.846192Z","steps":["trace[1096625010] 'process raft request' (duration: 422.365586ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:03:57.846225Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:03:57.423086Z","time spent":"423.125061ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:04:18.199016Z","caller":"traceutil/trace.go:171","msg":"trace[433771655] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"121.630635ms","start":"2026-10-14T13:04:18.077349Z","end":"2026-10-14T13:04:18.19898Z","steps":["trace[433771655] 'process raft request' (duration: 30.481457ms)","trace[433771655] 'compare' (duration: 91.017976ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:04:18.223366Z","caller":"traceutil/trace.go:171","msg":"trace[1976433450] linearizableReadLoop","detail":"{readStateIndex:1262; appliedIndex:1260; }","duration":"115.562197ms","start":"2026-10-14T13:04:18.107772Z","end":"2026-10-14T13:04:18.223334Z","steps":["trace[1976433450] 'read index received' (duration: 74.662µs)","trace[1976433450] 'applied index is now lower than readState.Index' (duration: 115.486175ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:04:18.223665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.858143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-10-14T13:04:18.223806Z","caller":"traceutil/trace.go:171","msg":"trace[1391291392] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1210; }","duration":"116.082837ms","start":"2026-10-14T13:04:18.107714Z","end":"2026-10-14T13:04:18.223797Z","steps":["trace[1391291392] 'agreement among raft nodes before linearized reading' (duration: 115.812002ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:04:18.223951Z","caller":"traceutil/trace.go:171","msg":"trace[2120049741] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"144.827201ms","start":"2026-10-14T13:04:18.079114Z","end":"2026-10-14T13:04:18.223941Z","steps":["trace[2120049741] 'process raft request' (duration: 144.043055ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:04:22.233753Z","caller":"traceutil/trace.go:171","msg":"trace[1736449042] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1293; }","duration":"149.283247ms","start":"2026-10-14T13:04:22.084442Z","end":"2026-10-14T13:04:22.233725Z","steps":["trace[1736449042] 'read index received' (duration: 149.097404ms)","trace[1736449042] 'applied index is now lower than readState.Index' (duration: 184.753µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:04:22.234209Z","caller":"traceutil/trace.go:171","msg":"trace[246310103] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"176.94036ms","start":"2026-10-14T13:04:22.05724Z","end":"2026-10-14T13:04:22.23418Z","steps":["trace[246310103] 'process raft request' (duration: 176.318778ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:22.234394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.92553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-10-14T13:04:22.234451Z","caller":"traceutil/trace.go:171","msg":"trace[1489735218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1240; }","duration":"150.071062ms","start":"2026-10-14T13:04:22.084369Z","end":"2026-10-14T13:04:22.23444Z","steps":["trace[1489735218] 'agreement among raft nodes before linearized reading' (duration: 149.825498ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:23.41594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"420.380604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:04:23.416031Z","caller":"traceutil/trace.go:171","msg":"trace[1134625840] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:1245; }","duration":"420.517737ms","start":"2026-10-14T13:04:22.995488Z","end":"2026-10-14T13:04:23.416006Z","steps":["trace[1134625840] 'count revisions from in-memory index tree' (duration: 420.309123ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:23.416086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:04:22.995469Z","time spent":"420.605819ms","remote":"127.0.0.1:58982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-10-14T13:04:24.382166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.297369ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-10-14T13:04:24.382309Z","caller":"traceutil/trace.go:171","msg":"trace[410902257] linearizableReadLoop","detail":"{readStateIndex:1303; appliedIndex:1301; }","duration":"204.086103ms","start":"2026-10-14T13:04:24.178209Z","end":"2026-10-14T13:04:24.382295Z","steps":["trace[410902257] 'read index received' (duration: 41.061µs)","trace[410902257] 'applied index is now lower than readState.Index' (duration: 204.044242ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:04:24.382392Z","caller":"traceutil/trace.go:171","msg":"trace[1347415171] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"555.129347ms","start":"2026-10-14T13:04:23.827251Z","end":"2026-10-14T13:04:24.382381Z","steps":["trace[1347415171] 'process raft request' (duration: 46.458291ms)","trace[1347415171] 'compare' (duration: 507.922211ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:04:24.382484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:04:23.827238Z","time spent":"555.224449ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-10-14T13:04:24.382759Z","caller":"traceutil/trace.go:171","msg":"trace[56151039] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"530.377992ms","start":"2026-10-14T13:04:23.852373Z","end":"2026-10-14T13:04:24.382751Z","steps":["trace[56151039] 'process raft request' (duration: 529.884072ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:24.382803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:04:23.85235Z","time spent":"530.431622ms","remote":"127.0.0.1:45614","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-10-14T13:04:24.382826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.616423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-10-14T13:04:24.382854Z","caller":"traceutil/trace.go:171","msg":"trace[2107277588] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1249; }","duration":"204.681645ms","start":"2026-10-14T13:04:24.178163Z","end":"2026-10-14T13:04:24.382844Z","steps":["trace[2107277588] 'agreement among raft nodes before linearized reading' (duration: 204.591203ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:24.383708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.626196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-10-14T13:04:24.383743Z","caller":"traceutil/trace.go:171","msg":"trace[1737510830] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1249; }","duration":"144.693247ms","start":"2026-10-14T13:04:24.239041Z","end":"2026-10-14T13:04:24.383734Z","steps":["trace[1737510830] 'agreement among raft nodes before linearized reading' (duration: 144.255699ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:24.597801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.807776ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-10-14T13:04:24.598063Z","caller":"traceutil/trace.go:171","msg":"trace[1057637399] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"209.470438ms","start":"2026-10-14T13:04:24.38855Z","end":"2026-10-14T13:04:24.59802Z","steps":["trace[1057637399] 'process raft request' (duration: 108.332445ms)","trace[1057637399] 'compare' (duration: 100.635963ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:04:24.598284Z","caller":"traceutil/trace.go:171","msg":"trace[1601411805] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"209.433338ms","start":"2026-10-14T13:04:24.388822Z","end":"2026-10-14T13:04:24.598256Z","steps":["trace[1601411805] 'process raft request' (duration: 209.195573ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:04:24.598501Z","caller":"traceutil/trace.go:171","msg":"trace[305333737] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"208.983429ms","start":"2026-10-14T13:04:24.389501Z","end":"2026-10-14T13:04:24.598484Z","steps":["trace[305333737] 'process raft request' (duration: 208.543151ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:04:24.598284Z","caller":"traceutil/trace.go:171","msg":"trace[1516553189] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"209.716043ms","start":"2026-10-14T13:04:24.388549Z","end":"2026-10-14T13:04:24.598265Z","steps":["trace[1516553189] 'process raft request' (duration: 209.368516ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:04:24.598497Z","caller":"traceutil/trace.go:171","msg":"trace[1494300249] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"208.014069ms","start":"2026-10-14T13:04:24.390451Z","end":"2026-10-14T13:04:24.598466Z","steps":["trace[1494300249] 'process raft request' (duration: 207.636762ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:04:24.598712Z","caller":"traceutil/trace.go:171","msg":"trace[1830761984] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"210.06418ms","start":"2026-10-14T13:04:24.388638Z","end":"2026-10-14T13:04:24.598702Z","steps":["trace[1830761984] 'process raft request' (duration: 209.341955ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:04:24.598913Z","caller":"traceutil/trace.go:171","msg":"trace[725798855] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"208.825935ms","start":"2026-10-14T13:04:24.390074Z","end":"2026-10-14T13:04:24.5989Z","steps":["trace[725798855] 'process raft request' (duration: 207.991559ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:04:36.019948Z","caller":"traceutil/trace.go:171","msg":"trace[564369828] linearizableReadLoop","detail":"{readStateIndex:1390; appliedIndex:1389; }","duration":"348.206369ms","start":"2026-10-14T13:04:35.671712Z","end":"2026-10-14T13:04:36.019918Z","steps":["trace[564369828] 'read index received' (duration: 347.900233ms)","trace[564369828] 'applied index is now lower than readState.Index' (duration: 304.966µs)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:04:36.020063Z","caller":"traceutil/trace.go:171","msg":"trace[1019689717] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"368.65399ms","start":"2026-10-14T13:04:35.65139Z","end":"2026-10-14T13:04:36.020044Z","steps":["trace[1019689717] 'process raft request' (duration: 368.316044ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:36.020117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.381012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-10-14T13:04:36.020145Z","caller":"traceutil/trace.go:171","msg":"trace[1613718704] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1333; }","duration":"348.491424ms","start":"2026-10-14T13:04:35.671646Z","end":"2026-10-14T13:04:36.020137Z","steps":["trace[1613718704] 'agreement among raft nodes before linearized reading' (duration: 348.389752ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:04:36.020163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:04:35.671619Z","time spent":"348.539686ms","remote":"127.0.0.1:45980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-10-14T13:04:36.020163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-10-14T13:04:35.651362Z","time spent":"368.736582ms","remote":"127.0.0.1:45802","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-10-14T13:09:40.59694Z","caller":"traceutil/trace.go:171","msg":"trace[1798427484] linearizableReadLoop","detail":"{readStateIndex:2885; appliedIndex:2883; }","duration":"178.904275ms","start":"2026-10-14T13:09:40.418013Z","end":"2026-10-14T13:09:40.596917Z","steps":["trace[1798427484] 'read index received' (duration: 2.93454ms)","trace[1798427484] 'applied index is now lower than readState.Index' (duration: 175.968565ms)"],"step_count":2} {"level":"info","ts":"2026-10-14T13:09:40.596965Z","caller":"traceutil/trace.go:171","msg":"trace[1037816412] transaction","detail":"{read_only:false; response_revision:2766; number_of_response:1; }","duration":"182.029328ms","start":"2026-10-14T13:09:40.414904Z","end":"2026-10-14T13:09:40.596933Z","steps":["trace[1037816412] 'process raft request' (duration: 107.215234ms)","trace[1037816412] 'compare' (duration: 74.60257ms)"],"step_count":2} {"level":"warn","ts":"2026-10-14T13:09:40.597146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.116669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-rkpdg\" ","response":"range_response_count:1 size:18525"} {"level":"warn","ts":"2026-10-14T13:09:40.597187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.071326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-10-14T13:09:40.597191Z","caller":"traceutil/trace.go:171","msg":"trace[502566529] range","detail":"{range_begin:/registry/pods/kube-system/cilium-rkpdg; range_end:; response_count:1; response_revision:2766; }","duration":"179.20002ms","start":"2026-10-14T13:09:40.41798Z","end":"2026-10-14T13:09:40.59718Z","steps":["trace[502566529] 'agreement among raft nodes before linearized reading' (duration: 179.019166ms)"],"step_count":1} {"level":"info","ts":"2026-10-14T13:09:40.597215Z","caller":"traceutil/trace.go:171","msg":"trace[1042816546] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2766; }","duration":"148.130168ms","start":"2026-10-14T13:09:40.449075Z","end":"2026-10-14T13:09:40.597206Z","steps":["trace[1042816546] 'agreement among raft nodes before linearized reading' (duration: 148.058056ms)"],"step_count":1} {"level":"warn","ts":"2026-10-14T13:09:40.59727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.710391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-67659f764b-gbqjf\" ","response":"range_response_count:1 size:4908"} {"level":"info","ts":"2026-10-14T13:09:40.597344Z","caller":"traceutil/trace.go:171","msg":"trace[493754107] range","detail":"{range_begin:/registry/pods/kube-system/coredns-67659f764b-gbqjf; range_end:; response_count:1; response_revision:2766; }","duration":"153.830203ms","start":"2026-10-14T13:09:40.443496Z","end":"2026-10-14T13:09:40.597327Z","steps":["trace[493754107] 'agreement among raft nodes before linearized reading' (duration: 153.628699ms)"],"step_count":1}