{"level":"warn","ts":"2026-02-12T03:34:03.468668Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-12T03:34:03.468857Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.62:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://162.253.55.62:2380","--initial-cluster=instance=https://162.253.55.62:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.62:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.62: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-02-12T03:34:03.468979Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-02-12T03:34:03.469032Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-02-12T03:34:03.469075Z","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-02-12T03:34:03.470037Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"]} {"level":"info","ts":"2026-02-12T03:34:03.470187Z","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":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.62: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-02-12T03:34:03.475071Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.587492ms"} {"level":"info","ts":"2026-02-12T03:34:03.509028Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"791a7e25b533cd26","cluster-id":"be484d2748da72cd"} {"level":"info","ts":"2026-02-12T03:34:03.509172Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=()"} {"level":"info","ts":"2026-02-12T03:34:03.509203Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 0"} {"level":"info","ts":"2026-02-12T03:34:03.509359Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 791a7e25b533cd26 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-12T03:34:03.509416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became follower at term 1"} {"level":"info","ts":"2026-02-12T03:34:03.509473Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"warn","ts":"2026-02-12T03:34:03.517055Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-12T03:34:03.5188Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-12T03:34:03.521613Z","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-02-12T03:34:03.52476Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"791a7e25b533cd26","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-12T03:34:03.524878Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"791a7e25b533cd26","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-12T03:34:03.526706Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 switched to configuration voters=(8726425928402717990)"} {"level":"info","ts":"2026-02-12T03:34:03.526878Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","added-peer-id":"791a7e25b533cd26","added-peer-peer-urls":["https://162.253.55.62:2380"]} {"level":"info","ts":"2026-02-12T03:34:03.527006Z","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-02-12T03:34:03.527056Z","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-02-12T03:34:03.527112Z","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-02-12T03:34:03.535764Z","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-02-12T03:34:03.53604Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"791a7e25b533cd26","initial-advertise-peer-urls":["https://162.253.55.62:2380"],"listen-peer-urls":["https://162.253.55.62:2380"],"advertise-client-urls":["https://162.253.55.62:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.62:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-12T03:34:03.536082Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-12T03:34:03.536266Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-02-12T03:34:03.536295Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.62:2380"} {"level":"info","ts":"2026-02-12T03:34:04.010453Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 is starting a new election at term 1"} {"level":"info","ts":"2026-02-12T03:34:04.010538Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became pre-candidate at term 1"} {"level":"info","ts":"2026-02-12T03:34:04.010588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgPreVoteResp from 791a7e25b533cd26 at term 1"} {"level":"info","ts":"2026-02-12T03:34:04.010612Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became candidate at term 2"} {"level":"info","ts":"2026-02-12T03:34:04.010688Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 received MsgVoteResp from 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-02-12T03:34:04.010714Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"791a7e25b533cd26 became leader at term 2"} {"level":"info","ts":"2026-02-12T03:34:04.010734Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 791a7e25b533cd26 elected leader 791a7e25b533cd26 at term 2"} {"level":"info","ts":"2026-02-12T03:34:04.037458Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"791a7e25b533cd26","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.62:2379]}","request-path":"/0/members/791a7e25b533cd26/attributes","cluster-id":"be484d2748da72cd","publish-timeout":"7s"} {"level":"info","ts":"2026-02-12T03:34:04.037609Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T03:34:04.037964Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:34:04.038098Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-12T03:34:04.040776Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-12T03:34:04.040811Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-12T03:34:04.042669Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-12T03:34:04.043238Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.62:2379"} {"level":"info","ts":"2026-02-12T03:34:04.04651Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"be484d2748da72cd","local-member-id":"791a7e25b533cd26","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:34:04.046736Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:34:04.046846Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-12T03:34:05.795277Z","caller":"traceutil/trace.go:171","msg":"trace[418678819] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"100.840044ms","start":"2026-02-12T03:34:05.694414Z","end":"2026-02-12T03:34:05.795254Z","steps":["trace[418678819] 'process raft request' (duration: 100.6598ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:05.795944Z","caller":"traceutil/trace.go:171","msg":"trace[587323892] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"100.557098ms","start":"2026-02-12T03:34:05.695374Z","end":"2026-02-12T03:34:05.795931Z","steps":["trace[587323892] 'process raft request' (duration: 99.822339ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:05.796922Z","caller":"traceutil/trace.go:171","msg":"trace[333821344] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"102.442526ms","start":"2026-02-12T03:34:05.694467Z","end":"2026-02-12T03:34:05.796909Z","steps":["trace[333821344] 'read index received' (duration: 51.415463ms)","trace[333821344] 'applied index is now lower than readState.Index' (duration: 51.026323ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:05.799348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.404341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-12T03:34:05.799412Z","caller":"traceutil/trace.go:171","msg":"trace[1012591725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"103.493903ms","start":"2026-02-12T03:34:05.695908Z","end":"2026-02-12T03:34:05.799402Z","steps":["trace[1012591725] 'agreement among raft nodes before linearized reading' (duration: 103.36026ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:05.805009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.670008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:2858"} {"level":"info","ts":"2026-02-12T03:34:05.807953Z","caller":"traceutil/trace.go:171","msg":"trace[414341993] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:12; }","duration":"113.629406ms","start":"2026-02-12T03:34:05.694308Z","end":"2026-02-12T03:34:05.807938Z","steps":["trace[414341993] 'agreement among raft nodes before linearized reading' (duration: 110.650349ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:05.805546Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.242938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-12T03:34:05.808136Z","caller":"traceutil/trace.go:171","msg":"trace[1657764381] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:12; }","duration":"107.855185ms","start":"2026-02-12T03:34:05.700273Z","end":"2026-02-12T03:34:05.808128Z","steps":["trace[1657764381] 'agreement among raft nodes before linearized reading' (duration: 105.231298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:05.805586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.171182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-12T03:34:05.808319Z","caller":"traceutil/trace.go:171","msg":"trace[697025138] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:12; }","duration":"108.938103ms","start":"2026-02-12T03:34:05.699373Z","end":"2026-02-12T03:34:05.808311Z","steps":["trace[697025138] 'agreement among raft nodes before linearized reading' (duration: 106.194452ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:08.767732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.017216ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:08.769066Z","caller":"traceutil/trace.go:171","msg":"trace[347583420] linearizableReadLoop","detail":"{readStateIndex:255; appliedIndex:253; }","duration":"307.478242ms","start":"2026-02-12T03:34:08.461552Z","end":"2026-02-12T03:34:08.76903Z","steps":["trace[347583420] 'read index received' (duration: 287.620084ms)","trace[347583420] 'applied index is now lower than readState.Index' (duration: 19.856488ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:08.769263Z","caller":"traceutil/trace.go:171","msg":"trace[750981703] transaction","detail":"{read_only:false; response_revision:248; number_of_response:1; }","duration":"447.110954ms","start":"2026-02-12T03:34:08.322109Z","end":"2026-02-12T03:34:08.76922Z","steps":["trace[750981703] 'process raft request' (duration: 76.069598ms)","trace[750981703] 'compare' (duration: 364.900562ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:08.769385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:08.322097Z","time spent":"447.253618ms","remote":"127.0.0.1:57428","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11440,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T03:34:08.771061Z","caller":"traceutil/trace.go:171","msg":"trace[2106768155] transaction","detail":"{read_only:false; response_revision:249; number_of_response:1; }","duration":"447.652979ms","start":"2026-02-12T03:34:08.323387Z","end":"2026-02-12T03:34:08.77104Z","steps":["trace[2106768155] 'process raft request' (duration: 444.556881ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:08.771421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:08.323376Z","time spent":"447.796132ms","remote":"127.0.0.1:57602","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-02-12T03:34:08.771694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.136918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:08.771935Z","caller":"traceutil/trace.go:171","msg":"trace[724676218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:0; response_revision:249; }","duration":"310.332323ms","start":"2026-02-12T03:34:08.461489Z","end":"2026-02-12T03:34:08.771822Z","steps":["trace[724676218] 'agreement among raft nodes before linearized reading' (duration: 310.172539ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:08.77204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:08.461469Z","time spent":"310.560419ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-12T03:34:08.77225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.531718ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:08.772395Z","caller":"traceutil/trace.go:171","msg":"trace[303761797] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:249; }","duration":"253.703994ms","start":"2026-02-12T03:34:08.518669Z","end":"2026-02-12T03:34:08.772373Z","steps":["trace[303761797] 'agreement among raft nodes before linearized reading' (duration: 253.548159ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:08.978839Z","caller":"traceutil/trace.go:171","msg":"trace[329484559] transaction","detail":"{read_only:false; response_revision:251; number_of_response:1; }","duration":"199.649558ms","start":"2026-02-12T03:34:08.779153Z","end":"2026-02-12T03:34:08.978802Z","steps":["trace[329484559] 'process raft request' (duration: 199.237708ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:08.979081Z","caller":"traceutil/trace.go:171","msg":"trace[2037697672] linearizableReadLoop","detail":"{readStateIndex:259; appliedIndex:256; }","duration":"138.467923ms","start":"2026-02-12T03:34:08.840544Z","end":"2026-02-12T03:34:08.979012Z","steps":["trace[2037697672] 'read index received' (duration: 137.93059ms)","trace[2037697672] 'applied index is now lower than readState.Index' (duration: 536.493µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:08.979214Z","caller":"traceutil/trace.go:171","msg":"trace[1923500872] transaction","detail":"{read_only:false; response_revision:252; number_of_response:1; }","duration":"199.946525ms","start":"2026-02-12T03:34:08.779253Z","end":"2026-02-12T03:34:08.979199Z","steps":["trace[1923500872] 'process raft request' (duration: 199.34448ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:08.979211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.650687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:08.979723Z","caller":"traceutil/trace.go:171","msg":"trace[776176129] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:253; }","duration":"139.219552ms","start":"2026-02-12T03:34:08.840492Z","end":"2026-02-12T03:34:08.979712Z","steps":["trace[776176129] 'agreement among raft nodes before linearized reading' (duration: 138.627907ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:08.97935Z","caller":"traceutil/trace.go:171","msg":"trace[1145856670] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"195.915934ms","start":"2026-02-12T03:34:08.783423Z","end":"2026-02-12T03:34:08.979339Z","steps":["trace[1145856670] 'process raft request' (duration: 195.233597ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:08.992543Z","caller":"traceutil/trace.go:171","msg":"trace[907759213] transaction","detail":"{read_only:false; response_revision:254; number_of_response:1; }","duration":"150.078234ms","start":"2026-02-12T03:34:08.842448Z","end":"2026-02-12T03:34:08.992526Z","steps":["trace[907759213] 'process raft request' (duration: 149.966162ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:08.99266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.89485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T03:34:08.994641Z","caller":"traceutil/trace.go:171","msg":"trace[2102416892] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:254; }","duration":"153.88572ms","start":"2026-02-12T03:34:08.840685Z","end":"2026-02-12T03:34:08.994571Z","steps":["trace[2102416892] 'agreement among raft nodes before linearized reading' (duration: 151.868889ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:09.255131Z","caller":"traceutil/trace.go:171","msg":"trace[87684855] linearizableReadLoop","detail":"{readStateIndex:264; appliedIndex:263; }","duration":"176.553981ms","start":"2026-02-12T03:34:09.078554Z","end":"2026-02-12T03:34:09.255108Z","steps":["trace[87684855] 'read index received' (duration: 81.842471ms)","trace[87684855] 'applied index is now lower than readState.Index' (duration: 94.7106ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:09.25527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.754025ms","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-02-12T03:34:09.2553Z","caller":"traceutil/trace.go:171","msg":"trace[884302097] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:0; response_revision:258; }","duration":"176.835477ms","start":"2026-02-12T03:34:09.078455Z","end":"2026-02-12T03:34:09.255291Z","steps":["trace[884302097] 'agreement among raft nodes before linearized reading' (duration: 176.740585ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:09.255521Z","caller":"traceutil/trace.go:171","msg":"trace[1617037725] transaction","detail":"{read_only:false; response_revision:258; number_of_response:1; }","duration":"197.86243ms","start":"2026-02-12T03:34:09.057607Z","end":"2026-02-12T03:34:09.255469Z","steps":["trace[1617037725] 'process raft request' (duration: 102.855393ms)","trace[1617037725] 'compare' (duration: 94.524585ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:09.481492Z","caller":"traceutil/trace.go:171","msg":"trace[459527304] linearizableReadLoop","detail":"{readStateIndex:267; appliedIndex:266; }","duration":"115.861965ms","start":"2026-02-12T03:34:09.365569Z","end":"2026-02-12T03:34:09.481431Z","steps":["trace[459527304] 'read index received' (duration: 88.093416ms)","trace[459527304] 'applied index is now lower than readState.Index' (duration: 27.767529ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:09.481653Z","caller":"traceutil/trace.go:171","msg":"trace[73430159] transaction","detail":"{read_only:false; response_revision:261; number_of_response:1; }","duration":"124.552441ms","start":"2026-02-12T03:34:09.357032Z","end":"2026-02-12T03:34:09.481585Z","steps":["trace[73430159] 'process raft request' (duration: 96.703ms)","trace[73430159] 'compare' (duration: 27.487482ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:09.482249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.658815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/expand-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:09.48231Z","caller":"traceutil/trace.go:171","msg":"trace[973120696] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/expand-controller; range_end:; response_count:0; response_revision:261; }","duration":"116.757267ms","start":"2026-02-12T03:34:09.365534Z","end":"2026-02-12T03:34:09.482291Z","steps":["trace[973120696] 'agreement among raft nodes before linearized reading' (duration: 116.230664ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:09.827766Z","caller":"traceutil/trace.go:171","msg":"trace[806339286] linearizableReadLoop","detail":"{readStateIndex:272; appliedIndex:271; }","duration":"199.280614ms","start":"2026-02-12T03:34:09.62847Z","end":"2026-02-12T03:34:09.827751Z","steps":["trace[806339286] 'read index received' (duration: 197.325596ms)","trace[806339286] 'applied index is now lower than readState.Index' (duration: 1.943708ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:09.828228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.743405ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/generic-garbage-collector\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:09.828319Z","caller":"traceutil/trace.go:171","msg":"trace[1204911998] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/generic-garbage-collector; range_end:; response_count:0; response_revision:266; }","duration":"199.866429ms","start":"2026-02-12T03:34:09.628443Z","end":"2026-02-12T03:34:09.828309Z","steps":["trace[1204911998] 'agreement among raft nodes before linearized reading' (duration: 199.656253ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:09.828484Z","caller":"traceutil/trace.go:171","msg":"trace[1863565695] transaction","detail":"{read_only:false; response_revision:266; number_of_response:1; }","duration":"201.082689ms","start":"2026-02-12T03:34:09.627396Z","end":"2026-02-12T03:34:09.828479Z","steps":["trace[1863565695] 'process raft request' (duration: 198.442893ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:10.886181Z","caller":"traceutil/trace.go:171","msg":"trace[1641488290] transaction","detail":"{read_only:false; response_revision:308; number_of_response:1; }","duration":"105.340026ms","start":"2026-02-12T03:34:10.780815Z","end":"2026-02-12T03:34:10.886155Z","steps":["trace[1641488290] 'process raft request' (duration: 105.09018ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:10.88624Z","caller":"traceutil/trace.go:171","msg":"trace[133077074] linearizableReadLoop","detail":"{readStateIndex:315; appliedIndex:315; }","duration":"105.061548ms","start":"2026-02-12T03:34:10.781138Z","end":"2026-02-12T03:34:10.8862Z","steps":["trace[133077074] 'read index received' (duration: 105.051188ms)","trace[133077074] 'applied index is now lower than readState.Index' (duration: 8.75µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:10.886443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.243153ms","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-02-12T03:34:10.88647Z","caller":"traceutil/trace.go:171","msg":"trace[309846763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:308; }","duration":"105.375786ms","start":"2026-02-12T03:34:10.781085Z","end":"2026-02-12T03:34:10.886461Z","steps":["trace[309846763] 'agreement among raft nodes before linearized reading' (duration: 105.230472ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:10.898735Z","caller":"traceutil/trace.go:171","msg":"trace[544764512] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"117.482453ms","start":"2026-02-12T03:34:10.781205Z","end":"2026-02-12T03:34:10.898688Z","steps":["trace[544764512] 'process raft request' (duration: 117.270067ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:10.898906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.404724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler\" ","response":"range_response_count:1 size:216"} {"level":"info","ts":"2026-02-12T03:34:10.898972Z","caller":"traceutil/trace.go:171","msg":"trace[256599289] transaction","detail":"{read_only:false; number_of_response:0; response_revision:308; }","duration":"117.7471ms","start":"2026-02-12T03:34:10.781221Z","end":"2026-02-12T03:34:10.898968Z","steps":["trace[256599289] 'process raft request' (duration: 117.395112ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:10.898982Z","caller":"traceutil/trace.go:171","msg":"trace[2022671268] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/horizontal-pod-autoscaler; range_end:; response_count:1; response_revision:310; }","duration":"113.551898ms","start":"2026-02-12T03:34:10.785395Z","end":"2026-02-12T03:34:10.898947Z","steps":["trace[2022671268] 'agreement among raft nodes before linearized reading' (duration: 113.358253ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:10.899198Z","caller":"traceutil/trace.go:171","msg":"trace[2093924830] transaction","detail":"{read_only:false; response_revision:309; number_of_response:1; }","duration":"117.895954ms","start":"2026-02-12T03:34:10.781293Z","end":"2026-02-12T03:34:10.899189Z","steps":["trace[2093924830] 'process raft request' (duration: 117.35396ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:10.899329Z","caller":"traceutil/trace.go:171","msg":"trace[1110316224] transaction","detail":"{read_only:false; response_revision:310; number_of_response:1; }","duration":"116.575622ms","start":"2026-02-12T03:34:10.782748Z","end":"2026-02-12T03:34:10.899323Z","steps":["trace[1110316224] 'process raft request' (duration: 115.975427ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:11.071406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.209867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-02-12T03:34:11.071456Z","caller":"traceutil/trace.go:171","msg":"trace[1140510815] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:311; }","duration":"134.291588ms","start":"2026-02-12T03:34:10.937153Z","end":"2026-02-12T03:34:11.071445Z","steps":["trace[1140510815] 'range keys from in-memory index tree' (duration: 134.108154ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:11.383863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.751579ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:11.38424Z","caller":"traceutil/trace.go:171","msg":"trace[501637885] transaction","detail":"{read_only:false; response_revision:313; number_of_response:1; }","duration":"308.268445ms","start":"2026-02-12T03:34:11.075944Z","end":"2026-02-12T03:34:11.384213Z","steps":["trace[501637885] 'process raft request' (duration: 99.122016ms)","trace[501637885] 'compare' (duration: 208.607476ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:11.384421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:11.075938Z","time spent":"308.432529ms","remote":"127.0.0.1:57528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T03:34:11.388663Z","caller":"traceutil/trace.go:171","msg":"trace[795234455] transaction","detail":"{read_only:false; response_revision:314; number_of_response:1; }","duration":"312.640621ms","start":"2026-02-12T03:34:11.076009Z","end":"2026-02-12T03:34:11.38865Z","steps":["trace[795234455] 'process raft request' (duration: 308.102561ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:11.388741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:11.075988Z","time spent":"312.708432ms","remote":"127.0.0.1:57602","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-02-12T03:34:11.556784Z","caller":"traceutil/trace.go:171","msg":"trace[822409241] transaction","detail":"{read_only:false; response_revision:315; number_of_response:1; }","duration":"159.544563ms","start":"2026-02-12T03:34:11.397222Z","end":"2026-02-12T03:34:11.556767Z","steps":["trace[822409241] 'process raft request' (duration: 90.125368ms)","trace[822409241] 'compare' (duration: 69.306662ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:11.890673Z","caller":"traceutil/trace.go:171","msg":"trace[844471347] linearizableReadLoop","detail":"{readStateIndex:326; appliedIndex:325; }","duration":"250.451162ms","start":"2026-02-12T03:34:11.640207Z","end":"2026-02-12T03:34:11.890658Z","steps":["trace[844471347] 'read index received' (duration: 250.325999ms)","trace[844471347] 'applied index is now lower than readState.Index' (duration: 124.593µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:11.890759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.534513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ephemeral-volume-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:11.890778Z","caller":"traceutil/trace.go:171","msg":"trace[838178274] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ephemeral-volume-controller; range_end:; response_count:0; response_revision:317; }","duration":"250.609565ms","start":"2026-02-12T03:34:11.640161Z","end":"2026-02-12T03:34:11.890771Z","steps":["trace[838178274] 'agreement among raft nodes before linearized reading' (duration: 250.561864ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:11.890941Z","caller":"traceutil/trace.go:171","msg":"trace[1698493578] transaction","detail":"{read_only:false; response_revision:317; number_of_response:1; }","duration":"266.154462ms","start":"2026-02-12T03:34:11.624766Z","end":"2026-02-12T03:34:11.890921Z","steps":["trace[1698493578] 'process raft request' (duration: 265.803733ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:12.382537Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.746413ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:12.382643Z","caller":"traceutil/trace.go:171","msg":"trace[559816710] linearizableReadLoop","detail":"{readStateIndex:330; appliedIndex:329; }","duration":"348.531222ms","start":"2026-02-12T03:34:12.034095Z","end":"2026-02-12T03:34:12.382627Z","steps":["trace[559816710] 'read index received' (duration: 127.547104ms)","trace[559816710] 'applied index is now lower than readState.Index' (duration: 220.982958ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:12.3827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.603953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:12.382728Z","caller":"traceutil/trace.go:171","msg":"trace[1251188701] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replication-controller; range_end:; response_count:0; response_revision:321; }","duration":"348.629174ms","start":"2026-02-12T03:34:12.034088Z","end":"2026-02-12T03:34:12.382717Z","steps":["trace[1251188701] 'agreement among raft nodes before linearized reading' (duration: 348.583353ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:12.382762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:12.034056Z","time spent":"348.698946ms","remote":"127.0.0.1:57528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/replication-controller\" "} {"level":"info","ts":"2026-02-12T03:34:12.382806Z","caller":"traceutil/trace.go:171","msg":"trace[1283834106] transaction","detail":"{read_only:false; response_revision:321; number_of_response:1; }","duration":"366.991865ms","start":"2026-02-12T03:34:12.015793Z","end":"2026-02-12T03:34:12.382785Z","steps":["trace[1283834106] 'process raft request' (duration: 145.927865ms)","trace[1283834106] 'compare' (duration: 220.63431ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:12.382923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:12.015773Z","time spent":"367.096717ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4579,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:34:12.732705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.449258ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:12.732826Z","caller":"traceutil/trace.go:171","msg":"trace[1083446543] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"254.033341ms","start":"2026-02-12T03:34:12.478782Z","end":"2026-02-12T03:34:12.732815Z","steps":["trace[1083446543] 'process raft request' (duration: 253.998711ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:12.733265Z","caller":"traceutil/trace.go:171","msg":"trace[2032608911] transaction","detail":"{read_only:false; response_revision:324; number_of_response:1; }","duration":"255.511167ms","start":"2026-02-12T03:34:12.477586Z","end":"2026-02-12T03:34:12.733097Z","steps":["trace[2032608911] 'process raft request' (duration: 135.612408ms)","trace[2032608911] 'compare' (duration: 119.361506ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:13.10342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.044191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:13.10436Z","caller":"traceutil/trace.go:171","msg":"trace[1946573485] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"359.448069ms","start":"2026-02-12T03:34:12.744888Z","end":"2026-02-12T03:34:13.104336Z","steps":["trace[1946573485] 'process raft request' (duration: 186.211953ms)","trace[1946573485] 'compare' (duration: 169.872566ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:13.104685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:12.74487Z","time spent":"359.741155ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7213,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:34:13.108866Z","caller":"traceutil/trace.go:171","msg":"trace[1656548258] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"362.351968ms","start":"2026-02-12T03:34:12.746504Z","end":"2026-02-12T03:34:13.108856Z","steps":["trace[1656548258] 'process raft request' (duration: 357.760959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:13.11019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:12.746495Z","time spent":"363.665919ms","remote":"127.0.0.1:57528","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":186,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T03:34:13.108727Z","caller":"traceutil/trace.go:171","msg":"trace[1152438058] linearizableReadLoop","detail":"{readStateIndex:336; appliedIndex:334; }","duration":"203.342827ms","start":"2026-02-12T03:34:12.905369Z","end":"2026-02-12T03:34:13.108712Z","steps":["trace[1152438058] 'read index received' (duration: 25.696117ms)","trace[1152438058] 'applied index is now lower than readState.Index' (duration: 177.64576ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:13.110128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.763822ms","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-02-12T03:34:13.110811Z","caller":"traceutil/trace.go:171","msg":"trace[1827775407] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:327; }","duration":"205.498599ms","start":"2026-02-12T03:34:12.905289Z","end":"2026-02-12T03:34:13.110787Z","steps":["trace[1827775407] 'agreement among raft nodes before linearized reading' (duration: 204.588377ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:13.754692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.496265ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:13.754803Z","caller":"traceutil/trace.go:171","msg":"trace[2093070314] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"636.23224ms","start":"2026-02-12T03:34:13.118552Z","end":"2026-02-12T03:34:13.754784Z","steps":["trace[2093070314] 'process raft request' (duration: 262.56281ms)","trace[2093070314] 'compare' (duration: 373.350042ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:13.754866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:13.118537Z","time spent":"636.300352ms","remote":"127.0.0.1:57602","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-02-12T03:34:13.758081Z","caller":"traceutil/trace.go:171","msg":"trace[105024021] linearizableReadLoop","detail":"{readStateIndex:338; appliedIndex:336; }","duration":"639.222341ms","start":"2026-02-12T03:34:13.118835Z","end":"2026-02-12T03:34:13.758057Z","steps":["trace[105024021] 'read index received' (duration: 262.358906ms)","trace[105024021] 'applied index is now lower than readState.Index' (duration: 376.862055ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:13.758283Z","caller":"traceutil/trace.go:171","msg":"trace[72795459] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"639.59172ms","start":"2026-02-12T03:34:13.11868Z","end":"2026-02-12T03:34:13.758271Z","steps":["trace[72795459] 'process raft request' (duration: 639.278043ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:13.758424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:13.118655Z","time spent":"639.677112ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6879,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:34:13.758594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.755714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:13.758635Z","caller":"traceutil/trace.go:171","msg":"trace[172120660] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/token-cleaner; range_end:; response_count:0; response_revision:329; }","duration":"639.817455ms","start":"2026-02-12T03:34:13.118806Z","end":"2026-02-12T03:34:13.758624Z","steps":["trace[172120660] 'agreement among raft nodes before linearized reading' (duration: 639.757034ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:13.758671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:13.118797Z","time spent":"639.864736ms","remote":"127.0.0.1:57528","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/kube-system/token-cleaner\" "} {"level":"warn","ts":"2026-02-12T03:34:13.758814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.707058ms","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-02-12T03:34:13.758839Z","caller":"traceutil/trace.go:171","msg":"trace[1038346502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:329; }","duration":"619.868782ms","start":"2026-02-12T03:34:13.138963Z","end":"2026-02-12T03:34:13.758832Z","steps":["trace[1038346502] 'agreement among raft nodes before linearized reading' (duration: 619.827781ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:13.758857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:13.138944Z","time spent":"619.908833ms","remote":"127.0.0.1:57602","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-02-12T03:34:13.762243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.87143ms","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-02-12T03:34:13.762347Z","caller":"traceutil/trace.go:171","msg":"trace[2111068365] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:329; }","duration":"123.040864ms","start":"2026-02-12T03:34:13.639292Z","end":"2026-02-12T03:34:13.762333Z","steps":["trace[2111068365] 'agreement among raft nodes before linearized reading' (duration: 122.876941ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:13.762545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.063621ms","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-02-12T03:34:13.762599Z","caller":"traceutil/trace.go:171","msg":"trace[770257958] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:329; }","duration":"369.151813ms","start":"2026-02-12T03:34:13.393439Z","end":"2026-02-12T03:34:13.762591Z","steps":["trace[770257958] 'agreement among raft nodes before linearized reading' (duration: 369.068642ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:13.762638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:13.393421Z","time spent":"369.207514ms","remote":"127.0.0.1:57602","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-02-12T03:34:14.056617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.121488ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:14.056725Z","caller":"traceutil/trace.go:171","msg":"trace[2048121213] linearizableReadLoop","detail":"{readStateIndex:344; appliedIndex:343; }","duration":"164.666011ms","start":"2026-02-12T03:34:13.89204Z","end":"2026-02-12T03:34:14.056706Z","steps":["trace[2048121213] 'read index received' (duration: 29.206915ms)","trace[2048121213] 'applied index is now lower than readState.Index' (duration: 135.457826ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:14.056762Z","caller":"traceutil/trace.go:171","msg":"trace[18546010] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"206.790291ms","start":"2026-02-12T03:34:13.849939Z","end":"2026-02-12T03:34:14.05673Z","steps":["trace[18546010] 'process raft request' (duration: 71.299195ms)","trace[18546010] 'compare' (duration: 134.920893ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:14.056848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.800404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:14.056876Z","caller":"traceutil/trace.go:171","msg":"trace[1893261342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:335; }","duration":"164.857245ms","start":"2026-02-12T03:34:13.89201Z","end":"2026-02-12T03:34:14.056867Z","steps":["trace[1893261342] 'agreement among raft nodes before linearized reading' (duration: 164.744392ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:14.550725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.228226ms","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-02-12T03:34:14.550865Z","caller":"traceutil/trace.go:171","msg":"trace[106331004] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:342; }","duration":"279.397879ms","start":"2026-02-12T03:34:14.271451Z","end":"2026-02-12T03:34:14.550849Z","steps":["trace[106331004] 'range keys from in-memory index tree' (duration: 279.147723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:14.551045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.639248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-12T03:34:14.551117Z","caller":"traceutil/trace.go:171","msg":"trace[1493103446] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:342; }","duration":"277.741081ms","start":"2026-02-12T03:34:14.273364Z","end":"2026-02-12T03:34:14.551105Z","steps":["trace[1493103446] 'range keys from in-memory index tree' (duration: 277.510285ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:14.55119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.125737ms","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-02-12T03:34:14.551865Z","caller":"traceutil/trace.go:171","msg":"trace[320654484] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:342; }","duration":"206.620129ms","start":"2026-02-12T03:34:14.345039Z","end":"2026-02-12T03:34:14.551659Z","steps":["trace[320654484] 'range keys from in-memory index tree' (duration: 206.028934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:14.551224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.823002ms","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-02-12T03:34:14.552307Z","caller":"traceutil/trace.go:171","msg":"trace[4523146] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:342; }","duration":"272.916619ms","start":"2026-02-12T03:34:14.279376Z","end":"2026-02-12T03:34:14.552293Z","steps":["trace[4523146] 'range keys from in-memory index tree' (duration: 271.77469ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:14.551251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.297079ms","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-02-12T03:34:14.552979Z","caller":"traceutil/trace.go:171","msg":"trace[1089856568] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:342; }","duration":"259.043431ms","start":"2026-02-12T03:34:14.293921Z","end":"2026-02-12T03:34:14.552965Z","steps":["trace[1089856568] 'range keys from in-memory index tree' (duration: 257.234718ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:14.55128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.044321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-12T03:34:14.553758Z","caller":"traceutil/trace.go:171","msg":"trace[1128558162] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:342; }","duration":"224.53991ms","start":"2026-02-12T03:34:14.329199Z","end":"2026-02-12T03:34:14.553739Z","steps":["trace[1128558162] 'range keys from in-memory index tree' (duration: 221.98833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:14.551308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.449228ms","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-02-12T03:34:14.555495Z","caller":"traceutil/trace.go:171","msg":"trace[929595874] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:342; }","duration":"225.643186ms","start":"2026-02-12T03:34:14.329834Z","end":"2026-02-12T03:34:14.555477Z","steps":["trace[929595874] 'range keys from in-memory index tree' (duration: 221.408546ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:14.551349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.166676ms","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-02-12T03:34:14.551376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.654492ms","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-02-12T03:34:14.551404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.404628ms","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-02-12T03:34:14.556148Z","caller":"traceutil/trace.go:171","msg":"trace[1484992532] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:342; }","duration":"110.986089ms","start":"2026-02-12T03:34:14.445147Z","end":"2026-02-12T03:34:14.556133Z","steps":["trace[1484992532] 'range keys from in-memory index tree' (duration: 106.120864ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.556269Z","caller":"traceutil/trace.go:171","msg":"trace[1989901222] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:342; }","duration":"206.551997ms","start":"2026-02-12T03:34:14.349705Z","end":"2026-02-12T03:34:14.556256Z","steps":["trace[1989901222] 'range keys from in-memory index tree' (duration: 201.624711ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.556332Z","caller":"traceutil/trace.go:171","msg":"trace[1606964707] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:342; }","duration":"195.341424ms","start":"2026-02-12T03:34:14.360982Z","end":"2026-02-12T03:34:14.556323Z","steps":["trace[1606964707] 'range keys from in-memory index tree' (duration: 190.372907ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.789487Z","caller":"traceutil/trace.go:171","msg":"trace[303122249] transaction","detail":"{read_only:false; response_revision:344; number_of_response:1; }","duration":"206.661569ms","start":"2026-02-12T03:34:14.582802Z","end":"2026-02-12T03:34:14.789464Z","steps":["trace[303122249] 'process raft request' (duration: 163.464023ms)","trace[303122249] 'compare' (duration: 42.9327ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:14.789883Z","caller":"traceutil/trace.go:171","msg":"trace[1323593028] linearizableReadLoop","detail":"{readStateIndex:361; appliedIndex:352; }","duration":"162.059481ms","start":"2026-02-12T03:34:14.627809Z","end":"2026-02-12T03:34:14.789869Z","steps":["trace[1323593028] 'read index received' (duration: 118.568718ms)","trace[1323593028] 'applied index is now lower than readState.Index' (duration: 43.489873ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:14.790144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.359826ms","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-02-12T03:34:14.790269Z","caller":"traceutil/trace.go:171","msg":"trace[511626833] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:352; }","duration":"207.505519ms","start":"2026-02-12T03:34:14.58275Z","end":"2026-02-12T03:34:14.790256Z","steps":["trace[511626833] 'agreement among raft nodes before linearized reading' (duration: 207.318545ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.790711Z","caller":"traceutil/trace.go:171","msg":"trace[187571914] transaction","detail":"{read_only:false; response_revision:345; number_of_response:1; }","duration":"204.678983ms","start":"2026-02-12T03:34:14.586009Z","end":"2026-02-12T03:34:14.790687Z","steps":["trace[187571914] 'process raft request' (duration: 203.367862ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.791207Z","caller":"traceutil/trace.go:171","msg":"trace[1722755169] transaction","detail":"{read_only:false; response_revision:346; number_of_response:1; }","duration":"203.398783ms","start":"2026-02-12T03:34:14.587797Z","end":"2026-02-12T03:34:14.791196Z","steps":["trace[1722755169] 'process raft request' (duration: 201.651451ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.791762Z","caller":"traceutil/trace.go:171","msg":"trace[308177378] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"203.916375ms","start":"2026-02-12T03:34:14.587837Z","end":"2026-02-12T03:34:14.791753Z","steps":["trace[308177378] 'process raft request' (duration: 201.650241ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.791825Z","caller":"traceutil/trace.go:171","msg":"trace[776053710] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"203.953446ms","start":"2026-02-12T03:34:14.587865Z","end":"2026-02-12T03:34:14.791819Z","steps":["trace[776053710] 'process raft request' (duration: 201.658032ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.791847Z","caller":"traceutil/trace.go:171","msg":"trace[1394407265] transaction","detail":"{read_only:false; response_revision:349; number_of_response:1; }","duration":"203.939386ms","start":"2026-02-12T03:34:14.587902Z","end":"2026-02-12T03:34:14.791842Z","steps":["trace[1394407265] 'process raft request' (duration: 201.816067ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.791865Z","caller":"traceutil/trace.go:171","msg":"trace[1295401774] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"203.931395ms","start":"2026-02-12T03:34:14.587927Z","end":"2026-02-12T03:34:14.791858Z","steps":["trace[1295401774] 'process raft request' (duration: 201.828586ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.791886Z","caller":"traceutil/trace.go:171","msg":"trace[1197664066] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"202.646515ms","start":"2026-02-12T03:34:14.589233Z","end":"2026-02-12T03:34:14.79188Z","steps":["trace[1197664066] 'process raft request' (duration: 200.552746ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.791973Z","caller":"traceutil/trace.go:171","msg":"trace[1686551245] transaction","detail":"{read_only:false; response_revision:352; number_of_response:1; }","duration":"202.43634ms","start":"2026-02-12T03:34:14.589531Z","end":"2026-02-12T03:34:14.791967Z","steps":["trace[1686551245] 'process raft request' (duration: 200.30185ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:14.79201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.791713ms","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":"info","ts":"2026-02-12T03:34:14.796132Z","caller":"traceutil/trace.go:171","msg":"trace[71752985] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:352; }","duration":"182.943382ms","start":"2026-02-12T03:34:14.613177Z","end":"2026-02-12T03:34:14.796121Z","steps":["trace[71752985] 'agreement among raft nodes before linearized reading' (duration: 178.808174ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:14.792036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.190858ms","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-02-12T03:34:14.796517Z","caller":"traceutil/trace.go:171","msg":"trace[2133359658] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:352; }","duration":"213.675554ms","start":"2026-02-12T03:34:14.582833Z","end":"2026-02-12T03:34:14.796508Z","steps":["trace[2133359658] 'agreement among raft nodes before linearized reading' (duration: 209.186928ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:14.797018Z","caller":"traceutil/trace.go:171","msg":"trace[1413486312] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"160.317239ms","start":"2026-02-12T03:34:14.636693Z","end":"2026-02-12T03:34:14.79701Z","steps":["trace[1413486312] 'process raft request' (duration: 160.260878ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.036582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.659876ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:15.036642Z","caller":"traceutil/trace.go:171","msg":"trace[901596321] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"146.761314ms","start":"2026-02-12T03:34:14.889871Z","end":"2026-02-12T03:34:15.036632Z","steps":["trace[901596321] 'compare' (duration: 139.400491ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:15.040796Z","caller":"traceutil/trace.go:171","msg":"trace[1769136129] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"142.434901ms","start":"2026-02-12T03:34:14.898353Z","end":"2026-02-12T03:34:15.040787Z","steps":["trace[1769136129] 'process raft request' (duration: 142.381959ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:15.200959Z","caller":"traceutil/trace.go:171","msg":"trace[876343644] linearizableReadLoop","detail":"{readStateIndex:374; appliedIndex:370; }","duration":"302.025153ms","start":"2026-02-12T03:34:14.8989Z","end":"2026-02-12T03:34:15.200925Z","steps":["trace[876343644] 'read index received' (duration: 141.810096ms)","trace[876343644] 'applied index is now lower than readState.Index' (duration: 160.214267ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:15.201087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.182607ms","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-02-12T03:34:15.201114Z","caller":"traceutil/trace.go:171","msg":"trace[1171429481] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:366; }","duration":"302.234008ms","start":"2026-02-12T03:34:14.898869Z","end":"2026-02-12T03:34:15.201103Z","steps":["trace[1171429481] 'agreement among raft nodes before linearized reading' (duration: 302.147726ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.201139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:14.898861Z","time spent":"302.271819ms","remote":"127.0.0.1:57528","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-02-12T03:34:15.201471Z","caller":"traceutil/trace.go:171","msg":"trace[1401949733] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"303.209241ms","start":"2026-02-12T03:34:14.898245Z","end":"2026-02-12T03:34:15.201454Z","steps":["trace[1401949733] 'process raft request' (duration: 283.881741ms)","trace[1401949733] 'compare' (duration: 18.592913ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:15.201531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:14.898228Z","time spent":"303.268403ms","remote":"127.0.0.1:57664","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:34:15.201769Z","caller":"traceutil/trace.go:171","msg":"trace[1415620784] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"303.292753ms","start":"2026-02-12T03:34:14.898465Z","end":"2026-02-12T03:34:15.201758Z","steps":["trace[1415620784] 'process raft request' (duration: 302.364961ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.201811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:14.898459Z","time spent":"303.332454ms","remote":"127.0.0.1:57752","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3669,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:34:15.201887Z","caller":"traceutil/trace.go:171","msg":"trace[2100551585] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"303.247652ms","start":"2026-02-12T03:34:14.89863Z","end":"2026-02-12T03:34:15.201878Z","steps":["trace[2100551585] 'process raft request' (duration: 302.237788ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.20191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:14.898623Z","time spent":"303.274044ms","remote":"127.0.0.1:57528","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-02-12T03:34:15.201949Z","caller":"traceutil/trace.go:171","msg":"trace[2040518393] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"301.241375ms","start":"2026-02-12T03:34:14.900701Z","end":"2026-02-12T03:34:15.201942Z","steps":["trace[2040518393] 'process raft request' (duration: 300.19673ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.201968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:14.900651Z","time spent":"301.307227ms","remote":"127.0.0.1:57418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":680,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-12T03:34:15.857559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.546108ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:15.857907Z","caller":"traceutil/trace.go:171","msg":"trace[1025139205] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:375; }","duration":"646.88111ms","start":"2026-02-12T03:34:15.211015Z","end":"2026-02-12T03:34:15.857896Z","steps":["trace[1025139205] 'read index received' (duration: 175.879082ms)","trace[1025139205] 'applied index is now lower than readState.Index' (duration: 471.001408ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:15.858765Z","caller":"traceutil/trace.go:171","msg":"trace[1632021139] transaction","detail":"{read_only:false; response_revision:367; number_of_response:1; }","duration":"812.7576ms","start":"2026-02-12T03:34:15.045997Z","end":"2026-02-12T03:34:15.858755Z","steps":["trace[1632021139] 'process raft request' (duration: 340.941443ms)","trace[1632021139] 'compare' (duration: 470.18332ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:15.859209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:15.045977Z","time spent":"812.817982ms","remote":"127.0.0.1:57768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2864,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:34:15.859431Z","caller":"traceutil/trace.go:171","msg":"trace[1340061040] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"811.904139ms","start":"2026-02-12T03:34:15.047519Z","end":"2026-02-12T03:34:15.859423Z","steps":["trace[1340061040] 'process raft request' (duration: 810.101448ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.859607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:15.047513Z","time spent":"811.94156ms","remote":"127.0.0.1:57418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":669,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T03:34:15.859878Z","caller":"traceutil/trace.go:171","msg":"trace[2095689939] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"812.31788ms","start":"2026-02-12T03:34:15.047552Z","end":"2026-02-12T03:34:15.85987Z","steps":["trace[2095689939] 'process raft request' (duration: 810.244101ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.859926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:15.047548Z","time spent":"812.356391ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3401,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:34:15.860448Z","caller":"traceutil/trace.go:171","msg":"trace[1147246412] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"812.72423ms","start":"2026-02-12T03:34:15.047715Z","end":"2026-02-12T03:34:15.860439Z","steps":["trace[1147246412] 'process raft request' (duration: 810.112989ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.860869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:15.04771Z","time spent":"812.76291ms","remote":"127.0.0.1:57436","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1731,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T03:34:15.861003Z","caller":"traceutil/trace.go:171","msg":"trace[1813569372] transaction","detail":"{read_only:false; response_revision:371; number_of_response:1; }","duration":"650.083985ms","start":"2026-02-12T03:34:15.210912Z","end":"2026-02-12T03:34:15.860996Z","steps":["trace[1813569372] 'process raft request' (duration: 646.940362ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.861496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:15.210896Z","time spent":"650.122446ms","remote":"127.0.0.1:57528","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-02-12T03:34:15.861597Z","caller":"traceutil/trace.go:171","msg":"trace[1324168417] transaction","detail":"{read_only:false; response_revision:372; number_of_response:1; }","duration":"650.505055ms","start":"2026-02-12T03:34:15.211085Z","end":"2026-02-12T03:34:15.86159Z","steps":["trace[1324168417] 'process raft request' (duration: 646.790349ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.861626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:15.211081Z","time spent":"650.530706ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3505,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-12T03:34:15.861873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"650.852502ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-02-12T03:34:15.861902Z","caller":"traceutil/trace.go:171","msg":"trace[311749647] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:372; }","duration":"650.897194ms","start":"2026-02-12T03:34:15.210998Z","end":"2026-02-12T03:34:15.861895Z","steps":["trace[311749647] 'agreement among raft nodes before linearized reading' (duration: 650.844323ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.862033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:15.210993Z","time spent":"651.030887ms","remote":"127.0.0.1:57752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":3707,"request content":"key:\"/registry/deployments/kube-system/coredns\" "} {"level":"warn","ts":"2026-02-12T03:34:15.862213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.639428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4256"} {"level":"info","ts":"2026-02-12T03:34:15.862241Z","caller":"traceutil/trace.go:171","msg":"trace[1325908623] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:372; }","duration":"592.69953ms","start":"2026-02-12T03:34:15.269535Z","end":"2026-02-12T03:34:15.862235Z","steps":["trace[1325908623] 'agreement among raft nodes before linearized reading' (duration: 592.652819ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:15.862259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:15.269521Z","time spent":"592.73419ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4279,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-02-12T03:34:15.867098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.50048ms","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-02-12T03:34:15.867131Z","caller":"traceutil/trace.go:171","msg":"trace[402695410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:372; }","duration":"107.588083ms","start":"2026-02-12T03:34:15.759536Z","end":"2026-02-12T03:34:15.867124Z","steps":["trace[402695410] 'agreement among raft nodes before linearized reading' (duration: 107.523441ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:15.995594Z","caller":"traceutil/trace.go:171","msg":"trace[982900557] linearizableReadLoop","detail":"{readStateIndex:382; appliedIndex:381; }","duration":"121.564988ms","start":"2026-02-12T03:34:15.874007Z","end":"2026-02-12T03:34:15.995572Z","steps":["trace[982900557] 'read index received' (duration: 91.770355ms)","trace[982900557] 'applied index is now lower than readState.Index' (duration: 29.793743ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:15.995762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.694901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:15.996001Z","caller":"traceutil/trace.go:171","msg":"trace[952797508] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:373; }","duration":"121.997598ms","start":"2026-02-12T03:34:15.873991Z","end":"2026-02-12T03:34:15.995989Z","steps":["trace[952797508] 'agreement among raft nodes before linearized reading' (duration: 121.6646ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:15.996332Z","caller":"traceutil/trace.go:171","msg":"trace[1788060064] transaction","detail":"{read_only:false; response_revision:373; number_of_response:1; }","duration":"123.978725ms","start":"2026-02-12T03:34:15.872339Z","end":"2026-02-12T03:34:15.996318Z","steps":["trace[1788060064] 'process raft request' (duration: 93.431594ms)","trace[1788060064] 'compare' (duration: 29.712121ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:15.998778Z","caller":"traceutil/trace.go:171","msg":"trace[707232926] transaction","detail":"{read_only:false; response_revision:374; number_of_response:1; }","duration":"123.742388ms","start":"2026-02-12T03:34:15.87502Z","end":"2026-02-12T03:34:15.998763Z","steps":["trace[707232926] 'process raft request' (duration: 122.475449ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.000282Z","caller":"traceutil/trace.go:171","msg":"trace[715317555] transaction","detail":"{read_only:false; response_revision:375; number_of_response:1; }","duration":"111.485894ms","start":"2026-02-12T03:34:15.888779Z","end":"2026-02-12T03:34:16.000265Z","steps":["trace[715317555] 'process raft request' (duration: 109.411165ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.000544Z","caller":"traceutil/trace.go:171","msg":"trace[1040857335] transaction","detail":"{read_only:false; response_revision:376; number_of_response:1; }","duration":"103.917837ms","start":"2026-02-12T03:34:15.896612Z","end":"2026-02-12T03:34:16.000529Z","steps":["trace[1040857335] 'process raft request' (duration: 101.629184ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.00084Z","caller":"traceutil/trace.go:171","msg":"trace[1278719576] transaction","detail":"{read_only:false; response_revision:377; number_of_response:1; }","duration":"104.193204ms","start":"2026-02-12T03:34:15.896633Z","end":"2026-02-12T03:34:16.000826Z","steps":["trace[1278719576] 'process raft request' (duration: 101.642194ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.001999Z","caller":"traceutil/trace.go:171","msg":"trace[1312898026] transaction","detail":"{read_only:false; response_revision:378; number_of_response:1; }","duration":"105.30232ms","start":"2026-02-12T03:34:15.896688Z","end":"2026-02-12T03:34:16.00199Z","steps":["trace[1312898026] 'process raft request' (duration: 101.627884ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.00293Z","caller":"traceutil/trace.go:171","msg":"trace[1105044490] transaction","detail":"{read_only:false; response_revision:379; number_of_response:1; }","duration":"106.215661ms","start":"2026-02-12T03:34:15.896703Z","end":"2026-02-12T03:34:16.002919Z","steps":["trace[1105044490] 'process raft request' (duration: 101.646224ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.004664Z","caller":"traceutil/trace.go:171","msg":"trace[1846471607] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"107.925661ms","start":"2026-02-12T03:34:15.89673Z","end":"2026-02-12T03:34:16.004656Z","steps":["trace[1846471607] 'process raft request' (duration: 101.653465ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.006619Z","caller":"traceutil/trace.go:171","msg":"trace[1668164329] transaction","detail":"{read_only:false; response_revision:381; number_of_response:1; }","duration":"109.835995ms","start":"2026-02-12T03:34:15.896774Z","end":"2026-02-12T03:34:16.00661Z","steps":["trace[1668164329] 'process raft request' (duration: 101.644585ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.006777Z","caller":"traceutil/trace.go:171","msg":"trace[239881153] transaction","detail":"{read_only:false; response_revision:382; number_of_response:1; }","duration":"108.230988ms","start":"2026-02-12T03:34:15.898538Z","end":"2026-02-12T03:34:16.006769Z","steps":["trace[239881153] 'process raft request' (duration: 99.906814ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.210912Z","caller":"traceutil/trace.go:171","msg":"trace[259144665] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"138.429207ms","start":"2026-02-12T03:34:16.072465Z","end":"2026-02-12T03:34:16.210895Z","steps":["trace[259144665] 'process raft request' (duration: 138.325875ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.211434Z","caller":"traceutil/trace.go:171","msg":"trace[857975816] transaction","detail":"{read_only:false; response_revision:388; number_of_response:1; }","duration":"190.188059ms","start":"2026-02-12T03:34:16.02124Z","end":"2026-02-12T03:34:16.211428Z","steps":["trace[857975816] 'process raft request' (duration: 189.447633ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.210927Z","caller":"traceutil/trace.go:171","msg":"trace[752500367] transaction","detail":"{read_only:false; response_revision:387; number_of_response:1; }","duration":"189.769179ms","start":"2026-02-12T03:34:16.020984Z","end":"2026-02-12T03:34:16.210753Z","steps":["trace[752500367] 'process raft request' (duration: 189.660997ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.211872Z","caller":"traceutil/trace.go:171","msg":"trace[1080207507] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"168.596971ms","start":"2026-02-12T03:34:16.043267Z","end":"2026-02-12T03:34:16.211864Z","steps":["trace[1080207507] 'process raft request' (duration: 167.472026ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.211941Z","caller":"traceutil/trace.go:171","msg":"trace[533323444] linearizableReadLoop","detail":"{readStateIndex:398; appliedIndex:394; }","duration":"150.596217ms","start":"2026-02-12T03:34:16.06134Z","end":"2026-02-12T03:34:16.211936Z","steps":["trace[533323444] 'read index received' (duration: 91.005015ms)","trace[533323444] 'applied index is now lower than readState.Index' (duration: 59.590732ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:16.212596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.574715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/kube-proxy\" ","response":"range_response_count:1 size:185"} {"level":"info","ts":"2026-02-12T03:34:16.212623Z","caller":"traceutil/trace.go:171","msg":"trace[302652440] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/kube-proxy; range_end:; response_count:1; response_revision:390; }","duration":"196.631247ms","start":"2026-02-12T03:34:16.015986Z","end":"2026-02-12T03:34:16.212617Z","steps":["trace[302652440] 'agreement among raft nodes before linearized reading' (duration: 195.968722ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:16.212914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.481842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:3995"} {"level":"info","ts":"2026-02-12T03:34:16.212936Z","caller":"traceutil/trace.go:171","msg":"trace[859473228] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:390; }","duration":"192.529573ms","start":"2026-02-12T03:34:16.020401Z","end":"2026-02-12T03:34:16.212931Z","steps":["trace[859473228] 'agreement among raft nodes before linearized reading' (duration: 192.494593ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.213978Z","caller":"traceutil/trace.go:171","msg":"trace[1150296176] transaction","detail":"{read_only:false; response_revision:386; number_of_response:1; }","duration":"193.065325ms","start":"2026-02-12T03:34:16.020906Z","end":"2026-02-12T03:34:16.213971Z","steps":["trace[1150296176] 'process raft request' (duration: 131.426386ms)","trace[1150296176] 'compare' (duration: 58.082497ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:16.395961Z","caller":"traceutil/trace.go:171","msg":"trace[1865210632] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"120.875303ms","start":"2026-02-12T03:34:16.27507Z","end":"2026-02-12T03:34:16.395945Z","steps":["trace[1865210632] 'process raft request' (duration: 120.831522ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:16.396223Z","caller":"traceutil/trace.go:171","msg":"trace[221477745] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"121.842896ms","start":"2026-02-12T03:34:16.274371Z","end":"2026-02-12T03:34:16.396214Z","steps":["trace[221477745] 'process raft request' (duration: 83.068253ms)","trace[221477745] 'compare' (duration: 38.375324ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:16.777758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.665374ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:16.777896Z","caller":"traceutil/trace.go:171","msg":"trace[1804943362] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:393; }","duration":"185.822947ms","start":"2026-02-12T03:34:16.592055Z","end":"2026-02-12T03:34:16.777878Z","steps":["trace[1804943362] 'range keys from in-memory index tree' (duration: 185.584003ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:17.814323Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674693927860315,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-12T03:34:17.974807Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.080039613s","expected-duration":"1s"} {"level":"info","ts":"2026-02-12T03:34:18.015217Z","caller":"traceutil/trace.go:171","msg":"trace[1152505312] linearizableReadLoop","detail":"{readStateIndex:404; appliedIndex:403; }","duration":"701.9078ms","start":"2026-02-12T03:34:17.313287Z","end":"2026-02-12T03:34:18.015195Z","steps":["trace[1152505312] 'read index received' (duration: 661.905782ms)","trace[1152505312] 'applied index is now lower than readState.Index' (duration: 40.000498ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:18.024753Z","caller":"traceutil/trace.go:171","msg":"trace[1326781555] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"1.130070638s","start":"2026-02-12T03:34:16.894667Z","end":"2026-02-12T03:34:18.024737Z","steps":["trace[1326781555] 'process raft request' (duration: 1.080625577s)","trace[1326781555] 'compare' (duration: 39.775853ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:18.025695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:16.894651Z","time spent":"1.13097967s","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6879,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:34:18.026103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.083411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:18.027759Z","caller":"traceutil/trace.go:171","msg":"trace[662580604] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:395; }","duration":"218.768929ms","start":"2026-02-12T03:34:17.808979Z","end":"2026-02-12T03:34:18.027748Z","steps":["trace[662580604] 'agreement among raft nodes before linearized reading' (duration: 217.101582ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:18.027603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"714.313649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-12T03:34:18.027852Z","caller":"traceutil/trace.go:171","msg":"trace[433723767] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:395; }","duration":"714.602176ms","start":"2026-02-12T03:34:17.313244Z","end":"2026-02-12T03:34:18.027846Z","steps":["trace[433723767] 'agreement among raft nodes before linearized reading' (duration: 714.33439ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:18.027874Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:17.313224Z","time spent":"714.642236ms","remote":"127.0.0.1:57374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.62\" "} {"level":"warn","ts":"2026-02-12T03:34:20.219135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.325654ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:20.219208Z","caller":"traceutil/trace.go:171","msg":"trace[1298264691] linearizableReadLoop","detail":"{readStateIndex:421; appliedIndex:420; }","duration":"138.257764ms","start":"2026-02-12T03:34:20.080938Z","end":"2026-02-12T03:34:20.219196Z","steps":["trace[1298264691] 'read index received' (duration: 9.764276ms)","trace[1298264691] 'applied index is now lower than readState.Index' (duration: 128.492588ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:20.219341Z","caller":"traceutil/trace.go:171","msg":"trace[1077437929] transaction","detail":"{read_only:false; response_revision:410; number_of_response:1; }","duration":"162.827955ms","start":"2026-02-12T03:34:20.056504Z","end":"2026-02-12T03:34:20.219332Z","steps":["trace[1077437929] 'process raft request' (duration: 34.234965ms)","trace[1077437929] 'compare' (duration: 128.160861ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:20.219473Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.53135ms","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-02-12T03:34:20.219492Z","caller":"traceutil/trace.go:171","msg":"trace[1428539625] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:410; }","duration":"138.573131ms","start":"2026-02-12T03:34:20.080913Z","end":"2026-02-12T03:34:20.219486Z","steps":["trace[1428539625] 'agreement among raft nodes before linearized reading' (duration: 138.53428ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:20.21958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.595882ms","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-02-12T03:34:20.219597Z","caller":"traceutil/trace.go:171","msg":"trace[741794411] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:410; }","duration":"138.624912ms","start":"2026-02-12T03:34:20.080967Z","end":"2026-02-12T03:34:20.219592Z","steps":["trace[741794411] 'agreement among raft nodes before linearized reading' (duration: 138.597001ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:20.550958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.945196ms","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-02-12T03:34:20.551081Z","caller":"traceutil/trace.go:171","msg":"trace[952476116] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:412; }","duration":"181.072809ms","start":"2026-02-12T03:34:20.369987Z","end":"2026-02-12T03:34:20.55106Z","steps":["trace[952476116] 'range keys from in-memory index tree' (duration: 180.930876ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:24.732522Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674693927860371,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-12T03:34:24.948674Z","caller":"traceutil/trace.go:171","msg":"trace[1218679493] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:430; }","duration":"717.073207ms","start":"2026-02-12T03:34:24.231585Z","end":"2026-02-12T03:34:24.948658Z","steps":["trace[1218679493] 'read index received' (duration: 716.929024ms)","trace[1218679493] 'applied index is now lower than readState.Index' (duration: 143.493µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:24.948749Z","caller":"traceutil/trace.go:171","msg":"trace[1119199832] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"858.704581ms","start":"2026-02-12T03:34:24.090039Z","end":"2026-02-12T03:34:24.948744Z","steps":["trace[1119199832] 'process raft request' (duration: 858.524587ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:24.948818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:24.09003Z","time spent":"858.737512ms","remote":"127.0.0.1:57602","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-02-12T03:34:24.948997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"717.418074ms","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-02-12T03:34:24.949018Z","caller":"traceutil/trace.go:171","msg":"trace[1188303883] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:419; }","duration":"717.476846ms","start":"2026-02-12T03:34:24.231536Z","end":"2026-02-12T03:34:24.949013Z","steps":["trace[1188303883] 'agreement among raft nodes before linearized reading' (duration: 717.414255ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:24.949034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:24.231522Z","time spent":"717.506946ms","remote":"127.0.0.1:57602","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-02-12T03:34:24.949101Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.889924ms","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-02-12T03:34:24.949118Z","caller":"traceutil/trace.go:171","msg":"trace[987392052] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:419; }","duration":"700.956425ms","start":"2026-02-12T03:34:24.248157Z","end":"2026-02-12T03:34:24.949113Z","steps":["trace[987392052] 'agreement among raft nodes before linearized reading' (duration: 700.930934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:24.94913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:24.24814Z","time spent":"700.987116ms","remote":"127.0.0.1:57602","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":"warn","ts":"2026-02-12T03:34:24.949218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"696.814598ms","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-02-12T03:34:24.949236Z","caller":"traceutil/trace.go:171","msg":"trace[642264895] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:419; }","duration":"696.857838ms","start":"2026-02-12T03:34:24.252374Z","end":"2026-02-12T03:34:24.949232Z","steps":["trace[642264895] 'agreement among raft nodes before linearized reading' (duration: 696.826238ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:24.949247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:24.252358Z","time spent":"696.88684ms","remote":"127.0.0.1:57602","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-02-12T03:34:25.170659Z","caller":"traceutil/trace.go:171","msg":"trace[625391539] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"215.768771ms","start":"2026-02-12T03:34:24.95487Z","end":"2026-02-12T03:34:25.170639Z","steps":["trace[625391539] 'process raft request' (duration: 209.49325ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:25.174908Z","caller":"traceutil/trace.go:171","msg":"trace[1015974688] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"218.456587ms","start":"2026-02-12T03:34:24.956446Z","end":"2026-02-12T03:34:25.174902Z","steps":["trace[1015974688] 'process raft request' (duration: 217.658199ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:25.174876Z","caller":"traceutil/trace.go:171","msg":"trace[277784624] transaction","detail":"{read_only:false; response_revision:422; number_of_response:1; }","duration":"217.020547ms","start":"2026-02-12T03:34:24.957844Z","end":"2026-02-12T03:34:25.174864Z","steps":["trace[277784624] 'process raft request' (duration: 216.353302ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:26.677379Z","caller":"traceutil/trace.go:171","msg":"trace[1423705966] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"240.54099ms","start":"2026-02-12T03:34:26.43682Z","end":"2026-02-12T03:34:26.677361Z","steps":["trace[1423705966] 'process raft request' (duration: 240.417568ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:29.489692Z","caller":"traceutil/trace.go:171","msg":"trace[64363202] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"215.802866ms","start":"2026-02-12T03:34:29.273873Z","end":"2026-02-12T03:34:29.489675Z","steps":["trace[64363202] 'process raft request' (duration: 215.477239ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:41.914156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.584062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:41.914473Z","caller":"traceutil/trace.go:171","msg":"trace[680397282] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:542; }","duration":"121.953808ms","start":"2026-02-12T03:34:41.792497Z","end":"2026-02-12T03:34:41.914451Z","steps":["trace[680397282] 'range keys from in-memory index tree' (duration: 121.520781ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:41.918134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.264717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:41.918399Z","caller":"traceutil/trace.go:171","msg":"trace[1004041771] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"111.529301ms","start":"2026-02-12T03:34:41.806816Z","end":"2026-02-12T03:34:41.918345Z","steps":["trace[1004041771] 'range keys from in-memory index tree' (duration: 111.228986ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:42.334126Z","caller":"traceutil/trace.go:171","msg":"trace[666372784] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"134.762948ms","start":"2026-02-12T03:34:42.199326Z","end":"2026-02-12T03:34:42.334089Z","steps":["trace[666372784] 'process raft request' (duration: 134.661996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.105327Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674693927860638,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-12T03:34:44.132804Z","caller":"traceutil/trace.go:171","msg":"trace[970460935] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"538.637878ms","start":"2026-02-12T03:34:43.594148Z","end":"2026-02-12T03:34:44.132786Z","steps":["trace[970460935] 'process raft request' (duration: 538.195711ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.132895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:43.594131Z","time spent":"538.71944ms","remote":"127.0.0.1:57392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4234,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T03:34:44.210076Z","caller":"traceutil/trace.go:171","msg":"trace[64974497] linearizableReadLoop","detail":"{readStateIndex:581; appliedIndex:580; }","duration":"609.275929ms","start":"2026-02-12T03:34:43.600777Z","end":"2026-02-12T03:34:44.210053Z","steps":["trace[64974497] 'read index received' (duration: 532.46331ms)","trace[64974497] 'applied index is now lower than readState.Index' (duration: 76.811769ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:44.210438Z","caller":"traceutil/trace.go:171","msg":"trace[1386187970] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"360.135586ms","start":"2026-02-12T03:34:43.850291Z","end":"2026-02-12T03:34:44.210426Z","steps":["trace[1386187970] 'process raft request' (duration: 359.611397ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.21053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:43.85026Z","time spent":"360.208407ms","remote":"127.0.0.1:57392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":187246,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-12T03:34:44.210764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.976331ms","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-02-12T03:34:44.210804Z","caller":"traceutil/trace.go:171","msg":"trace[166246748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:565; }","duration":"610.038351ms","start":"2026-02-12T03:34:43.600753Z","end":"2026-02-12T03:34:44.210792Z","steps":["trace[166246748] 'agreement among raft nodes before linearized reading' (duration: 609.93123ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.210838Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:43.600745Z","time spent":"610.084812ms","remote":"127.0.0.1:57602","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-02-12T03:34:44.228086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"578.814647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:44.228141Z","caller":"traceutil/trace.go:171","msg":"trace[760856350] range","detail":"{range_begin:/registry/secrets/local-path-storage/; range_end:/registry/secrets/local-path-storage0; response_count:0; response_revision:566; }","duration":"578.904448ms","start":"2026-02-12T03:34:43.649223Z","end":"2026-02-12T03:34:44.228128Z","steps":["trace[760856350] 'agreement among raft nodes before linearized reading' (duration: 578.784086ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.228201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:43.649209Z","time spent":"578.956048ms","remote":"127.0.0.1:57428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/local-path-storage/\" range_end:\"/registry/secrets/local-path-storage0\" "} {"level":"warn","ts":"2026-02-12T03:34:44.232688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.72377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:1 size:5586"} {"level":"info","ts":"2026-02-12T03:34:44.232725Z","caller":"traceutil/trace.go:171","msg":"trace[963764412] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:566; }","duration":"239.778871ms","start":"2026-02-12T03:34:43.992929Z","end":"2026-02-12T03:34:44.232708Z","steps":["trace[963764412] 'agreement among raft nodes before linearized reading' (duration: 236.682837ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.233047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.662429ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:44.233062Z","caller":"traceutil/trace.go:171","msg":"trace[290403161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"422.70157ms","start":"2026-02-12T03:34:43.810356Z","end":"2026-02-12T03:34:44.233057Z","steps":["trace[290403161] 'agreement among raft nodes before linearized reading' (duration: 422.67459ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.233075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:43.810343Z","time spent":"422.728861ms","remote":"127.0.0.1:41808","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-02-12T03:34:44.233166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"575.289392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-12T03:34:44.233252Z","caller":"traceutil/trace.go:171","msg":"trace[260598796] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:566; }","duration":"575.414405ms","start":"2026-02-12T03:34:43.657833Z","end":"2026-02-12T03:34:44.233248Z","steps":["trace[260598796] 'agreement among raft nodes before linearized reading' (duration: 575.299233ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.233265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:43.657827Z","time spent":"575.435155ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-12T03:34:44.896732Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674693927860645,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-12T03:34:44.920585Z","caller":"traceutil/trace.go:171","msg":"trace[1157971915] linearizableReadLoop","detail":"{readStateIndex:586; appliedIndex:585; }","duration":"523.876496ms","start":"2026-02-12T03:34:44.396693Z","end":"2026-02-12T03:34:44.920569Z","steps":["trace[1157971915] 'read index received' (duration: 523.574141ms)","trace[1157971915] 'applied index is now lower than readState.Index' (duration: 301.825µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:44.927812Z","caller":"traceutil/trace.go:171","msg":"trace[1536144369] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"582.945502ms","start":"2026-02-12T03:34:44.344848Z","end":"2026-02-12T03:34:44.927793Z","steps":["trace[1536144369] 'process raft request' (duration: 575.544802ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.928427Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:44.344831Z","time spent":"583.495852ms","remote":"127.0.0.1:57392","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188228,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:34:44.928792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"532.07813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-02-12T03:34:44.928842Z","caller":"traceutil/trace.go:171","msg":"trace[646779078] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:570; }","duration":"532.175722ms","start":"2026-02-12T03:34:44.396651Z","end":"2026-02-12T03:34:44.928827Z","steps":["trace[646779078] 'agreement among raft nodes before linearized reading' (duration: 532.018689ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.928914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:44.396631Z","time spent":"532.272943ms","remote":"127.0.0.1:57392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":13252,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" "} {"level":"warn","ts":"2026-02-12T03:34:44.929151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.352545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:44.929192Z","caller":"traceutil/trace.go:171","msg":"trace[475217826] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:570; }","duration":"413.414246ms","start":"2026-02-12T03:34:44.51577Z","end":"2026-02-12T03:34:44.929185Z","steps":["trace[475217826] 'agreement among raft nodes before linearized reading' (duration: 413.331394ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.929382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:44.515756Z","time spent":"413.577178ms","remote":"127.0.0.1:46962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:500 "} {"level":"warn","ts":"2026-02-12T03:34:44.934105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.793638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:44.934354Z","caller":"traceutil/trace.go:171","msg":"trace[1806274305] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:570; }","duration":"126.048613ms","start":"2026-02-12T03:34:44.808293Z","end":"2026-02-12T03:34:44.934342Z","steps":["trace[1806274305] 'agreement among raft nodes before linearized reading' (duration: 125.764168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.935125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.224986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-12T03:34:44.935409Z","caller":"traceutil/trace.go:171","msg":"trace[1520544155] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:570; }","duration":"138.537703ms","start":"2026-02-12T03:34:44.796862Z","end":"2026-02-12T03:34:44.9354Z","steps":["trace[1520544155] 'agreement among raft nodes before linearized reading' (duration: 138.173276ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.949877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"434.033288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:44.949967Z","caller":"traceutil/trace.go:171","msg":"trace[967253094] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:570; }","duration":"434.14369ms","start":"2026-02-12T03:34:44.515812Z","end":"2026-02-12T03:34:44.949956Z","steps":["trace[967253094] 'agreement among raft nodes before linearized reading' (duration: 433.438168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.950011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:44.515808Z","time spent":"434.193991ms","remote":"127.0.0.1:46962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" limit:10000 "} {"level":"warn","ts":"2026-02-12T03:34:44.950196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.777165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-12T03:34:44.950235Z","caller":"traceutil/trace.go:171","msg":"trace[1409699094] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:570; }","duration":"355.827236ms","start":"2026-02-12T03:34:44.594401Z","end":"2026-02-12T03:34:44.950228Z","steps":["trace[1409699094] 'agreement among raft nodes before linearized reading' (duration: 351.386167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.950266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:44.594393Z","time spent":"355.867296ms","remote":"127.0.0.1:57392","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4203,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"warn","ts":"2026-02-12T03:34:44.950344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.781312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:44.950385Z","caller":"traceutil/trace.go:171","msg":"trace[325069304] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:570; }","duration":"377.826852ms","start":"2026-02-12T03:34:44.57255Z","end":"2026-02-12T03:34:44.950377Z","steps":["trace[325069304] 'agreement among raft nodes before linearized reading' (duration: 373.254082ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.950413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:44.572548Z","time spent":"377.857823ms","remote":"127.0.0.1:46976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true "} {"level":"warn","ts":"2026-02-12T03:34:44.950532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.981025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:44.950577Z","caller":"traceutil/trace.go:171","msg":"trace[37180208] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:570; }","duration":"378.031586ms","start":"2026-02-12T03:34:44.572539Z","end":"2026-02-12T03:34:44.95057Z","steps":["trace[37180208] 'agreement among raft nodes before linearized reading' (duration: 373.272472ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.950611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:44.572535Z","time spent":"378.065306ms","remote":"127.0.0.1:46976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:10000 "} {"level":"warn","ts":"2026-02-12T03:34:44.950721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.190578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:44.950759Z","caller":"traceutil/trace.go:171","msg":"trace[1083925703] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:570; }","duration":"378.241049ms","start":"2026-02-12T03:34:44.572508Z","end":"2026-02-12T03:34:44.950749Z","steps":["trace[1083925703] 'agreement among raft nodes before linearized reading' (duration: 376.725833ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.950832Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:44.572497Z","time spent":"378.326711ms","remote":"127.0.0.1:46976","response type":"/etcdserverpb.KV/Range","request count":0,"request size":79,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" limit:500 "} {"level":"warn","ts":"2026-02-12T03:34:44.95094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.092937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:44.950984Z","caller":"traceutil/trace.go:171","msg":"trace[1701254177] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:570; }","duration":"435.140178ms","start":"2026-02-12T03:34:44.515832Z","end":"2026-02-12T03:34:44.950973Z","steps":["trace[1701254177] 'agreement among raft nodes before linearized reading' (duration: 433.410438ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:44.951013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:44.51583Z","time spent":"435.176948ms","remote":"127.0.0.1:46962","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"info","ts":"2026-02-12T03:34:45.498056Z","caller":"traceutil/trace.go:171","msg":"trace[2023367788] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"169.298515ms","start":"2026-02-12T03:34:45.328744Z","end":"2026-02-12T03:34:45.498043Z","steps":["trace[2023367788] 'process raft request' (duration: 169.151543ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:45.498474Z","caller":"traceutil/trace.go:171","msg":"trace[250537865] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:588; }","duration":"143.972556ms","start":"2026-02-12T03:34:45.354477Z","end":"2026-02-12T03:34:45.498449Z","steps":["trace[250537865] 'read index received' (duration: 143.963156ms)","trace[250537865] 'applied index is now lower than readState.Index' (duration: 7.6µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:45.498612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.124149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/local-path-storage/\" range_end:\"/registry/resourcequotas/local-path-storage0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:45.498652Z","caller":"traceutil/trace.go:171","msg":"trace[1166832883] range","detail":"{range_begin:/registry/resourcequotas/local-path-storage/; range_end:/registry/resourcequotas/local-path-storage0; response_count:0; response_revision:572; }","duration":"144.17242ms","start":"2026-02-12T03:34:45.354473Z","end":"2026-02-12T03:34:45.498645Z","steps":["trace[1166832883] 'agreement among raft nodes before linearized reading' (duration: 144.082138ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:45.590256Z","caller":"traceutil/trace.go:171","msg":"trace[58528151] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"230.853146ms","start":"2026-02-12T03:34:45.35939Z","end":"2026-02-12T03:34:45.590243Z","steps":["trace[58528151] 'process raft request' (duration: 177.01699ms)","trace[58528151] 'compare' (duration: 53.332898ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:45.590413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.123149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-12T03:34:45.59043Z","caller":"traceutil/trace.go:171","msg":"trace[685731598] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:574; }","duration":"197.173271ms","start":"2026-02-12T03:34:45.393252Z","end":"2026-02-12T03:34:45.590425Z","steps":["trace[685731598] 'agreement among raft nodes before linearized reading' (duration: 197.078959ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:45.590653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.996093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-12T03:34:45.590671Z","caller":"traceutil/trace.go:171","msg":"trace[742141342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:574; }","duration":"118.023164ms","start":"2026-02-12T03:34:45.472642Z","end":"2026-02-12T03:34:45.590665Z","steps":["trace[742141342] 'agreement among raft nodes before linearized reading' (duration: 117.986383ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:45.59077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.478165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T03:34:45.590783Z","caller":"traceutil/trace.go:171","msg":"trace[76828276] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:574; }","duration":"132.506067ms","start":"2026-02-12T03:34:45.458273Z","end":"2026-02-12T03:34:45.590779Z","steps":["trace[76828276] 'agreement among raft nodes before linearized reading' (duration: 132.480646ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:45.822962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.202138ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:45.823138Z","caller":"traceutil/trace.go:171","msg":"trace[185040416] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"145.753226ms","start":"2026-02-12T03:34:45.677374Z","end":"2026-02-12T03:34:45.823127Z","steps":["trace[185040416] 'process raft request' (duration: 39.338964ms)","trace[185040416] 'compare' (duration: 106.110727ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:47.670189Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674693927860723,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-12T03:34:48.045913Z","caller":"traceutil/trace.go:171","msg":"trace[1368478123] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"925.963446ms","start":"2026-02-12T03:34:47.119922Z","end":"2026-02-12T03:34:48.045885Z","steps":["trace[1368478123] 'process raft request' (duration: 925.847464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:48.046101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:47.119893Z","time spent":"926.128529ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:34:48.046446Z","caller":"traceutil/trace.go:171","msg":"trace[806232124] linearizableReadLoop","detail":"{readStateIndex:619; appliedIndex:619; }","duration":"876.625122ms","start":"2026-02-12T03:34:47.16981Z","end":"2026-02-12T03:34:48.046435Z","steps":["trace[806232124] 'read index received' (duration: 876.621422ms)","trace[806232124] 'applied index is now lower than readState.Index' (duration: 2.95µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:48.046532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"731.376219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-12T03:34:48.046558Z","caller":"traceutil/trace.go:171","msg":"trace[685309839] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:603; }","duration":"731.44368ms","start":"2026-02-12T03:34:47.315106Z","end":"2026-02-12T03:34:48.04655Z","steps":["trace[685309839] 'agreement among raft nodes before linearized reading' (duration: 731.392069ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:48.051281Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:47.315085Z","time spent":"736.188071ms","remote":"127.0.0.1:57374","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/162.253.55.62\" "} {"level":"warn","ts":"2026-02-12T03:34:48.051422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"881.617117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-12T03:34:48.051446Z","caller":"traceutil/trace.go:171","msg":"trace[1770641184] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"881.660598ms","start":"2026-02-12T03:34:47.169776Z","end":"2026-02-12T03:34:48.051437Z","steps":["trace[1770641184] 'agreement among raft nodes before linearized reading' (duration: 881.597537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:48.051458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:47.169762Z","time spent":"881.693468ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-12T03:34:48.051512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.085092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:48.051525Z","caller":"traceutil/trace.go:171","msg":"trace[1973040274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:603; }","duration":"242.119202ms","start":"2026-02-12T03:34:47.809402Z","end":"2026-02-12T03:34:48.051521Z","steps":["trace[1973040274] 'agreement among raft nodes before linearized reading' (duration: 242.100642ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:48.051618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.046097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-12T03:34:48.05163Z","caller":"traceutil/trace.go:171","msg":"trace[1624637792] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:603; }","duration":"426.072588ms","start":"2026-02-12T03:34:47.625554Z","end":"2026-02-12T03:34:48.051626Z","steps":["trace[1624637792] 'agreement among raft nodes before linearized reading' (duration: 426.033467ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:48.051641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:47.625546Z","time spent":"426.093118ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-12T03:34:48.051705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.500289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T03:34:48.051717Z","caller":"traceutil/trace.go:171","msg":"trace[120338812] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:603; }","duration":"428.536271ms","start":"2026-02-12T03:34:47.623177Z","end":"2026-02-12T03:34:48.051714Z","steps":["trace[120338812] 'agreement among raft nodes before linearized reading' (duration: 428.50342ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:48.051729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:47.623162Z","time spent":"428.564121ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-12T03:34:50.571647Z","caller":"traceutil/trace.go:171","msg":"trace[1634795049] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"252.795213ms","start":"2026-02-12T03:34:50.318838Z","end":"2026-02-12T03:34:50.571633Z","steps":["trace[1634795049] 'read index received' (duration: 252.64807ms)","trace[1634795049] 'applied index is now lower than readState.Index' (duration: 146.533µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:50.57182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.953595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-12T03:34:50.571837Z","caller":"traceutil/trace.go:171","msg":"trace[260603820] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:613; }","duration":"253.025416ms","start":"2026-02-12T03:34:50.318806Z","end":"2026-02-12T03:34:50.571832Z","steps":["trace[260603820] 'agreement among raft nodes before linearized reading' (duration: 252.892834ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:50.572081Z","caller":"traceutil/trace.go:171","msg":"trace[1589896289] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"267.740442ms","start":"2026-02-12T03:34:50.304335Z","end":"2026-02-12T03:34:50.572075Z","steps":["trace[1589896289] 'process raft request' (duration: 267.205373ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:52.974006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.417023ms","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-02-12T03:34:52.974058Z","caller":"traceutil/trace.go:171","msg":"trace[1597322072] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:621; }","duration":"399.500695ms","start":"2026-02-12T03:34:52.574544Z","end":"2026-02-12T03:34:52.974045Z","steps":["trace[1597322072] 'range keys from in-memory index tree' (duration: 399.325012ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:52.974084Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:52.574514Z","time spent":"399.563546ms","remote":"127.0.0.1:57602","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-02-12T03:34:53.005524Z","caller":"traceutil/trace.go:171","msg":"trace[1115028654] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"406.181115ms","start":"2026-02-12T03:34:52.599327Z","end":"2026-02-12T03:34:53.005509Z","steps":["trace[1115028654] 'read index received' (duration: 316.872872ms)","trace[1115028654] 'applied index is now lower than readState.Index' (duration: 89.307623ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:53.005741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.400139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-12T03:34:53.005759Z","caller":"traceutil/trace.go:171","msg":"trace[994488338] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:621; }","duration":"406.444839ms","start":"2026-02-12T03:34:52.599308Z","end":"2026-02-12T03:34:53.005753Z","steps":["trace[994488338] 'agreement among raft nodes before linearized reading' (duration: 406.403168ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:53.00578Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:52.599297Z","time spent":"406.476459ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-12T03:34:53.005969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.74861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fd9p4\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-12T03:34:53.005986Z","caller":"traceutil/trace.go:171","msg":"trace[407299356] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fd9p4; range_end:; response_count:1; response_revision:622; }","duration":"338.787561ms","start":"2026-02-12T03:34:52.667194Z","end":"2026-02-12T03:34:53.005981Z","steps":["trace[407299356] 'agreement among raft nodes before linearized reading' (duration: 338.705699ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:53.006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:52.667179Z","time spent":"338.817961ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16675,"request content":"key:\"/registry/pods/kube-system/cilium-fd9p4\" "} {"level":"warn","ts":"2026-02-12T03:34:54.309256Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674693927860774,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-12T03:34:54.316288Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.274905803s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-12T03:34:55.074579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"758.076427ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:55.074666Z","caller":"traceutil/trace.go:171","msg":"trace[1118074487] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"1.265651312s","start":"2026-02-12T03:34:53.809Z","end":"2026-02-12T03:34:55.074651Z","steps":["trace[1118074487] 'read index received' (duration: 507.381632ms)","trace[1118074487] 'applied index is now lower than readState.Index' (duration: 758.26834ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:55.074868Z","caller":"traceutil/trace.go:171","msg":"trace[361488977] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"2.058585716s","start":"2026-02-12T03:34:53.016269Z","end":"2026-02-12T03:34:55.074854Z","steps":["trace[361488977] 'process raft request' (duration: 1.300166644s)","trace[361488977] 'compare' (duration: 757.64926ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:55.074939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:53.016261Z","time spent":"2.058638027s","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":16799,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:34:55.075147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.26614115s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:55.075181Z","caller":"traceutil/trace.go:171","msg":"trace[1589774977] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:624; }","duration":"1.266198491s","start":"2026-02-12T03:34:53.80897Z","end":"2026-02-12T03:34:55.075169Z","steps":["trace[1589774977] 'agreement among raft nodes before linearized reading' (duration: 1.2661458s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:55.07521Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:53.808955Z","time spent":"1.266249041s","remote":"127.0.0.1:41798","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-02-12T03:34:55.07545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"963.972424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-12T03:34:55.075488Z","caller":"traceutil/trace.go:171","msg":"trace[1353031595] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:624; }","duration":"964.029456ms","start":"2026-02-12T03:34:54.111447Z","end":"2026-02-12T03:34:55.075476Z","steps":["trace[1353031595] 'agreement among raft nodes before linearized reading' (duration: 963.902044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:55.075519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:54.111433Z","time spent":"964.077146ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-12T03:34:55.083186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"955.835624ms","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-02-12T03:34:55.083329Z","caller":"traceutil/trace.go:171","msg":"trace[107080948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:624; }","duration":"962.985098ms","start":"2026-02-12T03:34:54.120318Z","end":"2026-02-12T03:34:55.083303Z","steps":["trace[107080948] 'agreement among raft nodes before linearized reading' (duration: 955.802024ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:55.083401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:54.120312Z","time spent":"963.080669ms","remote":"127.0.0.1:57602","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-02-12T03:34:55.083671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.315076ms","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-02-12T03:34:55.083743Z","caller":"traceutil/trace.go:171","msg":"trace[1037714669] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:624; }","duration":"970.397447ms","start":"2026-02-12T03:34:54.113339Z","end":"2026-02-12T03:34:55.083737Z","steps":["trace[1037714669] 'agreement among raft nodes before linearized reading' (duration: 970.280065ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:55.083821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:54.113334Z","time spent":"970.480908ms","remote":"127.0.0.1:57602","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-02-12T03:34:55.595975Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674693927860779,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-12T03:34:56.863666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"845.27013ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:34:56.863745Z","caller":"traceutil/trace.go:171","msg":"trace[1592426072] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"1.771351729s","start":"2026-02-12T03:34:55.092372Z","end":"2026-02-12T03:34:56.863724Z","steps":["trace[1592426072] 'process raft request' (duration: 925.958897ms)","trace[1592426072] 'compare' (duration: 845.123008ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:34:56.863783Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:55.09236Z","time spent":"1.771405971s","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:34:56.869741Z","caller":"traceutil/trace.go:171","msg":"trace[1566624819] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"1.777259723s","start":"2026-02-12T03:34:55.092466Z","end":"2026-02-12T03:34:56.869726Z","steps":["trace[1566624819] 'process raft request' (duration: 1.771749766s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:56.869959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:55.092462Z","time spent":"1.777446956s","remote":"127.0.0.1:57602","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-02-12T03:34:56.870949Z","caller":"traceutil/trace.go:171","msg":"trace[1191068966] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"1.775709768s","start":"2026-02-12T03:34:55.095232Z","end":"2026-02-12T03:34:56.870942Z","steps":["trace[1191068966] 'process raft request' (duration: 1.769102924s)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:34:56.871219Z","caller":"traceutil/trace.go:171","msg":"trace[483004967] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:642; }","duration":"1.77589231s","start":"2026-02-12T03:34:55.095316Z","end":"2026-02-12T03:34:56.871208Z","steps":["trace[483004967] 'read index received' (duration: 923.02456ms)","trace[483004967] 'applied index is now lower than readState.Index' (duration: 852.86707ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:34:56.871289Z","caller":"traceutil/trace.go:171","msg":"trace[1322669742] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"1.774534318s","start":"2026-02-12T03:34:55.096748Z","end":"2026-02-12T03:34:56.871282Z","steps":["trace[1322669742] 'process raft request' (duration: 1.774165582s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:56.871334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:55.096742Z","time spent":"1.774565939s","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:34:56.871236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:55.095225Z","time spent":"1.775991442s","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:34:56.87149Z","caller":"traceutil/trace.go:171","msg":"trace[367648003] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"1.772749119s","start":"2026-02-12T03:34:55.098734Z","end":"2026-02-12T03:34:56.871483Z","steps":["trace[367648003] 'process raft request' (duration: 1.772415244s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:56.871531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:55.098728Z","time spent":"1.77278358s","remote":"127.0.0.1:57602","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-02-12T03:34:56.871593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.776275456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:34:56.871615Z","caller":"traceutil/trace.go:171","msg":"trace[1836712843] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:629; }","duration":"1.776307487s","start":"2026-02-12T03:34:55.095301Z","end":"2026-02-12T03:34:56.871609Z","steps":["trace[1836712843] 'agreement among raft nodes before linearized reading' (duration: 1.776275867s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:34:56.871632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:34:55.095297Z","time spent":"1.776331238s","remote":"127.0.0.1:41798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-12T03:35:00.860578Z","caller":"traceutil/trace.go:171","msg":"trace[1158603798] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"145.260639ms","start":"2026-02-12T03:35:00.715299Z","end":"2026-02-12T03:35:00.860559Z","steps":["trace[1158603798] 'process raft request' (duration: 137.42703ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:05.204291Z","caller":"traceutil/trace.go:171","msg":"trace[1809261785] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"155.387386ms","start":"2026-02-12T03:35:05.048869Z","end":"2026-02-12T03:35:05.204256Z","steps":["trace[1809261785] 'process raft request' (duration: 120.303047ms)","trace[1809261785] 'compare' (duration: 34.934467ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:07.413226Z","caller":"traceutil/trace.go:171","msg":"trace[862062626] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:708; }","duration":"205.235987ms","start":"2026-02-12T03:35:07.207967Z","end":"2026-02-12T03:35:07.413203Z","steps":["trace[862062626] 'read index received' (duration: 3.000734ms)","trace[862062626] 'applied index is now lower than readState.Index' (duration: 202.234613ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:07.413318Z","caller":"traceutil/trace.go:171","msg":"trace[660404103] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"254.622275ms","start":"2026-02-12T03:35:07.15869Z","end":"2026-02-12T03:35:07.413312Z","steps":["trace[660404103] 'process raft request' (duration: 254.465512ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:07.413295Z","caller":"traceutil/trace.go:171","msg":"trace[1779118794] transaction","detail":"{read_only:false; response_revision:688; number_of_response:1; }","duration":"254.639126ms","start":"2026-02-12T03:35:07.158628Z","end":"2026-02-12T03:35:07.413267Z","steps":["trace[1779118794] 'process raft request' (duration: 209.63859ms)","trace[1779118794] 'compare' (duration: 44.792852ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:07.413582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.602673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-12T03:35:07.413607Z","caller":"traceutil/trace.go:171","msg":"trace[694314994] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:689; }","duration":"205.668974ms","start":"2026-02-12T03:35:07.20793Z","end":"2026-02-12T03:35:07.413599Z","steps":["trace[694314994] 'agreement among raft nodes before linearized reading' (duration: 205.579852ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:07.665471Z","caller":"traceutil/trace.go:171","msg":"trace[1550571804] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:712; }","duration":"183.937897ms","start":"2026-02-12T03:35:07.481488Z","end":"2026-02-12T03:35:07.665426Z","steps":["trace[1550571804] 'read index received' (duration: 18.509009ms)","trace[1550571804] 'applied index is now lower than readState.Index' (duration: 165.427878ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:07.665673Z","caller":"traceutil/trace.go:171","msg":"trace[274314103] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"210.194449ms","start":"2026-02-12T03:35:07.455467Z","end":"2026-02-12T03:35:07.665662Z","steps":["trace[274314103] 'process raft request' (duration: 158.127521ms)","trace[274314103] 'compare' (duration: 51.554909ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:07.665693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.194221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fd9p4\" ","response":"range_response_count:1 size:18246"} {"level":"info","ts":"2026-02-12T03:35:07.665746Z","caller":"traceutil/trace.go:171","msg":"trace[1168897967] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fd9p4; range_end:; response_count:1; response_revision:691; }","duration":"184.297403ms","start":"2026-02-12T03:35:07.481437Z","end":"2026-02-12T03:35:07.665734Z","steps":["trace[1168897967] 'agreement among raft nodes before linearized reading' (duration: 184.09053ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:07.901601Z","caller":"traceutil/trace.go:171","msg":"trace[761291735] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"223.177219ms","start":"2026-02-12T03:35:07.678409Z","end":"2026-02-12T03:35:07.901586Z","steps":["trace[761291735] 'process raft request' (duration: 157.838788ms)","trace[761291735] 'compare' (duration: 65.125788ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:08.165215Z","caller":"traceutil/trace.go:171","msg":"trace[1379297892] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"249.789578ms","start":"2026-02-12T03:35:07.915409Z","end":"2026-02-12T03:35:08.165199Z","steps":["trace[1379297892] 'process raft request' (duration: 243.651509ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:08.467529Z","caller":"traceutil/trace.go:171","msg":"trace[965430955] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"289.085506ms","start":"2026-02-12T03:35:08.178423Z","end":"2026-02-12T03:35:08.467508Z","steps":["trace[965430955] 'process raft request' (duration: 236.536336ms)","trace[965430955] 'compare' (duration: 52.476259ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:08.532503Z","caller":"traceutil/trace.go:171","msg":"trace[532356135] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"203.712883ms","start":"2026-02-12T03:35:08.328775Z","end":"2026-02-12T03:35:08.532488Z","steps":["trace[532356135] 'process raft request' (duration: 203.680083ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:08.532929Z","caller":"traceutil/trace.go:171","msg":"trace[157113214] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"345.961438ms","start":"2026-02-12T03:35:08.186961Z","end":"2026-02-12T03:35:08.532923Z","steps":["trace[157113214] 'process raft request' (duration: 345.41334ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:08.533114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:08.186945Z","time spent":"346.001328ms","remote":"127.0.0.1:57768","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14311,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:35:08.772865Z","caller":"traceutil/trace.go:171","msg":"trace[468079649] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"296.693686ms","start":"2026-02-12T03:35:08.476158Z","end":"2026-02-12T03:35:08.772851Z","steps":["trace[468079649] 'process raft request' (duration: 296.663195ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:08.773231Z","caller":"traceutil/trace.go:171","msg":"trace[1039073596] transaction","detail":"{read_only:false; response_revision:697; number_of_response:1; }","duration":"301.552296ms","start":"2026-02-12T03:35:08.471674Z","end":"2026-02-12T03:35:08.773226Z","steps":["trace[1039073596] 'process raft request' (duration: 296.603664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:08.773395Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:08.471659Z","time spent":"301.589657ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3798,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:35:08.773416Z","caller":"traceutil/trace.go:171","msg":"trace[1845353978] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"300.568642ms","start":"2026-02-12T03:35:08.472841Z","end":"2026-02-12T03:35:08.773409Z","steps":["trace[1845353978] 'process raft request' (duration: 299.908322ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:08.7735Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:08.472835Z","time spent":"300.630212ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3834,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:35:08.773675Z","caller":"traceutil/trace.go:171","msg":"trace[1158912178] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"298.864957ms","start":"2026-02-12T03:35:08.474804Z","end":"2026-02-12T03:35:08.773669Z","steps":["trace[1158912178] 'process raft request' (duration: 297.964435ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:08.773115Z","caller":"traceutil/trace.go:171","msg":"trace[1695141483] transaction","detail":"{read_only:false; response_revision:698; number_of_response:1; }","duration":"300.775224ms","start":"2026-02-12T03:35:08.47233Z","end":"2026-02-12T03:35:08.773105Z","steps":["trace[1695141483] 'process raft request' (duration: 300.396469ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:08.776118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:08.472322Z","time spent":"303.765807ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2843,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:35:09.029813Z","caller":"traceutil/trace.go:171","msg":"trace[1163451407] linearizableReadLoop","detail":"{readStateIndex:726; appliedIndex:725; }","duration":"179.051544ms","start":"2026-02-12T03:35:08.850745Z","end":"2026-02-12T03:35:09.029797Z","steps":["trace[1163451407] 'read index received' (duration: 116.201258ms)","trace[1163451407] 'applied index is now lower than readState.Index' (duration: 62.849806ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:09.029883Z","caller":"traceutil/trace.go:171","msg":"trace[1540883543] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"179.323988ms","start":"2026-02-12T03:35:08.850554Z","end":"2026-02-12T03:35:09.029878Z","steps":["trace[1540883543] 'process raft request' (duration: 116.417342ms)","trace[1540883543] 'compare' (duration: 62.739864ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:09.030252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.49348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/local-path-provisioner-6f56467975-dpqv2\" ","response":"range_response_count:1 size:2858"} {"level":"info","ts":"2026-02-12T03:35:09.030283Z","caller":"traceutil/trace.go:171","msg":"trace[1263244398] range","detail":"{range_begin:/registry/pods/local-path-storage/local-path-provisioner-6f56467975-dpqv2; range_end:; response_count:1; response_revision:703; }","duration":"179.5343ms","start":"2026-02-12T03:35:08.850742Z","end":"2026-02-12T03:35:09.030276Z","steps":["trace[1263244398] 'agreement among raft nodes before linearized reading' (duration: 179.441949ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:09.320283Z","caller":"traceutil/trace.go:171","msg":"trace[101224674] transaction","detail":"{read_only:false; response_revision:706; number_of_response:1; }","duration":"187.414067ms","start":"2026-02-12T03:35:09.132849Z","end":"2026-02-12T03:35:09.320263Z","steps":["trace[101224674] 'process raft request' (duration: 187.274476ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:09.320643Z","caller":"traceutil/trace.go:171","msg":"trace[800859393] linearizableReadLoop","detail":"{readStateIndex:729; appliedIndex:729; }","duration":"187.661711ms","start":"2026-02-12T03:35:09.132971Z","end":"2026-02-12T03:35:09.320632Z","steps":["trace[800859393] 'read index received' (duration: 187.657741ms)","trace[800859393] 'applied index is now lower than readState.Index' (duration: 3.16µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:09.320831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.843833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-6rhn8\" ","response":"range_response_count:1 size:3849"} {"level":"info","ts":"2026-02-12T03:35:09.320868Z","caller":"traceutil/trace.go:171","msg":"trace[855608494] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-6rhn8; range_end:; response_count:1; response_revision:706; }","duration":"187.903665ms","start":"2026-02-12T03:35:09.132955Z","end":"2026-02-12T03:35:09.320859Z","steps":["trace[855608494] 'agreement among raft nodes before linearized reading' (duration: 187.744093ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:09.390401Z","caller":"traceutil/trace.go:171","msg":"trace[1643448328] transaction","detail":"{read_only:false; response_revision:707; number_of_response:1; }","duration":"257.021625ms","start":"2026-02-12T03:35:09.13336Z","end":"2026-02-12T03:35:09.390382Z","steps":["trace[1643448328] 'process raft request' (duration: 256.939244ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:09.390664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.115527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-02-12T03:35:09.390686Z","caller":"traceutil/trace.go:171","msg":"trace[2046327202] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:707; }","duration":"174.176667ms","start":"2026-02-12T03:35:09.216503Z","end":"2026-02-12T03:35:09.39068Z","steps":["trace[2046327202] 'agreement among raft nodes before linearized reading' (duration: 174.065865ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:09.717202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.30735ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:35:09.717276Z","caller":"traceutil/trace.go:171","msg":"trace[1370105488] transaction","detail":"{read_only:false; response_revision:708; number_of_response:1; }","duration":"387.203002ms","start":"2026-02-12T03:35:09.330058Z","end":"2026-02-12T03:35:09.717261Z","steps":["trace[1370105488] 'process raft request' (duration: 251.780611ms)","trace[1370105488] 'compare' (duration: 135.222149ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:09.717319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:09.330043Z","time spent":"387.256723ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4717,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:35:09.717512Z","caller":"traceutil/trace.go:171","msg":"trace[1613311311] linearizableReadLoop","detail":"{readStateIndex:733; appliedIndex:730; }","duration":"300.101833ms","start":"2026-02-12T03:35:09.417392Z","end":"2026-02-12T03:35:09.717494Z","steps":["trace[1613311311] 'read index received' (duration: 164.455138ms)","trace[1613311311] 'applied index is now lower than readState.Index' (duration: 135.646115ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:09.717632Z","caller":"traceutil/trace.go:171","msg":"trace[1359423717] transaction","detail":"{read_only:false; response_revision:709; number_of_response:1; }","duration":"323.223885ms","start":"2026-02-12T03:35:09.3944Z","end":"2026-02-12T03:35:09.717624Z","steps":["trace[1359423717] 'process raft request' (duration: 323.031042ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:09.717669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:09.394384Z","time spent":"323.262505ms","remote":"127.0.0.1:57602","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-02-12T03:35:09.717834Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.651777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-02-12T03:35:09.717893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.498459ms","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-02-12T03:35:09.717898Z","caller":"traceutil/trace.go:171","msg":"trace[1623160738] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:710; }","duration":"299.732188ms","start":"2026-02-12T03:35:09.418148Z","end":"2026-02-12T03:35:09.717881Z","steps":["trace[1623160738] 'agreement among raft nodes before linearized reading' (duration: 299.558126ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:09.717932Z","caller":"traceutil/trace.go:171","msg":"trace[8842087] transaction","detail":"{read_only:false; response_revision:710; number_of_response:1; }","duration":"323.176024ms","start":"2026-02-12T03:35:09.394752Z","end":"2026-02-12T03:35:09.717928Z","steps":["trace[8842087] 'process raft request' (duration: 322.718507ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:09.71796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:09.394746Z","time spent":"323.201184ms","remote":"127.0.0.1:57418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":719,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-12T03:35:09.717914Z","caller":"traceutil/trace.go:171","msg":"trace[640732927] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:710; }","duration":"300.53703ms","start":"2026-02-12T03:35:09.41737Z","end":"2026-02-12T03:35:09.717907Z","steps":["trace[640732927] 'agreement among raft nodes before linearized reading' (duration: 300.451398ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:09.718109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.298922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T03:35:09.718128Z","caller":"traceutil/trace.go:171","msg":"trace[558100165] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:710; }","duration":"230.340323ms","start":"2026-02-12T03:35:09.487782Z","end":"2026-02-12T03:35:09.718122Z","steps":["trace[558100165] 'agreement among raft nodes before linearized reading' (duration: 230.306702ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:09.718134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:09.417359Z","time spent":"300.754772ms","remote":"127.0.0.1:57602","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":"warn","ts":"2026-02-12T03:35:09.718253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.259176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-02-12T03:35:09.71827Z","caller":"traceutil/trace.go:171","msg":"trace[165856183] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:710; }","duration":"215.300448ms","start":"2026-02-12T03:35:09.502965Z","end":"2026-02-12T03:35:09.718265Z","steps":["trace[165856183] 'agreement among raft nodes before linearized reading' (duration: 215.246457ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:09.901342Z","caller":"traceutil/trace.go:171","msg":"trace[1565358175] linearizableReadLoop","detail":"{readStateIndex:734; appliedIndex:733; }","duration":"174.104916ms","start":"2026-02-12T03:35:09.727208Z","end":"2026-02-12T03:35:09.901313Z","steps":["trace[1565358175] 'read index received' (duration: 150.162662ms)","trace[1565358175] 'applied index is now lower than readState.Index' (duration: 23.941214ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:09.901494Z","caller":"traceutil/trace.go:171","msg":"trace[1476565667] transaction","detail":"{read_only:false; response_revision:711; number_of_response:1; }","duration":"174.448333ms","start":"2026-02-12T03:35:09.727039Z","end":"2026-02-12T03:35:09.901488Z","steps":["trace[1476565667] 'process raft request' (duration: 150.376427ms)","trace[1476565667] 'compare' (duration: 23.67457ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:09.901677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.457492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-77cccfdc44-dq6ks\" ","response":"range_response_count:1 size:3849"} {"level":"info","ts":"2026-02-12T03:35:09.901699Z","caller":"traceutil/trace.go:171","msg":"trace[21925335] range","detail":"{range_begin:/registry/pods/kube-system/coredns-77cccfdc44-dq6ks; range_end:; response_count:1; response_revision:711; }","duration":"174.490622ms","start":"2026-02-12T03:35:09.727204Z","end":"2026-02-12T03:35:09.901694Z","steps":["trace[21925335] 'agreement among raft nodes before linearized reading' (duration: 174.404601ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:09.91127Z","caller":"traceutil/trace.go:171","msg":"trace[236769] transaction","detail":"{read_only:false; response_revision:713; number_of_response:1; }","duration":"180.898203ms","start":"2026-02-12T03:35:09.730361Z","end":"2026-02-12T03:35:09.911259Z","steps":["trace[236769] 'process raft request' (duration: 180.874503ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:09.911502Z","caller":"traceutil/trace.go:171","msg":"trace[1869639247] transaction","detail":"{read_only:false; response_revision:712; number_of_response:1; }","duration":"183.144187ms","start":"2026-02-12T03:35:09.728352Z","end":"2026-02-12T03:35:09.911496Z","steps":["trace[1869639247] 'process raft request' (duration: 182.806562ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:09.911482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.561996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:35:09.911619Z","caller":"traceutil/trace.go:171","msg":"trace[2105313535] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:713; }","duration":"101.732119ms","start":"2026-02-12T03:35:09.809869Z","end":"2026-02-12T03:35:09.911601Z","steps":["trace[2105313535] 'agreement among raft nodes before linearized reading' (duration: 101.526226ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:10.254092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.238417ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:35:10.254217Z","caller":"traceutil/trace.go:171","msg":"trace[1487641992] transaction","detail":"{read_only:false; response_revision:715; number_of_response:1; }","duration":"208.341547ms","start":"2026-02-12T03:35:10.045865Z","end":"2026-02-12T03:35:10.254207Z","steps":["trace[1487641992] 'process raft request' (duration: 208.287776ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:10.254421Z","caller":"traceutil/trace.go:171","msg":"trace[1904519809] transaction","detail":"{read_only:false; response_revision:714; number_of_response:1; }","duration":"346.926909ms","start":"2026-02-12T03:35:09.907489Z","end":"2026-02-12T03:35:10.254416Z","steps":["trace[1904519809] 'process raft request' (duration: 166.317047ms)","trace[1904519809] 'compare' (duration: 180.177776ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:10.254486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:09.907476Z","time spent":"346.98923ms","remote":"127.0.0.1:57508","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4717,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:35:10.254571Z","caller":"traceutil/trace.go:171","msg":"trace[1747291973] linearizableReadLoop","detail":"{readStateIndex:737; appliedIndex:736; }","duration":"341.080556ms","start":"2026-02-12T03:35:09.913484Z","end":"2026-02-12T03:35:10.254564Z","steps":["trace[1747291973] 'read index received' (duration: 160.338962ms)","trace[1747291973] 'applied index is now lower than readState.Index' (duration: 180.740984ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:10.254602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.118126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:35:10.254613Z","caller":"traceutil/trace.go:171","msg":"trace[385174840] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:715; }","duration":"341.148626ms","start":"2026-02-12T03:35:09.91346Z","end":"2026-02-12T03:35:10.254609Z","steps":["trace[385174840] 'agreement among raft nodes before linearized reading' (duration: 341.127246ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:10.254625Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:09.913452Z","time spent":"341.170847ms","remote":"127.0.0.1:41808","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-12T03:35:10.300874Z","caller":"traceutil/trace.go:171","msg":"trace[332256345] transaction","detail":"{read_only:false; response_revision:716; number_of_response:1; }","duration":"147.834404ms","start":"2026-02-12T03:35:10.153024Z","end":"2026-02-12T03:35:10.300859Z","steps":["trace[332256345] 'process raft request' (duration: 147.741533ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:16.132172Z","caller":"traceutil/trace.go:171","msg":"trace[662024794] transaction","detail":"{read_only:false; response_revision:780; number_of_response:1; }","duration":"124.206354ms","start":"2026-02-12T03:35:16.007943Z","end":"2026-02-12T03:35:16.132149Z","steps":["trace[662024794] 'process raft request' (duration: 124.054532ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:16.162476Z","caller":"traceutil/trace.go:171","msg":"trace[596101146] transaction","detail":"{read_only:false; response_revision:782; number_of_response:1; }","duration":"148.940032ms","start":"2026-02-12T03:35:16.013519Z","end":"2026-02-12T03:35:16.162459Z","steps":["trace[596101146] 'process raft request' (duration: 148.884451ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:16.163102Z","caller":"traceutil/trace.go:171","msg":"trace[1961184853] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"149.641131ms","start":"2026-02-12T03:35:16.013446Z","end":"2026-02-12T03:35:16.163087Z","steps":["trace[1961184853] 'process raft request' (duration: 142.334901ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:18.320281Z","caller":"traceutil/trace.go:171","msg":"trace[991613890] linearizableReadLoop","detail":"{readStateIndex:811; appliedIndex:810; }","duration":"153.106611ms","start":"2026-02-12T03:35:18.167159Z","end":"2026-02-12T03:35:18.320266Z","steps":["trace[991613890] 'read index received' (duration: 152.944229ms)","trace[991613890] 'applied index is now lower than readState.Index' (duration: 161.772µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:18.320347Z","caller":"traceutil/trace.go:171","msg":"trace[1871985207] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"179.162952ms","start":"2026-02-12T03:35:18.141179Z","end":"2026-02-12T03:35:18.320342Z","steps":["trace[1871985207] 'process raft request' (duration: 178.96495ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:18.320483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.312214ms","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-02-12T03:35:18.3205Z","caller":"traceutil/trace.go:171","msg":"trace[349094945] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:786; }","duration":"153.356454ms","start":"2026-02-12T03:35:18.167137Z","end":"2026-02-12T03:35:18.320494Z","steps":["trace[349094945] 'agreement among raft nodes before linearized reading' (duration: 153.283003ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:18.320559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.441452ms","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-02-12T03:35:18.320569Z","caller":"traceutil/trace.go:171","msg":"trace[1500280395] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:786; }","duration":"152.489602ms","start":"2026-02-12T03:35:18.168076Z","end":"2026-02-12T03:35:18.320566Z","steps":["trace[1500280395] 'agreement among raft nodes before linearized reading' (duration: 152.456882ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:18.497929Z","caller":"traceutil/trace.go:171","msg":"trace[1660184209] linearizableReadLoop","detail":"{readStateIndex:813; appliedIndex:811; }","duration":"116.042582ms","start":"2026-02-12T03:35:18.381866Z","end":"2026-02-12T03:35:18.497908Z","steps":["trace[1660184209] 'read index received' (duration: 16.650954ms)","trace[1660184209] 'applied index is now lower than readState.Index' (duration: 99.390708ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:18.498046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.160083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/kubeadm-config\" ","response":"range_response_count:1 size:999"} {"level":"info","ts":"2026-02-12T03:35:18.498099Z","caller":"traceutil/trace.go:171","msg":"trace[1344408226] range","detail":"{range_begin:/registry/configmaps/kube-system/kubeadm-config; range_end:; response_count:1; response_revision:788; }","duration":"116.249474ms","start":"2026-02-12T03:35:18.38184Z","end":"2026-02-12T03:35:18.49809Z","steps":["trace[1344408226] 'agreement among raft nodes before linearized reading' (duration: 116.150123ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:18.498184Z","caller":"traceutil/trace.go:171","msg":"trace[1650750229] transaction","detail":"{read_only:false; response_revision:787; number_of_response:1; }","duration":"171.916625ms","start":"2026-02-12T03:35:18.32624Z","end":"2026-02-12T03:35:18.498156Z","steps":["trace[1650750229] 'process raft request' (duration: 72.268573ms)","trace[1650750229] 'compare' (duration: 99.233155ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:18.498375Z","caller":"traceutil/trace.go:171","msg":"trace[1387312512] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"171.899485ms","start":"2026-02-12T03:35:18.326463Z","end":"2026-02-12T03:35:18.498363Z","steps":["trace[1387312512] 'process raft request' (duration: 171.408037ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:19.916365Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14782674693927861090,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-12T03:35:19.917215Z","caller":"traceutil/trace.go:171","msg":"trace[1891295930] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:814; }","duration":"501.033699ms","start":"2026-02-12T03:35:19.416154Z","end":"2026-02-12T03:35:19.917188Z","steps":["trace[1891295930] 'read index received' (duration: 500.808156ms)","trace[1891295930] 'applied index is now lower than readState.Index' (duration: 224.603µs)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:19.9173Z","caller":"traceutil/trace.go:171","msg":"trace[74795386] transaction","detail":"{read_only:false; response_revision:790; number_of_response:1; }","duration":"538.348687ms","start":"2026-02-12T03:35:19.378941Z","end":"2026-02-12T03:35:19.91729Z","steps":["trace[74795386] 'process raft request' (duration: 538.091764ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:19.917419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:19.37892Z","time spent":"538.411528ms","remote":"127.0.0.1:57418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":817,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-12T03:35:19.917931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.764279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-02-12T03:35:19.917966Z","caller":"traceutil/trace.go:171","msg":"trace[986117957] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:790; }","duration":"501.833549ms","start":"2026-02-12T03:35:19.416121Z","end":"2026-02-12T03:35:19.917955Z","steps":["trace[986117957] 'agreement among raft nodes before linearized reading' (duration: 501.653107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:19.917996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:19.416107Z","time spent":"501.88278ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-12T03:35:19.918437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.068161ms","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-02-12T03:35:19.91855Z","caller":"traceutil/trace.go:171","msg":"trace[816473883] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:790; }","duration":"137.208425ms","start":"2026-02-12T03:35:19.781329Z","end":"2026-02-12T03:35:19.918538Z","steps":["trace[816473883] 'agreement among raft nodes before linearized reading' (duration: 137.029761ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:19.918793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.089986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:35:19.918895Z","caller":"traceutil/trace.go:171","msg":"trace[1453032583] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:790; }","duration":"111.212537ms","start":"2026-02-12T03:35:19.807673Z","end":"2026-02-12T03:35:19.918886Z","steps":["trace[1453032583] 'agreement among raft nodes before linearized reading' (duration: 111.084746ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:26.315361Z","caller":"traceutil/trace.go:171","msg":"trace[1235391595] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"210.763772ms","start":"2026-02-12T03:35:26.104578Z","end":"2026-02-12T03:35:26.315342Z","steps":["trace[1235391595] 'process raft request' (duration: 136.801338ms)","trace[1235391595] 'compare' (duration: 73.897944ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:34.503522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.051486ms","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-02-12T03:35:34.503572Z","caller":"traceutil/trace.go:171","msg":"trace[1805703633] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:835; }","duration":"150.133018ms","start":"2026-02-12T03:35:34.353426Z","end":"2026-02-12T03:35:34.503559Z","steps":["trace[1805703633] 'range keys from in-memory index tree' (duration: 149.914695ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:34.660532Z","caller":"traceutil/trace.go:171","msg":"trace[469704432] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"150.487092ms","start":"2026-02-12T03:35:34.510027Z","end":"2026-02-12T03:35:34.660515Z","steps":["trace[469704432] 'process raft request' (duration: 94.621532ms)","trace[469704432] 'compare' (duration: 55.432555ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:36.404347Z","caller":"traceutil/trace.go:171","msg":"trace[1236845294] transaction","detail":"{read_only:false; response_revision:840; number_of_response:1; }","duration":"141.930177ms","start":"2026-02-12T03:35:36.262394Z","end":"2026-02-12T03:35:36.404324Z","steps":["trace[1236845294] 'process raft request' (duration: 141.748525ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:36.705579Z","caller":"traceutil/trace.go:171","msg":"trace[998496471] transaction","detail":"{read_only:false; response_revision:841; number_of_response:1; }","duration":"112.443913ms","start":"2026-02-12T03:35:36.593118Z","end":"2026-02-12T03:35:36.705562Z","steps":["trace[998496471] 'process raft request' (duration: 112.326022ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:37.294519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.016675ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:35:37.295408Z","caller":"traceutil/trace.go:171","msg":"trace[971316460] linearizableReadLoop","detail":"{readStateIndex:872; appliedIndex:870; }","duration":"474.020315ms","start":"2026-02-12T03:35:36.821371Z","end":"2026-02-12T03:35:37.295391Z","steps":["trace[971316460] 'read index received' (duration: 107.031648ms)","trace[971316460] 'applied index is now lower than readState.Index' (duration: 366.987757ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:35:37.295755Z","caller":"traceutil/trace.go:171","msg":"trace[916087562] transaction","detail":"{read_only:false; response_revision:843; number_of_response:1; }","duration":"583.708405ms","start":"2026-02-12T03:35:36.712033Z","end":"2026-02-12T03:35:37.295742Z","steps":["trace[916087562] 'process raft request' (duration: 216.409514ms)","trace[916087562] 'compare' (duration: 365.741932ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:37.296466Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:36.712026Z","time spent":"583.769656ms","remote":"127.0.0.1:57602","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-02-12T03:35:37.296871Z","caller":"traceutil/trace.go:171","msg":"trace[1735207832] transaction","detail":"{read_only:false; response_revision:844; number_of_response:1; }","duration":"583.200088ms","start":"2026-02-12T03:35:36.713657Z","end":"2026-02-12T03:35:37.296857Z","steps":["trace[1735207832] 'process raft request' (duration: 580.939511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:37.297032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:36.713648Z","time spent":"583.262598ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-12T03:35:37.297363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"475.984068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:35:37.297408Z","caller":"traceutil/trace.go:171","msg":"trace[1058802167] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:844; }","duration":"476.047609ms","start":"2026-02-12T03:35:36.821347Z","end":"2026-02-12T03:35:37.297394Z","steps":["trace[1058802167] 'agreement among raft nodes before linearized reading' (duration: 475.983288ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:37.297518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:36.821333Z","time spent":"476.17544ms","remote":"127.0.0.1:41798","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-02-12T03:35:37.297975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.959723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:35:37.298014Z","caller":"traceutil/trace.go:171","msg":"trace[985874547] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:844; }","duration":"459.028004ms","start":"2026-02-12T03:35:36.838979Z","end":"2026-02-12T03:35:37.298007Z","steps":["trace[985874547] 'agreement among raft nodes before linearized reading' (duration: 458.964042ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:35:37.298037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:36.838952Z","time spent":"459.079285ms","remote":"127.0.0.1:57628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true "} {"level":"info","ts":"2026-02-12T03:35:51.379642Z","caller":"traceutil/trace.go:171","msg":"trace[1138542019] transaction","detail":"{read_only:false; response_revision:883; number_of_response:1; }","duration":"513.445766ms","start":"2026-02-12T03:35:50.866169Z","end":"2026-02-12T03:35:51.379615Z","steps":["trace[1138542019] 'process raft request' (duration: 467.548896ms)","trace[1138542019] 'compare' (duration: 45.809709ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:35:51.379774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:35:50.866157Z","time spent":"513.550307ms","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-12T03:35:51.616526Z","caller":"traceutil/trace.go:171","msg":"trace[410936658] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"225.358926ms","start":"2026-02-12T03:35:51.39115Z","end":"2026-02-12T03:35:51.616509Z","steps":["trace[410936658] 'process raft request' (duration: 225.325446ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:35:51.616771Z","caller":"traceutil/trace.go:171","msg":"trace[2935737] transaction","detail":"{read_only:false; response_revision:884; number_of_response:1; }","duration":"225.76347ms","start":"2026-02-12T03:35:51.390975Z","end":"2026-02-12T03:35:51.616738Z","steps":["trace[2935737] 'process raft request' (duration: 172.944443ms)","trace[2935737] 'compare' (duration: 52.456774ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:36:09.875983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.390761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-02-12T03:36:09.876296Z","caller":"traceutil/trace.go:171","msg":"trace[903794613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:945; }","duration":"100.743115ms","start":"2026-02-12T03:36:09.775541Z","end":"2026-02-12T03:36:09.876284Z","steps":["trace[903794613] 'range keys from in-memory index tree' (duration: 100.29166ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:36:16.981414Z","caller":"traceutil/trace.go:171","msg":"trace[138615823] linearizableReadLoop","detail":"{readStateIndex:1022; appliedIndex:1021; }","duration":"158.219941ms","start":"2026-02-12T03:36:16.823173Z","end":"2026-02-12T03:36:16.981393Z","steps":["trace[138615823] 'read index received' (duration: 158.03255ms)","trace[138615823] 'applied index is now lower than readState.Index' (duration: 186.451µs)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:36:16.981714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.521954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:36:16.981803Z","caller":"traceutil/trace.go:171","msg":"trace[302602132] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:985; }","duration":"158.659897ms","start":"2026-02-12T03:36:16.823133Z","end":"2026-02-12T03:36:16.981793Z","steps":["trace[302602132] 'agreement among raft nodes before linearized reading' (duration: 158.510995ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:36:16.98209Z","caller":"traceutil/trace.go:171","msg":"trace[1958861218] transaction","detail":"{read_only:false; response_revision:985; number_of_response:1; }","duration":"292.030941ms","start":"2026-02-12T03:36:16.690048Z","end":"2026-02-12T03:36:16.982079Z","steps":["trace[1958861218] 'process raft request' (duration: 291.206542ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:25.458784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.721451ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-12T03:36:25.459849Z","caller":"traceutil/trace.go:171","msg":"trace[1129292902] transaction","detail":"{read_only:false; response_revision:1015; number_of_response:1; }","duration":"421.625258ms","start":"2026-02-12T03:36:25.038172Z","end":"2026-02-12T03:36:25.459797Z","steps":["trace[1129292902] 'process raft request' (duration: 301.820906ms)","trace[1129292902] 'compare' (duration: 118.60785ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:36:25.460169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:36:25.038158Z","time spent":"421.85275ms","remote":"127.0.0.1:57602","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-02-12T03:36:26.881229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.777834ms","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-02-12T03:36:26.881292Z","caller":"traceutil/trace.go:171","msg":"trace[1595779742] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1015; }","duration":"838.889735ms","start":"2026-02-12T03:36:26.042387Z","end":"2026-02-12T03:36:26.881277Z","steps":["trace[1595779742] 'range keys from in-memory index tree' (duration: 838.599782ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:26.881325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:36:26.042367Z","time spent":"838.951235ms","remote":"127.0.0.1:57602","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-02-12T03:36:26.881711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.132134207s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-02-12T03:36:26.881739Z","caller":"traceutil/trace.go:171","msg":"trace[600178944] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1015; }","duration":"1.132202958s","start":"2026-02-12T03:36:25.74953Z","end":"2026-02-12T03:36:26.881733Z","steps":["trace[600178944] 'range keys from in-memory index tree' (duration: 1.131997525s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:26.881757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:36:25.749509Z","time spent":"1.132243528s","remote":"127.0.0.1:57602","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-02-12T03:36:26.881863Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.072124045s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:36:26.881884Z","caller":"traceutil/trace.go:171","msg":"trace[761218780] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1015; }","duration":"1.072178625s","start":"2026-02-12T03:36:25.809701Z","end":"2026-02-12T03:36:26.881879Z","steps":["trace[761218780] 'range keys from in-memory index tree' (duration: 1.072030194s)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:26.8819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:36:25.809655Z","time spent":"1.072241096s","remote":"127.0.0.1:41798","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-02-12T03:36:26.881668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"837.3892ms","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-02-12T03:36:26.882185Z","caller":"traceutil/trace.go:171","msg":"trace[1437538638] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1015; }","duration":"838.2788ms","start":"2026-02-12T03:36:26.043853Z","end":"2026-02-12T03:36:26.882131Z","steps":["trace[1437538638] 'range keys from in-memory index tree' (duration: 837.25885ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:26.882362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:36:26.043842Z","time spent":"838.503612ms","remote":"127.0.0.1:57602","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-02-12T03:36:26.882572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.609564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-12T03:36:26.882602Z","caller":"traceutil/trace.go:171","msg":"trace[2003443346] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1015; }","duration":"450.678504ms","start":"2026-02-12T03:36:26.431917Z","end":"2026-02-12T03:36:26.882595Z","steps":["trace[2003443346] 'count revisions from in-memory index tree' (duration: 450.545662ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:26.882621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:36:26.431894Z","time spent":"450.721565ms","remote":"127.0.0.1:57674","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":2,"response size":30,"request content":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true "} {"level":"info","ts":"2026-02-12T03:36:27.086695Z","caller":"traceutil/trace.go:171","msg":"trace[816866791] transaction","detail":"{read_only:false; response_revision:1017; number_of_response:1; }","duration":"196.377385ms","start":"2026-02-12T03:36:26.890291Z","end":"2026-02-12T03:36:27.086669Z","steps":["trace[816866791] 'process raft request' (duration: 104.836663ms)","trace[816866791] 'compare' (duration: 91.095608ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:36:27.086839Z","caller":"traceutil/trace.go:171","msg":"trace[1874591565] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"193.759029ms","start":"2026-02-12T03:36:26.893059Z","end":"2026-02-12T03:36:27.086818Z","steps":["trace[1874591565] 'process raft request' (duration: 193.338165ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:33.191838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.975268ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-12T03:36:33.192212Z","caller":"traceutil/trace.go:171","msg":"trace[44340336] linearizableReadLoop","detail":"{readStateIndex:1077; appliedIndex:1076; }","duration":"397.367728ms","start":"2026-02-12T03:36:32.794832Z","end":"2026-02-12T03:36:33.1922Z","steps":["trace[44340336] 'read index received' (duration: 24.921µs)","trace[44340336] 'applied index is now lower than readState.Index' (duration: 397.341767ms)"],"step_count":2} {"level":"warn","ts":"2026-02-12T03:36:33.192399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.400829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/local-path-provisioner\" ","response":"range_response_count:1 size:1106"} {"level":"info","ts":"2026-02-12T03:36:33.192419Z","caller":"traceutil/trace.go:171","msg":"trace[426716269] range","detail":"{range_begin:/registry/clusterroles/local-path-provisioner; range_end:; response_count:1; response_revision:1037; }","duration":"391.436001ms","start":"2026-02-12T03:36:32.800976Z","end":"2026-02-12T03:36:33.192412Z","steps":["trace[426716269] 'agreement among raft nodes before linearized reading' (duration: 391.33809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:33.192437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:36:32.800969Z","time spent":"391.463241ms","remote":"127.0.0.1:57664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":1129,"request content":"key:\"/registry/clusterroles/local-path-provisioner\" "} {"level":"warn","ts":"2026-02-12T03:36:33.192558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.724811ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:1 size:840"} {"level":"info","ts":"2026-02-12T03:36:33.19259Z","caller":"traceutil/trace.go:171","msg":"trace[427968556] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:1; response_revision:1036; }","duration":"397.778861ms","start":"2026-02-12T03:36:32.794806Z","end":"2026-02-12T03:36:33.192585Z","steps":["trace[427968556] 'agreement among raft nodes before linearized reading' (duration: 397.453358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:33.192618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:36:32.794793Z","time spent":"397.809031ms","remote":"127.0.0.1:57664","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":1,"response size":863,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"info","ts":"2026-02-12T03:36:33.19277Z","caller":"traceutil/trace.go:171","msg":"trace[301178868] transaction","detail":"{read_only:false; response_revision:1037; number_of_response:1; }","duration":"292.746765ms","start":"2026-02-12T03:36:32.900014Z","end":"2026-02-12T03:36:33.192761Z","steps":["trace[301178868] 'process raft request' (duration: 291.897367ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:33.19284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.176286ms","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-02-12T03:36:33.192861Z","caller":"traceutil/trace.go:171","msg":"trace[755823490] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1037; }","duration":"202.255767ms","start":"2026-02-12T03:36:32.990599Z","end":"2026-02-12T03:36:33.192855Z","steps":["trace[755823490] 'agreement among raft nodes before linearized reading' (duration: 202.200266ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:33.192923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.339462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-12T03:36:33.192955Z","caller":"traceutil/trace.go:171","msg":"trace[738563989] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1037; }","duration":"385.386493ms","start":"2026-02-12T03:36:32.807563Z","end":"2026-02-12T03:36:33.192949Z","steps":["trace[738563989] 'agreement among raft nodes before linearized reading' (duration: 385.346502ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:33.192974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-12T03:36:32.807557Z","time spent":"385.412544ms","remote":"127.0.0.1:41798","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-12T03:36:37.440271Z","caller":"traceutil/trace.go:171","msg":"trace[304743816] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"131.891192ms","start":"2026-02-12T03:36:37.30836Z","end":"2026-02-12T03:36:37.440251Z","steps":["trace[304743816] 'process raft request' (duration: 128.794223ms)"],"step_count":1} {"level":"info","ts":"2026-02-12T03:36:37.440418Z","caller":"traceutil/trace.go:171","msg":"trace[1520786] linearizableReadLoop","detail":"{readStateIndex:1092; appliedIndex:1090; }","duration":"117.778011ms","start":"2026-02-12T03:36:37.322631Z","end":"2026-02-12T03:36:37.440409Z","steps":["trace[1520786] 'read index received' (duration: 114.443759ms)","trace[1520786] 'applied index is now lower than readState.Index' (duration: 3.333602ms)"],"step_count":2} {"level":"info","ts":"2026-02-12T03:36:37.440515Z","caller":"traceutil/trace.go:171","msg":"trace[611643574] transaction","detail":"{read_only:false; response_revision:1051; number_of_response:1; }","duration":"132.092494ms","start":"2026-02-12T03:36:37.308415Z","end":"2026-02-12T03:36:37.440507Z","steps":["trace[611643574] 'process raft request' (duration: 131.808292ms)"],"step_count":1} {"level":"warn","ts":"2026-02-12T03:36:37.440626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.985682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.62\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-12T03:36:37.440646Z","caller":"traceutil/trace.go:171","msg":"trace[1740703861] range","detail":"{range_begin:/registry/masterleases/162.253.55.62; range_end:; response_count:1; response_revision:1051; }","duration":"118.040574ms","start":"2026-02-12T03:36:37.322598Z","end":"2026-02-12T03:36:37.440639Z","steps":["trace[1740703861] 'agreement among raft nodes before linearized reading' (duration: 117.959283ms)"],"step_count":1}