{"level":"warn","ts":"2026-02-17T16:08:57.863641Z","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-17T16:08:57.863732Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.12: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.19.213.12:2380","--initial-cluster=instance=https://199.19.213.12:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.12:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.12: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-17T16:08:57.863826Z","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-17T16:08:57.863839Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.12:2380"]} {"level":"info","ts":"2026-02-17T16:08:57.863906Z","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-17T16:08:57.864547Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"]} {"level":"info","ts":"2026-02-17T16:08:57.864653Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":2,"max-cpu-available":2,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.12:2380"],"listen-peer-urls":["https://199.19.213.12:2380"],"advertise-client-urls":["https://199.19.213.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.12: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-17T16:08:58.052978Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"188.042294ms"} {"level":"info","ts":"2026-02-17T16:08:58.544714Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"790561176553eafe","cluster-id":"e32c72c573d8545f"} {"level":"info","ts":"2026-02-17T16:08:58.544821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=()"} {"level":"info","ts":"2026-02-17T16:08:58.544848Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became follower at term 0"} {"level":"info","ts":"2026-02-17T16:08:58.544859Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 790561176553eafe [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-02-17T16:08:58.544881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became follower at term 1"} {"level":"info","ts":"2026-02-17T16:08:58.544925Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=(8720483006584974078)"} {"level":"warn","ts":"2026-02-17T16:08:58.805074Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-02-17T16:08:58.869328Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-02-17T16:08:58.91308Z","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-17T16:08:58.993866Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"790561176553eafe","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-02-17T16:08:58.995278Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"790561176553eafe","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-02-17T16:08:58.995457Z","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-17T16:08:58.995493Z","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-17T16:08:58.995501Z","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-17T16:08:59.012256Z","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-17T16:08:59.012681Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"790561176553eafe","initial-advertise-peer-urls":["https://199.19.213.12:2380"],"listen-peer-urls":["https://199.19.213.12:2380"],"advertise-client-urls":["https://199.19.213.12:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.12:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-02-17T16:08:59.012703Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-02-17T16:08:59.013477Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.12:2380"} {"level":"info","ts":"2026-02-17T16:08:59.013496Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.12:2380"} {"level":"info","ts":"2026-02-17T16:08:59.019953Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe switched to configuration voters=(8720483006584974078)"} {"level":"info","ts":"2026-02-17T16:08:59.020074Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"e32c72c573d8545f","local-member-id":"790561176553eafe","added-peer-id":"790561176553eafe","added-peer-peer-urls":["https://199.19.213.12:2380"]} {"level":"info","ts":"2026-02-17T16:08:59.157053Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe is starting a new election at term 1"} {"level":"info","ts":"2026-02-17T16:08:59.157123Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became pre-candidate at term 1"} {"level":"info","ts":"2026-02-17T16:08:59.157311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe received MsgPreVoteResp from 790561176553eafe at term 1"} {"level":"info","ts":"2026-02-17T16:08:59.157328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became candidate at term 2"} {"level":"info","ts":"2026-02-17T16:08:59.157378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe received MsgVoteResp from 790561176553eafe at term 2"} {"level":"info","ts":"2026-02-17T16:08:59.15743Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"790561176553eafe became leader at term 2"} {"level":"info","ts":"2026-02-17T16:08:59.157443Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 790561176553eafe elected leader 790561176553eafe at term 2"} {"level":"info","ts":"2026-02-17T16:08:59.268199Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:08:59.277737Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"790561176553eafe","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.12:2379]}","request-path":"/0/members/790561176553eafe/attributes","cluster-id":"e32c72c573d8545f","publish-timeout":"7s"} {"level":"info","ts":"2026-02-17T16:08:59.278131Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T16:08:59.278853Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-02-17T16:08:59.279122Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-02-17T16:08:59.279211Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-02-17T16:08:59.280932Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.12:2379"} {"level":"info","ts":"2026-02-17T16:08:59.282572Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-02-17T16:08:59.320048Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"e32c72c573d8545f","local-member-id":"790561176553eafe","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:08:59.320163Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-02-17T16:08:59.320205Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-02-17T16:08:59.617876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.741759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.617928Z","caller":"traceutil/trace.go:171","msg":"trace[269456900] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"223.814792ms","start":"2026-02-17T16:08:59.394102Z","end":"2026-02-17T16:08:59.617916Z","steps":["trace[269456900] 'count revisions from in-memory index tree' (duration: 223.698888ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.618229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.334721ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.618249Z","caller":"traceutil/trace.go:171","msg":"trace[63500921] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"215.371203ms","start":"2026-02-17T16:08:59.402873Z","end":"2026-02-17T16:08:59.618244Z","steps":["trace[63500921] 'count revisions from in-memory index tree' (duration: 212.40786ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.618451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.414503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.61847Z","caller":"traceutil/trace.go:171","msg":"trace[939407992] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"220.444334ms","start":"2026-02-17T16:08:59.398021Z","end":"2026-02-17T16:08:59.618466Z","steps":["trace[939407992] 'range keys from in-memory index tree' (duration: 212.615159ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.618582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.263352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.618649Z","caller":"traceutil/trace.go:171","msg":"trace[302628759] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"204.343825ms","start":"2026-02-17T16:08:59.4143Z","end":"2026-02-17T16:08:59.618644Z","steps":["trace[302628759] 'count revisions from in-memory index tree' (duration: 204.236911ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.618761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.518062ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.618796Z","caller":"traceutil/trace.go:171","msg":"trace[118319520] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"204.575613ms","start":"2026-02-17T16:08:59.414216Z","end":"2026-02-17T16:08:59.618792Z","steps":["trace[118319520] 'range keys from in-memory index tree' (duration: 204.396167ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.618987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.38332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.619059Z","caller":"traceutil/trace.go:171","msg":"trace[1782119832] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"198.41131ms","start":"2026-02-17T16:08:59.42059Z","end":"2026-02-17T16:08:59.619001Z","steps":["trace[1782119832] 'count revisions from in-memory index tree' (duration: 198.367389ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.619197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.623309ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.619215Z","caller":"traceutil/trace.go:171","msg":"trace[790966531] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"198.65411ms","start":"2026-02-17T16:08:59.420557Z","end":"2026-02-17T16:08:59.619211Z","steps":["trace[790966531] 'range keys from in-memory index tree' (duration: 198.568006ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.619369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.561497ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.619388Z","caller":"traceutil/trace.go:171","msg":"trace[1343266218] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"188.594129ms","start":"2026-02-17T16:08:59.430789Z","end":"2026-02-17T16:08:59.619384Z","steps":["trace[1343266218] 'count revisions from in-memory index tree' (duration: 188.543067ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.619544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.781566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.619561Z","caller":"traceutil/trace.go:171","msg":"trace[1310973408] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"188.816357ms","start":"2026-02-17T16:08:59.430741Z","end":"2026-02-17T16:08:59.619558Z","steps":["trace[1310973408] 'range keys from in-memory index tree' (duration: 188.708383ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.61971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.693348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.619728Z","caller":"traceutil/trace.go:171","msg":"trace[1134101270] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"181.720949ms","start":"2026-02-17T16:08:59.438004Z","end":"2026-02-17T16:08:59.619725Z","steps":["trace[1134101270] 'count revisions from in-memory index tree' (duration: 181.662236ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.619861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.926677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.619878Z","caller":"traceutil/trace.go:171","msg":"trace[272948806] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"181.964007ms","start":"2026-02-17T16:08:59.43791Z","end":"2026-02-17T16:08:59.619874Z","steps":["trace[272948806] 'range keys from in-memory index tree' (duration: 181.75872ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.620006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.628137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.620028Z","caller":"traceutil/trace.go:171","msg":"trace[1825787667] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"166.659048ms","start":"2026-02-17T16:08:59.453365Z","end":"2026-02-17T16:08:59.620024Z","steps":["trace[1825787667] 'count revisions from in-memory index tree' (duration: 166.606106ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.6202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.873027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.620226Z","caller":"traceutil/trace.go:171","msg":"trace[151934508] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"166.921579ms","start":"2026-02-17T16:08:59.4533Z","end":"2026-02-17T16:08:59.620222Z","steps":["trace[151934508] 'range keys from in-memory index tree' (duration: 166.772963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.620483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.832101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.620503Z","caller":"traceutil/trace.go:171","msg":"trace[1522200006] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"149.870383ms","start":"2026-02-17T16:08:59.470629Z","end":"2026-02-17T16:08:59.620499Z","steps":["trace[1522200006] 'count revisions from in-memory index tree' (duration: 149.771269ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.62066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.116722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.620696Z","caller":"traceutil/trace.go:171","msg":"trace[1469677944] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"150.184974ms","start":"2026-02-17T16:08:59.470507Z","end":"2026-02-17T16:08:59.620692Z","steps":["trace[1469677944] 'range keys from in-memory index tree' (duration: 149.938686ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.621485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.052727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.625193Z","caller":"traceutil/trace.go:171","msg":"trace[1426744236] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"136.786337ms","start":"2026-02-17T16:08:59.488398Z","end":"2026-02-17T16:08:59.625185Z","steps":["trace[1426744236] 'count revisions from in-memory index tree' (duration: 133.017455ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.621518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.168271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.625447Z","caller":"traceutil/trace.go:171","msg":"trace[467263414] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"137.12598ms","start":"2026-02-17T16:08:59.488316Z","end":"2026-02-17T16:08:59.625442Z","steps":["trace[467263414] 'range keys from in-memory index tree' (duration: 133.048386ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.621532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.275879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.625774Z","caller":"traceutil/trace.go:171","msg":"trace[173037728] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"126.525569ms","start":"2026-02-17T16:08:59.499242Z","end":"2026-02-17T16:08:59.625768Z","steps":["trace[173037728] 'count revisions from in-memory index tree' (duration: 122.240237ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.621548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.338151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.626052Z","caller":"traceutil/trace.go:171","msg":"trace[1581955598] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"126.876513ms","start":"2026-02-17T16:08:59.499169Z","end":"2026-02-17T16:08:59.626046Z","steps":["trace[1581955598] 'range keys from in-memory index tree' (duration: 122.242568ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.621561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.389196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.626417Z","caller":"traceutil/trace.go:171","msg":"trace[1789619709] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"116.179378ms","start":"2026-02-17T16:08:59.510162Z","end":"2026-02-17T16:08:59.626341Z","steps":["trace[1789619709] 'count revisions from in-memory index tree' (duration: 111.374006ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.621574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.527152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.626721Z","caller":"traceutil/trace.go:171","msg":"trace[1188114113] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"116.619845ms","start":"2026-02-17T16:08:59.510035Z","end":"2026-02-17T16:08:59.626654Z","steps":["trace[1188114113] 'range keys from in-memory index tree' (duration: 111.376637ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.621586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.71665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.626914Z","caller":"traceutil/trace.go:171","msg":"trace[716041526] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"107.073213ms","start":"2026-02-17T16:08:59.519835Z","end":"2026-02-17T16:08:59.626908Z","steps":["trace[716041526] 'count revisions from in-memory index tree' (duration: 101.69979ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:08:59.6216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.793514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:08:59.627144Z","caller":"traceutil/trace.go:171","msg":"trace[136438221] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"107.347793ms","start":"2026-02-17T16:08:59.519791Z","end":"2026-02-17T16:08:59.627139Z","steps":["trace[136438221] 'range keys from in-memory index tree' (duration: 101.70411ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.040552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.026029ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:14"} {"level":"info","ts":"2026-02-17T16:09:01.040881Z","caller":"traceutil/trace.go:171","msg":"trace[339681221] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:5; }","duration":"376.513542ms","start":"2026-02-17T16:09:00.664354Z","end":"2026-02-17T16:09:01.040868Z","steps":["trace[339681221] 'read index received' (duration: 78.352124ms)","trace[339681221] 'applied index is now lower than readState.Index' (duration: 298.160728ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:01.040943Z","caller":"traceutil/trace.go:171","msg":"trace[1202248] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"373.866833ms","start":"2026-02-17T16:09:00.667069Z","end":"2026-02-17T16:09:01.040936Z","steps":["trace[1202248] 'process raft request' (duration: 373.560651ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:01.041099Z","caller":"traceutil/trace.go:171","msg":"trace[182852472] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"383.746193ms","start":"2026-02-17T16:09:00.657327Z","end":"2026-02-17T16:09:01.041074Z","steps":["trace[182852472] 'process raft request' (duration: 180.413146ms)","trace[182852472] 'compare' (duration: 201.899544ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:01.043951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.65732Z","time spent":"386.566127ms","remote":"127.0.0.1:52354","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:01.041244Z","caller":"traceutil/trace.go:171","msg":"trace[1192441230] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"370.180014ms","start":"2026-02-17T16:09:00.671054Z","end":"2026-02-17T16:09:01.041234Z","steps":["trace[1192441230] 'process raft request' (duration: 369.724847ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.044904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.671048Z","time spent":"373.800359ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:01.041342Z","caller":"traceutil/trace.go:171","msg":"trace[529256916] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"371.099498ms","start":"2026-02-17T16:09:00.670236Z","end":"2026-02-17T16:09:01.041335Z","steps":["trace[529256916] 'process raft request' (duration: 370.476355ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.045226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.670227Z","time spent":"374.865229ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:01.041362Z","caller":"traceutil/trace.go:171","msg":"trace[1622757075] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"370.501576ms","start":"2026-02-17T16:09:00.670856Z","end":"2026-02-17T16:09:01.041358Z","steps":["trace[1622757075] 'process raft request' (duration: 369.904924ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.045556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.670849Z","time spent":"374.64295ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:01.041578Z","caller":"traceutil/trace.go:171","msg":"trace[1847433045] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"369.951685ms","start":"2026-02-17T16:09:00.671619Z","end":"2026-02-17T16:09:01.04157Z","steps":["trace[1847433045] 'process raft request' (duration: 369.224688ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.04604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.671614Z","time spent":"374.186942ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:01.041599Z","caller":"traceutil/trace.go:171","msg":"trace[1395009733] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"370.033658ms","start":"2026-02-17T16:09:00.671561Z","end":"2026-02-17T16:09:01.041595Z","steps":["trace[1395009733] 'process raft request' (duration: 369.237589ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.04633Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.671548Z","time spent":"374.730623ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:01.041722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.350683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-17T16:09:01.043834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.667059Z","time spent":"376.709018ms","remote":"127.0.0.1:52750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:01.046694Z","caller":"traceutil/trace.go:171","msg":"trace[1881300001] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:9; }","duration":"382.238484ms","start":"2026-02-17T16:09:00.664336Z","end":"2026-02-17T16:09:01.046575Z","steps":["trace[1881300001] 'agreement among raft nodes before linearized reading' (duration: 377.298561ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.046777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.664329Z","time spent":"382.389879ms","remote":"127.0.0.1:52694","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"info","ts":"2026-02-17T16:09:01.078255Z","caller":"traceutil/trace.go:171","msg":"trace[1467702983] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"219.186306ms","start":"2026-02-17T16:09:00.858895Z","end":"2026-02-17T16:09:01.078081Z","steps":["trace[1467702983] 'process raft request' (duration: 219.046471ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.849513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.625136ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-17T16:09:01.850016Z","caller":"traceutil/trace.go:171","msg":"trace[2003999829] linearizableReadLoop","detail":"{readStateIndex:14; appliedIndex:12; }","duration":"809.057748ms","start":"2026-02-17T16:09:01.040908Z","end":"2026-02-17T16:09:01.849965Z","steps":["trace[2003999829] 'read index received' (duration: 37.094864ms)","trace[2003999829] 'applied index is now lower than readState.Index' (duration: 771.961964ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:01.850263Z","caller":"traceutil/trace.go:171","msg":"trace[558473899] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"797.740329ms","start":"2026-02-17T16:09:01.052299Z","end":"2026-02-17T16:09:01.85004Z","steps":["trace[558473899] 'process raft request' (duration: 797.591573ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:01.850411Z","caller":"traceutil/trace.go:171","msg":"trace[1819094526] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"797.610063ms","start":"2026-02-17T16:09:01.052776Z","end":"2026-02-17T16:09:01.850386Z","steps":["trace[1819094526] 'process raft request' (duration: 797.136686ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.850737Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:01.052769Z","time spent":"797.845473ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:01.851042Z","caller":"traceutil/trace.go:171","msg":"trace[432189457] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"798.211296ms","start":"2026-02-17T16:09:01.052817Z","end":"2026-02-17T16:09:01.851028Z","steps":["trace[432189457] 'process raft request' (duration: 797.118996ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.851138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:01.052813Z","time spent":"798.264098ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:01.851359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:01.052233Z","time spent":"798.263139ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:01.851653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"931.842849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:01.851711Z","caller":"traceutil/trace.go:171","msg":"trace[1119592284] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:17; }","duration":"931.955603ms","start":"2026-02-17T16:09:00.919744Z","end":"2026-02-17T16:09:01.851699Z","steps":["trace[1119592284] 'agreement among raft nodes before linearized reading' (duration: 931.584469ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.851784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.919714Z","time spent":"932.054287ms","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-node-lease/instance\" "} {"level":"warn","ts":"2026-02-17T16:09:01.851985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.131487263s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:01.852041Z","caller":"traceutil/trace.go:171","msg":"trace[1106867163] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:17; }","duration":"1.131562726s","start":"2026-02-17T16:09:00.720463Z","end":"2026-02-17T16:09:01.852026Z","steps":["trace[1106867163] 'agreement among raft nodes before linearized reading' (duration: 1.131492134s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.852135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.720448Z","time spent":"1.131672131s","remote":"127.0.0.1:52414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-17T16:09:01.852453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.150975163s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:01.852504Z","caller":"traceutil/trace.go:171","msg":"trace[1600681266] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:17; }","duration":"1.151060376s","start":"2026-02-17T16:09:00.70143Z","end":"2026-02-17T16:09:01.85249Z","steps":["trace[1600681266] 'agreement among raft nodes before linearized reading' (duration: 1.150975123s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.852728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.701416Z","time spent":"1.151292816s","remote":"127.0.0.1:52414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-02-17T16:09:01.852984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.185504316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:01.853046Z","caller":"traceutil/trace.go:171","msg":"trace[796810170] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:17; }","duration":"1.185571229s","start":"2026-02-17T16:09:00.667461Z","end":"2026-02-17T16:09:01.853032Z","steps":["trace[796810170] 'agreement among raft nodes before linearized reading' (duration: 1.185491406s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.853116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.667456Z","time spent":"1.185649081s","remote":"127.0.0.1:52378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"info","ts":"2026-02-17T16:09:01.852988Z","caller":"traceutil/trace.go:171","msg":"trace[1234450598] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"819.024378ms","start":"2026-02-17T16:09:01.033899Z","end":"2026-02-17T16:09:01.852924Z","steps":["trace[1234450598] 'process raft request' (duration: 413.913342ms)","trace[1234450598] 'compare' (duration: 401.45388ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:01.853457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.187170009s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.12\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:01.853499Z","caller":"traceutil/trace.go:171","msg":"trace[2039043298] range","detail":"{range_begin:/registry/masterleases/199.19.213.12; range_end:; response_count:0; response_revision:17; }","duration":"1.18721952s","start":"2026-02-17T16:09:00.666269Z","end":"2026-02-17T16:09:01.853489Z","steps":["trace[2039043298] 'agreement among raft nodes before linearized reading' (duration: 1.187159408s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.853569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.666264Z","time spent":"1.187291123s","remote":"127.0.0.1:52312","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.12\" "} {"level":"warn","ts":"2026-02-17T16:09:01.853745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:01.033874Z","time spent":"819.579498ms","remote":"127.0.0.1:52480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2846,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:01.854021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"803.460001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:2858"} {"level":"info","ts":"2026-02-17T16:09:01.854066Z","caller":"traceutil/trace.go:171","msg":"trace[330395672] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:17; }","duration":"803.526654ms","start":"2026-02-17T16:09:01.050529Z","end":"2026-02-17T16:09:01.854056Z","steps":["trace[330395672] 'agreement among raft nodes before linearized reading' (duration: 803.44427ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.854137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:01.050517Z","time spent":"803.608626ms","remote":"127.0.0.1:52480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":2881,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-02-17T16:09:01.854518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.704258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:01.854583Z","caller":"traceutil/trace.go:171","msg":"trace[795620386] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17; }","duration":"165.791261ms","start":"2026-02-17T16:09:01.688768Z","end":"2026-02-17T16:09:01.854559Z","steps":["trace[795620386] 'agreement among raft nodes before linearized reading' (duration: 165.715078ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.854937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.894287ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:01.854978Z","caller":"traceutil/trace.go:171","msg":"trace[2122860770] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:17; }","duration":"286.97971ms","start":"2026-02-17T16:09:01.567989Z","end":"2026-02-17T16:09:01.854969Z","steps":["trace[2122860770] 'agreement among raft nodes before linearized reading' (duration: 286.915358ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.855208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.79365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/system-node-critical\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:01.855247Z","caller":"traceutil/trace.go:171","msg":"trace[335656413] range","detail":"{range_begin:/registry/priorityclasses/system-node-critical; range_end:; response_count:0; response_revision:17; }","duration":"287.933595ms","start":"2026-02-17T16:09:01.567305Z","end":"2026-02-17T16:09:01.855238Z","steps":["trace[335656413] 'agreement among raft nodes before linearized reading' (duration: 287.870563ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.85549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"772.640609ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-94d26\" ","response":"range_response_count:1 size:861"} {"level":"info","ts":"2026-02-17T16:09:01.855528Z","caller":"traceutil/trace.go:171","msg":"trace[957242833] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-94d26; range_end:; response_count:1; response_revision:17; }","duration":"772.710962ms","start":"2026-02-17T16:09:01.082808Z","end":"2026-02-17T16:09:01.855519Z","steps":["trace[957242833] 'agreement among raft nodes before linearized reading' (duration: 772.645569ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.855678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:01.082771Z","time spent":"772.855717ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":884,"request content":"key:\"/registry/certificatesigningrequests/csr-94d26\" "} {"level":"info","ts":"2026-02-17T16:09:01.857884Z","caller":"traceutil/trace.go:171","msg":"trace[608404881] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"807.273942ms","start":"2026-02-17T16:09:01.050596Z","end":"2026-02-17T16:09:01.85787Z","steps":["trace[608404881] 'process raft request' (duration: 799.025596ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.858085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:01.050588Z","time spent":"807.453359ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:01.858536Z","caller":"traceutil/trace.go:171","msg":"trace[475309545] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"807.028843ms","start":"2026-02-17T16:09:01.051497Z","end":"2026-02-17T16:09:01.858526Z","steps":["trace[475309545] 'process raft request' (duration: 798.243998ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.858705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:01.051459Z","time spent":"807.20978ms","remote":"127.0.0.1:52750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:01.859007Z","caller":"traceutil/trace.go:171","msg":"trace[1913322131] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"807.370726ms","start":"2026-02-17T16:09:01.051626Z","end":"2026-02-17T16:09:01.858996Z","steps":["trace[1913322131] 'process raft request' (duration: 798.233027ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.859175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:01.05162Z","time spent":"807.528771ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:01.853382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.186250704s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:01.859473Z","caller":"traceutil/trace.go:171","msg":"trace[19147124] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:17; }","duration":"1.1923507s","start":"2026-02-17T16:09:00.667112Z","end":"2026-02-17T16:09:01.859463Z","steps":["trace[19147124] 'agreement among raft nodes before linearized reading' (duration: 1.186241053s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:01.859612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:00.667107Z","time spent":"1.192461794s","remote":"127.0.0.1:52414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-02-17T16:09:02.052417Z","caller":"traceutil/trace.go:171","msg":"trace[551724274] transaction","detail":"{read_only:false; response_revision:27; number_of_response:1; }","duration":"124.532162ms","start":"2026-02-17T16:09:01.927868Z","end":"2026-02-17T16:09:02.0524Z","steps":["trace[551724274] 'process raft request' (duration: 124.507761ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.053081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.071052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:02.053318Z","caller":"traceutil/trace.go:171","msg":"trace[339575733] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:27; }","duration":"179.318202ms","start":"2026-02-17T16:09:01.873989Z","end":"2026-02-17T16:09:02.053307Z","steps":["trace[339575733] 'agreement among raft nodes before linearized reading' (duration: 178.99051ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.052584Z","caller":"traceutil/trace.go:171","msg":"trace[913259582] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"181.066917ms","start":"2026-02-17T16:09:01.871455Z","end":"2026-02-17T16:09:02.052522Z","steps":["trace[913259582] 'process raft request' (duration: 152.478479ms)","trace[913259582] 'compare' (duration: 28.1117ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:02.052636Z","caller":"traceutil/trace.go:171","msg":"trace[1243406626] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"177.617429ms","start":"2026-02-17T16:09:01.875011Z","end":"2026-02-17T16:09:02.052629Z","steps":["trace[1243406626] 'process raft request' (duration: 177.207044ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.052714Z","caller":"traceutil/trace.go:171","msg":"trace[1141118643] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"177.517665ms","start":"2026-02-17T16:09:01.875134Z","end":"2026-02-17T16:09:02.052652Z","steps":["trace[1141118643] 'process raft request' (duration: 177.117701ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.052734Z","caller":"traceutil/trace.go:171","msg":"trace[1597193255] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"177.558476ms","start":"2026-02-17T16:09:01.875171Z","end":"2026-02-17T16:09:02.052729Z","steps":["trace[1597193255] 'process raft request' (duration: 177.10169ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.052749Z","caller":"traceutil/trace.go:171","msg":"trace[1942847394] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"177.489474ms","start":"2026-02-17T16:09:01.875256Z","end":"2026-02-17T16:09:02.052746Z","steps":["trace[1942847394] 'process raft request' (duration: 177.036257ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.052778Z","caller":"traceutil/trace.go:171","msg":"trace[1880461995] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"181.244663ms","start":"2026-02-17T16:09:01.871525Z","end":"2026-02-17T16:09:02.05277Z","steps":["trace[1880461995] 'process raft request' (duration: 180.63148ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.052819Z","caller":"traceutil/trace.go:171","msg":"trace[1264860091] transaction","detail":"{read_only:false; number_of_response:0; response_revision:20; }","duration":"179.027361ms","start":"2026-02-17T16:09:01.873788Z","end":"2026-02-17T16:09:02.052815Z","steps":["trace[1264860091] 'process raft request' (duration: 178.410209ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.052896Z","caller":"traceutil/trace.go:171","msg":"trace[827104949] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"176.541539ms","start":"2026-02-17T16:09:01.876345Z","end":"2026-02-17T16:09:02.052887Z","steps":["trace[827104949] 'process raft request' (duration: 175.963208ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.052921Z","caller":"traceutil/trace.go:171","msg":"trace[1494930071] transaction","detail":"{read_only:false; response_revision:26; number_of_response:1; }","duration":"176.472856ms","start":"2026-02-17T16:09:01.876442Z","end":"2026-02-17T16:09:02.052914Z","steps":["trace[1494930071] 'process raft request' (duration: 175.905605ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.052939Z","caller":"traceutil/trace.go:171","msg":"trace[943067946] linearizableReadLoop","detail":"{readStateIndex:24; appliedIndex:21; }","duration":"178.939708ms","start":"2026-02-17T16:09:01.873992Z","end":"2026-02-17T16:09:02.052932Z","steps":["trace[943067946] 'read index received' (duration: 14.791478ms)","trace[943067946] 'applied index is now lower than readState.Index' (duration: 164.14749ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:02.055829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.763663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:2858"} {"level":"info","ts":"2026-02-17T16:09:02.055958Z","caller":"traceutil/trace.go:171","msg":"trace[899659696] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:27; }","duration":"177.901928ms","start":"2026-02-17T16:09:01.878047Z","end":"2026-02-17T16:09:02.055949Z","steps":["trace[899659696] 'agreement among raft nodes before linearized reading' (duration: 177.364739ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.056261Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.959053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-node-lease\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:02.056339Z","caller":"traceutil/trace.go:171","msg":"trace[581007725] range","detail":"{range_begin:/registry/namespaces/kube-node-lease; range_end:; response_count:0; response_revision:27; }","duration":"133.099658ms","start":"2026-02-17T16:09:01.923211Z","end":"2026-02-17T16:09:02.05631Z","steps":["trace[581007725] 'agreement among raft nodes before linearized reading' (duration: 133.016555ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.056674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.47296ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:02.056906Z","caller":"traceutil/trace.go:171","msg":"trace[535354995] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:27; }","duration":"164.73712ms","start":"2026-02-17T16:09:01.892158Z","end":"2026-02-17T16:09:02.056895Z","steps":["trace[535354995] 'agreement among raft nodes before linearized reading' (duration: 164.489101ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.794052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.435836ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-17T16:09:02.794421Z","caller":"traceutil/trace.go:171","msg":"trace[1056179019] linearizableReadLoop","detail":"{readStateIndex:34; appliedIndex:31; }","duration":"718.944685ms","start":"2026-02-17T16:09:02.075458Z","end":"2026-02-17T16:09:02.794402Z","steps":["trace[1056179019] 'read index received' (duration: 11.345426ms)","trace[1056179019] 'applied index is now lower than readState.Index' (duration: 707.598249ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:02.794764Z","caller":"traceutil/trace.go:171","msg":"trace[292178951] transaction","detail":"{read_only:false; response_revision:29; number_of_response:1; }","duration":"722.739724ms","start":"2026-02-17T16:09:02.07201Z","end":"2026-02-17T16:09:02.79475Z","steps":["trace[292178951] 'process raft request' (duration: 274.54592ms)","trace[292178951] 'compare' (duration: 447.309512ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:02.794848Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.072001Z","time spent":"722.817308ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:02.795146Z","caller":"traceutil/trace.go:171","msg":"trace[678174953] transaction","detail":"{read_only:false; response_revision:30; number_of_response:1; }","duration":"719.762405ms","start":"2026-02-17T16:09:02.075372Z","end":"2026-02-17T16:09:02.795134Z","steps":["trace[678174953] 'process raft request' (duration: 718.781879ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.795257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.075351Z","time spent":"719.87632ms","remote":"127.0.0.1:52750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":713,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:02.795393Z","caller":"traceutil/trace.go:171","msg":"trace[721248642] transaction","detail":"{read_only:false; response_revision:31; number_of_response:1; }","duration":"719.588489ms","start":"2026-02-17T16:09:02.075795Z","end":"2026-02-17T16:09:02.795384Z","steps":["trace[721248642] 'process raft request' (duration: 718.416756ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.795445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.075788Z","time spent":"719.634721ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:02.795564Z","caller":"traceutil/trace.go:171","msg":"trace[1581543059] transaction","detail":"{read_only:false; response_revision:32; number_of_response:1; }","duration":"719.649832ms","start":"2026-02-17T16:09:02.075905Z","end":"2026-02-17T16:09:02.795555Z","steps":["trace[1581543059] 'process raft request' (duration: 718.347184ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.797122Z","caller":"traceutil/trace.go:171","msg":"trace[1679695903] transaction","detail":"{read_only:false; response_revision:33; number_of_response:1; }","duration":"721.146186ms","start":"2026-02-17T16:09:02.075947Z","end":"2026-02-17T16:09:02.797093Z","steps":["trace[1679695903] 'process raft request' (duration: 718.357514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.79805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.075941Z","time spent":"722.0733ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":959,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:02.797249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.075897Z","time spent":"719.694983ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":926,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:02.797696Z","caller":"traceutil/trace.go:171","msg":"trace[791350047] transaction","detail":"{read_only:false; response_revision:35; number_of_response:1; }","duration":"721.572872ms","start":"2026-02-17T16:09:02.076114Z","end":"2026-02-17T16:09:02.797687Z","steps":["trace[791350047] 'process raft request' (duration: 718.25376ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.798552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.076107Z","time spent":"722.423483ms","remote":"127.0.0.1:52656","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:02.797725Z","caller":"traceutil/trace.go:171","msg":"trace[281594350] transaction","detail":"{read_only:false; response_revision:34; number_of_response:1; }","duration":"721.730118ms","start":"2026-02-17T16:09:02.075985Z","end":"2026-02-17T16:09:02.797716Z","steps":["trace[281594350] 'process raft request' (duration: 718.355384ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.798849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.07598Z","time spent":"722.845778ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":983,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:02.797854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.382681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:02.799132Z","caller":"traceutil/trace.go:171","msg":"trace[51960376] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:0; response_revision:35; }","duration":"723.689739ms","start":"2026-02-17T16:09:02.075431Z","end":"2026-02-17T16:09:02.799121Z","steps":["trace[51960376] 'agreement among raft nodes before linearized reading' (duration: 722.34714ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.797902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.384551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-17T16:09:02.797923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.87791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-17T16:09:02.797945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.584299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-17T16:09:02.797965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"722.425193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-02-17T16:09:02.80025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.075424Z","time spent":"724.81071ms","remote":"127.0.0.1:52408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":27,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"info","ts":"2026-02-17T16:09:02.800428Z","caller":"traceutil/trace.go:171","msg":"trace[271278339] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:35; }","duration":"724.907204ms","start":"2026-02-17T16:09:02.075503Z","end":"2026-02-17T16:09:02.80041Z","steps":["trace[271278339] 'agreement among raft nodes before linearized reading' (duration: 722.385571ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.801329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.075498Z","time spent":"725.821457ms","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":27,"request content":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" "} {"level":"info","ts":"2026-02-17T16:09:02.800628Z","caller":"traceutil/trace.go:171","msg":"trace[2127632932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:35; }","duration":"111.639781ms","start":"2026-02-17T16:09:02.688975Z","end":"2026-02-17T16:09:02.800615Z","steps":["trace[2127632932] 'agreement among raft nodes before linearized reading' (duration: 108.936182ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:02.800841Z","caller":"traceutil/trace.go:171","msg":"trace[1400909062] range","detail":"{range_begin:/registry/resourcequotas/kube-node-lease/; range_end:/registry/resourcequotas/kube-node-lease0; response_count:0; response_revision:35; }","duration":"710.485156ms","start":"2026-02-17T16:09:02.090339Z","end":"2026-02-17T16:09:02.800824Z","steps":["trace[1400909062] 'agreement among raft nodes before linearized reading' (duration: 707.59244ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.801624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.090329Z","time spent":"711.286105ms","remote":"127.0.0.1:52378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-node-lease/\" range_end:\"/registry/resourcequotas/kube-node-lease0\" "} {"level":"info","ts":"2026-02-17T16:09:02.801237Z","caller":"traceutil/trace.go:171","msg":"trace[1423831689] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:35; }","duration":"725.584718ms","start":"2026-02-17T16:09:02.075526Z","end":"2026-02-17T16:09:02.801111Z","steps":["trace[1423831689] 'agreement among raft nodes before linearized reading' (duration: 722.427882ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:02.801782Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.075523Z","time spent":"726.251094ms","remote":"127.0.0.1:52650","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-02-17T16:09:03.288902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.025198ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-02-17T16:09:03.289056Z","caller":"traceutil/trace.go:171","msg":"trace[572663151] transaction","detail":"{read_only:false; response_revision:36; number_of_response:1; }","duration":"479.818899ms","start":"2026-02-17T16:09:02.809163Z","end":"2026-02-17T16:09:03.288982Z","steps":["trace[572663151] 'process raft request' (duration: 160.653536ms)","trace[572663151] 'compare' (duration: 318.825941ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:03.289369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.809153Z","time spent":"480.023916ms","remote":"127.0.0.1:52414","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":350,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:03.316469Z","caller":"traceutil/trace.go:171","msg":"trace[111691930] linearizableReadLoop","detail":"{readStateIndex:43; appliedIndex:39; }","duration":"505.484689ms","start":"2026-02-17T16:09:02.810963Z","end":"2026-02-17T16:09:03.316447Z","steps":["trace[111691930] 'read index received' (duration: 158.958804ms)","trace[111691930] 'applied index is now lower than readState.Index' (duration: 346.524875ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:03.316746Z","caller":"traceutil/trace.go:171","msg":"trace[1044031738] transaction","detail":"{read_only:false; response_revision:39; number_of_response:1; }","duration":"505.646665ms","start":"2026-02-17T16:09:02.810923Z","end":"2026-02-17T16:09:03.31657Z","steps":["trace[1044031738] 'process raft request' (duration: 505.453518ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:03.316959Z","caller":"traceutil/trace.go:171","msg":"trace[1596399250] transaction","detail":"{read_only:false; response_revision:38; number_of_response:1; }","duration":"506.050629ms","start":"2026-02-17T16:09:02.810893Z","end":"2026-02-17T16:09:03.316944Z","steps":["trace[1596399250] 'process raft request' (duration: 505.450357ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:03.317107Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.810889Z","time spent":"506.175333ms","remote":"127.0.0.1:52842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":950,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:03.317248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.81092Z","time spent":"505.912864ms","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:03.316758Z","caller":"traceutil/trace.go:171","msg":"trace[855216642] transaction","detail":"{read_only:false; response_revision:37; number_of_response:1; }","duration":"505.905244ms","start":"2026-02-17T16:09:02.810834Z","end":"2026-02-17T16:09:03.316739Z","steps":["trace[855216642] 'process raft request' (duration: 505.407346ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:03.318096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.810818Z","time spent":"506.988483ms","remote":"127.0.0.1:52408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3004,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:03.317771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"445.252352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:03.318492Z","caller":"traceutil/trace.go:171","msg":"trace[373429871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:40; }","duration":"445.936766ms","start":"2026-02-17T16:09:02.872478Z","end":"2026-02-17T16:09:03.318415Z","steps":["trace[373429871] 'agreement among raft nodes before linearized reading' (duration: 445.21117ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:03.318732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.872466Z","time spent":"446.211346ms","remote":"127.0.0.1:52278","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-02-17T16:09:03.319212Z","caller":"traceutil/trace.go:171","msg":"trace[1065851704] transaction","detail":"{read_only:false; response_revision:40; number_of_response:1; }","duration":"508.200778ms","start":"2026-02-17T16:09:02.810992Z","end":"2026-02-17T16:09:03.319192Z","steps":["trace[1065851704] 'process raft request' (duration: 505.414417ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:03.320017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.810988Z","time spent":"508.27962ms","remote":"127.0.0.1:52750","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":711,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:03.319841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.870712ms","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-17T16:09:03.320759Z","caller":"traceutil/trace.go:171","msg":"trace[1352681206] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:40; }","duration":"509.786865ms","start":"2026-02-17T16:09:02.81096Z","end":"2026-02-17T16:09:03.320747Z","steps":["trace[1352681206] 'agreement among raft nodes before linearized reading' (duration: 508.855461ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:03.320936Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:02.81094Z","time spent":"509.932039ms","remote":"127.0.0.1:52650","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":"info","ts":"2026-02-17T16:09:03.427897Z","caller":"traceutil/trace.go:171","msg":"trace[225747287] transaction","detail":"{read_only:false; response_revision:42; number_of_response:1; }","duration":"101.700877ms","start":"2026-02-17T16:09:03.326178Z","end":"2026-02-17T16:09:03.427878Z","steps":["trace[225747287] 'process raft request' (duration: 78.535677ms)","trace[225747287] 'compare' (duration: 22.281868ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:03.427181Z","caller":"traceutil/trace.go:171","msg":"trace[575787397] linearizableReadLoop","detail":"{readStateIndex:46; appliedIndex:44; }","duration":"100.102229ms","start":"2026-02-17T16:09:03.327058Z","end":"2026-02-17T16:09:03.42716Z","steps":["trace[575787397] 'read index received' (duration: 56.967795ms)","trace[575787397] 'applied index is now lower than readState.Index' (duration: 43.133414ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:03.428341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.263531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-view\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-02-17T16:09:03.428436Z","caller":"traceutil/trace.go:171","msg":"trace[1205568195] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-view; range_end:; response_count:0; response_revision:42; }","duration":"101.377035ms","start":"2026-02-17T16:09:03.327046Z","end":"2026-02-17T16:09:03.428423Z","steps":["trace[1205568195] 'agreement among raft nodes before linearized reading' (duration: 101.147107ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:04.492951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.587443ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:04.493488Z","caller":"traceutil/trace.go:171","msg":"trace[2033210662] transaction","detail":"{read_only:false; response_revision:169; number_of_response:1; }","duration":"286.802738ms","start":"2026-02-17T16:09:04.206657Z","end":"2026-02-17T16:09:04.49346Z","steps":["trace[2033210662] 'process raft request' (duration: 162.437147ms)","trace[2033210662] 'compare' (duration: 123.416356ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:04.494137Z","caller":"traceutil/trace.go:171","msg":"trace[530161564] linearizableReadLoop","detail":"{readStateIndex:173; appliedIndex:172; }","duration":"229.314025ms","start":"2026-02-17T16:09:04.264812Z","end":"2026-02-17T16:09:04.494126Z","steps":["trace[530161564] 'read index received' (duration: 104.301071ms)","trace[530161564] 'applied index is now lower than readState.Index' (duration: 125.011654ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:04.494366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.534673ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:2896"} {"level":"info","ts":"2026-02-17T16:09:04.494473Z","caller":"traceutil/trace.go:171","msg":"trace[1787455709] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:169; }","duration":"229.677008ms","start":"2026-02-17T16:09:04.264785Z","end":"2026-02-17T16:09:04.494462Z","steps":["trace[1787455709] 'agreement among raft nodes before linearized reading' (duration: 229.480651ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:04.494819Z","caller":"traceutil/trace.go:171","msg":"trace[867390417] transaction","detail":"{read_only:false; response_revision:170; number_of_response:1; }","duration":"229.922857ms","start":"2026-02-17T16:09:04.264889Z","end":"2026-02-17T16:09:04.494811Z","steps":["trace[867390417] 'process raft request' (duration: 229.193731ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:04.744015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.421341ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:04.74483Z","caller":"traceutil/trace.go:171","msg":"trace[272844755] transaction","detail":"{read_only:false; response_revision:172; number_of_response:1; }","duration":"217.081767ms","start":"2026-02-17T16:09:04.527712Z","end":"2026-02-17T16:09:04.744794Z","steps":["trace[272844755] 'process raft request' (duration: 87.994196ms)","trace[272844755] 'compare' (duration: 127.191403ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:04.745086Z","caller":"traceutil/trace.go:171","msg":"trace[1802430161] linearizableReadLoop","detail":"{readStateIndex:176; appliedIndex:175; }","duration":"188.542213ms","start":"2026-02-17T16:09:04.556523Z","end":"2026-02-17T16:09:04.745065Z","steps":["trace[1802430161] 'read index received' (duration: 59.092319ms)","trace[1802430161] 'applied index is now lower than readState.Index' (duration: 129.446993ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:04.748671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.134031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:resourcequota-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:04.748735Z","caller":"traceutil/trace.go:171","msg":"trace[517552987] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:resourcequota-controller; range_end:; response_count:0; response_revision:172; }","duration":"192.244926ms","start":"2026-02-17T16:09:04.556472Z","end":"2026-02-17T16:09:04.748717Z","steps":["trace[517552987] 'agreement among raft nodes before linearized reading' (duration: 188.801082ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:05.053309Z","caller":"traceutil/trace.go:171","msg":"trace[2023695813] transaction","detail":"{read_only:false; response_revision:180; number_of_response:1; }","duration":"123.322524ms","start":"2026-02-17T16:09:04.929924Z","end":"2026-02-17T16:09:05.053247Z","steps":["trace[2023695813] 'process raft request' (duration: 56.173125ms)","trace[2023695813] 'compare' (duration: 66.666911ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:05.054655Z","caller":"traceutil/trace.go:171","msg":"trace[1568136684] linearizableReadLoop","detail":"{readStateIndex:184; appliedIndex:183; }","duration":"109.339322ms","start":"2026-02-17T16:09:04.945301Z","end":"2026-02-17T16:09:05.054641Z","steps":["trace[1568136684] 'read index received' (duration: 40.743392ms)","trace[1568136684] 'applied index is now lower than readState.Index' (duration: 68.59473ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:05.054753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.431535ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:pvc-protection-controller\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:05.056323Z","caller":"traceutil/trace.go:171","msg":"trace[1484672540] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:pvc-protection-controller; range_end:; response_count:0; response_revision:180; }","duration":"110.988841ms","start":"2026-02-17T16:09:04.945269Z","end":"2026-02-17T16:09:05.056257Z","steps":["trace[1484672540] 'agreement among raft nodes before linearized reading' (duration: 109.438045ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:05.387049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.067167ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:05.387199Z","caller":"traceutil/trace.go:171","msg":"trace[1059995728] transaction","detail":"{read_only:false; response_revision:184; number_of_response:1; }","duration":"246.586071ms","start":"2026-02-17T16:09:05.140587Z","end":"2026-02-17T16:09:05.387173Z","steps":["trace[1059995728] 'process raft request' (duration: 103.303056ms)","trace[1059995728] 'compare' (duration: 142.86405ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:05.668451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.047042ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:05.668675Z","caller":"traceutil/trace.go:171","msg":"trace[1918557403] transaction","detail":"{read_only:false; response_revision:188; number_of_response:1; }","duration":"184.748107ms","start":"2026-02-17T16:09:05.483905Z","end":"2026-02-17T16:09:05.668653Z","steps":["trace[1918557403] 'process raft request' (duration: 51.435705ms)","trace[1918557403] 'compare' (duration: 132.845635ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:05.80937Z","caller":"traceutil/trace.go:171","msg":"trace[480455838] transaction","detail":"{read_only:false; response_revision:189; number_of_response:1; }","duration":"131.073322ms","start":"2026-02-17T16:09:05.678271Z","end":"2026-02-17T16:09:05.809344Z","steps":["trace[480455838] 'process raft request' (duration: 113.766048ms)","trace[480455838] 'compare' (duration: 16.91961ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:06.083764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.291255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:06.083972Z","caller":"traceutil/trace.go:171","msg":"trace[608119784] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::extension-apiserver-authentication-reader; range_end:; response_count:0; response_revision:191; }","duration":"174.502953ms","start":"2026-02-17T16:09:05.909421Z","end":"2026-02-17T16:09:06.083924Z","steps":["trace[608119784] 'range keys from in-memory index tree' (duration: 174.225933ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:06.609535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.280223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:06.609663Z","caller":"traceutil/trace.go:171","msg":"trace[2124458676] transaction","detail":"{read_only:false; response_revision:193; number_of_response:1; }","duration":"512.339592ms","start":"2026-02-17T16:09:06.097304Z","end":"2026-02-17T16:09:06.609643Z","steps":["trace[2124458676] 'process raft request' (duration: 315.853432ms)","trace[2124458676] 'compare' (duration: 196.153878ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:06.609729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.097296Z","time spent":"512.403444ms","remote":"127.0.0.1:52574","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-17T16:09:06.629251Z","caller":"traceutil/trace.go:171","msg":"trace[1046286343] transaction","detail":"{read_only:false; response_revision:194; number_of_response:1; }","duration":"438.192278ms","start":"2026-02-17T16:09:06.19104Z","end":"2026-02-17T16:09:06.629232Z","steps":["trace[1046286343] 'process raft request' (duration: 437.808894ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:06.629613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.191015Z","time spent":"438.285611ms","remote":"127.0.0.1:52646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":841,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:06.630475Z","caller":"traceutil/trace.go:171","msg":"trace[678521143] transaction","detail":"{read_only:false; response_revision:195; number_of_response:1; }","duration":"260.340102ms","start":"2026-02-17T16:09:06.370122Z","end":"2026-02-17T16:09:06.630463Z","steps":["trace[678521143] 'process raft request' (duration: 260.098684ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:06.630315Z","caller":"traceutil/trace.go:171","msg":"trace[1078522317] linearizableReadLoop","detail":"{readStateIndex:198; appliedIndex:196; }","duration":"422.272209ms","start":"2026-02-17T16:09:06.208028Z","end":"2026-02-17T16:09:06.6303Z","steps":["trace[1078522317] 'read index received' (duration: 205.273259ms)","trace[1078522317] 'applied index is now lower than readState.Index' (duration: 216.99809ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:06.631269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.205422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:06.631317Z","caller":"traceutil/trace.go:171","msg":"trace[1783694737] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:195; }","duration":"423.314866ms","start":"2026-02-17T16:09:06.207991Z","end":"2026-02-17T16:09:06.631306Z","steps":["trace[1783694737] 'agreement among raft nodes before linearized reading' (duration: 423.186441ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:06.63167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.207974Z","time spent":"423.533364ms","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T16:09:07.088158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.4937ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"info","ts":"2026-02-17T16:09:07.088223Z","caller":"traceutil/trace.go:171","msg":"trace[161506794] linearizableReadLoop","detail":"{readStateIndex:202; appliedIndex:201; }","duration":"405.281211ms","start":"2026-02-17T16:09:06.68293Z","end":"2026-02-17T16:09:07.088211Z","steps":["trace[161506794] 'read index received' (duration: 71.743119ms)","trace[161506794] 'applied index is now lower than readState.Index' (duration: 333.537132ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:07.088301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.678243Z","time spent":"410.053749ms","remote":"127.0.0.1:52368","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-02-17T16:09:07.088386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.447457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-scheduler\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:07.088487Z","caller":"traceutil/trace.go:171","msg":"trace[1866035633] range","detail":"{range_begin:/registry/rolebindings/kube-system/system::leader-locking-kube-scheduler; range_end:; response_count:0; response_revision:197; }","duration":"405.554471ms","start":"2026-02-17T16:09:06.682919Z","end":"2026-02-17T16:09:07.088474Z","steps":["trace[1866035633] 'agreement among raft nodes before linearized reading' (duration: 405.423176ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.088551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.682904Z","time spent":"405.636483ms","remote":"127.0.0.1:52646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":0,"response size":28,"request content":"key:\"/registry/rolebindings/kube-system/system::leader-locking-kube-scheduler\" "} {"level":"info","ts":"2026-02-17T16:09:07.090534Z","caller":"traceutil/trace.go:171","msg":"trace[666553112] transaction","detail":"{read_only:false; response_revision:198; number_of_response:1; }","duration":"405.747896ms","start":"2026-02-17T16:09:06.684779Z","end":"2026-02-17T16:09:07.090527Z","steps":["trace[666553112] 'process raft request' (duration: 405.608022ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:07.090646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:06.684766Z","time spent":"405.787388ms","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:09:07.090747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.227432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:07.090812Z","caller":"traceutil/trace.go:171","msg":"trace[422937713] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:198; }","duration":"218.293504ms","start":"2026-02-17T16:09:06.872506Z","end":"2026-02-17T16:09:07.0908Z","steps":["trace[422937713] 'agreement among raft nodes before linearized reading' (duration: 218.158509ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:07.288804Z","caller":"traceutil/trace.go:171","msg":"trace[1236146073] transaction","detail":"{read_only:false; response_revision:202; number_of_response:1; }","duration":"183.30649ms","start":"2026-02-17T16:09:07.105468Z","end":"2026-02-17T16:09:07.288775Z","steps":["trace[1236146073] 'process raft request' (duration: 84.070761ms)","trace[1236146073] 'compare' (duration: 99.088674ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:07.343461Z","caller":"traceutil/trace.go:171","msg":"trace[1244061046] transaction","detail":"{read_only:false; response_revision:203; number_of_response:1; }","duration":"186.448809ms","start":"2026-02-17T16:09:07.156983Z","end":"2026-02-17T16:09:07.343432Z","steps":["trace[1244061046] 'process raft request' (duration: 186.054206ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:07.55239Z","caller":"traceutil/trace.go:171","msg":"trace[527478812] transaction","detail":"{read_only:false; response_revision:206; number_of_response:1; }","duration":"170.749844ms","start":"2026-02-17T16:09:07.381613Z","end":"2026-02-17T16:09:07.552363Z","steps":["trace[527478812] 'process raft request' (duration: 170.700023ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:07.552634Z","caller":"traceutil/trace.go:171","msg":"trace[314908502] transaction","detail":"{read_only:false; response_revision:205; number_of_response:1; }","duration":"172.232096ms","start":"2026-02-17T16:09:07.380371Z","end":"2026-02-17T16:09:07.552603Z","steps":["trace[314908502] 'process raft request' (duration: 89.020224ms)","trace[314908502] 'compare' (duration: 82.782177ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:07.775973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.811292ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:07.776232Z","caller":"traceutil/trace.go:171","msg":"trace[988594391] transaction","detail":"{read_only:false; response_revision:208; number_of_response:1; }","duration":"209.460619ms","start":"2026-02-17T16:09:07.566755Z","end":"2026-02-17T16:09:07.776215Z","steps":["trace[988594391] 'process raft request' (duration: 209.399467ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:07.776462Z","caller":"traceutil/trace.go:171","msg":"trace[1299216433] transaction","detail":"{read_only:false; response_revision:207; number_of_response:1; }","duration":"211.085896ms","start":"2026-02-17T16:09:07.565319Z","end":"2026-02-17T16:09:07.776405Z","steps":["trace[1299216433] 'process raft request' (duration: 101.763496ms)","trace[1299216433] 'compare' (duration: 108.707168ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:07.934789Z","caller":"traceutil/trace.go:171","msg":"trace[829229431] transaction","detail":"{read_only:false; response_revision:210; number_of_response:1; }","duration":"106.964337ms","start":"2026-02-17T16:09:07.827797Z","end":"2026-02-17T16:09:07.934762Z","steps":["trace[829229431] 'process raft request' (duration: 64.15491ms)","trace[829229431] 'compare' (duration: 42.148565ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:07.935037Z","caller":"traceutil/trace.go:171","msg":"trace[753889134] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"106.871144ms","start":"2026-02-17T16:09:07.828148Z","end":"2026-02-17T16:09:07.935019Z","steps":["trace[753889134] 'process raft request' (duration: 106.118188ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:08.687629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.30242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:08.687981Z","caller":"traceutil/trace.go:171","msg":"trace[1690938374] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:257; }","duration":"216.706253ms","start":"2026-02-17T16:09:08.471255Z","end":"2026-02-17T16:09:08.687962Z","steps":["trace[1690938374] 'range keys from in-memory index tree' (duration: 216.240308ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:09.737954Z","caller":"traceutil/trace.go:171","msg":"trace[135104803] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"101.133422ms","start":"2026-02-17T16:09:09.636796Z","end":"2026-02-17T16:09:09.73793Z","steps":["trace[135104803] 'process raft request' (duration: 100.77334ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.037278Z","caller":"traceutil/trace.go:171","msg":"trace[983138845] transaction","detail":"{read_only:false; number_of_response:0; response_revision:324; }","duration":"136.798775ms","start":"2026-02-17T16:09:10.900459Z","end":"2026-02-17T16:09:11.037257Z","steps":["trace[983138845] 'process raft request' (duration: 84.271339ms)","trace[983138845] 'compare' (duration: 52.485025ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:11.078143Z","caller":"traceutil/trace.go:171","msg":"trace[2132925057] transaction","detail":"{read_only:false; response_revision:325; number_of_response:1; }","duration":"169.194603ms","start":"2026-02-17T16:09:10.908935Z","end":"2026-02-17T16:09:11.07813Z","steps":["trace[2132925057] 'process raft request' (duration: 168.7942ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.078805Z","caller":"traceutil/trace.go:171","msg":"trace[95155413] transaction","detail":"{read_only:false; response_revision:326; number_of_response:1; }","duration":"141.494759ms","start":"2026-02-17T16:09:10.937303Z","end":"2026-02-17T16:09:11.078798Z","steps":["trace[95155413] 'process raft request' (duration: 140.504216ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.25668Z","caller":"traceutil/trace.go:171","msg":"trace[1509301379] transaction","detail":"{read_only:false; response_revision:327; number_of_response:1; }","duration":"166.603525ms","start":"2026-02-17T16:09:11.089231Z","end":"2026-02-17T16:09:11.255834Z","steps":["trace[1509301379] 'process raft request' (duration: 142.374357ms)","trace[1509301379] 'compare' (duration: 24.058992ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:11.273966Z","caller":"traceutil/trace.go:171","msg":"trace[428683396] linearizableReadLoop","detail":"{readStateIndex:340; appliedIndex:338; }","duration":"159.989924ms","start":"2026-02-17T16:09:11.113958Z","end":"2026-02-17T16:09:11.273948Z","steps":["trace[428683396] 'read index received' (duration: 117.659853ms)","trace[428683396] 'applied index is now lower than readState.Index' (duration: 42.329391ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:11.274047Z","caller":"traceutil/trace.go:171","msg":"trace[441827085] transaction","detail":"{read_only:false; response_revision:328; number_of_response:1; }","duration":"184.670687ms","start":"2026-02-17T16:09:11.089366Z","end":"2026-02-17T16:09:11.274037Z","steps":["trace[441827085] 'process raft request' (duration: 184.489021ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.274168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.194941ms","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-17T16:09:11.274186Z","caller":"traceutil/trace.go:171","msg":"trace[2086442836] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:328; }","duration":"160.249363ms","start":"2026-02-17T16:09:11.113931Z","end":"2026-02-17T16:09:11.27418Z","steps":["trace[2086442836] 'agreement among raft nodes before linearized reading' (duration: 160.198981ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:11.502182Z","caller":"traceutil/trace.go:171","msg":"trace[1003405991] transaction","detail":"{read_only:false; response_revision:330; number_of_response:1; }","duration":"212.64992ms","start":"2026-02-17T16:09:11.289516Z","end":"2026-02-17T16:09:11.502166Z","steps":["trace[1003405991] 'process raft request' (duration: 186.677694ms)","trace[1003405991] 'compare' (duration: 25.603964ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:11.502342Z","caller":"traceutil/trace.go:171","msg":"trace[803364153] transaction","detail":"{read_only:false; response_revision:331; number_of_response:1; }","duration":"184.306716ms","start":"2026-02-17T16:09:11.318029Z","end":"2026-02-17T16:09:11.502335Z","steps":["trace[803364153] 'process raft request' (duration: 183.851741ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.971042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.813426ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:11.971177Z","caller":"traceutil/trace.go:171","msg":"trace[860903539] transaction","detail":"{read_only:false; response_revision:336; number_of_response:1; }","duration":"386.196557ms","start":"2026-02-17T16:09:11.584969Z","end":"2026-02-17T16:09:11.971165Z","steps":["trace[860903539] 'process raft request' (duration: 386.160366ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:11.971231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:11.584963Z","time spent":"386.252489ms","remote":"127.0.0.1:52512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":199,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:11.971499Z","caller":"traceutil/trace.go:171","msg":"trace[703789425] transaction","detail":"{read_only:false; response_revision:335; number_of_response:1; }","duration":"386.746876ms","start":"2026-02-17T16:09:11.584743Z","end":"2026-02-17T16:09:11.97149Z","steps":["trace[703789425] 'process raft request' (duration: 239.416334ms)","trace[703789425] 'compare' (duration: 146.726212ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:11.971557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:11.584732Z","time spent":"386.803897ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4049,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:12.261375Z","caller":"traceutil/trace.go:171","msg":"trace[421706305] transaction","detail":"{read_only:false; response_revision:339; number_of_response:1; }","duration":"112.536875ms","start":"2026-02-17T16:09:12.148814Z","end":"2026-02-17T16:09:12.261351Z","steps":["trace[421706305] 'process raft request' (duration: 100.603561ms)","trace[421706305] 'compare' (duration: 10.713133ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:12.26304Z","caller":"traceutil/trace.go:171","msg":"trace[1984878807] transaction","detail":"{read_only:false; response_revision:340; number_of_response:1; }","duration":"113.796276ms","start":"2026-02-17T16:09:12.149225Z","end":"2026-02-17T16:09:12.263022Z","steps":["trace[1984878807] 'process raft request' (duration: 111.008214ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:13.671201Z","caller":"traceutil/trace.go:171","msg":"trace[1501457087] linearizableReadLoop","detail":"{readStateIndex:363; appliedIndex:362; }","duration":"324.1445ms","start":"2026-02-17T16:09:13.347036Z","end":"2026-02-17T16:09:13.671181Z","steps":["trace[1501457087] 'read index received' (duration: 10.414941ms)","trace[1501457087] 'applied index is now lower than readState.Index' (duration: 313.728679ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:13.67128Z","caller":"traceutil/trace.go:171","msg":"trace[358433416] transaction","detail":"{read_only:false; response_revision:351; number_of_response:1; }","duration":"337.665371ms","start":"2026-02-17T16:09:13.333608Z","end":"2026-02-17T16:09:13.671273Z","steps":["trace[358433416] 'process raft request' (duration: 337.445223ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:13.67136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.3336Z","time spent":"337.699352ms","remote":"127.0.0.1:52572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2263,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:09:13.67159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.550653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-02-17T16:09:13.671628Z","caller":"traceutil/trace.go:171","msg":"trace[706250890] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:351; }","duration":"324.622565ms","start":"2026-02-17T16:09:13.346997Z","end":"2026-02-17T16:09:13.67162Z","steps":["trace[706250890] 'agreement among raft nodes before linearized reading' (duration: 324.562653ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:13.671648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.346861Z","time spent":"324.781591ms","remote":"127.0.0.1:52512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-02-17T16:09:13.689857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.363638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-17T16:09:13.689951Z","caller":"traceutil/trace.go:171","msg":"trace[548639631] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:352; }","duration":"302.45297ms","start":"2026-02-17T16:09:13.387448Z","end":"2026-02-17T16:09:13.689901Z","steps":["trace[548639631] 'agreement among raft nodes before linearized reading' (duration: 302.361697ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:13.689979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.387434Z","time spent":"302.537924ms","remote":"127.0.0.1:52512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-02-17T16:09:13.691386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.4753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"warn","ts":"2026-02-17T16:09:13.691502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.994617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-17T16:09:13.691528Z","caller":"traceutil/trace.go:171","msg":"trace[1354064193] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:352; }","duration":"254.0659ms","start":"2026-02-17T16:09:13.437453Z","end":"2026-02-17T16:09:13.691519Z","steps":["trace[1354064193] 'agreement among raft nodes before linearized reading' (duration: 254.028409ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:13.691604Z","caller":"traceutil/trace.go:171","msg":"trace[1711289806] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:352; }","duration":"152.716279ms","start":"2026-02-17T16:09:13.538879Z","end":"2026-02-17T16:09:13.691596Z","steps":["trace[1711289806] 'agreement among raft nodes before linearized reading' (duration: 152.468701ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:13.691772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.596373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"warn","ts":"2026-02-17T16:09:13.691431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.457199ms","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-17T16:09:13.692052Z","caller":"traceutil/trace.go:171","msg":"trace[367991648] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:352; }","duration":"160.10755ms","start":"2026-02-17T16:09:13.531938Z","end":"2026-02-17T16:09:13.692045Z","steps":["trace[367991648] 'agreement among raft nodes before linearized reading' (duration: 159.463989ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:13.691469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.57678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-02-17T16:09:13.692289Z","caller":"traceutil/trace.go:171","msg":"trace[1918881478] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:352; }","duration":"204.396507ms","start":"2026-02-17T16:09:13.487886Z","end":"2026-02-17T16:09:13.692282Z","steps":["trace[1918881478] 'agreement among raft nodes before linearized reading' (duration: 203.5626ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:13.691996Z","caller":"traceutil/trace.go:171","msg":"trace[1075647532] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:352; }","duration":"103.865922ms","start":"2026-02-17T16:09:13.588122Z","end":"2026-02-17T16:09:13.691988Z","steps":["trace[1075647532] 'agreement among raft nodes before linearized reading' (duration: 103.630375ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.201382Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184828973,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T16:09:14.409349Z","caller":"traceutil/trace.go:171","msg":"trace[672056865] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"727.720662ms","start":"2026-02-17T16:09:13.681606Z","end":"2026-02-17T16:09:14.409327Z","steps":["trace[672056865] 'process raft request' (duration: 727.610838ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.409471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.681585Z","time spent":"727.828675ms","remote":"127.0.0.1:52792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3620,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:14.439643Z","caller":"traceutil/trace.go:171","msg":"trace[1491062064] linearizableReadLoop","detail":"{readStateIndex:371; appliedIndex:365; }","duration":"738.809684ms","start":"2026-02-17T16:09:13.700814Z","end":"2026-02-17T16:09:14.439624Z","steps":["trace[1491062064] 'read index received' (duration: 709.142434ms)","trace[1491062064] 'applied index is now lower than readState.Index' (duration: 29.66642ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:14.440315Z","caller":"traceutil/trace.go:171","msg":"trace[1647956202] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"737.046707ms","start":"2026-02-17T16:09:13.703251Z","end":"2026-02-17T16:09:14.440298Z","steps":["trace[1647956202] 'process raft request' (duration: 735.91829ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.445624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.703232Z","time spent":"742.294336ms","remote":"127.0.0.1:52574","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-17T16:09:14.440357Z","caller":"traceutil/trace.go:171","msg":"trace[29075038] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"735.098792ms","start":"2026-02-17T16:09:13.705248Z","end":"2026-02-17T16:09:14.440347Z","steps":["trace[29075038] 'process raft request' (duration: 734.206003ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.445945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.705237Z","time spent":"740.613811ms","remote":"127.0.0.1:52368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":649,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:14.440446Z","caller":"traceutil/trace.go:171","msg":"trace[194516431] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"735.141154ms","start":"2026-02-17T16:09:13.705295Z","end":"2026-02-17T16:09:14.440436Z","steps":["trace[194516431] 'process raft request' (duration: 734.195664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.446576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.705291Z","time spent":"741.235661ms","remote":"127.0.0.1:52408","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:14.440477Z","caller":"traceutil/trace.go:171","msg":"trace[302661925] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"732.732365ms","start":"2026-02-17T16:09:13.707738Z","end":"2026-02-17T16:09:14.44047Z","steps":["trace[302661925] 'process raft request' (duration: 731.808005ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.446885Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.707726Z","time spent":"739.108872ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4711,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:14.440501Z","caller":"traceutil/trace.go:171","msg":"trace[1412713074] transaction","detail":"{read_only:false; response_revision:357; number_of_response:1; }","duration":"735.145104ms","start":"2026-02-17T16:09:13.705348Z","end":"2026-02-17T16:09:14.440494Z","steps":["trace[1412713074] 'process raft request' (duration: 734.171723ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.447212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.705344Z","time spent":"741.84204ms","remote":"127.0.0.1:52580","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1050,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:14.440784Z","caller":"traceutil/trace.go:171","msg":"trace[903908550] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"732.86829ms","start":"2026-02-17T16:09:13.707904Z","end":"2026-02-17T16:09:14.440773Z","steps":["trace[903908550] 'process raft request' (duration: 731.676132ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.447506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.707898Z","time spent":"739.577467ms","remote":"127.0.0.1:52480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3998,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:09:14.440871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.035634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-02-17T16:09:14.447802Z","caller":"traceutil/trace.go:171","msg":"trace[1597784994] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:359; }","duration":"747.001209ms","start":"2026-02-17T16:09:13.700788Z","end":"2026-02-17T16:09:14.44779Z","steps":["trace[1597784994] 'agreement among raft nodes before linearized reading' (duration: 740.030664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.447868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.700776Z","time spent":"747.065932ms","remote":"127.0.0.1:52512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":1,"response size":241,"request content":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" "} {"level":"warn","ts":"2026-02-17T16:09:14.490666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.993328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-02-17T16:09:14.490841Z","caller":"traceutil/trace.go:171","msg":"trace[57376095] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:361; }","duration":"752.218225ms","start":"2026-02-17T16:09:13.738605Z","end":"2026-02-17T16:09:14.490823Z","steps":["trace[57376095] 'agreement among raft nodes before linearized reading' (duration: 751.874484ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.490985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.738557Z","time spent":"752.413492ms","remote":"127.0.0.1:52512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"warn","ts":"2026-02-17T16:09:14.49152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"653.392627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-02-17T16:09:14.491588Z","caller":"traceutil/trace.go:171","msg":"trace[1093521654] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:361; }","duration":"653.5015ms","start":"2026-02-17T16:09:13.838071Z","end":"2026-02-17T16:09:14.491573Z","steps":["trace[1093521654] 'agreement among raft nodes before linearized reading' (duration: 653.393087ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.491626Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.838054Z","time spent":"653.564162ms","remote":"127.0.0.1:52512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-02-17T16:09:14.491884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"703.70199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-02-17T16:09:14.492031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.301493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-02-17T16:09:14.492091Z","caller":"traceutil/trace.go:171","msg":"trace[226414247] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:361; }","duration":"604.371855ms","start":"2026-02-17T16:09:13.887686Z","end":"2026-02-17T16:09:14.492058Z","steps":["trace[226414247] 'agreement among raft nodes before linearized reading' (duration: 604.271642ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.492175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.887666Z","time spent":"604.476988ms","remote":"127.0.0.1:52512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-02-17T16:09:14.491937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.848675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-02-17T16:09:14.49275Z","caller":"traceutil/trace.go:171","msg":"trace[203601718] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:361; }","duration":"162.700562ms","start":"2026-02-17T16:09:14.330035Z","end":"2026-02-17T16:09:14.492736Z","steps":["trace[203601718] 'agreement among raft nodes before linearized reading' (duration: 161.860355ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:14.493278Z","caller":"traceutil/trace.go:171","msg":"trace[2028297837] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:361; }","duration":"703.900676ms","start":"2026-02-17T16:09:13.788138Z","end":"2026-02-17T16:09:14.492039Z","steps":["trace[2028297837] 'agreement among raft nodes before linearized reading' (duration: 703.677319ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:14.493353Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:13.788107Z","time spent":"705.232459ms","remote":"127.0.0.1:52512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"info","ts":"2026-02-17T16:09:14.942701Z","caller":"traceutil/trace.go:171","msg":"trace[1750531866] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"266.479269ms","start":"2026-02-17T16:09:14.676207Z","end":"2026-02-17T16:09:14.942686Z","steps":["trace[1750531866] 'process raft request' (duration: 266.442377ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:14.943131Z","caller":"traceutil/trace.go:171","msg":"trace[57122133] transaction","detail":"{read_only:false; response_revision:389; number_of_response:1; }","duration":"272.421102ms","start":"2026-02-17T16:09:14.670701Z","end":"2026-02-17T16:09:14.943122Z","steps":["trace[57122133] 'process raft request' (duration: 264.03089ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:14.943189Z","caller":"traceutil/trace.go:171","msg":"trace[401417791] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"267.064238ms","start":"2026-02-17T16:09:14.676115Z","end":"2026-02-17T16:09:14.94318Z","steps":["trace[401417791] 'process raft request' (duration: 266.50805ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:14.943768Z","caller":"traceutil/trace.go:171","msg":"trace[1972867599] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"268.550116ms","start":"2026-02-17T16:09:14.675209Z","end":"2026-02-17T16:09:14.943759Z","steps":["trace[1972867599] 'process raft request' (duration: 267.372088ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:15.106492Z","caller":"traceutil/trace.go:171","msg":"trace[637539145] transaction","detail":"{read_only:false; response_revision:395; number_of_response:1; }","duration":"153.739458ms","start":"2026-02-17T16:09:14.952736Z","end":"2026-02-17T16:09:15.106475Z","steps":["trace[637539145] 'process raft request' (duration: 153.717647ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:15.106925Z","caller":"traceutil/trace.go:171","msg":"trace[1754489801] transaction","detail":"{read_only:false; response_revision:393; number_of_response:1; }","duration":"426.661425ms","start":"2026-02-17T16:09:14.680253Z","end":"2026-02-17T16:09:15.106915Z","steps":["trace[1754489801] 'process raft request' (duration: 417.774631ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:15.107132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:14.680246Z","time spent":"426.836162ms","remote":"127.0.0.1:52792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3737,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:15.10759Z","caller":"traceutil/trace.go:171","msg":"trace[251382120] transaction","detail":"{read_only:false; response_revision:394; number_of_response:1; }","duration":"421.351054ms","start":"2026-02-17T16:09:14.686232Z","end":"2026-02-17T16:09:15.107583Z","steps":["trace[251382120] 'process raft request' (duration: 420.182456ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:15.109792Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:14.686221Z","time spent":"423.543445ms","remote":"127.0.0.1:52368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:15.109664Z","caller":"traceutil/trace.go:171","msg":"trace[1180107627] linearizableReadLoop","detail":"{readStateIndex:406; appliedIndex:401; }","duration":"423.495493ms","start":"2026-02-17T16:09:14.686157Z","end":"2026-02-17T16:09:15.109652Z","steps":["trace[1180107627] 'read index received' (duration: 248.658523ms)","trace[1180107627] 'applied index is now lower than readState.Index' (duration: 174.83546ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:15.10974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.574475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/kube-system/kube-proxy\" ","response":"range_response_count:1 size:2879"} {"level":"info","ts":"2026-02-17T16:09:15.110244Z","caller":"traceutil/trace.go:171","msg":"trace[1843973814] range","detail":"{range_begin:/registry/daemonsets/kube-system/kube-proxy; range_end:; response_count:1; response_revision:395; }","duration":"424.084092ms","start":"2026-02-17T16:09:14.686151Z","end":"2026-02-17T16:09:15.110235Z","steps":["trace[1843973814] 'agreement among raft nodes before linearized reading' (duration: 423.535464ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:15.110278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:14.686103Z","time spent":"424.165694ms","remote":"127.0.0.1:52782","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":2902,"request content":"key:\"/registry/daemonsets/kube-system/kube-proxy\" "} {"level":"warn","ts":"2026-02-17T16:09:15.110545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"380.44923ms","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-17T16:09:15.110571Z","caller":"traceutil/trace.go:171","msg":"trace[1737512549] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:395; }","duration":"380.511862ms","start":"2026-02-17T16:09:14.730053Z","end":"2026-02-17T16:09:15.110565Z","steps":["trace[1737512549] 'agreement among raft nodes before linearized reading' (duration: 380.403389ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:15.110619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:14.730033Z","time spent":"380.551833ms","remote":"127.0.0.1:52574","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-17T16:09:15.110939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.970402ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5260"} {"level":"info","ts":"2026-02-17T16:09:15.110978Z","caller":"traceutil/trace.go:171","msg":"trace[720905863] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:395; }","duration":"204.044504ms","start":"2026-02-17T16:09:14.906926Z","end":"2026-02-17T16:09:15.110971Z","steps":["trace[720905863] 'agreement among raft nodes before linearized reading' (duration: 203.990343ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:18.686986Z","caller":"traceutil/trace.go:171","msg":"trace[756955023] transaction","detail":"{read_only:false; response_revision:418; number_of_response:1; }","duration":"188.88854ms","start":"2026-02-17T16:09:18.498081Z","end":"2026-02-17T16:09:18.686969Z","steps":["trace[756955023] 'process raft request' (duration: 188.56713ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:19.658263Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829076,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:09:20.158651Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829076,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:09:20.468443Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.547125279s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T16:09:20.468806Z","caller":"traceutil/trace.go:171","msg":"trace[2077184373] linearizableReadLoop","detail":"{readStateIndex:435; appliedIndex:434; }","duration":"1.311200332s","start":"2026-02-17T16:09:19.15758Z","end":"2026-02-17T16:09:20.468781Z","steps":["trace[2077184373] 'read index received' (duration: 1.311074778s)","trace[2077184373] 'applied index is now lower than readState.Index' (duration: 124.404µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:20.46905Z","caller":"traceutil/trace.go:171","msg":"trace[1039657818] transaction","detail":"{read_only:false; response_revision:420; number_of_response:1; }","duration":"1.547756548s","start":"2026-02-17T16:09:18.921235Z","end":"2026-02-17T16:09:20.468992Z","steps":["trace[1039657818] 'process raft request' (duration: 1.547369776s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:20.469342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.311743088s","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-17T16:09:20.469397Z","caller":"traceutil/trace.go:171","msg":"trace[2106595082] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:420; }","duration":"1.311835231s","start":"2026-02-17T16:09:19.157547Z","end":"2026-02-17T16:09:20.469382Z","steps":["trace[2106595082] 'agreement among raft nodes before linearized reading' (duration: 1.311732358s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:20.469449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:19.157533Z","time spent":"1.311907653s","remote":"127.0.0.1:52574","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-17T16:09:20.469648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:18.921224Z","time spent":"1.548093668s","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4049,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:20.48247Z","caller":"traceutil/trace.go:171","msg":"trace[117674808] transaction","detail":"{read_only:false; response_revision:421; number_of_response:1; }","duration":"266.623145ms","start":"2026-02-17T16:09:20.215835Z","end":"2026-02-17T16:09:20.482458Z","steps":["trace[117674808] 'process raft request' (duration: 256.792815ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:20.482964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"838.608562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:20.483058Z","caller":"traceutil/trace.go:171","msg":"trace[1157794847] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:421; }","duration":"839.121668ms","start":"2026-02-17T16:09:19.643927Z","end":"2026-02-17T16:09:20.483049Z","steps":["trace[1157794847] 'agreement among raft nodes before linearized reading' (duration: 838.634393ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:20.483141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:19.643905Z","time spent":"839.228701ms","remote":"127.0.0.1:52266","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-17T16:09:20.48331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106036263s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-17T16:09:20.483435Z","caller":"traceutil/trace.go:171","msg":"trace[277367304] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:421; }","duration":"1.106160896s","start":"2026-02-17T16:09:19.377268Z","end":"2026-02-17T16:09:20.483429Z","steps":["trace[277367304] 'agreement among raft nodes before linearized reading' (duration: 1.106021662s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:20.483516Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:19.377207Z","time spent":"1.106302001s","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-02-17T16:09:24.448613Z","caller":"traceutil/trace.go:171","msg":"trace[525736628] transaction","detail":"{read_only:false; response_revision:432; number_of_response:1; }","duration":"405.158232ms","start":"2026-02-17T16:09:24.04344Z","end":"2026-02-17T16:09:24.448598Z","steps":["trace[525736628] 'process raft request' (duration: 405.055629ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:24.448712Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:24.043424Z","time spent":"405.237535ms","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:09:24.733918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.607606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-17T16:09:24.734334Z","caller":"traceutil/trace.go:171","msg":"trace[913021075] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:432; }","duration":"196.984877ms","start":"2026-02-17T16:09:24.537261Z","end":"2026-02-17T16:09:24.734246Z","steps":["trace[913021075] 'range keys from in-memory index tree' (duration: 196.471942ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:24.73454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.24968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4034"} {"level":"info","ts":"2026-02-17T16:09:24.734623Z","caller":"traceutil/trace.go:171","msg":"trace[57113863] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:432; }","duration":"144.434756ms","start":"2026-02-17T16:09:24.590171Z","end":"2026-02-17T16:09:24.734606Z","steps":["trace[57113863] 'range keys from in-memory index tree' (duration: 144.113787ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:24.735035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.109507ms","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-17T16:09:24.735082Z","caller":"traceutil/trace.go:171","msg":"trace[1404954103] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:432; }","duration":"143.171448ms","start":"2026-02-17T16:09:24.591897Z","end":"2026-02-17T16:09:24.735068Z","steps":["trace[1404954103] 'range keys from in-memory index tree' (duration: 143.041025ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:25.022937Z","caller":"traceutil/trace.go:171","msg":"trace[202198203] linearizableReadLoop","detail":"{readStateIndex:452; appliedIndex:449; }","duration":"256.718885ms","start":"2026-02-17T16:09:24.766197Z","end":"2026-02-17T16:09:25.022916Z","steps":["trace[202198203] 'read index received' (duration: 57.94393ms)","trace[202198203] 'applied index is now lower than readState.Index' (duration: 198.774065ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:25.023339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.850339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-17T16:09:25.02339Z","caller":"traceutil/trace.go:171","msg":"trace[674916905] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:436; }","duration":"257.213208ms","start":"2026-02-17T16:09:24.766165Z","end":"2026-02-17T16:09:25.023378Z","steps":["trace[674916905] 'agreement among raft nodes before linearized reading' (duration: 256.833557ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:25.02431Z","caller":"traceutil/trace.go:171","msg":"trace[616462280] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"279.742329ms","start":"2026-02-17T16:09:24.744551Z","end":"2026-02-17T16:09:25.024294Z","steps":["trace[616462280] 'process raft request' (duration: 186.987064ms)","trace[616462280] 'compare' (duration: 91.185489ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:25.024517Z","caller":"traceutil/trace.go:171","msg":"trace[822763174] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"277.748581ms","start":"2026-02-17T16:09:24.746753Z","end":"2026-02-17T16:09:25.024501Z","steps":["trace[822763174] 'process raft request' (duration: 276.061732ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:25.024906Z","caller":"traceutil/trace.go:171","msg":"trace[1401220469] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"276.147584ms","start":"2026-02-17T16:09:24.748746Z","end":"2026-02-17T16:09:25.024894Z","steps":["trace[1401220469] 'process raft request' (duration: 274.128175ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:25.379372Z","caller":"traceutil/trace.go:171","msg":"trace[763342351] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"185.53013ms","start":"2026-02-17T16:09:25.193809Z","end":"2026-02-17T16:09:25.379339Z","steps":["trace[763342351] 'process raft request' (duration: 114.358852ms)","trace[763342351] 'compare' (duration: 70.88277ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:25.395274Z","caller":"traceutil/trace.go:171","msg":"trace[1217589986] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"187.92724ms","start":"2026-02-17T16:09:25.207338Z","end":"2026-02-17T16:09:25.395265Z","steps":["trace[1217589986] 'process raft request' (duration: 187.863518ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:25.571605Z","caller":"traceutil/trace.go:171","msg":"trace[150962610] transaction","detail":"{read_only:false; response_revision:453; number_of_response:1; }","duration":"171.489122ms","start":"2026-02-17T16:09:25.400086Z","end":"2026-02-17T16:09:25.571575Z","steps":["trace[150962610] 'process raft request' (duration: 123.105617ms)","trace[150962610] 'compare' (duration: 48.264222ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:25.660802Z","caller":"traceutil/trace.go:171","msg":"trace[919131189] transaction","detail":"{read_only:false; response_revision:457; number_of_response:1; }","duration":"249.026694ms","start":"2026-02-17T16:09:25.411742Z","end":"2026-02-17T16:09:25.660769Z","steps":["trace[919131189] 'process raft request' (duration: 248.923751ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:25.661369Z","caller":"traceutil/trace.go:171","msg":"trace[1043401218] transaction","detail":"{read_only:false; response_revision:454; number_of_response:1; }","duration":"254.768791ms","start":"2026-02-17T16:09:25.406582Z","end":"2026-02-17T16:09:25.661351Z","steps":["trace[1043401218] 'process raft request' (duration: 253.853124ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:25.661841Z","caller":"traceutil/trace.go:171","msg":"trace[393369776] transaction","detail":"{read_only:false; response_revision:455; number_of_response:1; }","duration":"254.02318ms","start":"2026-02-17T16:09:25.407808Z","end":"2026-02-17T16:09:25.661832Z","steps":["trace[393369776] 'process raft request' (duration: 252.752233ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:25.66421Z","caller":"traceutil/trace.go:171","msg":"trace[943763790] transaction","detail":"{read_only:false; response_revision:456; number_of_response:1; }","duration":"250.814836ms","start":"2026-02-17T16:09:25.410719Z","end":"2026-02-17T16:09:25.661534Z","steps":["trace[943763790] 'process raft request' (duration: 249.902529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.028291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.487937ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:26.028413Z","caller":"traceutil/trace.go:171","msg":"trace[739705036] transaction","detail":"{read_only:false; response_revision:458; number_of_response:1; }","duration":"450.320958ms","start":"2026-02-17T16:09:25.57808Z","end":"2026-02-17T16:09:26.028401Z","steps":["trace[739705036] 'process raft request' (duration: 332.684346ms)","trace[739705036] 'compare' (duration: 117.095346ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:26.028445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:25.578054Z","time spent":"450.37767ms","remote":"127.0.0.1:52368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":830,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:26.028643Z","caller":"traceutil/trace.go:171","msg":"trace[868825592] transaction","detail":"{read_only:false; response_revision:459; number_of_response:1; }","duration":"448.009881ms","start":"2026-02-17T16:09:25.580628Z","end":"2026-02-17T16:09:26.028638Z","steps":["trace[868825592] 'process raft request' (duration: 447.731123ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.028675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:25.580619Z","time spent":"448.036262ms","remote":"127.0.0.1:52792","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3818,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:26.02891Z","caller":"traceutil/trace.go:171","msg":"trace[328629] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"448.188706ms","start":"2026-02-17T16:09:25.580715Z","end":"2026-02-17T16:09:26.028904Z","steps":["trace[328629] 'process raft request' (duration: 447.875207ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.028937Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:25.5807Z","time spent":"448.222057ms","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4015,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:26.029115Z","caller":"traceutil/trace.go:171","msg":"trace[1913279406] linearizableReadLoop","detail":"{readStateIndex:476; appliedIndex:473; }","duration":"376.057112ms","start":"2026-02-17T16:09:25.653052Z","end":"2026-02-17T16:09:26.029109Z","steps":["trace[1913279406] 'read index received' (duration: 8.456326ms)","trace[1913279406] 'applied index is now lower than readState.Index' (duration: 367.600046ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:26.029176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.127744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:26.029188Z","caller":"traceutil/trace.go:171","msg":"trace[504923811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:461; }","duration":"376.141874ms","start":"2026-02-17T16:09:25.653042Z","end":"2026-02-17T16:09:26.029184Z","steps":["trace[504923811] 'agreement among raft nodes before linearized reading' (duration: 376.107714ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.029201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:25.652976Z","time spent":"376.222507ms","remote":"127.0.0.1:52266","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-17T16:09:26.029413Z","caller":"traceutil/trace.go:171","msg":"trace[1972707693] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"353.865677ms","start":"2026-02-17T16:09:25.675542Z","end":"2026-02-17T16:09:26.029408Z","steps":["trace[1972707693] 'process raft request' (duration: 353.077534ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.029437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:25.675528Z","time spent":"353.897307ms","remote":"127.0.0.1:52368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:26.034412Z","caller":"traceutil/trace.go:171","msg":"trace[737071152] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"358.766348ms","start":"2026-02-17T16:09:25.675636Z","end":"2026-02-17T16:09:26.034402Z","steps":["trace[737071152] 'process raft request' (duration: 353.441664ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.037194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:25.675632Z","time spent":"358.814849ms","remote":"127.0.0.1:52766","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-17T16:09:26.040185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.736413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-5dd5756b68\" ","response":"range_response_count:1 size:3797"} {"level":"info","ts":"2026-02-17T16:09:26.040228Z","caller":"traceutil/trace.go:171","msg":"trace[1100569145] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-5dd5756b68; range_end:; response_count:1; response_revision:462; }","duration":"364.635657ms","start":"2026-02-17T16:09:25.67558Z","end":"2026-02-17T16:09:26.040216Z","steps":["trace[1100569145] 'agreement among raft nodes before linearized reading' (duration: 353.734593ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:26.040833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:25.675576Z","time spent":"364.7653ms","remote":"127.0.0.1:52792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":3820,"request content":"key:\"/registry/replicasets/kube-system/coredns-5dd5756b68\" "} {"level":"warn","ts":"2026-02-17T16:09:26.271232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.285925ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:26.271301Z","caller":"traceutil/trace.go:171","msg":"trace[1956362787] linearizableReadLoop","detail":"{readStateIndex:479; appliedIndex:478; }","duration":"224.852632ms","start":"2026-02-17T16:09:26.046437Z","end":"2026-02-17T16:09:26.271289Z","steps":["trace[1956362787] 'read index received' (duration: 106.419753ms)","trace[1956362787] 'applied index is now lower than readState.Index' (duration: 118.432049ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:26.271378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.937784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/replicasets/kube-system/coredns-5dd5756b68\" ","response":"range_response_count:1 size:3797"} {"level":"info","ts":"2026-02-17T16:09:26.271406Z","caller":"traceutil/trace.go:171","msg":"trace[910439154] range","detail":"{range_begin:/registry/replicasets/kube-system/coredns-5dd5756b68; range_end:; response_count:1; response_revision:463; }","duration":"224.979615ms","start":"2026-02-17T16:09:26.046419Z","end":"2026-02-17T16:09:26.271399Z","steps":["trace[910439154] 'agreement among raft nodes before linearized reading' (duration: 224.900853ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:26.271608Z","caller":"traceutil/trace.go:171","msg":"trace[1161624992] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"225.383317ms","start":"2026-02-17T16:09:26.046215Z","end":"2026-02-17T16:09:26.271598Z","steps":["trace[1161624992] 'process raft request' (duration: 106.66088ms)","trace[1161624992] 'compare' (duration: 118.071028ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:26.760043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.294082ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:26.760121Z","caller":"traceutil/trace.go:171","msg":"trace[945028403] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"466.438875ms","start":"2026-02-17T16:09:26.293667Z","end":"2026-02-17T16:09:26.760106Z","steps":["trace[945028403] 'process raft request' (duration: 248.033169ms)","trace[945028403] 'compare' (duration: 218.080856ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:26.760162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.293654Z","time spent":"466.488076ms","remote":"127.0.0.1:52766","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-17T16:09:27.18809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.498678ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:27.188173Z","caller":"traceutil/trace.go:171","msg":"trace[1309649771] linearizableReadLoop","detail":"{readStateIndex:482; appliedIndex:481; }","duration":"359.89997ms","start":"2026-02-17T16:09:26.828259Z","end":"2026-02-17T16:09:27.188159Z","steps":["trace[1309649771] 'read index received' (duration: 139.182866ms)","trace[1309649771] 'applied index is now lower than readState.Index' (duration: 220.716043ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:27.188425Z","caller":"traceutil/trace.go:171","msg":"trace[790539628] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"421.291317ms","start":"2026-02-17T16:09:26.767117Z","end":"2026-02-17T16:09:27.188409Z","steps":["trace[790539628] 'process raft request' (duration: 200.380737ms)","trace[790539628] 'compare' (duration: 220.323703ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:27.188496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.767099Z","time spent":"421.359909ms","remote":"127.0.0.1:52766","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-17T16:09:27.188714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.449816ms","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-17T16:09:27.188749Z","caller":"traceutil/trace.go:171","msg":"trace[991618846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:466; }","duration":"360.508777ms","start":"2026-02-17T16:09:26.828229Z","end":"2026-02-17T16:09:27.188738Z","steps":["trace[991618846] 'agreement among raft nodes before linearized reading' (duration: 360.439075ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:27.188786Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:26.828178Z","time spent":"360.59766ms","remote":"127.0.0.1:52574","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-17T16:09:27.188951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.194435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-17T16:09:27.188978Z","caller":"traceutil/trace.go:171","msg":"trace[574601534] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:466; }","duration":"155.256647ms","start":"2026-02-17T16:09:27.033714Z","end":"2026-02-17T16:09:27.18897Z","steps":["trace[574601534] 'agreement among raft nodes before linearized reading' (duration: 155.209585ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:27.189296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.989411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-17T16:09:27.189329Z","caller":"traceutil/trace.go:171","msg":"trace[2080664035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:466; }","duration":"121.043782ms","start":"2026-02-17T16:09:27.068277Z","end":"2026-02-17T16:09:27.189321Z","steps":["trace[2080664035] 'agreement among raft nodes before linearized reading' (duration: 120.934239ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:27.189454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.462919ms","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-17T16:09:27.189488Z","caller":"traceutil/trace.go:171","msg":"trace[672875822] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:466; }","duration":"151.50458ms","start":"2026-02-17T16:09:27.037967Z","end":"2026-02-17T16:09:27.189472Z","steps":["trace[672875822] 'agreement among raft nodes before linearized reading' (duration: 151.462619ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:27.492513Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.100992ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:09:27.492771Z","caller":"traceutil/trace.go:171","msg":"trace[1469183532] transaction","detail":"{read_only:false; response_revision:470; number_of_response:1; }","duration":"295.117485ms","start":"2026-02-17T16:09:27.197635Z","end":"2026-02-17T16:09:27.492753Z","steps":["trace[1469183532] 'process raft request' (duration: 295.042413ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:27.492797Z","caller":"traceutil/trace.go:171","msg":"trace[302026825] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"295.6425ms","start":"2026-02-17T16:09:27.197133Z","end":"2026-02-17T16:09:27.492776Z","steps":["trace[302026825] 'process raft request' (duration: 180.210369ms)","trace[302026825] 'compare' (duration: 114.906416ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:27.49309Z","caller":"traceutil/trace.go:171","msg":"trace[21064705] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"295.690851ms","start":"2026-02-17T16:09:27.197393Z","end":"2026-02-17T16:09:27.493084Z","steps":["trace[21064705] 'process raft request' (duration: 295.227008ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:35.43012Z","caller":"traceutil/trace.go:171","msg":"trace[761492255] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"171.937981ms","start":"2026-02-17T16:09:35.258164Z","end":"2026-02-17T16:09:35.430102Z","steps":["trace[761492255] 'process raft request' (duration: 171.853779ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:39.814709Z","caller":"traceutil/trace.go:171","msg":"trace[1987674542] linearizableReadLoop","detail":"{readStateIndex:551; appliedIndex:549; }","duration":"102.989777ms","start":"2026-02-17T16:09:39.7117Z","end":"2026-02-17T16:09:39.81469Z","steps":["trace[1987674542] 'read index received' (duration: 38.259459ms)","trace[1987674542] 'applied index is now lower than readState.Index' (duration: 64.729408ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:39.814855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.136822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:4018"} {"level":"info","ts":"2026-02-17T16:09:39.814893Z","caller":"traceutil/trace.go:171","msg":"trace[955681149] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:532; }","duration":"103.222003ms","start":"2026-02-17T16:09:39.711661Z","end":"2026-02-17T16:09:39.814883Z","steps":["trace[955681149] 'agreement among raft nodes before linearized reading' (duration: 103.11306ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:39.815184Z","caller":"traceutil/trace.go:171","msg":"trace[1298321937] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"129.542407ms","start":"2026-02-17T16:09:39.685625Z","end":"2026-02-17T16:09:39.815168Z","steps":["trace[1298321937] 'process raft request' (duration: 64.401939ms)","trace[1298321937] 'compare' (duration: 64.538483ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:39.815315Z","caller":"traceutil/trace.go:171","msg":"trace[1956270496] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"129.382294ms","start":"2026-02-17T16:09:39.685919Z","end":"2026-02-17T16:09:39.815302Z","steps":["trace[1956270496] 'process raft request' (duration: 128.734217ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:40.173133Z","caller":"traceutil/trace.go:171","msg":"trace[910622690] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"347.736561ms","start":"2026-02-17T16:09:39.82538Z","end":"2026-02-17T16:09:40.173116Z","steps":["trace[910622690] 'process raft request' (duration: 347.651199ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:40.173245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:39.825363Z","time spent":"347.816922ms","remote":"127.0.0.1:52480","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4210,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:43.387722Z","caller":"traceutil/trace.go:171","msg":"trace[1332917764] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"120.590486ms","start":"2026-02-17T16:09:43.267088Z","end":"2026-02-17T16:09:43.387678Z","steps":["trace[1332917764] 'process raft request' (duration: 120.071534ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:43.562768Z","caller":"traceutil/trace.go:171","msg":"trace[288665554] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"144.502169ms","start":"2026-02-17T16:09:43.418249Z","end":"2026-02-17T16:09:43.562751Z","steps":["trace[288665554] 'process raft request' (duration: 85.001545ms)","trace[288665554] 'compare' (duration: 59.223937ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:44.126012Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829368,"retry-timeout":"500ms"} {"level":"info","ts":"2026-02-17T16:09:44.228852Z","caller":"traceutil/trace.go:171","msg":"trace[692015199] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"604.853782ms","start":"2026-02-17T16:09:43.623979Z","end":"2026-02-17T16:09:44.228833Z","steps":["trace[692015199] 'process raft request' (duration: 604.705119ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:44.229231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.623963Z","time spent":"605.19955ms","remote":"127.0.0.1:52340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5571,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:09:45.689884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000429102s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-17T16:09:45.689963Z","caller":"traceutil/trace.go:171","msg":"trace[1931394513] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000544225s","start":"2026-02-17T16:09:43.689402Z","end":"2026-02-17T16:09:45.689946Z","steps":["trace[1931394513] 'agreement among raft nodes before linearized reading' (duration: 2.000448813s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:45.690014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.689389Z","time spent":"2.000607956s","remote":"127.0.0.1:52266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/17 16:09:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T16:09:46.164109Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.891773301s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T16:09:46.21679Z","caller":"traceutil/trace.go:171","msg":"trace[1978817548] linearizableReadLoop","detail":"{readStateIndex:593; appliedIndex:588; }","duration":"2.591531992s","start":"2026-02-17T16:09:43.625236Z","end":"2026-02-17T16:09:46.216768Z","steps":["trace[1978817548] 'read index received' (duration: 603.570731ms)","trace[1978817548] 'applied index is now lower than readState.Index' (duration: 1.987959801s)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:46.216994Z","caller":"traceutil/trace.go:171","msg":"trace[1799495568] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"2.591824479s","start":"2026-02-17T16:09:43.625157Z","end":"2026-02-17T16:09:46.216982Z","steps":["trace[1799495568] 'process raft request' (duration: 2.539466825s)","trace[1799495568] 'compare' (duration: 51.391651ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:46.217121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.62515Z","time spent":"2.591897431s","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:46.217367Z","caller":"traceutil/trace.go:171","msg":"trace[1546297625] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"2.549509151s","start":"2026-02-17T16:09:43.667845Z","end":"2026-02-17T16:09:46.217354Z","steps":["trace[1546297625] 'process raft request' (duration: 2.548696232s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.217429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.667837Z","time spent":"2.549554332s","remote":"127.0.0.1:52340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:46.217549Z","caller":"traceutil/trace.go:171","msg":"trace[722200779] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"2.411005021s","start":"2026-02-17T16:09:43.806536Z","end":"2026-02-17T16:09:46.217541Z","steps":["trace[722200779] 'process raft request' (duration: 2.410110249s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.217591Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.806509Z","time spent":"2.411060572s","remote":"127.0.0.1:52340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-02-17T16:09:46.217709Z","caller":"traceutil/trace.go:171","msg":"trace[1505511213] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"2.207880912s","start":"2026-02-17T16:09:44.009806Z","end":"2026-02-17T16:09:46.217687Z","steps":["trace[1505511213] 'process raft request' (duration: 2.206885848s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.217749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:44.009784Z","time spent":"2.207945663s","remote":"127.0.0.1:52340","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-17T16:09:46.217879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.592636549s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:46.217912Z","caller":"traceutil/trace.go:171","msg":"trace[135567456] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:573; }","duration":"2.592685509s","start":"2026-02-17T16:09:43.625215Z","end":"2026-02-17T16:09:46.2179Z","steps":["trace[135567456] 'agreement among raft nodes before linearized reading' (duration: 2.592634598s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.217941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.625208Z","time spent":"2.59272504s","remote":"127.0.0.1:37154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:500 "} {"level":"warn","ts":"2026-02-17T16:09:46.249204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.623870523s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:46.249538Z","caller":"traceutil/trace.go:171","msg":"trace[1484069289] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:574; }","duration":"2.624228391s","start":"2026-02-17T16:09:43.62529Z","end":"2026-02-17T16:09:46.249518Z","steps":["trace[1484069289] 'agreement among raft nodes before linearized reading' (duration: 2.623789391s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.249813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.625285Z","time spent":"2.624506558s","remote":"127.0.0.1:37154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" limit:10000 "} {"level":"info","ts":"2026-02-17T16:09:46.250174Z","caller":"traceutil/trace.go:171","msg":"trace[492785866] transaction","detail":"{read_only:false; response_revision:574; number_of_response:1; }","duration":"1.423682912s","start":"2026-02-17T16:09:44.826439Z","end":"2026-02-17T16:09:46.250122Z","steps":["trace[492785866] 'process raft request' (duration: 1.422478383s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.25037Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:44.826411Z","time spent":"1.423823414s","remote":"127.0.0.1:52574","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-17T16:09:46.250843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.712906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:46.250886Z","caller":"traceutil/trace.go:171","msg":"trace[2034250506] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:574; }","duration":"560.807869ms","start":"2026-02-17T16:09:45.690066Z","end":"2026-02-17T16:09:46.250874Z","steps":["trace[2034250506] 'agreement among raft nodes before linearized reading' (duration: 560.718417ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.250954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:45.69005Z","time spent":"560.895051ms","remote":"127.0.0.1:52278","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-17T16:09:46.255004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.803513137s","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-17T16:09:46.255087Z","caller":"traceutil/trace.go:171","msg":"trace[2046442650] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:574; }","duration":"1.803659091s","start":"2026-02-17T16:09:44.451416Z","end":"2026-02-17T16:09:46.255075Z","steps":["trace[2046442650] 'agreement among raft nodes before linearized reading' (duration: 1.803525907s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.255152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:44.451397Z","time spent":"1.803727082s","remote":"127.0.0.1:52574","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-17T16:09:46.255913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.851042494s","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-17T16:09:46.256531Z","caller":"traceutil/trace.go:171","msg":"trace[424679480] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:574; }","duration":"1.85168176s","start":"2026-02-17T16:09:44.404839Z","end":"2026-02-17T16:09:46.25652Z","steps":["trace[424679480] 'agreement among raft nodes before linearized reading' (duration: 1.851049754s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.256604Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:44.404824Z","time spent":"1.851769191s","remote":"127.0.0.1:52340","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":"warn","ts":"2026-02-17T16:09:46.256785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.016024295s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:46.257041Z","caller":"traceutil/trace.go:171","msg":"trace[530296095] range","detail":"{range_begin:/registry/serviceaccounts/local-path-storage/local-path-provisioner; range_end:; response_count:0; response_revision:574; }","duration":"2.016302112s","start":"2026-02-17T16:09:44.24073Z","end":"2026-02-17T16:09:46.257032Z","steps":["trace[530296095] 'agreement among raft nodes before linearized reading' (duration: 2.016032005s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.2571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:44.240717Z","time spent":"2.016373863s","remote":"127.0.0.1:52512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":0,"response size":28,"request content":"key:\"/registry/serviceaccounts/local-path-storage/local-path-provisioner\" "} {"level":"warn","ts":"2026-02-17T16:09:46.257238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.545398ms","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-17T16:09:46.257264Z","caller":"traceutil/trace.go:171","msg":"trace[66709309] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:1; response_revision:574; }","duration":"651.601499ms","start":"2026-02-17T16:09:45.605656Z","end":"2026-02-17T16:09:46.257258Z","steps":["trace[66709309] 'agreement among raft nodes before linearized reading' (duration: 651.434385ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.257346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:45.605636Z","time spent":"651.704241ms","remote":"127.0.0.1:52340","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":"warn","ts":"2026-02-17T16:09:46.257504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.052299146s","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-17T16:09:46.257694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.452392934s","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":"info","ts":"2026-02-17T16:09:46.257714Z","caller":"traceutil/trace.go:171","msg":"trace[1096144645] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:574; }","duration":"1.452518536s","start":"2026-02-17T16:09:44.80519Z","end":"2026-02-17T16:09:46.257709Z","steps":["trace[1096144645] 'agreement among raft nodes before linearized reading' (duration: 1.452442324s)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:46.257697Z","caller":"traceutil/trace.go:171","msg":"trace[1183475403] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:574; }","duration":"2.052516451s","start":"2026-02-17T16:09:44.205171Z","end":"2026-02-17T16:09:46.257687Z","steps":["trace[1183475403] 'agreement among raft nodes before linearized reading' (duration: 2.052304096s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.257958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:44.205156Z","time spent":"2.052792178s","remote":"127.0.0.1:52340","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-17T16:09:46.258346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.42486958s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-17T16:09:46.258494Z","caller":"traceutil/trace.go:171","msg":"trace[550240748] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:575; }","duration":"2.425041004s","start":"2026-02-17T16:09:43.833442Z","end":"2026-02-17T16:09:46.258483Z","steps":["trace[550240748] 'agreement among raft nodes before linearized reading' (duration: 2.42486314s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.258581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.833432Z","time spent":"2.425139466s","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T16:09:46.258842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.426416618s","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-17T16:09:46.25901Z","caller":"traceutil/trace.go:171","msg":"trace[1012358635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:575; }","duration":"2.426638413s","start":"2026-02-17T16:09:43.832363Z","end":"2026-02-17T16:09:46.259002Z","steps":["trace[1012358635] 'agreement among raft nodes before linearized reading' (duration: 2.426412268s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.259086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.832345Z","time spent":"2.426731725s","remote":"127.0.0.1:52574","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-17T16:09:46.259266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.591503576s","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-17T16:09:46.259483Z","caller":"traceutil/trace.go:171","msg":"trace[136442887] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:575; }","duration":"2.591757232s","start":"2026-02-17T16:09:43.667714Z","end":"2026-02-17T16:09:46.259471Z","steps":["trace[136442887] 'agreement among raft nodes before linearized reading' (duration: 2.591505416s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.259573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.667702Z","time spent":"2.591832673s","remote":"127.0.0.1:52574","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-17T16:09:46.259747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.634413337s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:46.259849Z","caller":"traceutil/trace.go:171","msg":"trace[2141652589] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:575; }","duration":"2.634531811s","start":"2026-02-17T16:09:43.625306Z","end":"2026-02-17T16:09:46.259838Z","steps":["trace[2141652589] 'agreement among raft nodes before linearized reading' (duration: 2.634407818s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.259968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:43.625304Z","time spent":"2.634654793s","remote":"127.0.0.1:37154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:09:46.249355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.644199286s","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":"info","ts":"2026-02-17T16:09:46.260249Z","caller":"traceutil/trace.go:171","msg":"trace[502849832] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:1; response_revision:574; }","duration":"1.65512098s","start":"2026-02-17T16:09:44.605117Z","end":"2026-02-17T16:09:46.260238Z","steps":["trace[502849832] 'agreement among raft nodes before linearized reading' (duration: 1.644014062s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.260318Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:44.604991Z","time spent":"1.655316896s","remote":"127.0.0.1:52340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":5200,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" "} {"level":"warn","ts":"2026-02-17T16:09:46.257529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"852.107413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-02-17T16:09:46.260701Z","caller":"traceutil/trace.go:171","msg":"trace[1636792592] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:574; }","duration":"855.279549ms","start":"2026-02-17T16:09:45.405415Z","end":"2026-02-17T16:09:46.260695Z","steps":["trace[1636792592] 'agreement among raft nodes before linearized reading' (duration: 852.038341ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.260743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:45.405367Z","time spent":"855.368911ms","remote":"127.0.0.1:52340","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-17T16:09:46.257728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:44.805171Z","time spent":"1.452553898s","remote":"127.0.0.1:52340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4106,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" "} {"level":"warn","ts":"2026-02-17T16:09:46.257557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.052104844s","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-17T16:09:46.261137Z","caller":"traceutil/trace.go:171","msg":"trace[1489242907] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:574; }","duration":"1.055729652s","start":"2026-02-17T16:09:45.205401Z","end":"2026-02-17T16:09:46.261131Z","steps":["trace[1489242907] 'agreement among raft nodes before linearized reading' (duration: 1.052139105s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.261177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:45.205373Z","time spent":"1.055796844s","remote":"127.0.0.1:52340","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-17T16:09:46.257623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.252358961s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-02-17T16:09:46.261385Z","caller":"traceutil/trace.go:171","msg":"trace[1200525244] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:574; }","duration":"1.256147563s","start":"2026-02-17T16:09:45.005231Z","end":"2026-02-17T16:09:46.261379Z","steps":["trace[1200525244] 'agreement among raft nodes before linearized reading' (duration: 1.252362431s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:46.261434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:45.005212Z","time spent":"1.256215274s","remote":"127.0.0.1:52340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":1,"response size":4203,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" "} {"level":"info","ts":"2026-02-17T16:09:46.934401Z","caller":"traceutil/trace.go:171","msg":"trace[57402733] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"201.468327ms","start":"2026-02-17T16:09:46.732887Z","end":"2026-02-17T16:09:46.934356Z","steps":["trace[57402733] 'read index received' (duration: 106.193536ms)","trace[57402733] 'applied index is now lower than readState.Index' (duration: 95.273811ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:46.934471Z","caller":"traceutil/trace.go:171","msg":"trace[207031262] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"270.851613ms","start":"2026-02-17T16:09:46.663591Z","end":"2026-02-17T16:09:46.934442Z","steps":["trace[207031262] 'process raft request' (duration: 175.465859ms)","trace[207031262] 'compare' (duration: 95.106518ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:46.934754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.822126ms","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":"info","ts":"2026-02-17T16:09:46.934817Z","caller":"traceutil/trace.go:171","msg":"trace[226108899] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:1; response_revision:596; }","duration":"201.922589ms","start":"2026-02-17T16:09:46.73286Z","end":"2026-02-17T16:09:46.934783Z","steps":["trace[226108899] 'agreement among raft nodes before linearized reading' (duration: 201.651202ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:47.032266Z","caller":"traceutil/trace.go:171","msg":"trace[2134495960] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"188.351915ms","start":"2026-02-17T16:09:46.843896Z","end":"2026-02-17T16:09:47.032248Z","steps":["trace[2134495960] 'process raft request' (duration: 184.916423ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:47.295497Z","caller":"traceutil/trace.go:171","msg":"trace[1964678158] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:617; }","duration":"360.995965ms","start":"2026-02-17T16:09:46.934486Z","end":"2026-02-17T16:09:47.295482Z","steps":["trace[1964678158] 'read index received' (duration: 99.867187ms)","trace[1964678158] 'applied index is now lower than readState.Index' (duration: 261.128258ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:47.295578Z","caller":"traceutil/trace.go:171","msg":"trace[1688108599] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"433.127837ms","start":"2026-02-17T16:09:46.862443Z","end":"2026-02-17T16:09:47.295571Z","steps":["trace[1688108599] 'process raft request' (duration: 386.94017ms)","trace[1688108599] 'compare' (duration: 45.825338ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:09:47.295641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:46.862426Z","time spent":"433.165847ms","remote":"127.0.0.1:52340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":188237,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-02-17T16:09:47.295759Z","caller":"traceutil/trace.go:171","msg":"trace[383267999] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"350.959652ms","start":"2026-02-17T16:09:46.944795Z","end":"2026-02-17T16:09:47.295754Z","steps":["trace[383267999] 'process raft request' (duration: 350.656505ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:47.295781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:46.944776Z","time spent":"350.993852ms","remote":"127.0.0.1:52654","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1066,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:09:47.295909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"559.92206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-02-17T16:09:47.295926Z","caller":"traceutil/trace.go:171","msg":"trace[372985434] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:599; }","duration":"559.94859ms","start":"2026-02-17T16:09:46.735972Z","end":"2026-02-17T16:09:47.29592Z","steps":["trace[372985434] 'agreement among raft nodes before linearized reading' (duration: 559.866578ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:47.295939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:46.735967Z","time spent":"559.96932ms","remote":"127.0.0.1:52340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":24267,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" "} {"level":"warn","ts":"2026-02-17T16:09:47.296005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"563.086856ms","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-17T16:09:47.296019Z","caller":"traceutil/trace.go:171","msg":"trace[1409873093] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:1; response_revision:599; }","duration":"563.108386ms","start":"2026-02-17T16:09:46.732907Z","end":"2026-02-17T16:09:47.296015Z","steps":["trace[1409873093] 'agreement among raft nodes before linearized reading' (duration: 563.070495ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:47.296032Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:46.732905Z","time spent":"563.123137ms","remote":"127.0.0.1:52340","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":"warn","ts":"2026-02-17T16:09:47.296121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.308252ms","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-17T16:09:47.296133Z","caller":"traceutil/trace.go:171","msg":"trace[919344613] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:599; }","duration":"266.347542ms","start":"2026-02-17T16:09:47.029782Z","end":"2026-02-17T16:09:47.296129Z","steps":["trace[919344613] 'agreement among raft nodes before linearized reading' (duration: 266.28229ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:47.296293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.24121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:1 size:188486"} {"level":"info","ts":"2026-02-17T16:09:47.296307Z","caller":"traceutil/trace.go:171","msg":"trace[1848253906] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:1; response_revision:599; }","duration":"261.284631ms","start":"2026-02-17T16:09:47.035018Z","end":"2026-02-17T16:09:47.296302Z","steps":["trace[1848253906] 'agreement among raft nodes before linearized reading' (duration: 261.21381ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:09:54.200241Z","caller":"traceutil/trace.go:171","msg":"trace[1505686132] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"157.312527ms","start":"2026-02-17T16:09:54.04291Z","end":"2026-02-17T16:09:54.200223Z","steps":["trace[1505686132] 'process raft request' (duration: 157.200955ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:54.856532Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:09:55.357051Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:09:55.857825Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:09:56.358286Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:09:56.644015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000568728s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-02-17T16:09:56.644093Z","caller":"traceutil/trace.go:171","msg":"trace[1658204702] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000677231s","start":"2026-02-17T16:09:54.643398Z","end":"2026-02-17T16:09:56.644075Z","steps":["trace[1658204702] 'agreement among raft nodes before linearized reading' (duration: 2.000583479s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:56.644162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:54.643386Z","time spent":"2.000767963s","remote":"127.0.0.1:52266","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/02/17 16:09:56 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-02-17T16:09:56.858826Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:09:57.359302Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829502,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:09:57.523482Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.262278086s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T16:09:57.523802Z","caller":"traceutil/trace.go:171","msg":"trace[271592520] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"3.262659695s","start":"2026-02-17T16:09:54.261118Z","end":"2026-02-17T16:09:57.523778Z","steps":["trace[271592520] 'process raft request' (duration: 3.262509481s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:57.523938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:54.261107Z","time spent":"3.262765667s","remote":"127.0.0.1:52574","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-17T16:09:57.587958Z","caller":"traceutil/trace.go:171","msg":"trace[1853607539] linearizableReadLoop","detail":"{readStateIndex:659; appliedIndex:657; }","duration":"3.231448333s","start":"2026-02-17T16:09:54.356493Z","end":"2026-02-17T16:09:57.587941Z","steps":["trace[1853607539] 'read index received' (duration: 3.16726167s)","trace[1853607539] 'applied index is now lower than readState.Index' (duration: 64.186023ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:09:57.588157Z","caller":"traceutil/trace.go:171","msg":"trace[922515886] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"1.230946098s","start":"2026-02-17T16:09:56.357205Z","end":"2026-02-17T16:09:57.588151Z","steps":["trace[922515886] 'process raft request' (duration: 1.230643811s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:57.588222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:56.357187Z","time spent":"1.230985818s","remote":"127.0.0.1:52574","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-17T16:09:57.58837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.231894634s","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-17T16:09:57.588386Z","caller":"traceutil/trace.go:171","msg":"trace[2080071704] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:637; }","duration":"3.231937315s","start":"2026-02-17T16:09:54.356444Z","end":"2026-02-17T16:09:57.588381Z","steps":["trace[2080071704] 'agreement among raft nodes before linearized reading' (duration: 3.231870823s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:57.5884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:54.356429Z","time spent":"3.231967775s","remote":"127.0.0.1:52574","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-17T16:09:57.588499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.215356768s","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-17T16:09:57.588512Z","caller":"traceutil/trace.go:171","msg":"trace[2063007773] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:637; }","duration":"3.21539463s","start":"2026-02-17T16:09:54.373113Z","end":"2026-02-17T16:09:57.588508Z","steps":["trace[2063007773] 'agreement among raft nodes before linearized reading' (duration: 3.215353289s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:57.588524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:54.373101Z","time spent":"3.21542072s","remote":"127.0.0.1:52574","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-17T16:09:57.588769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.210629341s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-17T16:09:57.588825Z","caller":"traceutil/trace.go:171","msg":"trace[720754276] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:637; }","duration":"3.210709173s","start":"2026-02-17T16:09:54.3781Z","end":"2026-02-17T16:09:57.588809Z","steps":["trace[720754276] 'agreement among raft nodes before linearized reading' (duration: 3.210513989s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:57.588863Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:54.378086Z","time spent":"3.210769404s","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T16:09:57.588974Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.569272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:09:57.589022Z","caller":"traceutil/trace.go:171","msg":"trace[590701320] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:637; }","duration":"944.609542ms","start":"2026-02-17T16:09:56.64438Z","end":"2026-02-17T16:09:57.588989Z","steps":["trace[590701320] 'agreement among raft nodes before linearized reading' (duration: 944.560621ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:57.58905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:56.644366Z","time spent":"944.677424ms","remote":"127.0.0.1:52278","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-17T16:09:57.589262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.208094533s","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-17T16:09:57.589328Z","caller":"traceutil/trace.go:171","msg":"trace[452987291] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:637; }","duration":"3.208160235s","start":"2026-02-17T16:09:54.381158Z","end":"2026-02-17T16:09:57.589318Z","steps":["trace[452987291] 'agreement among raft nodes before linearized reading' (duration: 3.208040712s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:09:57.589354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:09:54.381129Z","time spent":"3.208219036s","remote":"127.0.0.1:52574","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-17T16:10:03.180002Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829572,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:10:03.680608Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16933143638184829572,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-02-17T16:10:03.709438Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.054527203s","expected-duration":"1s"} {"level":"info","ts":"2026-02-17T16:10:03.709637Z","caller":"traceutil/trace.go:171","msg":"trace[1085203884] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"1.054779369s","start":"2026-02-17T16:10:02.654846Z","end":"2026-02-17T16:10:03.709625Z","steps":["trace[1085203884] 'process raft request' (duration: 1.054710528s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:03.709711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:02.654825Z","time spent":"1.05485036s","remote":"127.0.0.1:52368","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":716,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-02-17T16:10:04.171008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.640269ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-02-17T16:10:04.17108Z","caller":"traceutil/trace.go:171","msg":"trace[177012568] linearizableReadLoop","detail":"{readStateIndex:698; appliedIndex:697; }","duration":"1.491891476s","start":"2026-02-17T16:10:02.679175Z","end":"2026-02-17T16:10:04.171066Z","steps":["trace[177012568] 'read index received' (duration: 1.03048378s)","trace[177012568] 'applied index is now lower than readState.Index' (duration: 461.407026ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:10:04.171279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.492097831s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:10:04.171294Z","caller":"traceutil/trace.go:171","msg":"trace[54062135] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:674; }","duration":"1.492142511s","start":"2026-02-17T16:10:02.679146Z","end":"2026-02-17T16:10:04.171289Z","steps":["trace[54062135] 'agreement among raft nodes before linearized reading' (duration: 1.49210557s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:04.171311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:02.679135Z","time spent":"1.492171902s","remote":"127.0.0.1:52278","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-17T16:10:04.17141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233076294s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:10:04.171423Z","caller":"traceutil/trace.go:171","msg":"trace[889338999] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:674; }","duration":"1.233120455s","start":"2026-02-17T16:10:02.938298Z","end":"2026-02-17T16:10:04.171418Z","steps":["trace[889338999] 'agreement among raft nodes before linearized reading' (duration: 1.233098464s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:04.171434Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:02.938286Z","time spent":"1.233145815s","remote":"127.0.0.1:52434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-02-17T16:10:04.171561Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.803453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-17T16:10:04.171575Z","caller":"traceutil/trace.go:171","msg":"trace[687663002] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:674; }","duration":"443.832173ms","start":"2026-02-17T16:10:03.727738Z","end":"2026-02-17T16:10:04.17157Z","steps":["trace[687663002] 'agreement among raft nodes before linearized reading' (duration: 443.768612ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:04.171586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:03.72773Z","time spent":"443.852973ms","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-02-17T16:10:04.171668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.947186ms","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-17T16:10:04.171679Z","caller":"traceutil/trace.go:171","msg":"trace[391682431] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:674; }","duration":"443.988726ms","start":"2026-02-17T16:10:03.727687Z","end":"2026-02-17T16:10:04.171676Z","steps":["trace[391682431] 'agreement among raft nodes before linearized reading' (duration: 443.953056ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:04.17169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:03.727672Z","time spent":"444.015868ms","remote":"127.0.0.1:52574","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-17T16:10:04.171759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.321499ms","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-17T16:10:04.17177Z","caller":"traceutil/trace.go:171","msg":"trace[2109714340] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:674; }","duration":"465.34214ms","start":"2026-02-17T16:10:03.706424Z","end":"2026-02-17T16:10:04.171766Z","steps":["trace[2109714340] 'agreement among raft nodes before linearized reading' (duration: 465.30753ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:04.171781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:03.706419Z","time spent":"465.359341ms","remote":"127.0.0.1:52574","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-17T16:10:04.171853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.40443ms","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-17T16:10:04.171864Z","caller":"traceutil/trace.go:171","msg":"trace[1600861344] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:674; }","duration":"472.45455ms","start":"2026-02-17T16:10:03.699406Z","end":"2026-02-17T16:10:04.17186Z","steps":["trace[1600861344] 'agreement among raft nodes before linearized reading' (duration: 472.417529ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:04.171875Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:03.699387Z","time spent":"472.485911ms","remote":"127.0.0.1:52574","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-17T16:10:04.171949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.751827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-17T16:10:04.171963Z","caller":"traceutil/trace.go:171","msg":"trace[1633814555] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:674; }","duration":"603.790538ms","start":"2026-02-17T16:10:03.568169Z","end":"2026-02-17T16:10:04.171959Z","steps":["trace[1633814555] 'agreement among raft nodes before linearized reading' (duration: 603.753858ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:04.171974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:03.568155Z","time spent":"603.816289ms","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-02-17T16:10:04.172045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.092589812s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-m9vmv\" ","response":"range_response_count:1 size:17914"} {"level":"info","ts":"2026-02-17T16:10:04.172056Z","caller":"traceutil/trace.go:171","msg":"trace[355737989] range","detail":"{range_begin:/registry/pods/kube-system/cilium-m9vmv; range_end:; response_count:1; response_revision:674; }","duration":"1.092627543s","start":"2026-02-17T16:10:03.079425Z","end":"2026-02-17T16:10:04.172053Z","steps":["trace[355737989] 'agreement among raft nodes before linearized reading' (duration: 1.092590043s)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:04.172066Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:03.07941Z","time spent":"1.092654304s","remote":"127.0.0.1:52486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17937,"request content":"key:\"/registry/pods/kube-system/cilium-m9vmv\" "} {"level":"info","ts":"2026-02-17T16:10:04.358601Z","caller":"traceutil/trace.go:171","msg":"trace[805431509] linearizableReadLoop","detail":"{readStateIndex:703; appliedIndex:699; }","duration":"162.681118ms","start":"2026-02-17T16:10:04.1959Z","end":"2026-02-17T16:10:04.358582Z","steps":["trace[805431509] 'read index received' (duration: 28.416629ms)","trace[805431509] 'applied index is now lower than readState.Index' (duration: 134.263359ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:10:04.358639Z","caller":"traceutil/trace.go:171","msg":"trace[1906536236] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"169.315398ms","start":"2026-02-17T16:10:04.189315Z","end":"2026-02-17T16:10:04.35863Z","steps":["trace[1906536236] 'process raft request' (duration: 169.154435ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:04.358696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.77942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:10:04.358727Z","caller":"traceutil/trace.go:171","msg":"trace[524632892] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:680; }","duration":"162.841532ms","start":"2026-02-17T16:10:04.195877Z","end":"2026-02-17T16:10:04.358718Z","steps":["trace[524632892] 'agreement among raft nodes before linearized reading' (duration: 162.782021ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:04.358747Z","caller":"traceutil/trace.go:171","msg":"trace[988593074] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"169.517392ms","start":"2026-02-17T16:10:04.189225Z","end":"2026-02-17T16:10:04.358742Z","steps":["trace[988593074] 'process raft request' (duration: 161.893492ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:04.358808Z","caller":"traceutil/trace.go:171","msg":"trace[601883161] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"169.519263ms","start":"2026-02-17T16:10:04.189285Z","end":"2026-02-17T16:10:04.358804Z","steps":["trace[601883161] 'process raft request' (duration: 169.120264ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:04.358871Z","caller":"traceutil/trace.go:171","msg":"trace[19699672] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"169.485542ms","start":"2026-02-17T16:10:04.189374Z","end":"2026-02-17T16:10:04.35886Z","steps":["trace[19699672] 'process raft request' (duration: 169.125434ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:04.359019Z","caller":"traceutil/trace.go:171","msg":"trace[2105067537] transaction","detail":"{read_only:false; response_revision:680; number_of_response:1; }","duration":"163.040816ms","start":"2026-02-17T16:10:04.195973Z","end":"2026-02-17T16:10:04.359014Z","steps":["trace[2105067537] 'process raft request' (duration: 162.561336ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:14.585701Z","caller":"traceutil/trace.go:171","msg":"trace[1353560298] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"117.569965ms","start":"2026-02-17T16:10:14.468108Z","end":"2026-02-17T16:10:14.585678Z","steps":["trace[1353560298] 'process raft request' (duration: 117.359611ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:14.610547Z","caller":"traceutil/trace.go:171","msg":"trace[147832604] linearizableReadLoop","detail":"{readStateIndex:815; appliedIndex:812; }","duration":"138.056459ms","start":"2026-02-17T16:10:14.472478Z","end":"2026-02-17T16:10:14.610535Z","steps":["trace[147832604] 'read index received' (duration: 112.952414ms)","trace[147832604] 'applied index is now lower than readState.Index' (duration: 25.103345ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:10:14.610878Z","caller":"traceutil/trace.go:171","msg":"trace[1340773104] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"142.552277ms","start":"2026-02-17T16:10:14.468309Z","end":"2026-02-17T16:10:14.610862Z","steps":["trace[1340773104] 'process raft request' (duration: 142.135319ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:14.61105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.552479ms","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-17T16:10:14.61108Z","caller":"traceutil/trace.go:171","msg":"trace[1432513331] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:786; }","duration":"138.606529ms","start":"2026-02-17T16:10:14.472464Z","end":"2026-02-17T16:10:14.611071Z","steps":["trace[1432513331] 'agreement among raft nodes before linearized reading' (duration: 138.299493ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:14.611149Z","caller":"traceutil/trace.go:171","msg":"trace[624814064] transaction","detail":"{read_only:false; response_revision:786; number_of_response:1; }","duration":"142.765782ms","start":"2026-02-17T16:10:14.468377Z","end":"2026-02-17T16:10:14.611143Z","steps":["trace[624814064] 'process raft request' (duration: 142.130939ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:16.361403Z","caller":"traceutil/trace.go:171","msg":"trace[1703510590] transaction","detail":"{read_only:false; response_revision:792; number_of_response:1; }","duration":"198.584523ms","start":"2026-02-17T16:10:16.162801Z","end":"2026-02-17T16:10:16.361386Z","steps":["trace[1703510590] 'process raft request' (duration: 198.481251ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:16.781202Z","caller":"traceutil/trace.go:171","msg":"trace[962605614] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"135.546517ms","start":"2026-02-17T16:10:16.645634Z","end":"2026-02-17T16:10:16.781181Z","steps":["trace[962605614] 'process raft request' (duration: 55.616012ms)","trace[962605614] 'compare' (duration: 79.840943ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:10:16.790327Z","caller":"traceutil/trace.go:171","msg":"trace[1115649116] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"141.362539ms","start":"2026-02-17T16:10:16.648955Z","end":"2026-02-17T16:10:16.790318Z","steps":["trace[1115649116] 'process raft request' (duration: 141.340389ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:16.790436Z","caller":"traceutil/trace.go:171","msg":"trace[1401329345] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"142.339979ms","start":"2026-02-17T16:10:16.648091Z","end":"2026-02-17T16:10:16.790431Z","steps":["trace[1401329345] 'process raft request' (duration: 142.142425ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:18.93595Z","caller":"traceutil/trace.go:171","msg":"trace[460279389] linearizableReadLoop","detail":"{readStateIndex:834; appliedIndex:833; }","duration":"142.736782ms","start":"2026-02-17T16:10:18.793198Z","end":"2026-02-17T16:10:18.935934Z","steps":["trace[460279389] 'read index received' (duration: 142.607109ms)","trace[460279389] 'applied index is now lower than readState.Index' (duration: 129.063µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:10:18.93617Z","caller":"traceutil/trace.go:171","msg":"trace[569837399] transaction","detail":"{read_only:false; response_revision:804; number_of_response:1; }","duration":"145.77898ms","start":"2026-02-17T16:10:18.790383Z","end":"2026-02-17T16:10:18.936162Z","steps":["trace[569837399] 'process raft request' (duration: 145.463324ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:18.936333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.1217ms","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-17T16:10:18.936356Z","caller":"traceutil/trace.go:171","msg":"trace[1648974962] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:804; }","duration":"143.169611ms","start":"2026-02-17T16:10:18.793181Z","end":"2026-02-17T16:10:18.936351Z","steps":["trace[1648974962] 'agreement among raft nodes before linearized reading' (duration: 143.087459ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:18.936444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.724383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-02-17T16:10:18.936461Z","caller":"traceutil/trace.go:171","msg":"trace[2047455412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:804; }","duration":"142.753473ms","start":"2026-02-17T16:10:18.793704Z","end":"2026-02-17T16:10:18.936457Z","steps":["trace[2047455412] 'agreement among raft nodes before linearized reading' (duration: 142.714212ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:20.88775Z","caller":"traceutil/trace.go:171","msg":"trace[1545468408] linearizableReadLoop","detail":"{readStateIndex:837; appliedIndex:836; }","duration":"246.274314ms","start":"2026-02-17T16:10:20.641457Z","end":"2026-02-17T16:10:20.887732Z","steps":["trace[1545468408] 'read index received' (duration: 246.138152ms)","trace[1545468408] 'applied index is now lower than readState.Index' (duration: 135.472µs)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:10:20.887994Z","caller":"traceutil/trace.go:171","msg":"trace[1076264894] transaction","detail":"{read_only:false; response_revision:807; number_of_response:1; }","duration":"421.681003ms","start":"2026-02-17T16:10:20.466305Z","end":"2026-02-17T16:10:20.887986Z","steps":["trace[1076264894] 'process raft request' (duration: 421.335846ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:20.888065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-02-17T16:10:20.466289Z","time spent":"421.726354ms","remote":"127.0.0.1:52574","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-02-17T16:10:20.888116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.778438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-17T16:10:20.888181Z","caller":"traceutil/trace.go:171","msg":"trace[811461220] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:807; }","duration":"212.875559ms","start":"2026-02-17T16:10:20.675291Z","end":"2026-02-17T16:10:20.888167Z","steps":["trace[811461220] 'agreement among raft nodes before linearized reading' (duration: 212.682256ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:20.888279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.818635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:10:20.888307Z","caller":"traceutil/trace.go:171","msg":"trace[1213021871] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:807; }","duration":"246.867635ms","start":"2026-02-17T16:10:20.641431Z","end":"2026-02-17T16:10:20.888299Z","steps":["trace[1213021871] 'agreement among raft nodes before linearized reading' (duration: 246.825564ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:21.400431Z","caller":"traceutil/trace.go:171","msg":"trace[689971298] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"139.845718ms","start":"2026-02-17T16:10:21.260565Z","end":"2026-02-17T16:10:21.400411Z","steps":["trace[689971298] 'process raft request' (duration: 83.404083ms)","trace[689971298] 'compare' (duration: 56.374284ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:10:21.604504Z","caller":"traceutil/trace.go:171","msg":"trace[933306689] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"198.092847ms","start":"2026-02-17T16:10:21.406393Z","end":"2026-02-17T16:10:21.604486Z","steps":["trace[933306689] 'process raft request' (duration: 137.118127ms)","trace[933306689] 'compare' (duration: 60.734945ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:10:22.389191Z","caller":"traceutil/trace.go:171","msg":"trace[764714528] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"205.34106ms","start":"2026-02-17T16:10:22.183828Z","end":"2026-02-17T16:10:22.389169Z","steps":["trace[764714528] 'process raft request' (duration: 205.070795ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:22.693444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.109984ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-02-17T16:10:22.693506Z","caller":"traceutil/trace.go:171","msg":"trace[1622790409] transaction","detail":"{read_only:false; number_of_response:1; response_revision:817; }","duration":"247.227326ms","start":"2026-02-17T16:10:22.44627Z","end":"2026-02-17T16:10:22.693497Z","steps":["trace[1622790409] 'process raft request' (duration: 55.987571ms)","trace[1622790409] 'compare' (duration: 190.908239ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:10:29.092018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.030384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-02-17T16:10:29.092071Z","caller":"traceutil/trace.go:171","msg":"trace[267445013] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:835; }","duration":"105.133706ms","start":"2026-02-17T16:10:28.986925Z","end":"2026-02-17T16:10:29.092058Z","steps":["trace[267445013] 'range keys from in-memory index tree' (duration: 104.966993ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:29.288103Z","caller":"traceutil/trace.go:171","msg":"trace[1494591968] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"189.247888ms","start":"2026-02-17T16:10:29.09884Z","end":"2026-02-17T16:10:29.288088Z","steps":["trace[1494591968] 'process raft request' (duration: 189.221798ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:29.288201Z","caller":"traceutil/trace.go:171","msg":"trace[1291656639] transaction","detail":"{read_only:false; response_revision:837; number_of_response:1; }","duration":"191.449978ms","start":"2026-02-17T16:10:29.096719Z","end":"2026-02-17T16:10:29.288169Z","steps":["trace[1291656639] 'process raft request' (duration: 176.780754ms)","trace[1291656639] 'compare' (duration: 14.45449ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:10:29.288347Z","caller":"traceutil/trace.go:171","msg":"trace[903382501] transaction","detail":"{read_only:false; response_revision:838; number_of_response:1; }","duration":"190.956979ms","start":"2026-02-17T16:10:29.097385Z","end":"2026-02-17T16:10:29.288342Z","steps":["trace[903382501] 'process raft request' (duration: 190.652994ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:10:35.281529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.79344ms","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-17T16:10:35.281588Z","caller":"traceutil/trace.go:171","msg":"trace[1342519829] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:851; }","duration":"103.899962ms","start":"2026-02-17T16:10:35.177674Z","end":"2026-02-17T16:10:35.281574Z","steps":["trace[1342519829] 'range keys from in-memory index tree' (duration: 103.665818ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:35.561867Z","caller":"traceutil/trace.go:171","msg":"trace[1666238756] transaction","detail":"{read_only:false; response_revision:855; number_of_response:1; }","duration":"146.606367ms","start":"2026-02-17T16:10:35.415235Z","end":"2026-02-17T16:10:35.561841Z","steps":["trace[1666238756] 'process raft request' (duration: 134.081289ms)","trace[1666238756] 'compare' (duration: 12.438537ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:10:51.35807Z","caller":"traceutil/trace.go:171","msg":"trace[294163282] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"147.34199ms","start":"2026-02-17T16:10:51.210713Z","end":"2026-02-17T16:10:51.358055Z","steps":["trace[294163282] 'process raft request' (duration: 147.029975ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:10:51.498959Z","caller":"traceutil/trace.go:171","msg":"trace[1204853627] transaction","detail":"{read_only:false; response_revision:898; number_of_response:1; }","duration":"107.445856ms","start":"2026-02-17T16:10:51.391496Z","end":"2026-02-17T16:10:51.498942Z","steps":["trace[1204853627] 'process raft request' (duration: 33.734905ms)","trace[1204853627] 'compare' (duration: 73.554988ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:11:01.718907Z","caller":"traceutil/trace.go:171","msg":"trace[1305122929] transaction","detail":"{read_only:false; response_revision:927; number_of_response:1; }","duration":"149.921664ms","start":"2026-02-17T16:11:01.568967Z","end":"2026-02-17T16:11:01.718889Z","steps":["trace[1305122929] 'process raft request' (duration: 82.458139ms)","trace[1305122929] 'compare' (duration: 67.11317ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:11:07.97393Z","caller":"traceutil/trace.go:171","msg":"trace[576056348] transaction","detail":"{read_only:false; response_revision:945; number_of_response:1; }","duration":"102.125907ms","start":"2026-02-17T16:11:07.87175Z","end":"2026-02-17T16:11:07.973876Z","steps":["trace[576056348] 'process raft request' (duration: 57.610572ms)","trace[576056348] 'compare' (duration: 42.751408ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:11:08.21891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.56855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T16:11:08.218977Z","caller":"traceutil/trace.go:171","msg":"trace[543710969] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:946; }","duration":"118.690831ms","start":"2026-02-17T16:11:08.100273Z","end":"2026-02-17T16:11:08.218963Z","steps":["trace[543710969] 'count revisions from in-memory index tree' (duration: 118.496429ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:11:20.278896Z","caller":"traceutil/trace.go:171","msg":"trace[391724246] transaction","detail":"{read_only:false; response_revision:1012; number_of_response:1; }","duration":"179.748907ms","start":"2026-02-17T16:11:20.099128Z","end":"2026-02-17T16:11:20.278877Z","steps":["trace[391724246] 'process raft request' (duration: 179.507444ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:20.279354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.922858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/default/test-pvc-pod\" ","response":"range_response_count:1 size:2475"} {"level":"info","ts":"2026-02-17T16:11:20.279375Z","caller":"traceutil/trace.go:171","msg":"trace[1738778656] range","detail":"{range_begin:/registry/pods/default/test-pvc-pod; range_end:; response_count:1; response_revision:1012; }","duration":"103.986328ms","start":"2026-02-17T16:11:20.175382Z","end":"2026-02-17T16:11:20.279369Z","steps":["trace[1738778656] 'agreement among raft nodes before linearized reading' (duration: 103.890847ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:11:20.278729Z","caller":"traceutil/trace.go:171","msg":"trace[620352730] linearizableReadLoop","detail":"{readStateIndex:1056; appliedIndex:1055; }","duration":"103.289498ms","start":"2026-02-17T16:11:20.175426Z","end":"2026-02-17T16:11:20.278715Z","steps":["trace[620352730] 'read index received' (duration: 103.172396ms)","trace[620352730] 'applied index is now lower than readState.Index' (duration: 116.482µs)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:11:21.980263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.385846ms","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-17T16:11:21.980319Z","caller":"traceutil/trace.go:171","msg":"trace[855976741] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1013; }","duration":"148.471297ms","start":"2026-02-17T16:11:21.831834Z","end":"2026-02-17T16:11:21.980306Z","steps":["trace[855976741] 'range keys from in-memory index tree' (duration: 148.270784ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:11:50.498256Z","caller":"traceutil/trace.go:171","msg":"trace[581954411] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"218.275443ms","start":"2026-02-17T16:11:50.279956Z","end":"2026-02-17T16:11:50.498231Z","steps":["trace[581954411] 'process raft request' (duration: 218.143411ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:11:50.518182Z","caller":"traceutil/trace.go:171","msg":"trace[30704662] linearizableReadLoop","detail":"{readStateIndex:1155; appliedIndex:1154; }","duration":"229.890598ms","start":"2026-02-17T16:11:50.288266Z","end":"2026-02-17T16:11:50.518157Z","steps":["trace[30704662] 'read index received' (duration: 209.998521ms)","trace[30704662] 'applied index is now lower than readState.Index' (duration: 19.890397ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:11:50.518418Z","caller":"traceutil/trace.go:171","msg":"trace[936233086] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"238.269382ms","start":"2026-02-17T16:11:50.280136Z","end":"2026-02-17T16:11:50.518405Z","steps":["trace[936233086] 'process raft request' (duration: 237.928377ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:50.518643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.359156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/local-path-storage/\" range_end:\"/registry/ingress/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:11:50.518684Z","caller":"traceutil/trace.go:171","msg":"trace[785065413] range","detail":"{range_begin:/registry/ingress/local-path-storage/; range_end:/registry/ingress/local-path-storage0; response_count:0; response_revision:1105; }","duration":"230.427946ms","start":"2026-02-17T16:11:50.288243Z","end":"2026-02-17T16:11:50.518671Z","steps":["trace[785065413] 'agreement among raft nodes before linearized reading' (duration: 230.353515ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:50.518851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.125918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:11:50.518881Z","caller":"traceutil/trace.go:171","msg":"trace[2008403404] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1105; }","duration":"191.186019ms","start":"2026-02-17T16:11:50.327686Z","end":"2026-02-17T16:11:50.518872Z","steps":["trace[2008403404] 'agreement among raft nodes before linearized reading' (duration: 191.136328ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:50.519443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.708105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-02-17T16:11:50.51948Z","caller":"traceutil/trace.go:171","msg":"trace[939588601] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1105; }","duration":"115.774635ms","start":"2026-02-17T16:11:50.403695Z","end":"2026-02-17T16:11:50.519469Z","steps":["trace[939588601] 'agreement among raft nodes before linearized reading' (duration: 115.648963ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:50.519646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.489884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-8xnjh\" ","response":"range_response_count:1 size:4411"} {"level":"info","ts":"2026-02-17T16:11:50.519672Z","caller":"traceutil/trace.go:171","msg":"trace[751874411] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-8xnjh; range_end:; response_count:1; response_revision:1105; }","duration":"136.553055ms","start":"2026-02-17T16:11:50.383111Z","end":"2026-02-17T16:11:50.519664Z","steps":["trace[751874411] 'agreement among raft nodes before linearized reading' (duration: 136.498514ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:50.519802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.412781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4063"} {"level":"info","ts":"2026-02-17T16:11:50.519819Z","caller":"traceutil/trace.go:171","msg":"trace[1643625971] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:1105; }","duration":"144.430481ms","start":"2026-02-17T16:11:50.375383Z","end":"2026-02-17T16:11:50.519813Z","steps":["trace[1643625971] 'agreement among raft nodes before linearized reading' (duration: 144.39647ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:50.519901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.633393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/local-path-storage/\" range_end:\"/registry/networkpolicies/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:11:50.519918Z","caller":"traceutil/trace.go:171","msg":"trace[608633250] range","detail":"{range_begin:/registry/networkpolicies/local-path-storage/; range_end:/registry/networkpolicies/local-path-storage0; response_count:0; response_revision:1105; }","duration":"173.691734ms","start":"2026-02-17T16:11:50.34622Z","end":"2026-02-17T16:11:50.519912Z","steps":["trace[608633250] 'agreement among raft nodes before linearized reading' (duration: 173.664724ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:50.520026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.290829ms","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-17T16:11:50.520043Z","caller":"traceutil/trace.go:171","msg":"trace[482585325] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1105; }","duration":"179.33152ms","start":"2026-02-17T16:11:50.340707Z","end":"2026-02-17T16:11:50.520039Z","steps":["trace[482585325] 'agreement among raft nodes before linearized reading' (duration: 179.281929ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:50.685701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.603593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-02-17T16:11:50.685885Z","caller":"traceutil/trace.go:171","msg":"trace[1711668089] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"151.214932ms","start":"2026-02-17T16:11:50.534655Z","end":"2026-02-17T16:11:50.68587Z","steps":["trace[1711668089] 'process raft request' (duration: 151.163251ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:11:50.686264Z","caller":"traceutil/trace.go:171","msg":"trace[1620499445] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"155.073174ms","start":"2026-02-17T16:11:50.531177Z","end":"2026-02-17T16:11:50.68625Z","steps":["trace[1620499445] 'process raft request' (duration: 32.838702ms)","trace[1620499445] 'compare' (duration: 121.480552ms)"],"step_count":2} {"level":"info","ts":"2026-02-17T16:11:50.686395Z","caller":"traceutil/trace.go:171","msg":"trace[1271562063] linearizableReadLoop","detail":"{readStateIndex:1156; appliedIndex:1155; }","duration":"151.748519ms","start":"2026-02-17T16:11:50.534638Z","end":"2026-02-17T16:11:50.686386Z","steps":["trace[1271562063] 'read index received' (duration: 29.387235ms)","trace[1271562063] 'applied index is now lower than readState.Index' (duration: 122.360474ms)"],"step_count":2} {"level":"warn","ts":"2026-02-17T16:11:50.686568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.924081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-8xnjh\" ","response":"range_response_count:1 size:4411"} {"level":"info","ts":"2026-02-17T16:11:50.6866Z","caller":"traceutil/trace.go:171","msg":"trace[1681758900] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-8xnjh; range_end:; response_count:1; response_revision:1107; }","duration":"151.986782ms","start":"2026-02-17T16:11:50.534604Z","end":"2026-02-17T16:11:50.68659Z","steps":["trace[1681758900] 'agreement among raft nodes before linearized reading' (duration: 151.923081ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:51.068085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.335824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/local-path-storage/\" range_end:\"/registry/persistentvolumeclaims/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:11:51.068186Z","caller":"traceutil/trace.go:171","msg":"trace[1163365285] range","detail":"{range_begin:/registry/persistentvolumeclaims/local-path-storage/; range_end:/registry/persistentvolumeclaims/local-path-storage0; response_count:0; response_revision:1107; }","duration":"233.468725ms","start":"2026-02-17T16:11:50.83469Z","end":"2026-02-17T16:11:51.068158Z","steps":["trace[1163365285] 'range keys from in-memory index tree' (duration: 233.262722ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:51.068762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.299165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo\" ","response":"range_response_count:1 size:496"} {"level":"info","ts":"2026-02-17T16:11:51.068822Z","caller":"traceutil/trace.go:171","msg":"trace[591885248] range","detail":"{range_begin:/registry/rolebindings/kube-public/kubeadm:bootstrap-signer-clusterinfo; range_end:; response_count:1; response_revision:1107; }","duration":"190.370836ms","start":"2026-02-17T16:11:50.878436Z","end":"2026-02-17T16:11:51.068806Z","steps":["trace[591885248] 'range keys from in-memory index tree' (duration: 190.216684ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:51.069497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.845345ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-02-17T16:11:51.069569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.72687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/local-path-storage/\" range_end:\"/registry/rolebindings/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-02-17T16:11:51.069765Z","caller":"traceutil/trace.go:171","msg":"trace[1255094018] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1107; }","duration":"142.054857ms","start":"2026-02-17T16:11:50.927618Z","end":"2026-02-17T16:11:51.069673Z","steps":["trace[1255094018] 'range keys from in-memory index tree' (duration: 141.828244ms)"],"step_count":1} {"level":"info","ts":"2026-02-17T16:11:51.069767Z","caller":"traceutil/trace.go:171","msg":"trace[643915407] range","detail":"{range_begin:/registry/rolebindings/local-path-storage/; range_end:/registry/rolebindings/local-path-storage0; response_count:0; response_revision:1107; }","duration":"210.959783ms","start":"2026-02-17T16:11:50.85879Z","end":"2026-02-17T16:11:51.06975Z","steps":["trace[643915407] 'range keys from in-memory index tree' (duration: 210.678749ms)"],"step_count":1} {"level":"warn","ts":"2026-02-17T16:11:51.070606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.417661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-vip-instance\" ","response":"range_response_count:1 size:4594"} {"level":"info","ts":"2026-02-17T16:11:51.070787Z","caller":"traceutil/trace.go:171","msg":"trace[846853979] range","detail":"{range_begin:/registry/pods/kube-system/kube-vip-instance; range_end:; response_count:1; response_revision:1107; }","duration":"195.183351ms","start":"2026-02-17T16:11:50.875473Z","end":"2026-02-17T16:11:51.070656Z","steps":["trace[846853979] 'range keys from in-memory index tree' (duration: 194.281099ms)"],"step_count":1}