{"level":"warn","ts":"2026-07-01T07:16:34.024141Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T07:16:34.024341Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.169: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://199.204.45.169:2380","--initial-cluster=instance=https://199.204.45.169:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.169:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.169: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-07-01T07:16:34.024492Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T07:16:34.024528Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-07-01T07:16:34.024588Z","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-07-01T07:16:34.025802Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"]} {"level":"info","ts":"2026-07-01T07:16:34.025989Z","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://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.169: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-07-01T07:16:34.035048Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"8.698859ms"} {"level":"info","ts":"2026-07-01T07:16:34.052231Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"1c917701ce165bac","cluster-id":"bfb5247022b87cb1"} {"level":"info","ts":"2026-07-01T07:16:34.052374Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T07:16:34.052448Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 0"} {"level":"info","ts":"2026-07-01T07:16:34.052519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 1c917701ce165bac [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T07:16:34.052596Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became follower at term 1"} {"level":"info","ts":"2026-07-01T07:16:34.052649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"warn","ts":"2026-07-01T07:16:34.348122Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T07:16:34.388249Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T07:16:34.474735Z","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-07-01T07:16:34.574998Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"1c917701ce165bac","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T07:16:34.57583Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"1c917701ce165bac","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T07:16:34.576014Z","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-07-01T07:16:34.578616Z","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-07-01T07:16:34.578648Z","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-07-01T07:16:34.582056Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-07-01T07:16:34.581904Z","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-07-01T07:16:34.582106Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.169:2380"} {"level":"info","ts":"2026-07-01T07:16:34.582545Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"1c917701ce165bac","initial-advertise-peer-urls":["https://199.204.45.169:2380"],"listen-peer-urls":["https://199.204.45.169:2380"],"advertise-client-urls":["https://199.204.45.169:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.169:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T07:16:34.582579Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T07:16:34.606796Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac switched to configuration voters=(2058557354321271724)"} {"level":"info","ts":"2026-07-01T07:16:34.607131Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","added-peer-id":"1c917701ce165bac","added-peer-peer-urls":["https://199.204.45.169:2380"]} {"level":"info","ts":"2026-07-01T07:16:34.607232Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T07:16:34.607329Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T07:16:34.607353Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgPreVoteResp from 1c917701ce165bac at term 1"} {"level":"info","ts":"2026-07-01T07:16:34.607486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became candidate at term 2"} {"level":"info","ts":"2026-07-01T07:16:34.607501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac received MsgVoteResp from 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-07-01T07:16:34.607595Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"1c917701ce165bac became leader at term 2"} {"level":"info","ts":"2026-07-01T07:16:34.607611Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 1c917701ce165bac elected leader 1c917701ce165bac at term 2"} {"level":"info","ts":"2026-07-01T07:16:34.642139Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:16:34.642216Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"1c917701ce165bac","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.169:2379]}","request-path":"/0/members/1c917701ce165bac/attributes","cluster-id":"bfb5247022b87cb1","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T07:16:34.642217Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T07:16:34.642464Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T07:16:34.645778Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.169:2379"} {"level":"info","ts":"2026-07-01T07:16:34.646033Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T07:16:34.646067Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T07:16:34.647555Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T07:16:34.669468Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"bfb5247022b87cb1","local-member-id":"1c917701ce165bac","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:16:34.669656Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T07:16:34.669707Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-07-01T07:16:39.551549Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605829698358642483,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:16:40.051731Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605829698358642483,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:16:40.151011Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.108021986s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T07:16:40.151504Z","caller":"traceutil/trace.go:171","msg":"trace[1035689975] transaction","detail":"{read_only:false; response_revision:232; number_of_response:1; }","duration":"1.108586064s","start":"2026-07-01T07:16:39.042892Z","end":"2026-07-01T07:16:40.151478Z","steps":["trace[1035689975] 'process raft request' (duration: 1.108421799s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:40.152288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:39.042874Z","time spent":"1.108708728s","remote":"127.0.0.1:47292","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4003,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:16:41.545438Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.39421535s","expected-duration":"1s"} {"level":"info","ts":"2026-07-01T07:16:41.545879Z","caller":"traceutil/trace.go:171","msg":"trace[1729713942] linearizableReadLoop","detail":"{readStateIndex:239; appliedIndex:237; }","duration":"2.495141748s","start":"2026-07-01T07:16:39.050705Z","end":"2026-07-01T07:16:41.545847Z","steps":["trace[1729713942] 'read index received' (duration: 1.100534355s)","trace[1729713942] 'applied index is now lower than readState.Index' (duration: 1.394606413s)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:16:41.54597Z","caller":"traceutil/trace.go:171","msg":"trace[1805147685] transaction","detail":"{read_only:false; response_revision:233; number_of_response:1; }","duration":"1.644723311s","start":"2026-07-01T07:16:39.901214Z","end":"2026-07-01T07:16:41.545937Z","steps":["trace[1805147685] 'process raft request' (duration: 1.644457713s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:41.546059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.495341195s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"warn","ts":"2026-07-01T07:16:41.546125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:39.901192Z","time spent":"1.644854626s","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3965,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:16:41.546136Z","caller":"traceutil/trace.go:171","msg":"trace[571504991] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:233; }","duration":"2.495450437s","start":"2026-07-01T07:16:39.050672Z","end":"2026-07-01T07:16:41.546122Z","steps":["trace[571504991] 'agreement among raft nodes before linearized reading' (duration: 2.495310443s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:41.546201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:39.050661Z","time spent":"2.49550373s","remote":"127.0.0.1:47328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":239,"request content":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" "} {"level":"info","ts":"2026-07-01T07:16:41.655746Z","caller":"traceutil/trace.go:171","msg":"trace[11867180] linearizableReadLoop","detail":"{readStateIndex:240; appliedIndex:239; }","duration":"109.768218ms","start":"2026-07-01T07:16:41.545956Z","end":"2026-07-01T07:16:41.655724Z","steps":["trace[11867180] 'read index received' (duration: 104.099742ms)","trace[11867180] 'applied index is now lower than readState.Index' (duration: 5.667586ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:16:41.656051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.616243457s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-07-01T07:16:41.65611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.621522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:1 size:216"} {"level":"warn","ts":"2026-07-01T07:16:41.65617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.459807623s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:16:41.656229Z","caller":"traceutil/trace.go:171","msg":"trace[1150267120] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:234; }","duration":"1.459902646s","start":"2026-07-01T07:16:40.19631Z","end":"2026-07-01T07:16:41.656213Z","steps":["trace[1150267120] 'agreement among raft nodes before linearized reading' (duration: 1.459807373s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:41.656222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.500540342s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-4zep5t\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T07:16:41.656285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:40.196294Z","time spent":"1.459979159s","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-01T07:16:41.656287Z","caller":"traceutil/trace.go:171","msg":"trace[968477684] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-4zep5t; range_end:; response_count:0; response_revision:234; }","duration":"1.500647317s","start":"2026-07-01T07:16:40.155624Z","end":"2026-07-01T07:16:41.656271Z","steps":["trace[968477684] 'agreement among raft nodes before linearized reading' (duration: 1.500558064s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:41.656312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.499107135s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-07-01T07:16:41.656335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:40.155601Z","time spent":"1.500724168s","remote":"127.0.0.1:47202","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-4zep5t\" "} {"level":"warn","ts":"2026-07-01T07:16:41.656226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.55558188s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-01T07:16:41.656398Z","caller":"traceutil/trace.go:171","msg":"trace[1436312600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:234; }","duration":"1.499199059s","start":"2026-07-01T07:16:40.157173Z","end":"2026-07-01T07:16:41.656372Z","steps":["trace[1436312600] 'agreement among raft nodes before linearized reading' (duration: 1.499000102s)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:41.656496Z","caller":"traceutil/trace.go:171","msg":"trace[925198156] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:234; }","duration":"2.55585418s","start":"2026-07-01T07:16:39.100572Z","end":"2026-07-01T07:16:41.656426Z","steps":["trace[925198156] 'agreement among raft nodes before linearized reading' (duration: 2.55556866s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:41.656503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:40.157167Z","time spent":"1.499320022s","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-01T07:16:41.656341Z","caller":"traceutil/trace.go:171","msg":"trace[651284715] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:1; response_revision:234; }","duration":"105.833839ms","start":"2026-07-01T07:16:41.550438Z","end":"2026-07-01T07:16:41.656271Z","steps":["trace[651284715] 'agreement among raft nodes before linearized reading' (duration: 105.588211ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:41.65652Z","caller":"traceutil/trace.go:171","msg":"trace[2023501741] transaction","detail":"{read_only:false; response_revision:234; number_of_response:1; }","duration":"533.367829ms","start":"2026-07-01T07:16:41.123136Z","end":"2026-07-01T07:16:41.656504Z","steps":["trace[2023501741] 'process raft request' (duration: 526.945489ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:41.656547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:39.100549Z","time spent":"2.555986943s","remote":"127.0.0.1:47208","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-07-01T07:16:41.656801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:41.123107Z","time spent":"533.548675ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5498,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:16:41.657566Z","caller":"traceutil/trace.go:171","msg":"trace[575649034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:234; }","duration":"1.61634201s","start":"2026-07-01T07:16:40.039788Z","end":"2026-07-01T07:16:41.65613Z","steps":["trace[575649034] 'agreement among raft nodes before linearized reading' (duration: 1.616131433s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:41.656029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.617292002s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-07-01T07:16:41.657627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:40.039748Z","time spent":"1.617864201s","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-07-01T07:16:41.657664Z","caller":"traceutil/trace.go:171","msg":"trace[2022950260] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:234; }","duration":"1.618967897s","start":"2026-07-01T07:16:40.038678Z","end":"2026-07-01T07:16:41.657646Z","steps":["trace[2022950260] 'agreement among raft nodes before linearized reading' (duration: 1.617275851s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:41.657779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:40.038647Z","time spent":"1.61905907s","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-01T07:16:42.607828Z","caller":"traceutil/trace.go:171","msg":"trace[760982592] transaction","detail":"{read_only:false; response_revision:284; number_of_response:1; }","duration":"145.175394ms","start":"2026-07-01T07:16:42.462637Z","end":"2026-07-01T07:16:42.607812Z","steps":["trace[760982592] 'process raft request' (duration: 143.630244ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:43.267124Z","caller":"traceutil/trace.go:171","msg":"trace[356617288] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"169.439607ms","start":"2026-07-01T07:16:43.097655Z","end":"2026-07-01T07:16:43.267095Z","steps":["trace[356617288] 'process raft request' (duration: 169.314293ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:43.267156Z","caller":"traceutil/trace.go:171","msg":"trace[1059441411] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"166.484613ms","start":"2026-07-01T07:16:43.100642Z","end":"2026-07-01T07:16:43.267127Z","steps":["trace[1059441411] 'process raft request' (duration: 166.40973ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:43.267204Z","caller":"traceutil/trace.go:171","msg":"trace[2115500109] transaction","detail":"{read_only:false; number_of_response:0; response_revision:287; }","duration":"166.450922ms","start":"2026-07-01T07:16:43.10073Z","end":"2026-07-01T07:16:43.267181Z","steps":["trace[2115500109] 'process raft request' (duration: 166.340868ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:43.267297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.444116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-07-01T07:16:43.267352Z","caller":"traceutil/trace.go:171","msg":"trace[956912459] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:288; }","duration":"153.535069ms","start":"2026-07-01T07:16:43.113805Z","end":"2026-07-01T07:16:43.26734Z","steps":["trace[956912459] 'agreement among raft nodes before linearized reading' (duration: 153.420615ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:43.267359Z","caller":"traceutil/trace.go:171","msg":"trace[875481696] transaction","detail":"{read_only:false; response_revision:288; number_of_response:1; }","duration":"153.506817ms","start":"2026-07-01T07:16:43.11384Z","end":"2026-07-01T07:16:43.267346Z","steps":["trace[875481696] 'process raft request' (duration: 153.254468ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:43.267173Z","caller":"traceutil/trace.go:171","msg":"trace[1943650124] linearizableReadLoop","detail":"{readStateIndex:302; appliedIndex:298; }","duration":"153.321392ms","start":"2026-07-01T07:16:43.113835Z","end":"2026-07-01T07:16:43.267156Z","steps":["trace[1943650124] 'read index received' (duration: 73.852976ms)","trace[1943650124] 'applied index is now lower than readState.Index' (duration: 79.467616ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:16:43.56627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.514274ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:16:43.566371Z","caller":"traceutil/trace.go:171","msg":"trace[1838825253] linearizableReadLoop","detail":"{readStateIndex:305; appliedIndex:304; }","duration":"252.921692ms","start":"2026-07-01T07:16:43.313434Z","end":"2026-07-01T07:16:43.566356Z","steps":["trace[1838825253] 'read index received' (duration: 115.077066ms)","trace[1838825253] 'applied index is now lower than readState.Index' (duration: 137.843406ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:16:43.566454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.026204ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/persistent-volume-binder\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:16:43.56648Z","caller":"traceutil/trace.go:171","msg":"trace[1676020229] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/persistent-volume-binder; range_end:; response_count:0; response_revision:290; }","duration":"253.073396ms","start":"2026-07-01T07:16:43.313398Z","end":"2026-07-01T07:16:43.566471Z","steps":["trace[1676020229] 'agreement among raft nodes before linearized reading' (duration: 253.000424ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:43.566842Z","caller":"traceutil/trace.go:171","msg":"trace[724702965] transaction","detail":"{read_only:false; response_revision:290; number_of_response:1; }","duration":"288.221922ms","start":"2026-07-01T07:16:43.278604Z","end":"2026-07-01T07:16:43.566826Z","steps":["trace[724702965] 'process raft request' (duration: 149.952743ms)","trace[724702965] 'compare' (duration: 137.398191ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:16:43.788381Z","caller":"traceutil/trace.go:171","msg":"trace[508579586] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:306; }","duration":"182.680632ms","start":"2026-07-01T07:16:43.605675Z","end":"2026-07-01T07:16:43.788355Z","steps":["trace[508579586] 'read index received' (duration: 142.709022ms)","trace[508579586] 'applied index is now lower than readState.Index' (duration: 39.97034ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:16:43.78843Z","caller":"traceutil/trace.go:171","msg":"trace[1349664048] transaction","detail":"{read_only:false; response_revision:292; number_of_response:1; }","duration":"213.571911ms","start":"2026-07-01T07:16:43.574812Z","end":"2026-07-01T07:16:43.788384Z","steps":["trace[1349664048] 'process raft request' (duration: 173.599631ms)","trace[1349664048] 'compare' (duration: 39.785174ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:16:43.788572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.040418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-01T07:16:43.788617Z","caller":"traceutil/trace.go:171","msg":"trace[1788584358] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:292; }","duration":"171.154982ms","start":"2026-07-01T07:16:43.61745Z","end":"2026-07-01T07:16:43.788605Z","steps":["trace[1788584358] 'agreement among raft nodes before linearized reading' (duration: 171.065349ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:43.788608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.871308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-01T07:16:43.788724Z","caller":"traceutil/trace.go:171","msg":"trace[1995791173] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:292; }","duration":"183.068544ms","start":"2026-07-01T07:16:43.60564Z","end":"2026-07-01T07:16:43.788709Z","steps":["trace[1995791173] 'agreement among raft nodes before linearized reading' (duration: 182.799236ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:43.788995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.14394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-07-01T07:16:43.789014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.06356ms","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-07-01T07:16:43.789078Z","caller":"traceutil/trace.go:171","msg":"trace[731172655] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:292; }","duration":"112.140052ms","start":"2026-07-01T07:16:43.676923Z","end":"2026-07-01T07:16:43.789063Z","steps":["trace[731172655] 'agreement among raft nodes before linearized reading' (duration: 112.027968ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:43.789085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.719713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-07-01T07:16:43.789117Z","caller":"traceutil/trace.go:171","msg":"trace[2005449940] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:292; }","duration":"153.768115ms","start":"2026-07-01T07:16:43.635339Z","end":"2026-07-01T07:16:43.789107Z","steps":["trace[2005449940] 'agreement among raft nodes before linearized reading' (duration: 153.720293ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:43.789035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.557135ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-07-01T07:16:43.789264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.580297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-07-01T07:16:43.789297Z","caller":"traceutil/trace.go:171","msg":"trace[2108147808] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:292; }","duration":"166.632868ms","start":"2026-07-01T07:16:43.622655Z","end":"2026-07-01T07:16:43.789288Z","steps":["trace[2108147808] 'agreement among raft nodes before linearized reading' (duration: 166.585286ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:43.789301Z","caller":"traceutil/trace.go:171","msg":"trace[1437215328] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:292; }","duration":"127.820094ms","start":"2026-07-01T07:16:43.661437Z","end":"2026-07-01T07:16:43.789257Z","steps":["trace[1437215328] 'agreement among raft nodes before linearized reading' (duration: 127.561366ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:43.78939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.047774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-07-01T07:16:43.789423Z","caller":"traceutil/trace.go:171","msg":"trace[1069181575] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:292; }","duration":"168.100696ms","start":"2026-07-01T07:16:43.621313Z","end":"2026-07-01T07:16:43.789414Z","steps":["trace[1069181575] 'agreement among raft nodes before linearized reading' (duration: 168.048434ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:43.789225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.778878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-07-01T07:16:43.789498Z","caller":"traceutil/trace.go:171","msg":"trace[1501256225] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:292; }","duration":"160.108839ms","start":"2026-07-01T07:16:43.629379Z","end":"2026-07-01T07:16:43.789487Z","steps":["trace[1501256225] 'agreement among raft nodes before linearized reading' (duration: 159.820949ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:43.789526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.636997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-01T07:16:43.789577Z","caller":"traceutil/trace.go:171","msg":"trace[1489069568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:292; }","duration":"116.700648ms","start":"2026-07-01T07:16:43.672867Z","end":"2026-07-01T07:16:43.789568Z","steps":["trace[1489069568] 'agreement among raft nodes before linearized reading' (duration: 116.632616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:43.789534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.607176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-01T07:16:43.789626Z","caller":"traceutil/trace.go:171","msg":"trace[314272709] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:292; }","duration":"116.7219ms","start":"2026-07-01T07:16:43.672895Z","end":"2026-07-01T07:16:43.789617Z","steps":["trace[314272709] 'agreement among raft nodes before linearized reading' (duration: 116.598866ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:43.789453Z","caller":"traceutil/trace.go:171","msg":"trace[2040951625] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:292; }","duration":"116.222693ms","start":"2026-07-01T07:16:43.67281Z","end":"2026-07-01T07:16:43.789033Z","steps":["trace[2040951625] 'agreement among raft nodes before linearized reading' (duration: 116.100049ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:44.249132Z","caller":"traceutil/trace.go:171","msg":"trace[282932024] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"455.681239ms","start":"2026-07-01T07:16:43.793423Z","end":"2026-07-01T07:16:44.249104Z","steps":["trace[282932024] 'process raft request' (duration: 372.581577ms)","trace[282932024] 'compare' (duration: 82.890485ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:16:44.249365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:43.793408Z","time spent":"455.864124ms","remote":"127.0.0.1:47410","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-07-01T07:16:44.249593Z","caller":"traceutil/trace.go:171","msg":"trace[326649984] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"455.74217ms","start":"2026-07-01T07:16:43.79381Z","end":"2026-07-01T07:16:44.249552Z","steps":["trace[326649984] 'process raft request' (duration: 455.254474ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:44.249887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:43.793801Z","time spent":"455.895294ms","remote":"127.0.0.1:47410","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-07-01T07:16:44.249879Z","caller":"traceutil/trace.go:171","msg":"trace[1829883980] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"455.202702ms","start":"2026-07-01T07:16:43.79456Z","end":"2026-07-01T07:16:44.249762Z","steps":["trace[1829883980] 'process raft request' (duration: 454.924443ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:44.250057Z","caller":"traceutil/trace.go:171","msg":"trace[18273101] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"448.623493ms","start":"2026-07-01T07:16:43.801418Z","end":"2026-07-01T07:16:44.250042Z","steps":["trace[18273101] 'process raft request' (duration: 448.263541ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:44.250077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"438.622522ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-01T07:16:44.249923Z","caller":"traceutil/trace.go:171","msg":"trace[209586006] linearizableReadLoop","detail":"{readStateIndex:312; appliedIndex:307; }","duration":"438.452725ms","start":"2026-07-01T07:16:43.811446Z","end":"2026-07-01T07:16:44.249899Z","steps":["trace[209586006] 'read index received' (duration: 23.256535ms)","trace[209586006] 'applied index is now lower than readState.Index' (duration: 415.19386ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:16:44.250207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:43.801405Z","time spent":"448.725475ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4649,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:16:44.250188Z","caller":"traceutil/trace.go:171","msg":"trace[446889767] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:297; }","duration":"438.768997ms","start":"2026-07-01T07:16:43.811401Z","end":"2026-07-01T07:16:44.25017Z","steps":["trace[446889767] 'agreement among raft nodes before linearized reading' (duration: 438.564729ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:44.250313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.29421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-07-01T07:16:44.250303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:43.811389Z","time spent":"438.89673ms","remote":"127.0.0.1:47328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-07-01T07:16:44.25037Z","caller":"traceutil/trace.go:171","msg":"trace[448579754] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:297; }","duration":"388.381492ms","start":"2026-07-01T07:16:43.861971Z","end":"2026-07-01T07:16:44.250353Z","steps":["trace[448579754] 'agreement among raft nodes before linearized reading' (duration: 388.272539ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:44.250411Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:43.861958Z","time spent":"388.444734ms","remote":"127.0.0.1:47328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-07-01T07:16:44.250361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:43.794537Z","time spent":"455.488402ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:16:44.250753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.588364ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-01T07:16:44.250796Z","caller":"traceutil/trace.go:171","msg":"trace[1856969702] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:297; }","duration":"288.668428ms","start":"2026-07-01T07:16:43.962118Z","end":"2026-07-01T07:16:44.250787Z","steps":["trace[1856969702] 'agreement among raft nodes before linearized reading' (duration: 288.609036ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:44.25087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.521583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"warn","ts":"2026-07-01T07:16:44.250945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.506695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-07-01T07:16:44.250981Z","caller":"traceutil/trace.go:171","msg":"trace[276082807] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:297; }","duration":"339.541976ms","start":"2026-07-01T07:16:43.911431Z","end":"2026-07-01T07:16:44.250973Z","steps":["trace[276082807] 'agreement among raft nodes before linearized reading' (duration: 339.442873ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:44.250946Z","caller":"traceutil/trace.go:171","msg":"trace[301588449] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:297; }","duration":"189.638526ms","start":"2026-07-01T07:16:44.061294Z","end":"2026-07-01T07:16:44.250933Z","steps":["trace[301588449] 'agreement among raft nodes before linearized reading' (duration: 189.482781ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:44.250635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.228916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-01T07:16:44.251088Z","caller":"traceutil/trace.go:171","msg":"trace[1184046477] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:297; }","duration":"238.711941ms","start":"2026-07-01T07:16:44.012367Z","end":"2026-07-01T07:16:44.251079Z","steps":["trace[1184046477] 'agreement among raft nodes before linearized reading' (duration: 238.225876ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:44.250753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.132056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-07-01T07:16:44.251006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:43.911352Z","time spent":"339.648449ms","remote":"127.0.0.1:47328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"info","ts":"2026-07-01T07:16:44.251214Z","caller":"traceutil/trace.go:171","msg":"trace[396605567] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:297; }","duration":"139.615241ms","start":"2026-07-01T07:16:44.111586Z","end":"2026-07-01T07:16:44.251202Z","steps":["trace[396605567] 'agreement among raft nodes before linearized reading' (duration: 139.073515ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:45.070142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.874899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:16:45.070367Z","caller":"traceutil/trace.go:171","msg":"trace[89982072] transaction","detail":"{read_only:false; response_revision:311; number_of_response:1; }","duration":"753.943664ms","start":"2026-07-01T07:16:44.316387Z","end":"2026-07-01T07:16:45.070331Z","steps":["trace[89982072] 'process raft request' (duration: 360.764976ms)","trace[89982072] 'compare' (duration: 392.643392ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:16:45.070555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:44.316361Z","time spent":"754.078529ms","remote":"127.0.0.1:47204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:16:45.070646Z","caller":"traceutil/trace.go:171","msg":"trace[756707125] linearizableReadLoop","detail":"{readStateIndex:327; appliedIndex:325; }","duration":"754.006217ms","start":"2026-07-01T07:16:44.316619Z","end":"2026-07-01T07:16:45.070625Z","steps":["trace[756707125] 'read index received' (duration: 2.133038ms)","trace[756707125] 'applied index is now lower than readState.Index' (duration: 751.871959ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:16:45.070667Z","caller":"traceutil/trace.go:171","msg":"trace[1241631695] transaction","detail":"{read_only:false; response_revision:312; number_of_response:1; }","duration":"754.007258ms","start":"2026-07-01T07:16:44.31656Z","end":"2026-07-01T07:16:45.070567Z","steps":["trace[1241631695] 'process raft request' (duration: 753.707587ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:45.070807Z","caller":"traceutil/trace.go:171","msg":"trace[1940627367] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"754.162662ms","start":"2026-07-01T07:16:44.31662Z","end":"2026-07-01T07:16:45.070783Z","steps":["trace[1940627367] 'process raft request' (duration: 753.776239ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:45.070864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:44.316545Z","time spent":"754.242524ms","remote":"127.0.0.1:47504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2264,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:16:45.070942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:44.31661Z","time spent":"754.273545ms","remote":"127.0.0.1:47328","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":164,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:16:45.07096Z","caller":"traceutil/trace.go:171","msg":"trace[1611276230] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"752.481039ms","start":"2026-07-01T07:16:44.318463Z","end":"2026-07-01T07:16:45.070944Z","steps":["trace[1611276230] 'process raft request' (duration: 752.046286ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:45.07106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:44.318456Z","time spent":"752.545931ms","remote":"127.0.0.1:47636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3691,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:16:45.070905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.265475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4369"} {"level":"info","ts":"2026-07-01T07:16:45.071181Z","caller":"traceutil/trace.go:171","msg":"trace[1049833605] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:315; }","duration":"754.561585ms","start":"2026-07-01T07:16:44.316603Z","end":"2026-07-01T07:16:45.071165Z","steps":["trace[1049833605] 'agreement among raft nodes before linearized reading' (duration: 754.213634ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:45.071248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:44.31659Z","time spent":"754.638487ms","remote":"127.0.0.1:47292","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":4392,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-07-01T07:16:45.071263Z","caller":"traceutil/trace.go:171","msg":"trace[424307320] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"753.209142ms","start":"2026-07-01T07:16:44.318016Z","end":"2026-07-01T07:16:45.071226Z","steps":["trace[424307320] 'process raft request' (duration: 752.434947ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:45.07138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:44.318008Z","time spent":"753.291064ms","remote":"127.0.0.1:47504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:16:45.125105Z","caller":"traceutil/trace.go:171","msg":"trace[405394425] transaction","detail":"{read_only:false; response_revision:316; number_of_response:1; }","duration":"805.924912ms","start":"2026-07-01T07:16:44.319161Z","end":"2026-07-01T07:16:45.125086Z","steps":["trace[405394425] 'process raft request' (duration: 805.776648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:45.125272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:44.319153Z","time spent":"806.056207ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6950,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:16:45.125442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.860316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-07-01T07:16:45.125562Z","caller":"traceutil/trace.go:171","msg":"trace[1853268420] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:316; }","duration":"714.01067ms","start":"2026-07-01T07:16:44.411511Z","end":"2026-07-01T07:16:45.125522Z","steps":["trace[1853268420] 'agreement among raft nodes before linearized reading' (duration: 713.821945ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:45.125617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"764.028156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-07-01T07:16:45.12577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"663.043937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-07-01T07:16:45.125812Z","caller":"traceutil/trace.go:171","msg":"trace[61589021] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:316; }","duration":"663.13364ms","start":"2026-07-01T07:16:44.462665Z","end":"2026-07-01T07:16:45.125799Z","steps":["trace[61589021] 'agreement among raft nodes before linearized reading' (duration: 662.993766ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:45.125846Z","caller":"traceutil/trace.go:171","msg":"trace[696088511] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:316; }","duration":"764.228312ms","start":"2026-07-01T07:16:44.361549Z","end":"2026-07-01T07:16:45.125778Z","steps":["trace[696088511] 'agreement among raft nodes before linearized reading' (duration: 763.933893ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:16:45.125842Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:44.462635Z","time spent":"663.200622ms","remote":"127.0.0.1:47328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-07-01T07:16:45.125944Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:44.361496Z","time spent":"764.432668ms","remote":"127.0.0.1:47328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-07-01T07:16:45.125636Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:16:44.411486Z","time spent":"714.136944ms","remote":"127.0.0.1:47328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" "} {"level":"info","ts":"2026-07-01T07:16:45.215726Z","caller":"traceutil/trace.go:171","msg":"trace[1285169016] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"140.332655ms","start":"2026-07-01T07:16:45.075359Z","end":"2026-07-01T07:16:45.215691Z","steps":["trace[1285169016] 'process raft request' (duration: 103.704728ms)","trace[1285169016] 'compare' (duration: 36.431581ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:16:45.215922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.870946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3706"} {"level":"info","ts":"2026-07-01T07:16:45.215817Z","caller":"traceutil/trace.go:171","msg":"trace[207620926] transaction","detail":"{read_only:false; response_revision:319; number_of_response:1; }","duration":"135.312897ms","start":"2026-07-01T07:16:45.080487Z","end":"2026-07-01T07:16:45.2158Z","steps":["trace[207620926] 'process raft request' (duration: 135.207104ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:45.215975Z","caller":"traceutil/trace.go:171","msg":"trace[347979099] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:319; }","duration":"136.957648ms","start":"2026-07-01T07:16:45.079006Z","end":"2026-07-01T07:16:45.215964Z","steps":["trace[347979099] 'agreement among raft nodes before linearized reading' (duration: 136.846085ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:16:45.215803Z","caller":"traceutil/trace.go:171","msg":"trace[2140408496] transaction","detail":"{read_only:false; response_revision:318; number_of_response:1; }","duration":"140.195821ms","start":"2026-07-01T07:16:45.075584Z","end":"2026-07-01T07:16:45.21578Z","steps":["trace[2140408496] 'process raft request' (duration: 140.055546ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:18.059248Z","caller":"traceutil/trace.go:171","msg":"trace[1854787532] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"131.974374ms","start":"2026-07-01T07:17:17.927256Z","end":"2026-07-01T07:17:18.05923Z","steps":["trace[1854787532] 'process raft request' (duration: 121.003021ms)","trace[1854787532] 'compare' (duration: 10.406651ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:18.059348Z","caller":"traceutil/trace.go:171","msg":"trace[1688589482] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"128.915447ms","start":"2026-07-01T07:17:17.930427Z","end":"2026-07-01T07:17:18.059343Z","steps":["trace[1688589482] 'process raft request' (duration: 128.435145ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:18.916441Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605829698358643086,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:17:19.416931Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605829698358643086,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-01T07:17:19.49173Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.359291357s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-01T07:17:19.871048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.109711082s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:19.871184Z","caller":"traceutil/trace.go:171","msg":"trace[724138001] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:561; }","duration":"1.109859046s","start":"2026-07-01T07:17:18.761304Z","end":"2026-07-01T07:17:19.871163Z","steps":["trace[724138001] 'range keys from in-memory index tree' (duration: 1.109693632s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:19.871496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.397171ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:17:19.871727Z","caller":"traceutil/trace.go:171","msg":"trace[275312569] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"1.75769812s","start":"2026-07-01T07:17:18.114005Z","end":"2026-07-01T07:17:19.871703Z","steps":["trace[275312569] 'process raft request' (duration: 1.378022833s)","trace[275312569] 'compare' (duration: 379.270908ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:17:19.871804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:18.113972Z","time spent":"1.757799932s","remote":"127.0.0.1:47178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":98698,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:17:19.871849Z","caller":"traceutil/trace.go:171","msg":"trace[2069906355] linearizableReadLoop","detail":"{readStateIndex:589; appliedIndex:586; }","duration":"1.456488543s","start":"2026-07-01T07:17:18.415342Z","end":"2026-07-01T07:17:19.871831Z","steps":["trace[2069906355] 'read index received' (duration: 1.076697345s)","trace[2069906355] 'applied index is now lower than readState.Index' (duration: 379.790138ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:19.871943Z","caller":"traceutil/trace.go:171","msg":"trace[1546661455] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"1.656691371s","start":"2026-07-01T07:17:18.215207Z","end":"2026-07-01T07:17:19.871899Z","steps":["trace[1546661455] 'process raft request' (duration: 1.656561768s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:19.872004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.328471344s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T07:17:19.872038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.449194832s","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-07-01T07:17:19.872044Z","caller":"traceutil/trace.go:171","msg":"trace[238060140] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:564; }","duration":"1.328555886s","start":"2026-07-01T07:17:18.543477Z","end":"2026-07-01T07:17:19.872032Z","steps":["trace[238060140] 'agreement among raft nodes before linearized reading' (duration: 1.328490584s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:19.87206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.448291621s","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-07-01T07:17:19.872084Z","caller":"traceutil/trace.go:171","msg":"trace[1862605352] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:564; }","duration":"1.449258873s","start":"2026-07-01T07:17:18.422814Z","end":"2026-07-01T07:17:19.872073Z","steps":["trace[1862605352] 'agreement among raft nodes before linearized reading' (duration: 1.44914223s)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:19.872091Z","caller":"traceutil/trace.go:171","msg":"trace[96887465] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:564; }","duration":"1.448337202s","start":"2026-07-01T07:17:18.423745Z","end":"2026-07-01T07:17:19.872082Z","steps":["trace[96887465] 'agreement among raft nodes before linearized reading' (duration: 1.44825219s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:19.872094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:18.543455Z","time spent":"1.328628447s","remote":"127.0.0.1:47122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T07:17:19.872078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.456725188s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-07-01T07:17:19.872123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:18.423739Z","time spent":"1.448377342s","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T07:17:19.87212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:18.422805Z","time spent":"1.449307294s","remote":"127.0.0.1:47410","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-07-01T07:17:19.8721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:18.215173Z","time spent":"1.656848694s","remote":"127.0.0.1:47178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-01T07:17:19.872158Z","caller":"traceutil/trace.go:171","msg":"trace[325824099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:564; }","duration":"1.456851081s","start":"2026-07-01T07:17:18.415289Z","end":"2026-07-01T07:17:19.872141Z","steps":["trace[325824099] 'agreement among raft nodes before linearized reading' (duration: 1.456618466s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:19.872191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:18.41527Z","time spent":"1.456913343s","remote":"127.0.0.1:47410","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-07-01T07:17:19.871893Z","caller":"traceutil/trace.go:171","msg":"trace[1156113929] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"1.74243228s","start":"2026-07-01T07:17:18.129434Z","end":"2026-07-01T07:17:19.871867Z","steps":["trace[1156113929] 'process raft request' (duration: 1.742161394s)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:19.872637Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:18.129411Z","time spent":"1.743157496s","remote":"127.0.0.1:47178","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20842,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:17:26.114127Z","caller":"traceutil/trace.go:171","msg":"trace[253892248] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"182.681403ms","start":"2026-07-01T07:17:25.931421Z","end":"2026-07-01T07:17:26.114102Z","steps":["trace[253892248] 'process raft request' (duration: 182.48602ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:26.114168Z","caller":"traceutil/trace.go:171","msg":"trace[1069526691] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"182.280345ms","start":"2026-07-01T07:17:25.931855Z","end":"2026-07-01T07:17:26.114135Z","steps":["trace[1069526691] 'process raft request' (duration: 182.178373ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:27.045831Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605829698358643215,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-01T07:17:27.07778Z","caller":"traceutil/trace.go:171","msg":"trace[308372151] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"532.199669ms","start":"2026-07-01T07:17:26.545557Z","end":"2026-07-01T07:17:27.077757Z","steps":["trace[308372151] 'read index received' (duration: 531.965803ms)","trace[308372151] 'applied index is now lower than readState.Index' (duration: 233.046µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:27.077858Z","caller":"traceutil/trace.go:171","msg":"trace[1626206117] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"858.587133ms","start":"2026-07-01T07:17:26.219227Z","end":"2026-07-01T07:17:27.077814Z","steps":["trace[1626206117] 'process raft request' (duration: 858.348488ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:27.077902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.322841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:27.077942Z","caller":"traceutil/trace.go:171","msg":"trace[560051430] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"532.417663ms","start":"2026-07-01T07:17:26.545514Z","end":"2026-07-01T07:17:27.077932Z","steps":["trace[560051430] 'agreement among raft nodes before linearized reading' (duration: 532.316161ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:27.077982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:26.545493Z","time spent":"532.481975ms","remote":"127.0.0.1:47122","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-01T07:17:27.078016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:26.219169Z","time spent":"858.768866ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:17:28.102421Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":6605829698358643218,"retry-timeout":"500ms"} {"level":"info","ts":"2026-07-01T07:17:28.200156Z","caller":"traceutil/trace.go:171","msg":"trace[1915237789] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"598.291036ms","start":"2026-07-01T07:17:27.601846Z","end":"2026-07-01T07:17:28.200137Z","steps":["trace[1915237789] 'read index received' (duration: 598.113293ms)","trace[1915237789] 'applied index is now lower than readState.Index' (duration: 176.913µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:28.200249Z","caller":"traceutil/trace.go:171","msg":"trace[1285943526] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"893.539902ms","start":"2026-07-01T07:17:27.306703Z","end":"2026-07-01T07:17:28.200243Z","steps":["trace[1285943526] 'process raft request' (duration: 893.313198ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:28.200332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:27.306676Z","time spent":"893.591613ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:17:28.200545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.474326ms","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-07-01T07:17:28.200627Z","caller":"traceutil/trace.go:171","msg":"trace[180676387] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:619; }","duration":"258.595179ms","start":"2026-07-01T07:17:27.942019Z","end":"2026-07-01T07:17:28.200614Z","steps":["trace[180676387] 'agreement among raft nodes before linearized reading' (duration: 258.337813ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:28.20058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"598.742186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.169\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-07-01T07:17:28.200807Z","caller":"traceutil/trace.go:171","msg":"trace[628637723] range","detail":"{range_begin:/registry/masterleases/199.204.45.169; range_end:; response_count:1; response_revision:619; }","duration":"599.005121ms","start":"2026-07-01T07:17:27.601795Z","end":"2026-07-01T07:17:28.200801Z","steps":["trace[628637723] 'agreement among raft nodes before linearized reading' (duration: 598.742016ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:28.200827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:27.601774Z","time spent":"599.046982ms","remote":"127.0.0.1:47158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.169\" "} {"level":"warn","ts":"2026-07-01T07:17:28.511259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:28.201517Z","time spent":"309.738077ms","remote":"127.0.0.1:47158","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-07-01T07:17:28.526395Z","caller":"traceutil/trace.go:171","msg":"trace[1025294992] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"320.927984ms","start":"2026-07-01T07:17:28.20544Z","end":"2026-07-01T07:17:28.526368Z","steps":["trace[1025294992] 'process raft request' (duration: 320.668929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:28.526556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:28.205377Z","time spent":"321.104148ms","remote":"127.0.0.1:47410","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-07-01T07:17:28.527331Z","caller":"traceutil/trace.go:171","msg":"trace[1889437092] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"321.397864ms","start":"2026-07-01T07:17:28.205907Z","end":"2026-07-01T07:17:28.527304Z","steps":["trace[1889437092] 'process raft request' (duration: 320.390544ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:28.527462Z","caller":"traceutil/trace.go:171","msg":"trace[1168950061] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"321.178729ms","start":"2026-07-01T07:17:28.206264Z","end":"2026-07-01T07:17:28.527443Z","steps":["trace[1168950061] 'process raft request' (duration: 320.894033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:28.527495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:28.205894Z","time spent":"321.512246ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:17:28.527556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:28.206252Z","time spent":"321.26521ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:17:28.527951Z","caller":"traceutil/trace.go:171","msg":"trace[543258138] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"321.082828ms","start":"2026-07-01T07:17:28.206854Z","end":"2026-07-01T07:17:28.527937Z","steps":["trace[543258138] 'process raft request' (duration: 320.413905ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:28.52804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:28.206832Z","time spent":"321.171749ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:17:32.533903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.181006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-f9vvq\" ","response":"range_response_count:1 size:17790"} {"level":"info","ts":"2026-07-01T07:17:32.533964Z","caller":"traceutil/trace.go:171","msg":"trace[1649268467] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"291.075915ms","start":"2026-07-01T07:17:32.242867Z","end":"2026-07-01T07:17:32.533943Z","steps":["trace[1649268467] 'process raft request' (duration: 288.186898ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:32.534014Z","caller":"traceutil/trace.go:171","msg":"trace[629601785] range","detail":"{range_begin:/registry/pods/kube-system/cilium-f9vvq; range_end:; response_count:1; response_revision:679; }","duration":"292.33139ms","start":"2026-07-01T07:17:32.241657Z","end":"2026-07-01T07:17:32.533988Z","steps":["trace[629601785] 'range keys from in-memory index tree' (duration: 292.022393ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:32.533963Z","caller":"traceutil/trace.go:171","msg":"trace[1461929798] linearizableReadLoop","detail":"{readStateIndex:707; appliedIndex:706; }","duration":"211.581355ms","start":"2026-07-01T07:17:32.322349Z","end":"2026-07-01T07:17:32.53393Z","steps":["trace[1461929798] 'read index received' (duration: 208.654817ms)","trace[1461929798] 'applied index is now lower than readState.Index' (duration: 2.923578ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:17:32.534182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.820109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-07-01T07:17:32.534347Z","caller":"traceutil/trace.go:171","msg":"trace[1463208578] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:680; }","duration":"212.025804ms","start":"2026-07-01T07:17:32.322301Z","end":"2026-07-01T07:17:32.534327Z","steps":["trace[1463208578] 'agreement among raft nodes before linearized reading' (duration: 211.711898ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:36.646856Z","caller":"traceutil/trace.go:171","msg":"trace[314807253] transaction","detail":"{read_only:false; response_revision:723; number_of_response:1; }","duration":"104.820671ms","start":"2026-07-01T07:17:36.542014Z","end":"2026-07-01T07:17:36.646834Z","steps":["trace[314807253] 'process raft request' (duration: 104.637487ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:40.29122Z","caller":"traceutil/trace.go:171","msg":"trace[326810039] transaction","detail":"{read_only:false; response_revision:745; number_of_response:1; }","duration":"219.855381ms","start":"2026-07-01T07:17:40.071338Z","end":"2026-07-01T07:17:40.291193Z","steps":["trace[326810039] 'process raft request' (duration: 193.12037ms)","trace[326810039] 'compare' (duration: 26.591818ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:40.437361Z","caller":"traceutil/trace.go:171","msg":"trace[1341209908] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"135.425698ms","start":"2026-07-01T07:17:40.301912Z","end":"2026-07-01T07:17:40.437337Z","steps":["trace[1341209908] 'process raft request' (duration: 115.847598ms)","trace[1341209908] 'compare' (duration: 19.439008ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:40.901517Z","caller":"traceutil/trace.go:171","msg":"trace[8414442] transaction","detail":"{read_only:false; response_revision:751; number_of_response:1; }","duration":"116.522111ms","start":"2026-07-01T07:17:40.784965Z","end":"2026-07-01T07:17:40.901487Z","steps":["trace[8414442] 'process raft request' (duration: 116.392849ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:40.912031Z","caller":"traceutil/trace.go:171","msg":"trace[1000058034] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"126.691867ms","start":"2026-07-01T07:17:40.785272Z","end":"2026-07-01T07:17:40.911964Z","steps":["trace[1000058034] 'process raft request' (duration: 126.535594ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:40.912135Z","caller":"traceutil/trace.go:171","msg":"trace[241874282] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"126.367042ms","start":"2026-07-01T07:17:40.785747Z","end":"2026-07-01T07:17:40.912114Z","steps":["trace[241874282] 'process raft request' (duration: 126.180448ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:41.541459Z","caller":"traceutil/trace.go:171","msg":"trace[332115831] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"137.213612ms","start":"2026-07-01T07:17:41.404222Z","end":"2026-07-01T07:17:41.541435Z","steps":["trace[332115831] 'process raft request' (duration: 114.489868ms)","trace[332115831] 'compare' (duration: 22.539821ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:41.57935Z","caller":"traceutil/trace.go:171","msg":"trace[926478781] transaction","detail":"{read_only:false; response_revision:756; number_of_response:1; }","duration":"174.903719ms","start":"2026-07-01T07:17:41.40443Z","end":"2026-07-01T07:17:41.579334Z","steps":["trace[926478781] 'process raft request' (duration: 174.742916ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:41.579609Z","caller":"traceutil/trace.go:171","msg":"trace[284820472] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"170.833474ms","start":"2026-07-01T07:17:41.408736Z","end":"2026-07-01T07:17:41.57957Z","steps":["trace[284820472] 'process raft request' (duration: 170.549219ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:41.913935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.948008ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T07:17:41.914157Z","caller":"traceutil/trace.go:171","msg":"trace[882267972] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"327.571932ms","start":"2026-07-01T07:17:41.586532Z","end":"2026-07-01T07:17:41.914104Z","steps":["trace[882267972] 'process raft request' (duration: 327.50394ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:41.914268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:41.586518Z","time spent":"327.711494ms","remote":"127.0.0.1:47424","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1290,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:17:41.914326Z","caller":"traceutil/trace.go:171","msg":"trace[446949783] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"327.781906ms","start":"2026-07-01T07:17:41.58651Z","end":"2026-07-01T07:17:41.914292Z","steps":["trace[446949783] 'process raft request' (duration: 179.392821ms)","trace[446949783] 'compare' (duration: 147.772244ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:17:41.914645Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:41.586486Z","time spent":"328.078271ms","remote":"127.0.0.1:47654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3852,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:17:42.231589Z","caller":"traceutil/trace.go:171","msg":"trace[92030622] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"302.120985ms","start":"2026-07-01T07:17:41.928558Z","end":"2026-07-01T07:17:42.230679Z","steps":["trace[92030622] 'process raft request' (duration: 301.534055ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:42.231757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:41.928492Z","time spent":"303.199365ms","remote":"127.0.0.1:47636","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4213,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:17:42.656706Z","caller":"traceutil/trace.go:171","msg":"trace[2056268631] linearizableReadLoop","detail":"{readStateIndex:793; appliedIndex:792; }","duration":"112.150149ms","start":"2026-07-01T07:17:42.544529Z","end":"2026-07-01T07:17:42.65668Z","steps":["trace[2056268631] 'read index received' (duration: 111.910874ms)","trace[2056268631] 'applied index is now lower than readState.Index' (duration: 237.985µs)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:17:42.656864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.322091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:42.656946Z","caller":"traceutil/trace.go:171","msg":"trace[765221689] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:762; }","duration":"112.464435ms","start":"2026-07-01T07:17:42.544467Z","end":"2026-07-01T07:17:42.656932Z","steps":["trace[765221689] 'agreement among raft nodes before linearized reading' (duration: 112.320331ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:42.656936Z","caller":"traceutil/trace.go:171","msg":"trace[944030264] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"210.874883ms","start":"2026-07-01T07:17:42.44595Z","end":"2026-07-01T07:17:42.656825Z","steps":["trace[944030264] 'process raft request' (duration: 210.593818ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:43.009349Z","caller":"traceutil/trace.go:171","msg":"trace[1915805868] linearizableReadLoop","detail":"{readStateIndex:794; appliedIndex:793; }","duration":"102.976331ms","start":"2026-07-01T07:17:42.90635Z","end":"2026-07-01T07:17:43.009327Z","steps":["trace[1915805868] 'read index received' (duration: 102.810438ms)","trace[1915805868] 'applied index is now lower than readState.Index' (duration: 164.743µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:43.009378Z","caller":"traceutil/trace.go:171","msg":"trace[617362439] transaction","detail":"{read_only:false; response_revision:763; number_of_response:1; }","duration":"219.888117ms","start":"2026-07-01T07:17:42.789465Z","end":"2026-07-01T07:17:43.009353Z","steps":["trace[617362439] 'process raft request' (duration: 219.720304ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:43.009557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.192385ms","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-07-01T07:17:43.009668Z","caller":"traceutil/trace.go:171","msg":"trace[1532409746] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:763; }","duration":"103.315677ms","start":"2026-07-01T07:17:42.906341Z","end":"2026-07-01T07:17:43.009657Z","steps":["trace[1532409746] 'agreement among raft nodes before linearized reading' (duration: 103.094333ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:43.107759Z","caller":"traceutil/trace.go:171","msg":"trace[1248245962] transaction","detail":"{read_only:false; response_revision:764; number_of_response:1; }","duration":"148.501883ms","start":"2026-07-01T07:17:42.959238Z","end":"2026-07-01T07:17:43.10774Z","steps":["trace[1248245962] 'process raft request' (duration: 148.269348ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:43.107845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.879996ms","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-07-01T07:17:43.107929Z","caller":"traceutil/trace.go:171","msg":"trace[1250697405] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:764; }","duration":"192.082611ms","start":"2026-07-01T07:17:42.915828Z","end":"2026-07-01T07:17:43.107911Z","steps":["trace[1250697405] 'agreement among raft nodes before linearized reading' (duration: 191.860756ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:43.108074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.085545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/\" range_end:\"/registry/replicasets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T07:17:43.108118Z","caller":"traceutil/trace.go:171","msg":"trace[2142846284] range","detail":"{range_begin:/registry/replicasets/; range_end:/registry/replicasets0; response_count:0; response_revision:764; }","duration":"158.157736ms","start":"2026-07-01T07:17:42.949944Z","end":"2026-07-01T07:17:43.108102Z","steps":["trace[2142846284] 'agreement among raft nodes before linearized reading' (duration: 158.087985ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:43.108279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.16922ms","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-07-01T07:17:43.108318Z","caller":"traceutil/trace.go:171","msg":"trace[258810466] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:764; }","duration":"192.253852ms","start":"2026-07-01T07:17:42.916055Z","end":"2026-07-01T07:17:43.108309Z","steps":["trace[258810466] 'agreement among raft nodes before linearized reading' (duration: 192.14114ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:43.187717Z","caller":"traceutil/trace.go:171","msg":"trace[499463606] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"174.760706ms","start":"2026-07-01T07:17:43.012925Z","end":"2026-07-01T07:17:43.187686Z","steps":["trace[499463606] 'process raft request' (duration: 174.637204ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:43.605269Z","caller":"traceutil/trace.go:171","msg":"trace[1272379114] transaction","detail":"{read_only:false; response_revision:768; number_of_response:1; }","duration":"114.746079ms","start":"2026-07-01T07:17:43.490496Z","end":"2026-07-01T07:17:43.605242Z","steps":["trace[1272379114] 'process raft request' (duration: 114.293221ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.216396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.960465ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-01T07:17:44.216503Z","caller":"traceutil/trace.go:171","msg":"trace[1380221813] linearizableReadLoop","detail":"{readStateIndex:800; appliedIndex:799; }","duration":"231.399883ms","start":"2026-07-01T07:17:43.985084Z","end":"2026-07-01T07:17:44.216484Z","steps":["trace[1380221813] 'read index received' (duration: 303.325µs)","trace[1380221813] 'applied index is now lower than readState.Index' (duration: 231.095248ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T07:17:44.216619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.516885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.216688Z","caller":"traceutil/trace.go:171","msg":"trace[436268619] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:768; }","duration":"231.595397ms","start":"2026-07-01T07:17:43.985077Z","end":"2026-07-01T07:17:44.216673Z","steps":["trace[436268619] 'agreement among raft nodes before linearized reading' (duration: 231.468204ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.216718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.544546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.216787Z","caller":"traceutil/trace.go:171","msg":"trace[1073206924] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:768; }","duration":"231.664908ms","start":"2026-07-01T07:17:43.985111Z","end":"2026-07-01T07:17:44.216776Z","steps":["trace[1073206924] 'agreement among raft nodes before linearized reading' (duration: 231.518225ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.007123ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T07:17:44.21713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.152221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.219881Z","caller":"traceutil/trace.go:171","msg":"trace[392408019] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:768; }","duration":"112.934761ms","start":"2026-07-01T07:17:44.106924Z","end":"2026-07-01T07:17:44.219859Z","steps":["trace[392408019] 'agreement among raft nodes before linearized reading' (duration: 110.143602ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.284033ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.220008Z","caller":"traceutil/trace.go:171","msg":"trace[1317628327] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:768; }","duration":"113.096304ms","start":"2026-07-01T07:17:44.106881Z","end":"2026-07-01T07:17:44.219977Z","steps":["trace[1317628327] 'agreement among raft nodes before linearized reading' (duration: 110.280154ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.136096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.22017Z","caller":"traceutil/trace.go:171","msg":"trace[1732109588] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:768; }","duration":"138.081269ms","start":"2026-07-01T07:17:44.082078Z","end":"2026-07-01T07:17:44.220159Z","steps":["trace[1732109588] 'agreement among raft nodes before linearized reading' (duration: 135.125416ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.228625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.220353Z","caller":"traceutil/trace.go:171","msg":"trace[557209446] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:768; }","duration":"139.33404ms","start":"2026-07-01T07:17:44.081009Z","end":"2026-07-01T07:17:44.220343Z","steps":["trace[557209446] 'agreement among raft nodes before linearized reading' (duration: 136.238335ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.288156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.220446Z","caller":"traceutil/trace.go:171","msg":"trace[171366492] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:768; }","duration":"139.453162ms","start":"2026-07-01T07:17:44.080985Z","end":"2026-07-01T07:17:44.220438Z","steps":["trace[171366492] 'agreement among raft nodes before linearized reading' (duration: 136.298146ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.186421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.22052Z","caller":"traceutil/trace.go:171","msg":"trace[539159202] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:768; }","duration":"159.377978ms","start":"2026-07-01T07:17:44.061134Z","end":"2026-07-01T07:17:44.220512Z","steps":["trace[539159202] 'agreement among raft nodes before linearized reading' (duration: 156.191661ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:44.219669Z","caller":"traceutil/trace.go:171","msg":"trace[1909031452] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:768; }","duration":"110.724912ms","start":"2026-07-01T07:17:44.10893Z","end":"2026-07-01T07:17:44.219655Z","steps":["trace[1909031452] 'agreement among raft nodes before linearized reading' (duration: 107.83423ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.096396ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.220644Z","caller":"traceutil/trace.go:171","msg":"trace[1351655249] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:768; }","duration":"160.336125ms","start":"2026-07-01T07:17:44.06029Z","end":"2026-07-01T07:17:44.220626Z","steps":["trace[1351655249] 'agreement among raft nodes before linearized reading' (duration: 157.099497ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.176428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.220883Z","caller":"traceutil/trace.go:171","msg":"trace[1411363510] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:768; }","duration":"160.6193ms","start":"2026-07-01T07:17:44.060246Z","end":"2026-07-01T07:17:44.220865Z","steps":["trace[1411363510] 'agreement among raft nodes before linearized reading' (duration: 157.186088ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.093606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.221014Z","caller":"traceutil/trace.go:171","msg":"trace[194455430] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:768; }","duration":"183.62236ms","start":"2026-07-01T07:17:44.037374Z","end":"2026-07-01T07:17:44.220997Z","steps":["trace[194455430] 'agreement among raft nodes before linearized reading' (duration: 180.092616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.690187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.221123Z","caller":"traceutil/trace.go:171","msg":"trace[1910275486] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:768; }","duration":"184.283992ms","start":"2026-07-01T07:17:44.03682Z","end":"2026-07-01T07:17:44.221104Z","steps":["trace[1910275486] 'agreement among raft nodes before linearized reading' (duration: 180.681457ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.83096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.221248Z","caller":"traceutil/trace.go:171","msg":"trace[49192066] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:768; }","duration":"184.550656ms","start":"2026-07-01T07:17:44.036684Z","end":"2026-07-01T07:17:44.221235Z","steps":["trace[49192066] 'agreement among raft nodes before linearized reading' (duration: 180.84929ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:44.217582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.737578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T07:17:44.221355Z","caller":"traceutil/trace.go:171","msg":"trace[858795317] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:768; }","duration":"235.518606ms","start":"2026-07-01T07:17:43.985825Z","end":"2026-07-01T07:17:44.221344Z","steps":["trace[858795317] 'agreement among raft nodes before linearized reading' (duration: 231.742138ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:45.388211Z","caller":"traceutil/trace.go:171","msg":"trace[717031866] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"191.125686ms","start":"2026-07-01T07:17:45.197065Z","end":"2026-07-01T07:17:45.388191Z","steps":["trace[717031866] 'process raft request' (duration: 191.023234ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:17:45.572092Z","caller":"traceutil/trace.go:171","msg":"trace[243145935] linearizableReadLoop","detail":"{readStateIndex:805; appliedIndex:803; }","duration":"110.265158ms","start":"2026-07-01T07:17:45.461805Z","end":"2026-07-01T07:17:45.57207Z","steps":["trace[243145935] 'read index received' (duration: 81.988628ms)","trace[243145935] 'applied index is now lower than readState.Index' (duration: 28.27565ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:45.572114Z","caller":"traceutil/trace.go:171","msg":"trace[544821235] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"374.71249ms","start":"2026-07-01T07:17:45.197371Z","end":"2026-07-01T07:17:45.572083Z","steps":["trace[544821235] 'process raft request' (duration: 346.531232ms)","trace[544821235] 'compare' (duration: 28.007794ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:45.57219Z","caller":"traceutil/trace.go:171","msg":"trace[338194203] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"373.661431ms","start":"2026-07-01T07:17:45.1985Z","end":"2026-07-01T07:17:45.572162Z","steps":["trace[338194203] 'process raft request' (duration: 373.516229ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:45.572257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:45.197361Z","time spent":"374.812582ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:17:45.572333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.524632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T07:17:45.572375Z","caller":"traceutil/trace.go:171","msg":"trace[1979233667] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:773; }","duration":"110.653815ms","start":"2026-07-01T07:17:45.461711Z","end":"2026-07-01T07:17:45.572365Z","steps":["trace[1979233667] 'agreement among raft nodes before linearized reading' (duration: 110.537853ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:45.572372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:45.198483Z","time spent":"373.807164ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T07:17:49.88724Z","caller":"traceutil/trace.go:171","msg":"trace[1316417044] linearizableReadLoop","detail":"{readStateIndex:824; appliedIndex:823; }","duration":"484.693477ms","start":"2026-07-01T07:17:49.402523Z","end":"2026-07-01T07:17:49.887216Z","steps":["trace[1316417044] 'read index received' (duration: 484.452122ms)","trace[1316417044] 'applied index is now lower than readState.Index' (duration: 240.175µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T07:17:49.887293Z","caller":"traceutil/trace.go:171","msg":"trace[461589156] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"547.176476ms","start":"2026-07-01T07:17:49.340086Z","end":"2026-07-01T07:17:49.887262Z","steps":["trace[461589156] 'process raft request' (duration: 546.887751ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:49.887459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:49.340045Z","time spent":"547.331039ms","remote":"127.0.0.1:47296","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4028,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T07:17:49.887608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.900831ms","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-07-01T07:17:49.887668Z","caller":"traceutil/trace.go:171","msg":"trace[1672025473] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:791; }","duration":"302.995383ms","start":"2026-07-01T07:17:49.584652Z","end":"2026-07-01T07:17:49.887647Z","steps":["trace[1672025473] 'agreement among raft nodes before linearized reading' (duration: 302.726578ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:49.887712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:49.584633Z","time spent":"303.068694ms","remote":"127.0.0.1:47410","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-07-01T07:17:49.887712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.187479ms","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-07-01T07:17:49.887765Z","caller":"traceutil/trace.go:171","msg":"trace[1329077063] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:791; }","duration":"302.29732ms","start":"2026-07-01T07:17:49.585452Z","end":"2026-07-01T07:17:49.88775Z","steps":["trace[1329077063] 'agreement among raft nodes before linearized reading' (duration: 302.067317ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:49.887797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:49.585424Z","time spent":"302.365271ms","remote":"127.0.0.1:47410","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":"warn","ts":"2026-07-01T07:17:49.887992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.989992ms","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-07-01T07:17:49.888029Z","caller":"traceutil/trace.go:171","msg":"trace[221576235] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:791; }","duration":"485.575981ms","start":"2026-07-01T07:17:49.402444Z","end":"2026-07-01T07:17:49.88802Z","steps":["trace[221576235] 'agreement among raft nodes before linearized reading' (duration: 484.9259ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T07:17:49.888055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T07:17:49.402424Z","time spent":"485.625172ms","remote":"127.0.0.1:47410","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-01T07:18:02.096683Z","caller":"traceutil/trace.go:171","msg":"trace[1057545111] transaction","detail":"{read_only:false; response_revision:940; number_of_response:1; }","duration":"104.678908ms","start":"2026-07-01T07:18:01.991969Z","end":"2026-07-01T07:18:02.096648Z","steps":["trace[1057545111] 'process raft request' (duration: 104.389263ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:18:02.096661Z","caller":"traceutil/trace.go:171","msg":"trace[1209843080] transaction","detail":"{read_only:false; response_revision:941; number_of_response:1; }","duration":"104.480675ms","start":"2026-07-01T07:18:01.992147Z","end":"2026-07-01T07:18:02.096628Z","steps":["trace[1209843080] 'process raft request' (duration: 104.415634ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:18:03.704022Z","caller":"traceutil/trace.go:171","msg":"trace[1828796844] transaction","detail":"{read_only:false; response_revision:951; number_of_response:1; }","duration":"117.363492ms","start":"2026-07-01T07:18:03.586621Z","end":"2026-07-01T07:18:03.703984Z","steps":["trace[1828796844] 'process raft request' (duration: 117.096408ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:18:03.704354Z","caller":"traceutil/trace.go:171","msg":"trace[357320786] transaction","detail":"{read_only:false; response_revision:952; number_of_response:1; }","duration":"114.773202ms","start":"2026-07-01T07:18:03.589552Z","end":"2026-07-01T07:18:03.704325Z","steps":["trace[357320786] 'process raft request' (duration: 114.357336ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:18:04.907115Z","caller":"traceutil/trace.go:171","msg":"trace[677219402] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"100.627972ms","start":"2026-07-01T07:18:04.806455Z","end":"2026-07-01T07:18:04.907083Z","steps":["trace[677219402] 'process raft request' (duration: 100.385278ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:18:06.300902Z","caller":"traceutil/trace.go:171","msg":"trace[1892756856] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"183.512873ms","start":"2026-07-01T07:18:06.116927Z","end":"2026-07-01T07:18:06.30044Z","steps":["trace[1892756856] 'process raft request' (duration: 181.639925ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T07:19:46.048541Z","caller":"traceutil/trace.go:171","msg":"trace[1052420415] transaction","detail":"{read_only:false; response_revision:1341; number_of_response:1; }","duration":"257.995126ms","start":"2026-07-01T07:19:45.790526Z","end":"2026-07-01T07:19:46.048521Z","steps":["trace[1052420415] 'process raft request' (duration: 257.868334ms)"],"step_count":1}