{"level":"warn","ts":"2026-02-19T02:21:52.535175Z","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-19T02:21:52.535267Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.70:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.70:2380","--initial-cluster=instance=https://199.204.45.70:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.70:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.70: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-19T02:21:52.535335Z","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-19T02:21:52.535351Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-02-19T02:21:52.535371Z","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-19T02:21:52.536Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"]} {"level":"info","ts":"2026-02-19T02:21:52.53609Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.70: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-19T02:21:52.651157Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"89.154633ms"} {"level":"info","ts":"2026-02-19T02:21:52.829569Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"f8844a9a4263041d","cluster-id":"4749b7c221ae0648"} {"level":"info","ts":"2026-02-19T02:21:52.829724Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=()"} {"level":"info","ts":"2026-02-19T02:21:52.829776Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 0"} {"level":"info","ts":"2026-02-19T02:21:52.829885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft f8844a9a4263041d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-19T02:21:52.829988Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became follower at term 1"} {"level":"info","ts":"2026-02-19T02:21:52.830185Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"warn","ts":"2026-02-19T02:21:53.166214Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-19T02:21:53.245967Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-19T02:21:53.333553Z","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-19T02:21:53.361699Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"f8844a9a4263041d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-19T02:21:53.361917Z","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-19T02:21:53.362016Z","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-19T02:21:53.362043Z","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-19T02:21:53.363536Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"f8844a9a4263041d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-19T02:21:53.366879Z","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-19T02:21:53.366957Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-02-19T02:21:53.367072Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"f8844a9a4263041d","initial-advertise-peer-urls":["https://199.204.45.70:2380"],"listen-peer-urls":["https://199.204.45.70:2380"],"advertise-client-urls":["https://199.204.45.70:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.70:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-19T02:21:53.367126Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-19T02:21:53.366992Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.70:2380"} {"level":"info","ts":"2026-02-19T02:21:53.419312Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d switched to configuration voters=(17907520044731139101)"} {"level":"info","ts":"2026-02-19T02:21:53.419444Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","added-peer-id":"f8844a9a4263041d","added-peer-peer-urls":["https://199.204.45.70:2380"]} {"level":"info","ts":"2026-02-19T02:21:53.532144Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d is starting a new election at term 1"} {"level":"info","ts":"2026-02-19T02:21:53.532191Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became pre-candidate at term 1"} {"level":"info","ts":"2026-02-19T02:21:53.532234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgPreVoteResp from f8844a9a4263041d at term 1"} {"level":"info","ts":"2026-02-19T02:21:53.532249Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became candidate at term 2"} {"level":"info","ts":"2026-02-19T02:21:53.532256Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d received MsgVoteResp from f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-02-19T02:21:53.532267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"f8844a9a4263041d became leader at term 2"} {"level":"info","ts":"2026-02-19T02:21:53.532279Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: f8844a9a4263041d elected leader f8844a9a4263041d at term 2"} {"level":"info","ts":"2026-02-19T02:21:53.571631Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"f8844a9a4263041d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.70:2379]}","request-path":"/0/members/f8844a9a4263041d/attributes","cluster-id":"4749b7c221ae0648","publish-timeout":"7s"} {"level":"info","ts":"2026-02-19T02:21:53.571876Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T02:21:53.571876Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-19T02:21:53.572171Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:21:53.572551Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-19T02:21:53.572616Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-19T02:21:53.574635Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-19T02:21:53.574735Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.70:2379"} {"level":"info","ts":"2026-02-19T02:21:53.612642Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"4749b7c221ae0648","local-member-id":"f8844a9a4263041d","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:21:53.612848Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:21:53.612886Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-02-19T02:21:56.543885Z","caller":"traceutil/trace.go:171","msg":"trace[1077702202] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"306.816405ms","start":"2026-02-19T02:21:56.237036Z","end":"2026-02-19T02:21:56.543852Z","steps":["trace[1077702202] 'process raft request' (duration: 306.485844ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:21:56.544014Z","caller":"traceutil/trace.go:171","msg":"trace[1397616492] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"302.209036ms","start":"2026-02-19T02:21:56.241516Z","end":"2026-02-19T02:21:56.543725Z","steps":["trace[1397616492] 'read index received' (duration: 301.887005ms)","trace[1397616492] 'applied index is now lower than readState.Index' (duration: 320.771µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:21:56.544204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.607007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T02:21:56.54428Z","caller":"traceutil/trace.go:171","msg":"trace[320167023] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:72; }","duration":"302.715747ms","start":"2026-02-19T02:21:56.241549Z","end":"2026-02-19T02:21:56.544265Z","steps":["trace[320167023] 'agreement among raft nodes before linearized reading' (duration: 302.539916ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:21:56.544318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:21:56.241536Z","time spent":"302.773467ms","remote":"127.0.0.1:59492","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-edit\" "} {"level":"warn","ts":"2026-02-19T02:21:56.54451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.995187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-19T02:21:56.544695Z","caller":"traceutil/trace.go:171","msg":"trace[1621046625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:72; }","duration":"303.226748ms","start":"2026-02-19T02:21:56.241446Z","end":"2026-02-19T02:21:56.544673Z","steps":["trace[1621046625] 'agreement among raft nodes before linearized reading' (duration: 302.512936ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:21:56.544872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:21:56.241422Z","time spent":"303.431718ms","remote":"127.0.0.1:59172","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-02-19T02:21:56.54609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:21:56.237019Z","time spent":"307.038035ms","remote":"127.0.0.1:59512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T02:22:01.118354Z","caller":"traceutil/trace.go:171","msg":"trace[1907557003] transaction","detail":"{read_only:false; response_revision:322; number_of_response:1; }","duration":"209.720633ms","start":"2026-02-19T02:22:00.908602Z","end":"2026-02-19T02:22:01.118323Z","steps":["trace[1907557003] 'process raft request' (duration: 208.915056ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:02.25908Z","caller":"traceutil/trace.go:171","msg":"trace[1948222817] transaction","detail":"{read_only:false; response_revision:329; number_of_response:1; }","duration":"564.461054ms","start":"2026-02-19T02:22:01.694578Z","end":"2026-02-19T02:22:02.259039Z","steps":["trace[1948222817] 'process raft request' (duration: 527.044511ms)","trace[1948222817] 'compare' (duration: 37.150471ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:02.259506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:01.694549Z","time spent":"564.643895ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:22:02.269723Z","caller":"traceutil/trace.go:171","msg":"trace[827604361] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"560.747846ms","start":"2026-02-19T02:22:01.708944Z","end":"2026-02-19T02:22:02.269692Z","steps":["trace[827604361] 'process raft request' (duration: 560.600934ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:02.269902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:01.708912Z","time spent":"560.915567ms","remote":"127.0.0.1:59356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":192,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T02:22:02.53333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.549145ms","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-19T02:22:02.533432Z","caller":"traceutil/trace.go:171","msg":"trace[1115272335] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:333; }","duration":"173.688826ms","start":"2026-02-19T02:22:02.359721Z","end":"2026-02-19T02:22:02.53341Z","steps":["trace[1115272335] 'range keys from in-memory index tree' (duration: 173.462874ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:03.564409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.291234ms","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-19T02:22:03.564705Z","caller":"traceutil/trace.go:171","msg":"trace[1110522424] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:341; }","duration":"104.584716ms","start":"2026-02-19T02:22:03.460036Z","end":"2026-02-19T02:22:03.564621Z","steps":["trace[1110522424] 'range keys from in-memory index tree' (duration: 104.179792ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:04.042319Z","caller":"traceutil/trace.go:171","msg":"trace[2011623436] linearizableReadLoop","detail":"{readStateIndex:355; appliedIndex:354; }","duration":"183.396546ms","start":"2026-02-19T02:22:03.858895Z","end":"2026-02-19T02:22:04.042292Z","steps":["trace[2011623436] 'read index received' (duration: 183.198444ms)","trace[2011623436] 'applied index is now lower than readState.Index' (duration: 196.932µs)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:04.042544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.633239ms","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-19T02:22:04.04246Z","caller":"traceutil/trace.go:171","msg":"trace[566610081] transaction","detail":"{read_only:false; response_revision:342; number_of_response:1; }","duration":"224.016987ms","start":"2026-02-19T02:22:03.818404Z","end":"2026-02-19T02:22:04.042421Z","steps":["trace[566610081] 'process raft request' (duration: 223.751804ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:04.042601Z","caller":"traceutil/trace.go:171","msg":"trace[1557366117] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:342; }","duration":"183.821961ms","start":"2026-02-19T02:22:03.858766Z","end":"2026-02-19T02:22:04.042588Z","steps":["trace[1557366117] 'agreement among raft nodes before linearized reading' (duration: 183.68063ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:04.042626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.935927ms","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-19T02:22:04.042757Z","caller":"traceutil/trace.go:171","msg":"trace[1026384908] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:342; }","duration":"179.073779ms","start":"2026-02-19T02:22:03.863658Z","end":"2026-02-19T02:22:04.042732Z","steps":["trace[1026384908] 'agreement among raft nodes before linearized reading' (duration: 178.894687ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:04.042814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.203239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-nh9ipg\" ","response":"range_response_count:1 size:540"} {"level":"info","ts":"2026-02-19T02:22:04.042846Z","caller":"traceutil/trace.go:171","msg":"trace[1486830571] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-nh9ipg; range_end:; response_count:1; response_revision:342; }","duration":"142.276169ms","start":"2026-02-19T02:22:03.90056Z","end":"2026-02-19T02:22:04.042836Z","steps":["trace[1486830571] 'agreement among raft nodes before linearized reading' (duration: 142.197068ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:04.042835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.447661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:1 size:536"} {"level":"info","ts":"2026-02-19T02:22:04.042941Z","caller":"traceutil/trace.go:171","msg":"trace[281782944] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:1; response_revision:342; }","duration":"142.621263ms","start":"2026-02-19T02:22:03.900293Z","end":"2026-02-19T02:22:04.042914Z","steps":["trace[281782944] 'agreement among raft nodes before linearized reading' (duration: 142.39298ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:04.042842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.008049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-02-19T02:22:04.042982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.666333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-02-19T02:22:04.043032Z","caller":"traceutil/trace.go:171","msg":"trace[986133831] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:342; }","duration":"134.243452ms","start":"2026-02-19T02:22:03.908774Z","end":"2026-02-19T02:22:04.043017Z","steps":["trace[986133831] 'agreement among raft nodes before linearized reading' (duration: 133.891018ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:04.043082Z","caller":"traceutil/trace.go:171","msg":"trace[557126591] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:342; }","duration":"142.777305ms","start":"2026-02-19T02:22:03.900266Z","end":"2026-02-19T02:22:04.043043Z","steps":["trace[557126591] 'agreement among raft nodes before linearized reading' (duration: 142.484711ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:11.251762Z","caller":"traceutil/trace.go:171","msg":"trace[1753083878] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"292.484971ms","start":"2026-02-19T02:22:10.95922Z","end":"2026-02-19T02:22:11.251705Z","steps":["trace[1753083878] 'process raft request' (duration: 292.301268ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:11.879427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.695744ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:22:11.879539Z","caller":"traceutil/trace.go:171","msg":"trace[441492964] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"623.390717ms","start":"2026-02-19T02:22:11.256129Z","end":"2026-02-19T02:22:11.87952Z","steps":["trace[441492964] 'process raft request' (duration: 91.380907ms)","trace[441492964] 'compare' (duration: 531.561832ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:11.879617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:11.256112Z","time spent":"623.476249ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:22:11.909872Z","caller":"traceutil/trace.go:171","msg":"trace[1431199499] linearizableReadLoop","detail":"{readStateIndex:430; appliedIndex:428; }","duration":"644.284276ms","start":"2026-02-19T02:22:11.265562Z","end":"2026-02-19T02:22:11.909846Z","steps":["trace[1431199499] 'read index received' (duration: 82.278319ms)","trace[1431199499] 'applied index is now lower than readState.Index' (duration: 562.004897ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:11.910069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"644.458849ms","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-19T02:22:11.910046Z","caller":"traceutil/trace.go:171","msg":"trace[533478368] transaction","detail":"{read_only:false; response_revision:415; number_of_response:1; }","duration":"644.49779ms","start":"2026-02-19T02:22:11.265496Z","end":"2026-02-19T02:22:11.909994Z","steps":["trace[533478368] 'process raft request' (duration: 644.217135ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:11.910109Z","caller":"traceutil/trace.go:171","msg":"trace[313503976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:415; }","duration":"644.577852ms","start":"2026-02-19T02:22:11.265519Z","end":"2026-02-19T02:22:11.910097Z","steps":["trace[313503976] 'agreement among raft nodes before linearized reading' (duration: 644.45913ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:11.910147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:11.265501Z","time spent":"644.637493ms","remote":"127.0.0.1:59416","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-19T02:22:11.910218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:11.265462Z","time spent":"644.665324ms","remote":"127.0.0.1:59594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4158,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:22:11.910291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.982669ms","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-19T02:22:11.910384Z","caller":"traceutil/trace.go:171","msg":"trace[2057300252] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:415; }","duration":"491.116602ms","start":"2026-02-19T02:22:11.41924Z","end":"2026-02-19T02:22:11.910357Z","steps":["trace[2057300252] 'agreement among raft nodes before linearized reading' (duration: 490.962029ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:11.910449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:11.419218Z","time spent":"491.216844ms","remote":"127.0.0.1:59338","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-19T02:22:12.661323Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565171234095785,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T02:22:13.119317Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.202731493s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-19T02:22:13.366193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.34709ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:22:13.366322Z","caller":"traceutil/trace.go:171","msg":"trace[612207941] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"1.449819138s","start":"2026-02-19T02:22:11.916476Z","end":"2026-02-19T02:22:13.366295Z","steps":["trace[612207941] 'process raft request' (duration: 1.203262024s)","trace[612207941] 'compare' (duration: 246.186216ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:13.366438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:11.916451Z","time spent":"1.449950351s","remote":"127.0.0.1:59624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3656,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T02:22:13.368026Z","caller":"traceutil/trace.go:171","msg":"trace[1370640219] transaction","detail":"{read_only:false; response_revision:417; number_of_response:1; }","duration":"1.451138197s","start":"2026-02-19T02:22:11.916854Z","end":"2026-02-19T02:22:13.367993Z","steps":["trace[1370640219] 'process raft request' (duration: 1.450932543s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:13.368221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:11.916844Z","time spent":"1.45127288s","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:22:13.368312Z","caller":"traceutil/trace.go:171","msg":"trace[1260947950] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"1.448494527s","start":"2026-02-19T02:22:11.919793Z","end":"2026-02-19T02:22:13.368288Z","steps":["trace[1260947950] 'process raft request' (duration: 1.448135609s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:13.368441Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:11.919775Z","time spent":"1.448596788s","remote":"127.0.0.1:59338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4241,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:22:13.374576Z","caller":"traceutil/trace.go:171","msg":"trace[754404667] linearizableReadLoop","detail":"{readStateIndex:433; appliedIndex:430; }","duration":"1.213900996s","start":"2026-02-19T02:22:12.160656Z","end":"2026-02-19T02:22:13.374557Z","steps":["trace[754404667] 'read index received' (duration: 959.088163ms)","trace[754404667] 'applied index is now lower than readState.Index' (duration: 254.811093ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:13.374711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.214044969s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:22:13.374749Z","caller":"traceutil/trace.go:171","msg":"trace[1672975338] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:419; }","duration":"1.21412877s","start":"2026-02-19T02:22:12.16061Z","end":"2026-02-19T02:22:13.374739Z","steps":["trace[1672975338] 'agreement among raft nodes before linearized reading' (duration: 1.214034768s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:13.375037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:12.160587Z","time spent":"1.214233182s","remote":"127.0.0.1:59172","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-19T02:22:13.377719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.450948ms","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-19T02:22:13.377972Z","caller":"traceutil/trace.go:171","msg":"trace[1231878194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:421; }","duration":"121.56639ms","start":"2026-02-19T02:22:13.256207Z","end":"2026-02-19T02:22:13.377773Z","steps":["trace[1231878194] 'agreement among raft nodes before linearized reading' (duration: 121.418207ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:13.377971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.073001912s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-19T02:22:13.378013Z","caller":"traceutil/trace.go:171","msg":"trace[556240040] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:421; }","duration":"1.073267548s","start":"2026-02-19T02:22:12.304733Z","end":"2026-02-19T02:22:13.378001Z","steps":["trace[556240040] 'agreement among raft nodes before linearized reading' (duration: 1.073012822s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:13.37841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:12.30471Z","time spent":"1.073689508s","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T02:22:15.850473Z","caller":"traceutil/trace.go:171","msg":"trace[2072275445] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"153.64837ms","start":"2026-02-19T02:22:15.696801Z","end":"2026-02-19T02:22:15.85045Z","steps":["trace[2072275445] 'process raft request' (duration: 153.477037ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:26.165333Z","caller":"traceutil/trace.go:171","msg":"trace[1786357939] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"439.184512ms","start":"2026-02-19T02:22:25.726095Z","end":"2026-02-19T02:22:26.165279Z","steps":["trace[1786357939] 'process raft request' (duration: 438.913813ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:26.165666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:25.726066Z","time spent":"439.384758ms","remote":"127.0.0.1:59326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4212,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:22:26.167122Z","caller":"traceutil/trace.go:171","msg":"trace[312095956] linearizableReadLoop","detail":"{readStateIndex:531; appliedIndex:529; }","duration":"142.217694ms","start":"2026-02-19T02:22:26.024878Z","end":"2026-02-19T02:22:26.167096Z","steps":["trace[312095956] 'read index received' (duration: 139.697341ms)","trace[312095956] 'applied index is now lower than readState.Index' (duration: 2.518703ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:26.167282Z","caller":"traceutil/trace.go:171","msg":"trace[1498625242] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"177.311566ms","start":"2026-02-19T02:22:25.989959Z","end":"2026-02-19T02:22:26.167271Z","steps":["trace[1498625242] 'process raft request' (duration: 176.898762ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:26.167614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.720711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-19T02:22:26.167664Z","caller":"traceutil/trace.go:171","msg":"trace[1632745785] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:512; }","duration":"142.803034ms","start":"2026-02-19T02:22:26.024832Z","end":"2026-02-19T02:22:26.167635Z","steps":["trace[1632745785] 'agreement among raft nodes before linearized reading' (duration: 142.618788ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:27.618695Z","caller":"traceutil/trace.go:171","msg":"trace[1807011459] linearizableReadLoop","detail":"{readStateIndex:535; appliedIndex:533; }","duration":"162.533777ms","start":"2026-02-19T02:22:27.456122Z","end":"2026-02-19T02:22:27.618656Z","steps":["trace[1807011459] 'read index received' (duration: 52.319525ms)","trace[1807011459] 'applied index is now lower than readState.Index' (duration: 110.212562ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:27.618832Z","caller":"traceutil/trace.go:171","msg":"trace[631414158] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"172.462084ms","start":"2026-02-19T02:22:27.446319Z","end":"2026-02-19T02:22:27.618782Z","steps":["trace[631414158] 'process raft request' (duration: 85.754141ms)","trace[631414158] 'compare' (duration: 86.394113ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:27.618906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.757734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-19T02:22:27.619003Z","caller":"traceutil/trace.go:171","msg":"trace[1656249306] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:515; }","duration":"162.91447ms","start":"2026-02-19T02:22:27.456067Z","end":"2026-02-19T02:22:27.618982Z","steps":["trace[1656249306] 'agreement among raft nodes before linearized reading' (duration: 162.720393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:27.619055Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.133196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-02-19T02:22:27.619121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.013597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-02-19T02:22:27.619146Z","caller":"traceutil/trace.go:171","msg":"trace[449327958] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:515; }","duration":"145.258921ms","start":"2026-02-19T02:22:27.473864Z","end":"2026-02-19T02:22:27.619123Z","steps":["trace[449327958] 'agreement among raft nodes before linearized reading' (duration: 145.064674ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:27.619185Z","caller":"traceutil/trace.go:171","msg":"trace[728446003] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:515; }","duration":"108.156251ms","start":"2026-02-19T02:22:27.511016Z","end":"2026-02-19T02:22:27.619172Z","steps":["trace[728446003] 'agreement among raft nodes before linearized reading' (duration: 107.975865ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:28.012643Z","caller":"traceutil/trace.go:171","msg":"trace[1685072979] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"386.949071ms","start":"2026-02-19T02:22:27.625653Z","end":"2026-02-19T02:22:28.012602Z","steps":["trace[1685072979] 'process raft request' (duration: 386.689872ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:28.0129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:27.625647Z","time spent":"387.117456ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:22:32.999461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"784.156539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-19T02:22:32.999554Z","caller":"traceutil/trace.go:171","msg":"trace[637373435] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:551; }","duration":"784.324856ms","start":"2026-02-19T02:22:32.215207Z","end":"2026-02-19T02:22:32.999532Z","steps":["trace[637373435] 'range keys from in-memory index tree' (duration: 783.532095ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:32.999604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:32.215173Z","time spent":"784.42307ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T02:22:33.82301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.638745ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-19T02:22:33.823345Z","caller":"traceutil/trace.go:171","msg":"trace[852133139] linearizableReadLoop","detail":"{readStateIndex:573; appliedIndex:571; }","duration":"812.416206ms","start":"2026-02-19T02:22:33.010911Z","end":"2026-02-19T02:22:33.823327Z","steps":["trace[852133139] 'read index received' (duration: 117.545232ms)","trace[852133139] 'applied index is now lower than readState.Index' (duration: 694.856733ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:33.823423Z","caller":"traceutil/trace.go:171","msg":"trace[493727237] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"820.039428ms","start":"2026-02-19T02:22:33.003372Z","end":"2026-02-19T02:22:33.823412Z","steps":["trace[493727237] 'process raft request' (duration: 819.791978ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:33.823807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.343508ms","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-19T02:22:33.823838Z","caller":"traceutil/trace.go:171","msg":"trace[1451669770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:552; }","duration":"134.407131ms","start":"2026-02-19T02:22:33.689421Z","end":"2026-02-19T02:22:33.823828Z","steps":["trace[1451669770] 'agreement among raft nodes before linearized reading' (duration: 134.317657ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:33.823887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.083616ms","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-19T02:22:33.823963Z","caller":"traceutil/trace.go:171","msg":"trace[1992689825] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:552; }","duration":"175.201911ms","start":"2026-02-19T02:22:33.648738Z","end":"2026-02-19T02:22:33.82394Z","steps":["trace[1992689825] 'agreement among raft nodes before linearized reading' (duration: 175.012684ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:33.823579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"812.662584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qxrbp\" ","response":"range_response_count:1 size:16652"} {"level":"info","ts":"2026-02-19T02:22:33.824099Z","caller":"traceutil/trace.go:171","msg":"trace[1852958705] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qxrbp; range_end:; response_count:1; response_revision:552; }","duration":"813.220076ms","start":"2026-02-19T02:22:33.01085Z","end":"2026-02-19T02:22:33.82407Z","steps":["trace[1852958705] 'agreement among raft nodes before linearized reading' (duration: 812.608202ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:33.824242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:33.010826Z","time spent":"813.380832ms","remote":"127.0.0.1:59338","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-qxrbp\" "} {"level":"warn","ts":"2026-02-19T02:22:33.824291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.083609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:22:33.824337Z","caller":"traceutil/trace.go:171","msg":"trace[1780422001] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:552; }","duration":"664.201473ms","start":"2026-02-19T02:22:33.160124Z","end":"2026-02-19T02:22:33.824326Z","steps":["trace[1780422001] 'agreement among raft nodes before linearized reading' (duration: 663.605511ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:33.824132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:33.003339Z","time spent":"820.351849ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:22:33.824366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:33.160107Z","time spent":"664.250885ms","remote":"127.0.0.1:59172","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-19T02:22:34.260335Z","caller":"traceutil/trace.go:171","msg":"trace[1990275400] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"431.014474ms","start":"2026-02-19T02:22:33.829286Z","end":"2026-02-19T02:22:34.260301Z","steps":["trace[1990275400] 'process raft request' (duration: 353.151453ms)","trace[1990275400] 'compare' (duration: 77.708605ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:34.26053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:33.829268Z","time spent":"431.15335ms","remote":"127.0.0.1:59416","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-19T02:22:34.336738Z","caller":"traceutil/trace.go:171","msg":"trace[1791768245] linearizableReadLoop","detail":"{readStateIndex:576; appliedIndex:573; }","duration":"302.110969ms","start":"2026-02-19T02:22:34.034589Z","end":"2026-02-19T02:22:34.3367Z","steps":["trace[1791768245] 'read index received' (duration: 147.866755ms)","trace[1791768245] 'applied index is now lower than readState.Index' (duration: 154.242534ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:34.33702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.40821ms","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-19T02:22:34.337081Z","caller":"traceutil/trace.go:171","msg":"trace[1466337905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:555; }","duration":"302.478663ms","start":"2026-02-19T02:22:34.034565Z","end":"2026-02-19T02:22:34.337044Z","steps":["trace[1466337905] 'agreement among raft nodes before linearized reading' (duration: 302.268245ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:34.337125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:34.034461Z","time spent":"302.65418ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T02:22:34.337284Z","caller":"traceutil/trace.go:171","msg":"trace[2070426432] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"507.880146ms","start":"2026-02-19T02:22:33.829362Z","end":"2026-02-19T02:22:34.337242Z","steps":["trace[2070426432] 'process raft request' (duration: 507.080615ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:34.337339Z","caller":"traceutil/trace.go:171","msg":"trace[1232931097] transaction","detail":"{read_only:false; response_revision:555; number_of_response:1; }","duration":"501.710799ms","start":"2026-02-19T02:22:33.835585Z","end":"2026-02-19T02:22:34.337295Z","steps":["trace[1232931097] 'process raft request' (duration: 501.048853ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:34.33748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:33.829319Z","time spent":"508.051563ms","remote":"127.0.0.1:59416","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-19T02:22:34.337547Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:33.835573Z","time spent":"501.861735ms","remote":"127.0.0.1:59338","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-19T02:22:34.739524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.011888ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:22:34.73969Z","caller":"traceutil/trace.go:171","msg":"trace[2107716228] transaction","detail":"{read_only:false; response_revision:556; number_of_response:1; }","duration":"396.690666ms","start":"2026-02-19T02:22:34.342972Z","end":"2026-02-19T02:22:34.739663Z","steps":["trace[2107716228] 'process raft request' (duration: 220.410278ms)","trace[2107716228] 'compare' (duration: 175.769348ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:34.739796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:34.342945Z","time spent":"396.817061ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:22:36.054494Z","caller":"traceutil/trace.go:171","msg":"trace[1028608334] transaction","detail":"{read_only:false; response_revision:557; number_of_response:1; }","duration":"221.573042ms","start":"2026-02-19T02:22:35.832887Z","end":"2026-02-19T02:22:36.05446Z","steps":["trace[1028608334] 'process raft request' (duration: 221.389965ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:37.244636Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565171234096070,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T02:22:37.474226Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.10641709s","expected-duration":"1s"} {"level":"warn","ts":"2026-02-19T02:22:37.519517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.176729193s","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-19T02:22:37.519588Z","caller":"traceutil/trace.go:171","msg":"trace[141523956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:557; }","duration":"1.176843308s","start":"2026-02-19T02:22:36.342728Z","end":"2026-02-19T02:22:37.519572Z","steps":["trace[141523956] 'range keys from in-memory index tree' (duration: 1.176580418s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:37.519619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:36.342706Z","time spent":"1.17690717s","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-19T02:22:37.519786Z","caller":"traceutil/trace.go:171","msg":"trace[1945561717] linearizableReadLoop","detail":"{readStateIndex:579; appliedIndex:578; }","duration":"775.537083ms","start":"2026-02-19T02:22:36.74419Z","end":"2026-02-19T02:22:37.519727Z","steps":["trace[1945561717] 'read index received' (duration: 730.200533ms)","trace[1945561717] 'applied index is now lower than readState.Index' (duration: 45.33487ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:37.519924Z","caller":"traceutil/trace.go:171","msg":"trace[1398903125] transaction","detail":"{read_only:false; response_revision:558; number_of_response:1; }","duration":"1.152186078s","start":"2026-02-19T02:22:36.367723Z","end":"2026-02-19T02:22:37.519909Z","steps":["trace[1398903125] 'process raft request' (duration: 1.106789585s)","trace[1398903125] 'compare' (duration: 44.671243ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:37.520019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.921241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T02:22:37.520094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:36.367707Z","time spent":"1.152258241s","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-19T02:22:37.520403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"776.220741ms","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-19T02:22:37.520446Z","caller":"traceutil/trace.go:171","msg":"trace[868529042] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:558; }","duration":"776.302404ms","start":"2026-02-19T02:22:36.744132Z","end":"2026-02-19T02:22:37.520435Z","steps":["trace[868529042] 'agreement among raft nodes before linearized reading' (duration: 776.124317ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:37.520478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:36.744109Z","time spent":"776.362327ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T02:22:37.520495Z","caller":"traceutil/trace.go:171","msg":"trace[2113844722] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:558; }","duration":"360.047756ms","start":"2026-02-19T02:22:37.160035Z","end":"2026-02-19T02:22:37.520083Z","steps":["trace[2113844722] 'agreement among raft nodes before linearized reading' (duration: 359.91643ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:37.520589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:37.16002Z","time spent":"360.550757ms","remote":"127.0.0.1:59172","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-19T02:22:37.520597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.868798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.70\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-02-19T02:22:37.520721Z","caller":"traceutil/trace.go:171","msg":"trace[1868240723] range","detail":"{range_begin:/registry/masterleases/199.204.45.70; range_end:; response_count:1; response_revision:558; }","duration":"177.987054ms","start":"2026-02-19T02:22:37.342679Z","end":"2026-02-19T02:22:37.520666Z","steps":["trace[1868240723] 'agreement among raft nodes before linearized reading' (duration: 177.836777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:37.521163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.255856676s","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-19T02:22:37.521216Z","caller":"traceutil/trace.go:171","msg":"trace[1565504081] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:557; }","duration":"1.25642928s","start":"2026-02-19T02:22:36.264773Z","end":"2026-02-19T02:22:37.521202Z","steps":["trace[1565504081] 'range keys from in-memory index tree' (duration: 1.254357984s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:37.521255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:36.264741Z","time spent":"1.256500732s","remote":"127.0.0.1:59416","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-19T02:22:40.541952Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":296565171234096103,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-19T02:22:40.643697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110774205s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-02-19T02:22:40.643705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110567596s","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-19T02:22:40.643767Z","caller":"traceutil/trace.go:171","msg":"trace[1731654480] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:574; }","duration":"1.11089121s","start":"2026-02-19T02:22:39.53286Z","end":"2026-02-19T02:22:40.643751Z","steps":["trace[1731654480] 'range keys from in-memory index tree' (duration: 1.110634729s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:40.643798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:39.532838Z","time spent":"1.110955013s","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-02-19T02:22:40.643801Z","caller":"traceutil/trace.go:171","msg":"trace[14512246] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:574; }","duration":"1.110747804s","start":"2026-02-19T02:22:39.533025Z","end":"2026-02-19T02:22:40.643773Z","steps":["trace[14512246] 'range keys from in-memory index tree' (duration: 1.110344287s)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:40.643821Z","caller":"traceutil/trace.go:171","msg":"trace[1847271329] linearizableReadLoop","detail":"{readStateIndex:598; appliedIndex:596; }","duration":"602.949753ms","start":"2026-02-19T02:22:40.040849Z","end":"2026-02-19T02:22:40.643799Z","steps":["trace[1847271329] 'read index received' (duration: 557.937017ms)","trace[1847271329] 'applied index is now lower than readState.Index' (duration: 45.011586ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:40.643848Z","caller":"traceutil/trace.go:171","msg":"trace[1473791380] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"601.132064ms","start":"2026-02-19T02:22:40.0427Z","end":"2026-02-19T02:22:40.643833Z","steps":["trace[1473791380] 'process raft request' (duration: 601.011459ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:40.643867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:39.53296Z","time spent":"1.11088789s","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-02-19T02:22:40.643858Z","caller":"traceutil/trace.go:171","msg":"trace[208938948] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.046055528s","start":"2026-02-19T02:22:39.597747Z","end":"2026-02-19T02:22:40.643802Z","steps":["trace[208938948] 'process raft request' (duration: 1.000991609s)","trace[208938948] 'compare' (duration: 44.60746ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:40.643921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:40.042684Z","time spent":"601.192007ms","remote":"127.0.0.1:59232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":846,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T02:22:40.643988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.133321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-hcpnq\" ","response":"range_response_count:1 size:4635"} {"level":"info","ts":"2026-02-19T02:22:40.644021Z","caller":"traceutil/trace.go:171","msg":"trace[14310690] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-hcpnq; range_end:; response_count:1; response_revision:576; }","duration":"603.205724ms","start":"2026-02-19T02:22:40.040805Z","end":"2026-02-19T02:22:40.644011Z","steps":["trace[14310690] 'agreement among raft nodes before linearized reading' (duration: 603.084139ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:40.644048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:40.040784Z","time spent":"603.256617ms","remote":"127.0.0.1:59338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4658,"request content":"key:\"/registry/pods/kube-system/cilium-operator-7fcd8d6ffd-hcpnq\" "} {"level":"warn","ts":"2026-02-19T02:22:40.644041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.405385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-19T02:22:40.644107Z","caller":"traceutil/trace.go:171","msg":"trace[1368795130] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:576; }","duration":"570.480889ms","start":"2026-02-19T02:22:40.073603Z","end":"2026-02-19T02:22:40.644084Z","steps":["trace[1368795130] 'agreement among raft nodes before linearized reading' (duration: 570.325832ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:40.644124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"484.500661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T02:22:40.644125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:39.597716Z","time spent":"1.046295909s","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:22:40.644152Z","caller":"traceutil/trace.go:171","msg":"trace[1303222184] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:576; }","duration":"484.578824ms","start":"2026-02-19T02:22:40.159566Z","end":"2026-02-19T02:22:40.644144Z","steps":["trace[1303222184] 'agreement among raft nodes before linearized reading' (duration: 484.533362ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:40.644154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:40.073597Z","time spent":"570.543931ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T02:22:40.644178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:40.15953Z","time spent":"484.644307ms","remote":"127.0.0.1:59172","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-19T02:22:40.644486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.11109943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-19T02:22:40.644547Z","caller":"traceutil/trace.go:171","msg":"trace[638071764] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:574; }","duration":"1.111201405s","start":"2026-02-19T02:22:39.533327Z","end":"2026-02-19T02:22:40.644528Z","steps":["trace[638071764] 'range keys from in-memory index tree' (duration: 1.109970591s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:40.644679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:39.533309Z","time spent":"1.111270078s","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-02-19T02:22:43.056175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.201542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:22:43.05633Z","caller":"traceutil/trace.go:171","msg":"trace[517539902] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"898.381839ms","start":"2026-02-19T02:22:42.157916Z","end":"2026-02-19T02:22:43.056298Z","steps":["trace[517539902] 'read index received' (duration: 349.848462ms)","trace[517539902] 'applied index is now lower than readState.Index' (duration: 548.531327ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:43.056367Z","caller":"traceutil/trace.go:171","msg":"trace[1649491857] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"968.466769ms","start":"2026-02-19T02:22:42.087844Z","end":"2026-02-19T02:22:43.056311Z","steps":["trace[1649491857] 'process raft request' (duration: 420.032446ms)","trace[1649491857] 'compare' (duration: 547.901189ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:22:43.056538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"898.59954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T02:22:43.056565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.087813Z","time spent":"968.645496ms","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-19T02:22:43.056591Z","caller":"traceutil/trace.go:171","msg":"trace[1969503478] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:617; }","duration":"898.716235ms","start":"2026-02-19T02:22:42.157857Z","end":"2026-02-19T02:22:43.056573Z","steps":["trace[1969503478] 'agreement among raft nodes before linearized reading' (duration: 898.560167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:43.056641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.157834Z","time spent":"898.796759ms","remote":"127.0.0.1:59172","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-19T02:22:43.108253Z","caller":"traceutil/trace.go:171","msg":"trace[232228432] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"417.442574ms","start":"2026-02-19T02:22:42.690746Z","end":"2026-02-19T02:22:43.108189Z","steps":["trace[232228432] 'process raft request' (duration: 417.323859ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:43.108725Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.6907Z","time spent":"417.821501ms","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":23277,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T02:22:44.063298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"544.969411ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-19T02:22:44.063672Z","caller":"traceutil/trace.go:171","msg":"trace[811886239] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"1.00229562s","start":"2026-02-19T02:22:43.06134Z","end":"2026-02-19T02:22:44.063636Z","steps":["trace[811886239] 'process raft request' (duration: 1.002088651s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.063834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:43.061323Z","time spent":"1.002423616s","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4156,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:22:44.064174Z","caller":"traceutil/trace.go:171","msg":"trace[353689832] linearizableReadLoop","detail":"{readStateIndex:641; appliedIndex:639; }","duration":"1.007761557s","start":"2026-02-19T02:22:43.056382Z","end":"2026-02-19T02:22:44.064144Z","steps":["trace[353689832] 'read index received' (duration: 51.584888ms)","trace[353689832] 'applied index is now lower than readState.Index' (duration: 956.174289ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:44.064215Z","caller":"traceutil/trace.go:171","msg":"trace[576355874] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"949.321039ms","start":"2026-02-19T02:22:43.114874Z","end":"2026-02-19T02:22:44.064195Z","steps":["trace[576355874] 'process raft request' (duration: 948.746863ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.064319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:43.11484Z","time spent":"949.419534ms","remote":"127.0.0.1:59232","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":712,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-19T02:22:44.064347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.579443736s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-19T02:22:44.06435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.388127629s","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-19T02:22:44.064397Z","caller":"traceutil/trace.go:171","msg":"trace[1162716527] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:620; }","duration":"1.57952858s","start":"2026-02-19T02:22:42.484851Z","end":"2026-02-19T02:22:44.064379Z","steps":["trace[1162716527] 'agreement among raft nodes before linearized reading' (duration: 1.579438746s)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.064411Z","caller":"traceutil/trace.go:171","msg":"trace[1962580754] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:620; }","duration":"1.388230963s","start":"2026-02-19T02:22:42.676164Z","end":"2026-02-19T02:22:44.064395Z","steps":["trace[1962580754] 'agreement among raft nodes before linearized reading' (duration: 1.387997493s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.064436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.484838Z","time spent":"1.579588102s","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-19T02:22:44.064462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.676138Z","time spent":"1.388311787s","remote":"127.0.0.1:59416","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-19T02:22:44.064471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.388713775s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-02-19T02:22:44.064522Z","caller":"traceutil/trace.go:171","msg":"trace[995621802] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:620; }","duration":"1.388806769s","start":"2026-02-19T02:22:42.675695Z","end":"2026-02-19T02:22:44.064502Z","steps":["trace[995621802] 'agreement among raft nodes before linearized reading' (duration: 1.388696204s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.064562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.675664Z","time spent":"1.388887813s","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-19T02:22:44.06464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006686478s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:22:44.064664Z","caller":"traceutil/trace.go:171","msg":"trace[174816301] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:620; }","duration":"1.006752131s","start":"2026-02-19T02:22:43.057905Z","end":"2026-02-19T02:22:44.064657Z","steps":["trace[174816301] 'agreement among raft nodes before linearized reading' (duration: 1.006696959s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.064681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:43.057884Z","time spent":"1.006794023s","remote":"127.0.0.1:59160","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-19T02:22:44.064768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.179801787s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:1 size:4333"} {"level":"info","ts":"2026-02-19T02:22:44.064828Z","caller":"traceutil/trace.go:171","msg":"trace[1454566666] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:620; }","duration":"1.179948964s","start":"2026-02-19T02:22:42.88486Z","end":"2026-02-19T02:22:44.064809Z","steps":["trace[1454566666] 'agreement among raft nodes before linearized reading' (duration: 1.179775076s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.064848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.388001684s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-02-19T02:22:44.064884Z","caller":"traceutil/trace.go:171","msg":"trace[844960583] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:620; }","duration":"1.388057236s","start":"2026-02-19T02:22:42.676816Z","end":"2026-02-19T02:22:44.064874Z","steps":["trace[844960583] 'agreement among raft nodes before linearized reading' (duration: 1.38792002s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.06489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.624333ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:1 size:5177"} {"level":"warn","ts":"2026-02-19T02:22:44.064352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.39398599s","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-19T02:22:44.064919Z","caller":"traceutil/trace.go:171","msg":"trace[1139152690] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:620; }","duration":"179.709897ms","start":"2026-02-19T02:22:43.885199Z","end":"2026-02-19T02:22:44.064909Z","steps":["trace[1139152690] 'agreement among raft nodes before linearized reading' (duration: 179.601272ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.064918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.676805Z","time spent":"1.388105389s","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-02-19T02:22:44.064928Z","caller":"traceutil/trace.go:171","msg":"trace[974336567] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:620; }","duration":"1.394628699s","start":"2026-02-19T02:22:42.670287Z","end":"2026-02-19T02:22:44.064916Z","steps":["trace[974336567] 'agreement among raft nodes before linearized reading' (duration: 1.393884275s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.064969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.670253Z","time spent":"1.394705442s","remote":"127.0.0.1:59416","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-19T02:22:44.065052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.599839ms","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":"warn","ts":"2026-02-19T02:22:44.06488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.884824Z","time spent":"1.180042488s","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4356,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" "} {"level":"info","ts":"2026-02-19T02:22:44.065105Z","caller":"traceutil/trace.go:171","msg":"trace[553497481] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:620; }","duration":"379.692093ms","start":"2026-02-19T02:22:43.685404Z","end":"2026-02-19T02:22:44.065096Z","steps":["trace[553497481] 'agreement among raft nodes before linearized reading' (duration: 379.599809ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.065122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:43.685376Z","time spent":"379.742305ms","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9343,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"warn","ts":"2026-02-19T02:22:44.065121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.338544243s","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-19T02:22:44.065226Z","caller":"traceutil/trace.go:171","msg":"trace[998139315] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:620; }","duration":"1.338748603s","start":"2026-02-19T02:22:42.726457Z","end":"2026-02-19T02:22:44.065205Z","steps":["trace[998139315] 'agreement among raft nodes before linearized reading' (duration: 1.33846895s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.065317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.726428Z","time spent":"1.338872399s","remote":"127.0.0.1:59416","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-19T02:22:44.065387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"581.001979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:1 size:10377"} {"level":"warn","ts":"2026-02-19T02:22:44.065405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"980.497417ms","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-19T02:22:44.065429Z","caller":"traceutil/trace.go:171","msg":"trace[669585634] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:620; }","duration":"980.55364ms","start":"2026-02-19T02:22:43.084869Z","end":"2026-02-19T02:22:44.065423Z","steps":["trace[669585634] 'agreement among raft nodes before linearized reading' (duration: 980.485777ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.065448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:43.084858Z","time spent":"980.586271ms","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":92,"response count":1,"response size":5609,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" "} {"level":"info","ts":"2026-02-19T02:22:44.065439Z","caller":"traceutil/trace.go:171","msg":"trace[1896377582] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:620; }","duration":"581.053711ms","start":"2026-02-19T02:22:43.484367Z","end":"2026-02-19T02:22:44.065421Z","steps":["trace[1896377582] 'agreement among raft nodes before linearized reading' (duration: 580.912205ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.065492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:43.484276Z","time spent":"581.197637ms","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":1,"response size":10400,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" "} {"level":"warn","ts":"2026-02-19T02:22:44.065495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"781.076078ms","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-19T02:22:44.065535Z","caller":"traceutil/trace.go:171","msg":"trace[1994684667] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:620; }","duration":"781.158762ms","start":"2026-02-19T02:22:43.284364Z","end":"2026-02-19T02:22:44.065523Z","steps":["trace[1994684667] 'agreement among raft nodes before linearized reading' (duration: 781.048127ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.065565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:43.284342Z","time spent":"781.216174ms","remote":"127.0.0.1:59200","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-19T02:22:44.064789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.780095546s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:22:44.065596Z","caller":"traceutil/trace.go:171","msg":"trace[1032791765] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:620; }","duration":"1.780901445s","start":"2026-02-19T02:22:42.284686Z","end":"2026-02-19T02:22:44.065588Z","steps":["trace[1032791765] 'agreement among raft nodes before linearized reading' (duration: 1.780078936s)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.065614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:22:42.284624Z","time spent":"1.780984818s","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"info","ts":"2026-02-19T02:22:44.259462Z","caller":"traceutil/trace.go:171","msg":"trace[1293451776] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"187.154911ms","start":"2026-02-19T02:22:44.072264Z","end":"2026-02-19T02:22:44.259419Z","steps":["trace[1293451776] 'process raft request' (duration: 181.916382ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.330604Z","caller":"traceutil/trace.go:171","msg":"trace[266670186] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"258.038293ms","start":"2026-02-19T02:22:44.072502Z","end":"2026-02-19T02:22:44.33054Z","steps":["trace[266670186] 'process raft request' (duration: 257.75401ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.330668Z","caller":"traceutil/trace.go:171","msg":"trace[2108551303] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"257.412924ms","start":"2026-02-19T02:22:44.073218Z","end":"2026-02-19T02:22:44.330631Z","steps":["trace[2108551303] 'process raft request' (duration: 257.224035ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.330821Z","caller":"traceutil/trace.go:171","msg":"trace[149943059] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"257.258057ms","start":"2026-02-19T02:22:44.073518Z","end":"2026-02-19T02:22:44.330776Z","steps":["trace[149943059] 'process raft request' (duration: 257.043537ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.331475Z","caller":"traceutil/trace.go:171","msg":"trace[1948223299] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"253.694245ms","start":"2026-02-19T02:22:44.077747Z","end":"2026-02-19T02:22:44.331442Z","steps":["trace[1948223299] 'process raft request' (duration: 253.457834ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.331657Z","caller":"traceutil/trace.go:171","msg":"trace[494341961] linearizableReadLoop","detail":"{readStateIndex:647; appliedIndex:643; }","duration":"256.456531ms","start":"2026-02-19T02:22:44.075186Z","end":"2026-02-19T02:22:44.331642Z","steps":["trace[494341961] 'read index received' (duration: 178.988537ms)","trace[494341961] 'applied index is now lower than readState.Index' (duration: 77.466734ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:44.331705Z","caller":"traceutil/trace.go:171","msg":"trace[1651043137] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"253.665733ms","start":"2026-02-19T02:22:44.078014Z","end":"2026-02-19T02:22:44.33168Z","steps":["trace[1651043137] 'process raft request' (duration: 253.360939ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.331779Z","caller":"traceutil/trace.go:171","msg":"trace[435681321] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"246.82801ms","start":"2026-02-19T02:22:44.084942Z","end":"2026-02-19T02:22:44.33177Z","steps":["trace[435681321] 'process raft request' (duration: 246.534706ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.331842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.621998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-19T02:22:44.331882Z","caller":"traceutil/trace.go:171","msg":"trace[744109769] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:628; }","duration":"256.724663ms","start":"2026-02-19T02:22:44.075144Z","end":"2026-02-19T02:22:44.331868Z","steps":["trace[744109769] 'agreement among raft nodes before linearized reading' (duration: 256.626329ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:44.332411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.498401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"warn","ts":"2026-02-19T02:22:44.332428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.555423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qxrbp\" ","response":"range_response_count:1 size:17666"} {"level":"info","ts":"2026-02-19T02:22:44.332473Z","caller":"traceutil/trace.go:171","msg":"trace[1569776504] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qxrbp; range_end:; response_count:1; response_revision:628; }","duration":"247.637537ms","start":"2026-02-19T02:22:44.084824Z","end":"2026-02-19T02:22:44.332462Z","steps":["trace[1569776504] 'agreement among raft nodes before linearized reading' (duration: 247.442848ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.332481Z","caller":"traceutil/trace.go:171","msg":"trace[1555843969] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:628; }","duration":"247.633787ms","start":"2026-02-19T02:22:44.084825Z","end":"2026-02-19T02:22:44.332458Z","steps":["trace[1555843969] 'agreement among raft nodes before linearized reading' (duration: 247.291351ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.331287Z","caller":"traceutil/trace.go:171","msg":"trace[236772934] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"255.604542ms","start":"2026-02-19T02:22:44.075665Z","end":"2026-02-19T02:22:44.331269Z","steps":["trace[236772934] 'process raft request' (duration: 255.025665ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.516184Z","caller":"traceutil/trace.go:171","msg":"trace[432101453] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"158.516622ms","start":"2026-02-19T02:22:44.357626Z","end":"2026-02-19T02:22:44.516142Z","steps":["trace[432101453] 'process raft request' (duration: 108.378008ms)","trace[432101453] 'compare' (duration: 49.934413ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:44.51935Z","caller":"traceutil/trace.go:171","msg":"trace[616956823] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"141.751224ms","start":"2026-02-19T02:22:44.377564Z","end":"2026-02-19T02:22:44.519315Z","steps":["trace[616956823] 'process raft request' (duration: 141.285413ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:22:44.893686Z","caller":"traceutil/trace.go:171","msg":"trace[267535333] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"181.772155ms","start":"2026-02-19T02:22:44.711891Z","end":"2026-02-19T02:22:44.893663Z","steps":["trace[267535333] 'process raft request' (duration: 181.602357ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:45.161043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.18289ms","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-19T02:22:45.161195Z","caller":"traceutil/trace.go:171","msg":"trace[680282355] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:631; }","duration":"193.343987ms","start":"2026-02-19T02:22:44.967831Z","end":"2026-02-19T02:22:45.161175Z","steps":["trace[680282355] 'range keys from in-memory index tree' (duration: 193.16436ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:45.161571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.101356ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:22:45.16164Z","caller":"traceutil/trace.go:171","msg":"trace[1651098158] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"240.454693ms","start":"2026-02-19T02:22:44.921173Z","end":"2026-02-19T02:22:45.161627Z","steps":["trace[1651098158] 'process raft request' (duration: 101.230331ms)","trace[1651098158] 'compare' (duration: 138.405954ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:45.177098Z","caller":"traceutil/trace.go:171","msg":"trace[1120916870] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"216.380641ms","start":"2026-02-19T02:22:44.960709Z","end":"2026-02-19T02:22:45.177089Z","steps":["trace[1120916870] 'process raft request' (duration: 216.180232ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:45.471266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.374421ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-19T02:22:45.471382Z","caller":"traceutil/trace.go:171","msg":"trace[760222595] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"198.671347ms","start":"2026-02-19T02:22:45.272691Z","end":"2026-02-19T02:22:45.471363Z","steps":["trace[760222595] 'process raft request' (duration: 90.114026ms)","trace[760222595] 'compare' (duration: 108.109519ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:22:45.477158Z","caller":"traceutil/trace.go:171","msg":"trace[266473948] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"191.020113ms","start":"2026-02-19T02:22:45.286108Z","end":"2026-02-19T02:22:45.477128Z","steps":["trace[266473948] 'process raft request' (duration: 190.641255ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:22:45.887175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.883748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188252"} {"level":"info","ts":"2026-02-19T02:22:45.887255Z","caller":"traceutil/trace.go:171","msg":"trace[2094156760] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:640; }","duration":"185.029604ms","start":"2026-02-19T02:22:45.702206Z","end":"2026-02-19T02:22:45.887236Z","steps":["trace[2094156760] 'range keys from in-memory index tree' (duration: 184.558233ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:24:13.078773Z","caller":"traceutil/trace.go:171","msg":"trace[1990933637] linearizableReadLoop","detail":"{readStateIndex:1059; appliedIndex:1058; }","duration":"228.374147ms","start":"2026-02-19T02:24:12.850372Z","end":"2026-02-19T02:24:13.078746Z","steps":["trace[1990933637] 'read index received' (duration: 217.693739ms)","trace[1990933637] 'applied index is now lower than readState.Index' (duration: 10.679108ms)"],"step_count":2} {"level":"info","ts":"2026-02-19T02:24:13.078829Z","caller":"traceutil/trace.go:171","msg":"trace[935756392] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"232.192963ms","start":"2026-02-19T02:24:12.846619Z","end":"2026-02-19T02:24:13.078812Z","steps":["trace[935756392] 'process raft request' (duration: 221.44078ms)","trace[935756392] 'compare' (duration: 10.544868ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:24:13.079097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.708142ms","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-19T02:24:13.079358Z","caller":"traceutil/trace.go:171","msg":"trace[554209241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1013; }","duration":"228.93747ms","start":"2026-02-19T02:24:12.850312Z","end":"2026-02-19T02:24:13.079249Z","steps":["trace[554209241] 'agreement among raft nodes before linearized reading' (duration: 228.570813ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:24:13.079613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.35428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5054"} {"level":"info","ts":"2026-02-19T02:24:13.079667Z","caller":"traceutil/trace.go:171","msg":"trace[188525284] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1013; }","duration":"222.430796ms","start":"2026-02-19T02:24:12.857223Z","end":"2026-02-19T02:24:13.079653Z","steps":["trace[188525284] 'agreement among raft nodes before linearized reading' (duration: 222.266044ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:24:13.079734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.180361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/admin\" ","response":"range_response_count:1 size:3548"} {"level":"info","ts":"2026-02-19T02:24:13.079795Z","caller":"traceutil/trace.go:171","msg":"trace[2023476708] range","detail":"{range_begin:/registry/clusterroles/admin; range_end:; response_count:1; response_revision:1013; }","duration":"190.29664ms","start":"2026-02-19T02:24:12.889479Z","end":"2026-02-19T02:24:13.079775Z","steps":["trace[2023476708] 'agreement among raft nodes before linearized reading' (duration: 190.16537ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:24:13.079822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.629607ms","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-19T02:24:13.079858Z","caller":"traceutil/trace.go:171","msg":"trace[1954771763] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1013; }","duration":"228.667931ms","start":"2026-02-19T02:24:12.851179Z","end":"2026-02-19T02:24:13.079847Z","steps":["trace[1954771763] 'agreement among raft nodes before linearized reading' (duration: 228.546942ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:24:13.080399Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.752261ms","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-19T02:24:13.080443Z","caller":"traceutil/trace.go:171","msg":"trace[1113604635] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1013; }","duration":"229.811235ms","start":"2026-02-19T02:24:12.850617Z","end":"2026-02-19T02:24:13.080428Z","steps":["trace[1113604635] 'agreement among raft nodes before linearized reading' (duration: 228.81108ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:24:13.295497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.194747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" limit:500 ","response":"range_response_count:120 size:88602"} {"level":"info","ts":"2026-02-19T02:24:13.29559Z","caller":"traceutil/trace.go:171","msg":"trace[1428901347] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:120; response_revision:1016; }","duration":"113.343998ms","start":"2026-02-19T02:24:13.182225Z","end":"2026-02-19T02:24:13.295569Z","steps":["trace[1428901347] 'range keys from in-memory index tree' (duration: 111.738117ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:24:15.489082Z","caller":"traceutil/trace.go:171","msg":"trace[1844607246] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"315.774724ms","start":"2026-02-19T02:24:15.173252Z","end":"2026-02-19T02:24:15.489027Z","steps":["trace[1844607246] 'process raft request' (duration: 235.003156ms)","trace[1844607246] 'compare' (duration: 80.201144ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:24:15.489237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:24:15.173237Z","time spent":"315.917454ms","remote":"127.0.0.1:59416","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-19T02:24:15.489841Z","caller":"traceutil/trace.go:171","msg":"trace[1335659107] linearizableReadLoop","detail":"{readStateIndex:1067; appliedIndex:1064; }","duration":"147.535705ms","start":"2026-02-19T02:24:15.342277Z","end":"2026-02-19T02:24:15.489812Z","steps":["trace[1335659107] 'read index received' (duration: 65.99399ms)","trace[1335659107] 'applied index is now lower than readState.Index' (duration: 81.540625ms)"],"step_count":2} {"level":"warn","ts":"2026-02-19T02:24:15.490037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.744801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:daemon-set-controller\" ","response":"range_response_count:1 size:958"} {"level":"info","ts":"2026-02-19T02:24:15.490087Z","caller":"traceutil/trace.go:171","msg":"trace[1228225237] range","detail":"{range_begin:/registry/clusterroles/system:controller:daemon-set-controller; range_end:; response_count:1; response_revision:1021; }","duration":"147.841348ms","start":"2026-02-19T02:24:15.342228Z","end":"2026-02-19T02:24:15.490069Z","steps":["trace[1228225237] 'agreement among raft nodes before linearized reading' (duration: 147.743311ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:24:15.490038Z","caller":"traceutil/trace.go:171","msg":"trace[1042188268] transaction","detail":"{read_only:false; response_revision:1021; number_of_response:1; }","duration":"314.430172ms","start":"2026-02-19T02:24:15.175541Z","end":"2026-02-19T02:24:15.489971Z","steps":["trace[1042188268] 'process raft request' (duration: 314.164502ms)"],"step_count":1} {"level":"info","ts":"2026-02-19T02:24:15.490091Z","caller":"traceutil/trace.go:171","msg":"trace[653810116] transaction","detail":"{read_only:false; response_revision:1020; number_of_response:1; }","duration":"314.571913ms","start":"2026-02-19T02:24:15.175496Z","end":"2026-02-19T02:24:15.490068Z","steps":["trace[653810116] 'process raft request' (duration: 313.300198ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:24:15.490169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.646448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cilium-operator\" ","response":"range_response_count:1 size:785"} {"level":"warn","ts":"2026-02-19T02:24:15.490214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:24:15.175536Z","time spent":"314.600976ms","remote":"127.0.0.1:59416","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-19T02:24:15.490227Z","caller":"traceutil/trace.go:171","msg":"trace[193160729] range","detail":"{range_begin:/registry/clusterrolebindings/cilium-operator; range_end:; response_count:1; response_revision:1021; }","duration":"146.740905ms","start":"2026-02-19T02:24:15.343473Z","end":"2026-02-19T02:24:15.490214Z","steps":["trace[193160729] 'agreement among raft nodes before linearized reading' (duration: 146.631357ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:24:15.490236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-19T02:24:15.17549Z","time spent":"314.674381ms","remote":"127.0.0.1:59416","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-19T02:24:15.814533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.024007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/cluster-admin\" ","response":"range_response_count:1 size:679"} {"level":"info","ts":"2026-02-19T02:24:15.814645Z","caller":"traceutil/trace.go:171","msg":"trace[1945359976] range","detail":"{range_begin:/registry/clusterrolebindings/cluster-admin; range_end:; response_count:1; response_revision:1021; }","duration":"157.143436ms","start":"2026-02-19T02:24:15.657462Z","end":"2026-02-19T02:24:15.814606Z","steps":["trace[1945359976] 'range keys from in-memory index tree' (duration: 156.967092ms)"],"step_count":1} {"level":"warn","ts":"2026-02-19T02:24:15.814654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.705288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:deployment-controller\" ","response":"range_response_count:1 size:913"} {"level":"info","ts":"2026-02-19T02:24:15.814714Z","caller":"traceutil/trace.go:171","msg":"trace[1395575437] range","detail":"{range_begin:/registry/clusterroles/system:controller:deployment-controller; range_end:; response_count:1; response_revision:1021; }","duration":"159.794934ms","start":"2026-02-19T02:24:15.654901Z","end":"2026-02-19T02:24:15.814696Z","steps":["trace[1395575437] 'range keys from in-memory index tree' (duration: 159.635333ms)"],"step_count":1}